builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0071 starttime: 1457702159.16 results: success (0) buildid: 20160311031816 builduid: 14b671a5fad341eebe7d2c80535f1fbc revision: f7ed458ec73dc42d58fda3d69b1036738d968833 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.156234) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.156661) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.156988) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 /builds/slave/test program finished with exit code 0 elapsedTime=0.005531 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.185837) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.186139) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.237206) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.237467) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005269 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.302639) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.303004) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.303380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.303660) ========= 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.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-03-11 05:15:59-- 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% 8.41M=0.001s 2016-03-11 05:15:59 (8.41 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.159287 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.485330) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.485653) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.019434 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-11 05:15:59.538260) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 05:15:59.538592) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f7ed458ec73dc42d58fda3d69b1036738d968833 --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 f7ed458ec73dc42d58fda3d69b1036738d968833 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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-03-11 05:15:59,587 truncating revision to first 12 chars 2016-03-11 05:15:59,587 Setting DEBUG logging. 2016-03-11 05:15:59,587 attempt 1/10 2016-03-11 05:15:59,587 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f7ed458ec73d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-11 05:16:00,660 unpacking tar archive at: fx-team-f7ed458ec73d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.323865 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 05:16:00.882791) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 05:16:00.883330) ========= echo f7ed458ec73dc42d58fda3d69b1036738d968833 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'f7ed458ec73dc42d58fda3d69b1036738d968833'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 f7ed458ec73dc42d58fda3d69b1036738d968833 program finished with exit code 0 elapsedTime=0.004973 script_repo_revision: 'f7ed458ec73dc42d58fda3d69b1036738d968833' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-11 05:16:00.934028) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 05:16:00.934340) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-11 05:16:00.948255) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-11 05:16:00.948668) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 05:16:01 INFO - MultiFileLogger online at 20160311 05:16:01 in /builds/slave/test 05:16:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:16:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:16:01 INFO - {'append_to_log': False, 05:16:01 INFO - 'base_work_dir': '/builds/slave/test', 05:16:01 INFO - 'blob_upload_branch': 'Fx-Team', 05:16:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:16:01 INFO - 'branch': 'Fx-Team', 05:16:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:16:01 INFO - 'config_files': ('talos/mac_config.py',), 05:16:01 INFO - 'default_actions': ('clobber', 05:16:01 INFO - 'read-buildbot-config', 05:16:01 INFO - 'download-and-extract', 05:16:01 INFO - 'populate-webroot', 05:16:01 INFO - 'create-virtualenv', 05:16:01 INFO - 'install', 05:16:01 INFO - 'run-tests'), 05:16:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:16:01 INFO - 'download_minidump_stackwalk': True, 05:16:01 INFO - 'download_symbols': 'ondemand', 05:16:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:16:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:16:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:16:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:16:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:16:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:16:01 INFO - 'installer_path': 'installer.exe', 05:16:01 INFO - 'log_level': 'info', 05:16:01 INFO - 'log_name': 'talos', 05:16:01 INFO - 'log_to_console': True, 05:16:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:16:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:16:01 INFO - 'opt_config_files': (), 05:16:01 INFO - 'pip_index': False, 05:16:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:01 INFO - 'cmd': ('bash', 05:16:01 INFO - '-c', 05:16:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:01 INFO - 'enabled': True, 05:16:01 INFO - 'halt_on_failure': False, 05:16:01 INFO - 'name': 'check_screen_resolution'},), 05:16:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:16:01 INFO - 'cmd': ('bash', 05:16:01 INFO - '-c', 05:16:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:16:01 INFO - 'enabled': True, 05:16:01 INFO - 'halt_on_failure': False, 05:16:01 INFO - 'name': 'check_screen_resolution'},), 05:16:01 INFO - 'run_cmd_checks_enabled': True, 05:16:01 INFO - 'sps_profile': False, 05:16:01 INFO - 'sps_profile_interval': 0, 05:16:01 INFO - 'suite': 'dromaeojs', 05:16:01 INFO - 'system_bits': '32', 05:16:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:16:01 INFO - 'title': 't-yosemite-r7-0071', 05:16:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:16:01 INFO - 'use_talos_json': True, 05:16:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:16:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:16:01 INFO - 'work_dir': 'build'} 05:16:01 INFO - ##### 05:16:01 INFO - ##### Running clobber step. 05:16:01 INFO - ##### 05:16:01 INFO - Running pre-action listener: _resource_record_pre_action 05:16:01 INFO - Running main action method: clobber 05:16:01 INFO - rmtree: /builds/slave/test/build 05:16:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:16:02 INFO - Running post-action listener: _resource_record_post_action 05:16:02 INFO - ##### 05:16:02 INFO - ##### Running read-buildbot-config step. 05:16:02 INFO - ##### 05:16:02 INFO - Running pre-action listener: _resource_record_pre_action 05:16:02 INFO - Running main action method: read_buildbot_config 05:16:02 INFO - Using buildbot properties: 05:16:02 INFO - { 05:16:02 INFO - "project": "", 05:16:02 INFO - "product": "firefox", 05:16:02 INFO - "script_repo_revision": "production", 05:16:02 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:16:02 INFO - "repository": "", 05:16:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:16:02 INFO - "buildid": "20160311031816", 05:16:02 INFO - "pgo_build": "False", 05:16:02 INFO - "basedir": "/builds/slave/test", 05:16:02 INFO - "buildnumber": 525, 05:16:02 INFO - "slavename": "t-yosemite-r7-0071", 05:16:02 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:16:02 INFO - "platform": "yosemite_r7", 05:16:02 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:16:02 INFO - "branch": "fx-team", 05:16:02 INFO - "repo_path": "integration/fx-team", 05:16:02 INFO - "revision": "f7ed458ec73dc42d58fda3d69b1036738d968833", 05:16:02 INFO - "stage_platform": "macosx64", 05:16:02 INFO - "builduid": "14b671a5fad341eebe7d2c80535f1fbc", 05:16:02 INFO - "slavebuilddir": "test" 05:16:02 INFO - } 05:16:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:16:02 INFO - Running post-action listener: _resource_record_post_action 05:16:02 INFO - ##### 05:16:02 INFO - ##### Running download-and-extract step. 05:16:02 INFO - ##### 05:16:02 INFO - Running pre-action listener: _resource_record_pre_action 05:16:02 INFO - Running main action method: download_and_extract 05:16:02 INFO - mkdir: /builds/slave/test/build/tests 05:16: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')]} 05:16:02 INFO - https://queue.taskcluster.net/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:16:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:16:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:16:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:16:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:16:03 INFO - Downloaded 1199 bytes. 05:16:03 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:16:03 INFO - Using the following test package requirements: 05:16:03 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:16:03 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:16:03 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:16:03 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:16:03 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:16:03 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:16:03 INFO - u'jsshell-mac.zip'], 05:16:03 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:16:03 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:16:03 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:16:03 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:16:03 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:16:03 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:16:03 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:16:03 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:16:03 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:16:03 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:16:03 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:16:03 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:16:03 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')]} 05:16:03 INFO - https://queue.taskcluster.net/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:16:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:16:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:16:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:16:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:16:05 INFO - Downloaded 17867611 bytes. 05:16:05 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:16:08 INFO - Return code: 0 05:16:08 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:08 INFO - https://queue.taskcluster.net/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:16:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:16:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:16:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:16:09 INFO - Downloaded 17867611 bytes. 05:16:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:16:13 INFO - Return code: 0 05:16:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:13 INFO - https://queue.taskcluster.net/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:16:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:16:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:16:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:16:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:16:14 INFO - Downloaded 10845161 bytes. 05:16:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:16:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:16:14 INFO - Return code: 0 05:16:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:14 INFO - https://queue.taskcluster.net/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:16:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:16:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:16:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:16:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:16:17 INFO - Downloaded 111002946 bytes. 05:16:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:16:17 INFO - mkdir: /builds/slave/test/properties 05:16:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:17 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:17 INFO - Contents: 05:16:17 INFO - build_url:https://queue.taskcluster.net/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:16:18 INFO - Running post-action listener: _resource_record_post_action 05:16:18 INFO - Running post-action listener: set_extra_try_arguments 05:16:18 INFO - ##### 05:16:18 INFO - ##### Running populate-webroot step. 05:16:18 INFO - ##### 05:16:18 INFO - Running pre-action listener: _resource_record_pre_action 05:16:18 INFO - Running main action method: populate_webroot 05:16:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:18 INFO - '--tppagecycles', 05:16:18 INFO - '7'], 05:16:18 INFO - 'tests': ['tsvgm']}}, 05:16:18 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:16:18 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:16:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:18 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:16:18 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:16:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:18 INFO - 'talos_options': ['--e10s'], 05:16:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:18 INFO - 'tests': ['damp', 'tps']}, 05:16:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:18 INFO - 'talos_options': ['--e10s'], 05:16:18 INFO - 'tests': ['damp', 'tps']}, 05:16:18 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:16:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:18 INFO - 'other': {'tests': ['a11yr', 05:16:18 INFO - 'ts_paint', 05:16:18 INFO - 'tpaint', 05:16:18 INFO - 'sessionrestore', 05:16:18 INFO - 'sessionrestore_no_auto_restore', 05:16:18 INFO - 'tabpaint']}, 05:16:18 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:16:18 INFO - 'tests': ['a11yr', 05:16:18 INFO - 'ts_paint', 05:16:18 INFO - 'tpaint', 05:16:18 INFO - 'sessionrestore', 05:16:18 INFO - 'sessionrestore_no_auto_restore', 05:16:18 INFO - 'tabpaint']}, 05:16:18 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:16:18 INFO - 'tests': ['a11yr', 05:16:18 INFO - 'ts_paint', 05:16:18 INFO - 'tpaint', 05:16:18 INFO - 'sessionrestore', 05:16:18 INFO - 'sessionrestore_no_auto_restore', 05:16:18 INFO - 'tabpaint']}, 05:16:18 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:16:18 INFO - 'tests': ['a11yr', 05:16:18 INFO - 'ts_paint', 05:16:18 INFO - 'tpaint', 05:16:18 INFO - 'sessionrestore', 05:16:18 INFO - 'sessionrestore_no_auto_restore', 05:16:18 INFO - 'tabpaint']}, 05:16:18 INFO - 'other_l64': {'tests': ['a11yr', 05:16:18 INFO - 'ts_paint', 05:16:18 INFO - 'tpaint', 05:16:18 INFO - 'sessionrestore', 05:16:18 INFO - 'sessionrestore_no_auto_restore', 05:16:18 INFO - 'tabpaint']}, 05:16:18 INFO - 'other_nol64': {'tests': ['a11yr', 05:16:18 INFO - 'ts_paint', 05:16:18 INFO - 'tpaint', 05:16:18 INFO - 'sessionrestore', 05:16:18 INFO - 'sessionrestore_no_auto_restore', 05:16:18 INFO - 'tabpaint']}, 05:16:18 INFO - 'svgr': {'tests': ['tsvgx', 05:16:18 INFO - 'tsvgr_opacity', 05:16:18 INFO - 'tart', 05:16:18 INFO - 'tscrollx', 05:16:18 INFO - 'cart']}, 05:16:18 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:16:18 INFO - 'tests': ['tsvgx', 05:16:18 INFO - 'tsvgr_opacity', 05:16:18 INFO - 'tart', 05:16:18 INFO - 'tscrollx', 05:16:18 INFO - 'cart']}, 05:16:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:18 INFO - 'tests': ['tp5o']}, 05:16:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:18 INFO - 'talos_options': ['--e10s'], 05:16:18 INFO - 'tests': ['tp5o']}, 05:16:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:18 INFO - 'talos_options': ['--xperf_path', 05:16:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:18 INFO - 'tests': ['tp5n']}, 05:16:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:16:18 INFO - 'talos_options': ['--e10s', 05:16:18 INFO - '--xperf_path', 05:16:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:18 INFO - 'tests': ['tp5n']}}, 05:16:18 INFO - 'talos.zip': {'path': '', 05:16:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:18 INFO - Running post-action listener: _resource_record_post_action 05:16:18 INFO - ##### 05:16:18 INFO - ##### Running create-virtualenv step. 05:16:18 INFO - ##### 05:16:18 INFO - Running pre-action listener: _resource_record_pre_action 05:16:18 INFO - Running main action method: create_virtualenv 05:16:18 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:18 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 05:16:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:18 INFO - Using real prefix '/tools/python27' 05:16:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:19 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:22 INFO - Installing pip.................done. 05:16:22 INFO - Return code: 0 05:16:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16:22 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')]} 05:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:22 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')]} 05:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:22 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 0x106f63a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca60db5620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e07d30>, '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 0x106c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dfeb20>, '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.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 05:16:22 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 05:16:22 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 05:16:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk3zF6VTqH/Render', 05:16:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:22 INFO - 'HOME': '/Users/cltbld', 05:16:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:22 INFO - 'LOGNAME': 'cltbld', 05:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:22 INFO - 'MOZ_NO_REMOTE': '1', 05:16:22 INFO - 'NO_EM_RESTART': '1', 05:16:22 INFO - 'PAGER': '/bin/cat', 05:16:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:22 INFO - 'PWD': '/builds/slave/test', 05:16:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:22 INFO - 'SHELL': '/bin/bash', 05:16:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TtzKRpnvp5/Listeners', 05:16:22 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:16:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:22 INFO - 'USER': 'cltbld', 05:16:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:22 INFO - 'XPC_FLAGS': '0x0', 05:16:22 INFO - 'XPC_SERVICE_NAME': '0', 05:16:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:22 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 05:16:22 INFO - Cleaning up... 05:16:22 INFO - Return code: 0 05:16:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:16:22 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')]} 05:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:22 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')]} 05:16:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106f63a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca60db5620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e07d30>, '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 0x106c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dfeb20>, '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.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 05:16:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:16:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:16:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk3zF6VTqH/Render', 05:16:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:22 INFO - 'HOME': '/Users/cltbld', 05:16:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:22 INFO - 'LOGNAME': 'cltbld', 05:16:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:22 INFO - 'MOZ_NO_REMOTE': '1', 05:16:22 INFO - 'NO_EM_RESTART': '1', 05:16:22 INFO - 'PAGER': '/bin/cat', 05:16:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:22 INFO - 'PWD': '/builds/slave/test', 05:16:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:22 INFO - 'SHELL': '/bin/bash', 05:16:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TtzKRpnvp5/Listeners', 05:16:22 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:16:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:22 INFO - 'USER': 'cltbld', 05:16:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:22 INFO - 'XPC_FLAGS': '0x0', 05:16:22 INFO - 'XPC_SERVICE_NAME': '0', 05:16:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:22 INFO - Downloading/unpacking psutil>=0.7.1 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:25 INFO - Installing collected packages: psutil 05:16:25 INFO - Running setup.py install for psutil 05:16:25 INFO - building 'psutil._psutil_osx' extension 05:16:25 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 05:16:25 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 05:16:25 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 05:16:25 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 05:16:25 INFO - building 'psutil._psutil_posix' extension 05:16:25 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 05:16:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:16:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:16:26 INFO - ^ 05:16:26 INFO - 1 warning generated. 05:16:26 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 05:16:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:26 INFO - Successfully installed psutil 05:16:26 INFO - Cleaning up... 05:16:26 INFO - Return code: 0 05:16:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106f63a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca60db5620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e07d30>, '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 0x106c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dfeb20>, '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.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 05:16:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:16:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:16:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk3zF6VTqH/Render', 05:16:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:26 INFO - 'HOME': '/Users/cltbld', 05:16:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:26 INFO - 'LOGNAME': 'cltbld', 05:16:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:26 INFO - 'MOZ_NO_REMOTE': '1', 05:16:26 INFO - 'NO_EM_RESTART': '1', 05:16:26 INFO - 'PAGER': '/bin/cat', 05:16:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:26 INFO - 'PWD': '/builds/slave/test', 05:16:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:26 INFO - 'SHELL': '/bin/bash', 05:16:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TtzKRpnvp5/Listeners', 05:16:26 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:16:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:26 INFO - 'USER': 'cltbld', 05:16:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:26 INFO - 'XPC_FLAGS': '0x0', 05:16:26 INFO - 'XPC_SERVICE_NAME': '0', 05:16:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:26 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:16:26 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 05:16:26 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 05:16:26 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 05:16:26 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 05:16:26 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 05:16:26 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 05:16:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:16:28 INFO - Installing collected packages: mozsystemmonitor 05:16:28 INFO - Running setup.py install for mozsystemmonitor 05:16:29 INFO - Successfully installed mozsystemmonitor 05:16:29 INFO - Cleaning up... 05:16:29 INFO - Return code: 0 05:16:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106f63a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca60db5620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e07d30>, '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 0x106c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dfeb20>, '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.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 05:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:16:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk3zF6VTqH/Render', 05:16:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:29 INFO - 'HOME': '/Users/cltbld', 05:16:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:29 INFO - 'LOGNAME': 'cltbld', 05:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:29 INFO - 'MOZ_NO_REMOTE': '1', 05:16:29 INFO - 'NO_EM_RESTART': '1', 05:16:29 INFO - 'PAGER': '/bin/cat', 05:16:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:29 INFO - 'PWD': '/builds/slave/test', 05:16:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:29 INFO - 'SHELL': '/bin/bash', 05:16:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TtzKRpnvp5/Listeners', 05:16:29 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:16:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:29 INFO - 'USER': 'cltbld', 05:16:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:29 INFO - 'XPC_FLAGS': '0x0', 05:16:29 INFO - 'XPC_SERVICE_NAME': '0', 05:16:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:29 INFO - Downloading/unpacking blobuploader==1.2.4 05:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:31 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16:32 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 05:16:32 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 05:16:32 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 05:16:32 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 05:16:32 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 05:16:32 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 05:16:32 INFO - Downloading docopt-0.6.1.tar.gz 05:16:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:32 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:32 INFO - Running setup.py install for blobuploader 05:16:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:33 INFO - Running setup.py install for requests 05:16:33 INFO - Running setup.py install for docopt 05:16:33 INFO - Successfully installed blobuploader requests docopt 05:16:33 INFO - Cleaning up... 05:16:33 INFO - Return code: 0 05:16:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:33 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 0x106f63a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca60db5620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e07d30>, '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 0x106c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dfeb20>, '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.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 05:16:33 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 05:16:33 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 05:16:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk3zF6VTqH/Render', 05:16:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:33 INFO - 'HOME': '/Users/cltbld', 05:16:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:33 INFO - 'LOGNAME': 'cltbld', 05:16:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:33 INFO - 'MOZ_NO_REMOTE': '1', 05:16:33 INFO - 'NO_EM_RESTART': '1', 05:16:33 INFO - 'PAGER': '/bin/cat', 05:16:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:33 INFO - 'PWD': '/builds/slave/test', 05:16:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:33 INFO - 'SHELL': '/bin/bash', 05:16:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TtzKRpnvp5/Listeners', 05:16:33 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:16:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:33 INFO - 'USER': 'cltbld', 05:16:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:33 INFO - 'XPC_FLAGS': '0x0', 05:16:33 INFO - 'XPC_SERVICE_NAME': '0', 05:16:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-2zDO5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-mZfpnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-_rI3Qx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-BgPgdw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-HBAmyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Wu6kt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-YwiBeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-v87Irp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:34 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-sQnEGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-8vCuH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-IQ_Bwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-yVLJHu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-uzNIml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-jAMo91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-_qYQ_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-hWvgYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:35 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-khq4hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:35 INFO - Running setup.py install for manifestparser 05:16:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:36 INFO - Running setup.py install for mozcrash 05:16:36 INFO - Running setup.py install for mozdebug 05:16:36 INFO - Running setup.py install for mozdevice 05:16:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:16:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:36 INFO - Running setup.py install for mozfile 05:16:36 INFO - Running setup.py install for mozhttpd 05:16:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:36 INFO - Running setup.py install for mozinfo 05:16:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:36 INFO - Running setup.py install for mozInstall 05:16:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:37 INFO - Running setup.py install for mozleak 05:16:37 INFO - Running setup.py install for mozlog 05:16:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:37 INFO - Running setup.py install for moznetwork 05:16:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:37 INFO - Running setup.py install for mozprocess 05:16:37 INFO - Running setup.py install for mozprofile 05:16:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:37 INFO - Running setup.py install for mozrunner 05:16:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:38 INFO - Running setup.py install for mozscreenshot 05:16:38 INFO - Running setup.py install for moztest 05:16:38 INFO - Running setup.py install for mozversion 05:16:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:38 INFO - Cleaning up... 05:16:38 INFO - Return code: 0 05:16:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:38 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 0x106f63a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca60db5620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e07d30>, '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 0x106c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dfeb20>, '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.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 05:16:38 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 05:16:38 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 05:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk3zF6VTqH/Render', 05:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:38 INFO - 'HOME': '/Users/cltbld', 05:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:38 INFO - 'LOGNAME': 'cltbld', 05:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:38 INFO - 'MOZ_NO_REMOTE': '1', 05:16:38 INFO - 'NO_EM_RESTART': '1', 05:16:38 INFO - 'PAGER': '/bin/cat', 05:16:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:38 INFO - 'PWD': '/builds/slave/test', 05:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:38 INFO - 'SHELL': '/bin/bash', 05:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TtzKRpnvp5/Listeners', 05:16:38 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:38 INFO - 'USER': 'cltbld', 05:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:38 INFO - 'XPC_FLAGS': '0x0', 05:16:38 INFO - 'XPC_SERVICE_NAME': '0', 05:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:38 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-T22CK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:38 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)) 05:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:38 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-rGsnmt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:38 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)) 05:16:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:38 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-OhtOiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:39 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)) 05:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:39 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-qy1il0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:39 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)) 05:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:39 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-G3ZkmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:39 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)) 05:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:39 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-k5vzMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:39 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)) 05:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:39 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-lLHaGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:39 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)) 05:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:39 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-54voNJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:39 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)) 05:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:39 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-nHal8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:39 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)) 05:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:39 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-_rVuJW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:39 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-5VOeli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:39 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)) 05:16:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:39 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-q1i9fa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:40 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)) 05:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:40 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-4rOZou-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:40 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)) 05:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:40 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-7ZKahk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:40 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)) 05:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:40 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-Ckp7bf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:40 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)) 05:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:40 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-SDu8IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:40 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)) 05:16:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:40 INFO - Running setup.py (path:/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/pip-qCq9M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:40 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)) 05:16:40 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)) 05:16:40 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)) 05:16:40 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)) 05:16:40 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)) 05:16:40 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)) 05:16:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:42 INFO - Downloading blessings-1.6.tar.gz 05:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:16:43 INFO - Installing collected packages: blessings 05:16:43 INFO - Running setup.py install for blessings 05:16:43 INFO - Successfully installed blessings 05:16:43 INFO - Cleaning up... 05:16:43 INFO - Return code: 0 05:16:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:43 INFO - Reading from file tmpfile_stdout 05:16:43 INFO - Current package versions: 05:16:43 INFO - blessings == 1.6 05:16:43 INFO - blobuploader == 1.2.4 05:16:43 INFO - docopt == 0.6.1 05:16:43 INFO - manifestparser == 1.1 05:16:43 INFO - mozInstall == 1.12 05:16:43 INFO - mozcrash == 0.17 05:16:43 INFO - mozdebug == 0.1 05:16:43 INFO - mozdevice == 0.48 05:16:43 INFO - mozfile == 1.2 05:16:43 INFO - mozhttpd == 0.7 05:16:43 INFO - mozinfo == 0.9 05:16:43 INFO - mozleak == 0.1 05:16:43 INFO - mozlog == 3.1 05:16:43 INFO - moznetwork == 0.27 05:16:43 INFO - mozprocess == 0.22 05:16:43 INFO - mozprofile == 0.28 05:16:43 INFO - mozrunner == 6.11 05:16:43 INFO - mozscreenshot == 0.1 05:16:43 INFO - mozsystemmonitor == 0.0 05:16:43 INFO - moztest == 0.7 05:16:43 INFO - mozversion == 1.4 05:16:43 INFO - psutil == 3.1.1 05:16:43 INFO - requests == 1.2.3 05:16:43 INFO - wsgiref == 0.1.2 05:16:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:43 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')]} 05:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:43 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')]} 05:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:43 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 0x106f63a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca60db5620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e07d30>, '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 0x106c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dfeb20>, '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.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 05:16:43 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 05:16:43 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 05:16:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk3zF6VTqH/Render', 05:16:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:43 INFO - 'HOME': '/Users/cltbld', 05:16:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:43 INFO - 'LOGNAME': 'cltbld', 05:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:43 INFO - 'MOZ_NO_REMOTE': '1', 05:16:43 INFO - 'NO_EM_RESTART': '1', 05:16:43 INFO - 'PAGER': '/bin/cat', 05:16:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:43 INFO - 'PWD': '/builds/slave/test', 05:16:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:43 INFO - 'SHELL': '/bin/bash', 05:16:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TtzKRpnvp5/Listeners', 05:16:43 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:16:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:43 INFO - 'USER': 'cltbld', 05:16:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:43 INFO - 'XPC_FLAGS': '0x0', 05:16:43 INFO - 'XPC_SERVICE_NAME': '0', 05:16:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:43 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)) 05:16:43 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)) 05:16:43 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)) 05:16:43 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)) 05:16:43 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)) 05:16:43 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)) 05:16:43 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)) 05:16:43 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)) 05:16:43 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)) 05:16:43 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)) 05:16:43 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)) 05:16:43 INFO - Cleaning up... 05:16:43 INFO - Return code: 0 05:16:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:16:43 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')]} 05:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:43 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')]} 05:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:43 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 0x106f63a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca60db5620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e07d30>, '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 0x106c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dfeb20>, '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.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 05:16:43 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 05:16:43 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 05:16:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk3zF6VTqH/Render', 05:16:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:43 INFO - 'HOME': '/Users/cltbld', 05:16:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:43 INFO - 'LOGNAME': 'cltbld', 05:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:43 INFO - 'MOZ_NO_REMOTE': '1', 05:16:43 INFO - 'NO_EM_RESTART': '1', 05:16:43 INFO - 'PAGER': '/bin/cat', 05:16:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:43 INFO - 'PWD': '/builds/slave/test', 05:16:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:43 INFO - 'SHELL': '/bin/bash', 05:16:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TtzKRpnvp5/Listeners', 05:16:43 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:16:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:43 INFO - 'USER': 'cltbld', 05:16:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:43 INFO - 'XPC_FLAGS': '0x0', 05:16:43 INFO - 'XPC_SERVICE_NAME': '0', 05:16:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:44 INFO - Downloading/unpacking jsonschema 05:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:16:46 INFO - Downloading/unpacking functools32 (from jsonschema) 05:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:46 INFO - Downloading functools32-3.2.3-2.tar.gz 05:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:16:46 INFO - warning: no files found matching '*.txt' 05:16:46 INFO - no previously-included directories found matching 'build' 05:16:46 INFO - no previously-included directories found matching 'dist' 05:16:46 INFO - no previously-included directories found matching '.git*' 05:16:46 INFO - Installing collected packages: jsonschema, functools32 05:16:46 INFO - Running setup.py install for functools32 05:16:47 INFO - warning: no files found matching '*.txt' 05:16:47 INFO - no previously-included directories found matching 'build' 05:16:47 INFO - no previously-included directories found matching 'dist' 05:16:47 INFO - no previously-included directories found matching '.git*' 05:16:47 INFO - Successfully installed jsonschema functools32 05:16:47 INFO - Cleaning up... 05:16:47 INFO - Return code: 0 05:16:47 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:16:47 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')]} 05:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:47 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')]} 05:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:47 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 0x106f63a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106f6b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca60db5620>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e07d30>, '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 0x106c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dfeb20>, '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.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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 05:16:47 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 05:16:47 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 05:16:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk3zF6VTqH/Render', 05:16:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:47 INFO - 'HOME': '/Users/cltbld', 05:16:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:47 INFO - 'LOGNAME': 'cltbld', 05:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:47 INFO - 'MOZ_NO_REMOTE': '1', 05:16:47 INFO - 'NO_EM_RESTART': '1', 05:16:47 INFO - 'PAGER': '/bin/cat', 05:16:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:47 INFO - 'PWD': '/builds/slave/test', 05:16:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:47 INFO - 'SHELL': '/bin/bash', 05:16:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TtzKRpnvp5/Listeners', 05:16:47 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:16:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:47 INFO - 'USER': 'cltbld', 05:16:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:47 INFO - 'XPC_FLAGS': '0x0', 05:16:47 INFO - 'XPC_SERVICE_NAME': '0', 05:16:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:47 INFO - Downloading/unpacking flake8 05:16:47 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 05:16:47 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 05:16:47 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 05:16:47 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 05:16:47 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 05:16:47 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 05:16:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:16:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:16:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:16:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:51 INFO - no previously-included directories found matching 'docs/_build' 05:16:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:16:51 INFO - Running setup.py install for pep8 05:16:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:16:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:16:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:16:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:16:51 INFO - no previously-included directories found matching 'docs/_build' 05:16:52 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:16:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:16:52 INFO - Cleaning up... 05:16:52 INFO - Return code: 0 05:16:52 INFO - Running post-action listener: _resource_record_post_action 05:16:52 INFO - Running post-action listener: _start_resource_monitoring 05:16:52 INFO - Starting resource monitoring. 05:16:52 INFO - ##### 05:16:52 INFO - ##### Running install step. 05:16:52 INFO - ##### 05:16:52 INFO - Running pre-action listener: _resource_record_pre_action 05:16:52 INFO - Running main action method: install 05:16:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:52 INFO - Reading from file tmpfile_stdout 05:16:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:16:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:16:52 INFO - Reading from file tmpfile_stdout 05:16:52 INFO - Output received: 05:16:52 INFO - Usage: mozinstall [options] installer 05:16:52 INFO - Options: 05:16:52 INFO - -h, --help show this help message and exit 05:16:52 INFO - -d DEST, --destination=DEST 05:16:52 INFO - Directory to install application into. [default: 05:16:52 INFO - "/builds/slave/test"] 05:16:52 INFO - --app=APP Application being installed. [default: firefox] 05:16:52 INFO - mkdir: /builds/slave/test/build/application 05:16:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:17:26 INFO - Reading from file tmpfile_stdout 05:17:26 INFO - Output received: 05:17:26 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:17:26 INFO - Running post-action listener: _resource_record_post_action 05:17:26 INFO - ##### 05:17:26 INFO - ##### Running run-tests step. 05:17:26 INFO - ##### 05:17:26 INFO - Running pre-action listener: _resource_record_pre_action 05:17:26 INFO - Running main action method: run_tests 05:17:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:17:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:17:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:17:26 INFO - 2016-03-11 05:17:26.329 screenresolution[1966:27160] starting screenresolution argv=screenresolution get 05:17:26 INFO - 2016-03-11 05:17:26.331 screenresolution[1966:27160] Display 0: 1600x1200x32@60 05:17:26 INFO - 2016-03-11 05:17:26.337 screenresolution[1967:27163] starting screenresolution argv=screenresolution list 05:17:26 INFO - Available Modes on Display 0 05:17:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:17:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:17:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:17:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:17:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:17:26 INFO - Intel Iris: 05:17:26 INFO - Chipset Model: Intel Iris 05:17:26 INFO - Type: GPU 05:17:26 INFO - Bus: Built-In 05:17:26 INFO - VRAM (Dynamic, Max): 1536 MB 05:17:26 INFO - Vendor: Intel (0x8086) 05:17:26 INFO - Device ID: 0x0a2e 05:17:26 INFO - Revision ID: 0x0009 05:17:26 INFO - Displays: 05:17:26 INFO - Display: 05:17:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:17:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:17:26 INFO - Display Serial Number: 1600x1200 60 05:17:26 INFO - Main Display: Yes 05:17:26 INFO - Mirror: Off 05:17:26 INFO - Online: Yes 05:17:26 INFO - Rotation: Supported 05:17:26 INFO - Return code: 0 05:17:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:26 INFO - Python 2.7.3 05:17:26 INFO - Return code: 0 05:17:26 INFO - grabbing minidump binary from tooltool 05:17:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:26 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106e07d30>, '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 0x106c2bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106dfeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:26 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:17:26 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:17:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:26 INFO - Return code: 0 05:17:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:17:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:17:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:17:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:17:27 INFO - Return code: 0 05:17:27 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:17:27 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0071 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:17:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Dk3zF6VTqH/Render', 05:17:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:27 INFO - 'HOME': '/Users/cltbld', 05:17:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:27 INFO - 'LOGNAME': 'cltbld', 05:17:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:27 INFO - 'MOZ_NO_REMOTE': '1', 05:17:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:27 INFO - 'NO_EM_RESTART': '1', 05:17:27 INFO - 'PAGER': '/bin/cat', 05:17:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:27 INFO - 'PWD': '/builds/slave/test', 05:17:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:27 INFO - 'SHELL': '/bin/bash', 05:17:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TtzKRpnvp5/Listeners', 05:17:27 INFO - 'TMPDIR': '/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/', 05:17:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:27 INFO - 'USER': 'cltbld', 05:17:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:27 INFO - 'XPC_FLAGS': '0x0', 05:17:27 INFO - 'XPC_SERVICE_NAME': '0', 05:17:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0071', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:17:28 INFO - mozversion application_buildid: 20160311031816 05:17:28 INFO - mozversion application_changeset: f7ed458ec73dc42d58fda3d69b1036738d968833 05:17:28 INFO - mozversion application_display_name: Nightly 05:17:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:28 INFO - mozversion application_name: Firefox 05:17:28 INFO - mozversion application_remotingname: firefox 05:17:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:17:28 INFO - mozversion application_vendor: Mozilla 05:17:28 INFO - mozversion application_version: 48.0a1 05:17:28 INFO - mozversion platform_buildid: 20160311031816 05:17:28 INFO - mozversion platform_changeset: f7ed458ec73dc42d58fda3d69b1036738d968833 05:17:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:17:28 INFO - mozversion platform_version: 48.0a1 05:17:28 INFO - using testdate: 1457702248 05:17:28 INFO - actual date: 1457702248 05:17:28 INFO - starting webserver on 'localhost:51903' 05:17:28 INFO - SUITE-START | Running 2 tests 05:17:28 INFO - TEST-START | dromaeo_css 05:17:28 INFO - operating with platform_type : mac_ 05:17:28 INFO - Initialising browser for dromaeo_css test... 05:17:28 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp4Mhjqo/profile http://localhost:51903/getInfo.html) 05:17:30 INFO - PROCESS | 1985 | __metrics Screen width/height:1600/1200 05:17:30 INFO - PROCESS | 1985 | colorDepth:24 05:17:30 INFO - PROCESS | 1985 | Browser inner width/height: 1024/689 05:17:30 INFO - PROCESS | 1985 | __metrics 05:17:30 INFO - PROCESS | 1985 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:17:30 ERROR - PROCESS | 1985 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:17:31 INFO - TEST-INFO | 1985: exit 0 05:17:31 INFO - Browser initialized. 05:17:31 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:31 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmp4Mhjqo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:43 INFO - PROCESS | 1988 | RSS: Main: 242970624 05:17:43 INFO - PROCESS | 1988 | 05:18:33 INFO - PROCESS | 1988 | 1457702313973 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] 05:20:44 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:51903/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51903/tests/dromaeo/cssquery-ext.html) 05:20:45 INFO - PROCESS | 1988 | RSS: Main: 337907712 05:20:45 INFO - PROCESS | 1988 | 05:23:48 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:51903/tests/dromaeo/cssquery-ext.html (next: http://localhost:51903/tests/dromaeo/cssquery-jquery.html) 05:23:48 INFO - PROCESS | 1988 | RSS: Main: 368316416 05:23:48 INFO - PROCESS | 1988 | 05:26:51 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:51903/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51903/tests/dromaeo/cssquery-mootools.html) 05:26:51 INFO - PROCESS | 1988 | RSS: Main: 377782272 05:26:51 INFO - PROCESS | 1988 | 05:29:53 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:51903/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51903/tests/dromaeo/cssquery-prototype.html) 05:29:54 INFO - PROCESS | 1988 | RSS: Main: 334823424 05:29:54 INFO - PROCESS | 1988 | 05:32:57 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:51903/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51903/tests/dromaeo/cssquery-yui.html) 05:32:58 INFO - PROCESS | 1988 | RSS: Main: 335208448 05:32:58 INFO - PROCESS | 1988 | 05:36:01 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:51903/tests/dromaeo/cssquery-yui.html (next: http://localhost:51903/tests/dromaeo/cssquery-dojo.html) 05:36:01 INFO - PROCESS | 1988 | RSS: Main: 383340544 05:36:01 INFO - PROCESS | 1988 | 05:36:01 INFO - PROCESS | 1988 | __start_tp_report 05:36:01 INFO - PROCESS | 1988 | _x_x_mozilla_page_load 05:36:01 INFO - PROCESS | 1988 | _x_x_mozilla_page_load_details 05:36:01 INFO - PROCESS | 1988 | |i|pagename|runs| 05:36:01 INFO - PROCESS | 1988 | |0;dojo.html;3411.4371128763746;3431.6739909708585;3466.7919924804505;3470.149813295743;3517.138301116225;4587.931181032287;5543.6396634218745;5570.749316280767;5578.776848926038;5596.496315331619;5547.916781248285;5572.86067848304;5622.522085622727;5693.914591281124;5710.857228569288;5037.974810125944;5049.949500504994;5087.771050302746;5101.693898366091;5256.632035757499;5196.480351964811;5208.036513245042;5220.216967454874;5223.608229382792;5238.685678859261;4938.678985865908;5009.398872135331;5037.269595908573;5042.672226305279;5122.564582010534;5073.746312684388;5094.566961808251;5111.923321150186;5142.717150556718;5181.35233095863;5009.699418034929;5033.546980771712;5060.392752869642;5068.189089745623;5084.847454576368;5361.169018802092;5488.9725551372385;5495.010898038351;5497.8075767348355;5503.449655034465;6158.9692051539905;6182.598131121463;6186.690665466754;6192.81421557354;6197.256329240475;5120.718360490171;6236.875262494725;6237;6246.437820596123;6261.436470717657;4709.387779588632;5587.552995760329;5687.0900655895275;5714.085746280575;5720.313562372458;6218.440340369298;6236.875262494725;6244.188255526752;6253.624782513064;6274.686265686697;5975.581709280309;5991.281046274475;6006.279246490449;6050.788222412194;6054.424829641177;5958.106284057426;6058;6071.089336599457;6129.450483693955;6207.441330280206;5047.596192304607;6146.371211628922;6153.5692501525355;6157.107219453154;6159.81520554384;6173.197484327009;6183.938160618426;6187.690615469209;6197.752089916443;6214.067889816473;4790.856274311776;4832.806687732451;4847;4868.634852386085;4868.95131048685;4356.433663623772;4393.0994146199955;4393.340998850134;4413.095315460323;4417.204903117406;5588.161775733673;5631.465010823965;5643.435656434323;5711.457411545896;5762.1068734346245;6139.308154112039;6139.815805525842;6146.815595532141;6157.507399408037;6170.5372097092895;4728.834490792806;5617.8033768817895;5625.071863142617;5627.662340259598;5679.261695979496;5202.76587553561;5263.6578622389425;5275.129603615361;5283.181106928432;5356.464353564613;6276.811695649138;6284.308726040132;6285.308616052231;6303.212098487689;6314.431701146918;6075.969620151871;6148.877022459616;6155.753769849156;6167.259928808572;6176.3514830943905;5247.291615631841;6101.610781564156;6161.476274516716;6218.471429928507;6260.843478913063;6107.175531303217;6109.053096770008;6132.41742034506;6132.846678832886;6134.141220229082;6147;6191.25704915413;6201.317855036033;6211.3167551570195;6219;5785.27684039495;5867.090600956859;6051.939480605313;6055.061465472859;6084.056971169476;5959.67221802805;5995.490383317292;5996.460318571175;5998.130271110752;6025.156478092983;5729.942700572941;5864.44287792659;5875.294964604275;5877.529797616266;5884.176215329943;5921.289445266596;5973.223480947449;5992.67040312787;5993.910091348546;5996.010658241341;5830.912536311874;5859.5019423349495;5869.8553782012095;5882.970585147218;5909.970450147722 05:36:01 INFO - PROCESS | 1988 | |1;ext.html;496.8633625752918;570.5293133165137;599.841042123837;611.7461253579764;640.4236187431312;30624.693753062464;38186.85439436814;38295.80852095739;38330.42504362433;38424.231515369676;38767.418488722695;39221;39308.21383572327;39447;39507.20985580287;8545.401821872472;8697.347698922575;9385.155336019758;9626.903730962671;11587.710307242301;9599.4720290384;11628.534858605646;11631.418429078554;11634.883651163507;11639.767204655902;11584.53661853529;11651.242669226516;11672.41637918105;11676;11678.357690327028;8785.516796576187;11788.410579471036;12013.879861201363;12025.819612705816;12028.27830330183;9620.855687164698;11635.825462617982;11642.126840486997;11649.76700465986;11654.883451165464;38456.423153652715;38788.03029924246;38821;38868.22263554741;38967.63613273522;3203.823789691566;3228.209088773242;3262.429074911881;3321.717653999413;3519.384107781128;29273.85363073171;29323.41353172946;29404.558931616044;29650.406991860043;29826.40347193066;2714.4028313770937;2751.6422865027616;2763.22864596819;2784.3456787654886;2858.2711408590885;506039;510141;510707;511208.44395778154;511420.9999999963;45522.77238613852;46451;67210.32789672138;67969;68217.3178268221;45553;45940;46023;46058.76970615125;46090;15851.524454266391;16058.67882642364;16079.919600402158;16091.436799711953;16093.275802588678;12820.743585128244;12858.228506289652;12868.356582170854;12892.290923999082;12897.968162546973;12356.505739770488;14660.486882959045;14986.550403487912;14998.625034374229;15127.47053853132;5549.417311182348;5641.379448260688;6483.870322593521;6563.113979612691;6636.5354425190735;904.3895370624801;955.1165172215811;973.090160699748;1028.6142696488816;1040.0119886108228;28396.432071358457;28791.856040719664;28952.394284514496;29112.708872911;29250.414991700047;1080.9567617295377;1125.4372813593204;1155.0817100405197;1157.3518829455531;1196.842246641027;12041.698957526132;14580.781288280685;15096.773548396783;15098.094114353175;15234.542963711106;517205;522530;523644;523843;524109.3794531003;58238.505689658756;60306.396936030076;60325;60332.69833650804;60350.69824650849;1335.2389138191331;1339.9799003014768;1340.7452584009202;1451.1945870042016;1489.4935721854622;22737;29927;29957.101286961428;30841.30372829426;30864;51380;54032.18951715806;54803.451965479835;55020.44979550153;55120.724396379366;477356;478246;479854;479943;480274;28067.71932280651;32819.34361312808;33467;33809;34321;35793.28413431769;40876.79561602173;41708.957276068344;42054.36918446287;42422.36366454567;28004;35678.821605891804;35741.82129089338;36312;36341.27317453583;35476.82261588779;35521.82239088788;35831.46252806262;36333.818330909235;36419.27161456809;35338.82330588331;35582.46626300556;35992.4601130978;36412.27175456529;36872.07819804527;30799;31651.892183773456;31712.524312134876;31826.681733182373;33877.322453551285;24231.192333230952;24236;24818.627720583845;24884.659602741063;25087.623685645096 05:36:01 INFO - PROCESS | 1988 | |2;jquery.html;357.16245404526387;360.80155914247166;362.5486269594357;370.56643726839593;373.441704651546;16899.746503802453;17293.39473118441;19097.61804763904;19788.60422791543;21516.784832151672;19591.804081959177;20431.489212769688;20699.275525356614;20701.689474657855;20721.378358649228;5966.522678185735;6138.416850399205;6192.195014648089;6196.101565273033;6197.380261973789;4258.127083947783;4286.2499062664065;4434.68957172998;6093.299270583873;6683.799486015428;6636.668166591675;6638.73445062197;6645.734170633169;6650;6655.134832471772;6544.574602650812;6601.438877695402;6602.801915942506;6608.173978252718;6635.369639884203;3794.2790869734663;3972.741771784825;3978.781167035812;5546.473085056913;5665.518430933375;23544.411389715224;23967.16114935969;24660.876695616585;24680;24836.130735424354;2107.388857231401;2170.4899348653053;2192.8684278943315;2203.3830527452337;2329.94175145621;13715.451381944711;14134;14158.150510969272;14987;15006.249687515581;1715.185286988683;1764.0562299169883;1779.919903604341;1792.937247196355;1825.7261410788356;101958.47062294072;103471;104490.47754761254;104966;105290.47354763254;10442.373457592417;10550.472476376304;10780.245382823285;10825.188110891715;10904.672859814218;12967.286799225945;12975.156614820007;13011.544595939286;13016.934915325552;13030.08789384734;8531.274841638406;8731.345149113842;8741.038485766561;8833.60248788806;8835.514046727363;8984.32617553686;8984.550772461482;9049.638014479347;9111.453312801254;9118.58966346516;6232.407921247474;6325.841853953688;6347.809565713036;6367.713452894631;6433.4209921106385;1795.1473050301263;1811.3388613156367;1815.5551889787087;1860.776706795166;1861.5997560524552;920.4707293306376;923.2660035271975;943.8253923024263;977.9511024448891;999.7103736180392;20187.79812201859;20236.392908212776;20863.895680521804;20953.16187352489;21341.359759206938;850.5917159763349;873.554487211514;984.9261305402124;1004.3622299839654;1045.7542477517777;10488.31825931312;10999.900009998935;11399.031017431664;11454.370009649549;11486.827697584544;583743;635993;642654;645371;649530;79408.80886786587;102333.48833255786;108559;113169.86830131758;114982.27526587108;1053.062774131024;1055.6410820321128;1056.5720883042227;1063.8457423673678;1073.1910339497003;18620.5344866374;18672.066396680384;18867.90566047161;18900.338488152847;19049.428517144508;48742.29401970914;49377.76555585995;49484.257736133266;49697.503024969286;50090.499095008585;63217;65341.67329163514;65559;65965.67017164883;67144.65710685856;7755.534667919943;7847.332976697045;8086.231807978233;8166.387520935835;8281.917180828115;9539.47532885698;11155.609553665583;12166.330851803235;12816.333876595983;13729;10110.292279540361;10968.519249901481;11429.714257143638;11495.482703278205;11875.287482751062;10319.277650564389;11451.48468318911;11478.82781758291;11518.251313664585;11717.707057323634;9397.906020939703;11557.364344960772;11871.406429678655;12023;12059.939700301793;8090.474119182234;8198.83602327962;8281.54451505173;8317.83364332722;8498.53258070812;11591.6522504325;11600.88399115998;11883.940580297043;11922.463489143183;11945.283283003047 05:36:01 INFO - PROCESS | 1988 | |3;mootools.html;1445.3423692220028;1601.3914712409282;1631.5105468359493;1904.2192700992596;2029.0260674876058;7117.537360071592;7853.76438706839;8727.694530691435;8749.21257086862;8761.737147885558;8533.232009119178;8589.398742088057;8689.174528419806;8695.956520217405;8739.431936924095;2186.7157269555014;2453.227233421471;2484.776370126688;2485.1798906360946;2486.962695559568;2462.4213309872166;2525.7726804587583;2525.987370063147;2526.494701059786;2531.974680253192;2430.44099857033;2459.8524088554655;2479.814013948952;2481.950360992779;2485.701715794098;2175.1516908405733;2400.351904985644;2467.76556227159;2468.456939473313;2473.2209354053416;2419.987900060506;2457.2382561405843;2461.4461746107163;2464.137551856854;2466.90132394704;8559.101294364064;8663.306935445149;8674.262687671555;8677.913220867773;8688.044315125331;5287.709175995319;5397.325334333208;5441.238226648273;5441.483059109418;5452.345718513804;3547.6629720176543;3557.3596752584526;3612.313660404541;3698.9815050924844;3705.110773414388;1032.948352582368;1040.93754374737;1048.7535429174138;1088.4666513408451;1622.4970259219679;11134.888651113548;11155.944220278847;11167.274127181707;11167.553297868075;11187.328760274328;4456.821727130879;4649.093426781745;4687.7656117194;4714.717116972993;4726.480087190406;8881.33389995753;8931.598078086372;8937.865932011026;8942.642294308154;8950.194482496607;5227.738613069331;5264.131418316011;5284.313039304942;5318.787248510016;5330.706811125426;4462.750429879639;4573.359729637853;4830.275458681226;4904.141775189328;4960.751962401865;3679.2089700714473;3716.4611131385795;3732.1789206374556;3755.9436608450897;3779.7543159694533;1168.649405178443;1178.281248438452;1182.1429463638792;1195.0738177912187;1197.024425093546;1239.6962744127748;1242.8446444194476;1263.9557615483413;1264.2288204195434;1269.853966793812;8118.594070296462;8141.633626486822;8271.296939760188;8301.2943899768;8346.707865224687;1119.5018216893404;1153.3944679043402;1210.6791700199453;1213.925675776926;1239.1821397877359;6250.905367266879;6308.7476500940365;6374.553781235269;6377.617342959345;6390.9041364378645;10226.59093636261;10548.683539493828;10560.630377936735;10653.733656658645;10701.304415213142;9800.705978820646;10596.993285637853;10687.572497100184;10695.304805187638;10702.46487675613;8006.919930800734;8122.147174546588;8155.999999999882;8196.262336389753;8220.38347123968;7916;7975.920240797518;8015.799605009922;8059.476134051268;8070.314023308085;9338.299627528098;9346.252299816135;9406.482643454401;9493.762655933657;9559.856602150834;9599.47202903847;9641.180499657326;9785.07041831025;10004.549795259376;10014.3490673106;6847.383735463832;7030.613316267654;7215.494915355875;7497.175310715926;7617.923820761722;8195.79510512218;8204.179582041748;8250.422470427013;8257.545834979133;8261.297789687944;7183.389411900047;7209;7210.675519601526;7407.59258240802;7416.6291685414435;6315.27374351937;7263.782086537412;7374.446916481178;7534.284242996907;7577.393808495417;7654.15804261542;7674.194209607911;7695.653695583824;7727.227277272228;7750.147483776893;6915.066466027223;7012.298770123151;7062.117235345582;7069.328413800681;7109.857802844018;7077.186123595647;7160.212376638669;7160.64196790148;7175.641217938978;7252.5648461092505 05:36:01 INFO - PROCESS | 1988 | |4;prototype.html;310.492345015899;316.5726269536126;328.1910091624146;334.35690863722283;335.9260962588231;5270.8418747437545;6534.183227096613;6570.835729106769;6602.207735071786;6603.867922641544;5905.704714764255;6048.697565121748;6445.742170313193;6542.8691426171445;6571.769988050419;4625.8149674013;4697.765111744417;4724.433068031841;4811.254255590372;4862.270659401082;4798.392538499606;4823.324734537167;4919.557239848413;4924.876878078041;4935.605151587883;3870.980645096771;4803;4816.349792777965;4816.470188279286;4825.396825396825;4555.772211389434;4651.651126165517;4672.789724462407;4683.601893839028;4684.391029166187;4116.444280022189;4118.5057793065025;4121.29937910553;4124.216398884232;4128.979355103235;6314.210723659543;6318.241810982666;6321.304656487782;6325.272593651743;6351.047342898602;5693.459121383462;5694.886102277931;5703.458171473745;5708.286464191976;5719.28508936383;6792.524523283372;7025.262347453546;7029.121359830021;7039.788806335818;7042.964785176093;4676.883077923045;4689.062187562501;4693.389859318301;4694.718316900997;4695.060987802419;7458.776236712907;7474.439417043689;7482.962585187093;7489.7378591749575;7490.887636685454;4758.904821903542;4762.190427627312;4763;4766.451858036301;4769.570738633471;4809.254565542346;4824.903501930012;4826.276058591239;4826.7827947742435;4830.7101573905675;5692.089265717465;5695.316562012585;5695.7152142392715;5707.058335374617;5707.143928410772;6794.864102717918;7114.359707626339;7137.286271372925;7147.857042859114;7152.9284707152265;1639.3934244329437;1679.6892574873443;1680.134730613735;1680.6974744546098;1682.385929135881;1071.1912506058031;1091.2143256855052;1102.862142232221;1103.8178700514486;1108.1024370260116;6411.230652321751;6588.439982601437;6600.636964966973;6612.272650008592;6613.074169616258;6166.506679465632;7130.180029296697;7243.384312333511;7284.635768211569;7298.927010729931;6085.482733967574;6589.80230593083;6646.634435106115;6693.698783554752;6720.193576770819;3843.0968722350785;3844.5386553613744;3880.20455806559;3888.2417928504237;3894.90262743428;7331.963340183265;7428.220036896156;7727.690892364355;7727.922720772833;7770.53376797394;7580.620968951641;7614.791710404032;7616.8476630467085;7631.618419079024;7632.618369081523;7734.922650773533;7750;7753.961230194039;7768.883466748003;7769.261920117579;7357.963210183915;7373.5575865448245;7378.852422951403;7389.298016688406;7414.184439711736;5574.358948720949;6141.263048434216;6987.7204911802955;7193.964030179815;7295.124585049828;7644.044494438195;7645.847083058196;7699.114601820638;7707.229277072248;7708.267714567107;4585.220512512814;4607.6083532900075;4629.421322334708;4630.884227894329;4632.5135860734135;7251.673674684546;7263.782086537412;7269.127704675473;7270.6728197230195;7273.199948005821;6816.931830681629;7034.824129396806;7042.683079261548;7089.361957423856;7093.822654433474;7010.298970102949;7040.0847889774;7069.646517674199;7071.5049946505305;7079.398251148504;6867.175938887365;6877.071595334566;6878.518503704692;6881.277465866012;6909.689063992032;7005.859882802213;7024.367806897404;7032.12098487689;7040.823979400556;7047.083879095685;6598.67006649656;6633.6019838809825;6903.240643529108;6924.757633482804;6967.581945083311 05:36:01 INFO - PROCESS | 1988 | |5;yui.html;689.8827199376107;718.989215161773;750.0811505905267;752.6011214056549;797.1351084073782;14797.778033329496;15033.774493382594;15040.6991860163;15042.849571504295;15045.623859403493;13746.381412836421;13864.029517933723;14215.152030236055;14393;14425;743.7099531182816;753.8605358008758;922.1700469577384;924.4360939826701;942.3921570586967;940.5062342270295;942.3497786527308;942.9717108486722;944.0606596436555;946.9100435458621;983.9704808855746;984.2273815055183;985.1133979418508;986.1568359052978;987.2003677021636;772.8261141243231;961.4135377419768;971.9757006074834;979.6718099436697;982.4547376206202;727.7743899391205;727.9381252593536;728.2499026003226;728.9744858929965;729.4529103172621;15203.087814731152;15276.312565934448;15285.082895026222;15292.388304467808;15307.311170997333;10538.473076346152;10664.573417063308;12564.183328083736;12632.178908370926;12939.87060129396;10060.496975151287;10095.29332946694;10273.962380542602;10797.676069717922;10912.890871091267;3582.8925132246072;3650.5254316938895;3657.0491672165163;3667.7065834733426;3674.761140525857;83546;83671.5816420914;84117.57941210255;84656.30687386218;84758;9340.112689294507;9427.292953028551;9692.321537492307;9748.46383448903;9797.216222702167;21150.894245528983;21194.15223391047;21223.78776212249;21268.149274028867;21275.574488510454;7410.5183163094225;7598.962005189938;7639.274268944441;7724.0731112266885;7732.381409487228;4012.518497780285;4110.321796903478;4118.814653340607;4137.524184718796;4168.270552653274;3576.588692300367;3616.8553257869917;3619.6380361963593;3626.401643728755;3632.3824949758605;636.4431122767578;653.650297091054;654.2966311215463;655.9996006090654;667.2260178193272;573.7934343636288;584.6696616411799;594.1384991761876;607.696151924038;629.0689779126918;8064.435489515678;8178.5092894426525;8244.8351032979;8353;8380.110277681164;558.187836697604;573.6242760991557;590.5364289033089;595.2975488923025;602.7739597650881;3724.7951362675312;3813.923721525554;3845.2309538092495;3867.323218436762;3890.0858298299877;74197.25802742012;75985;76294.61852690701;76577;86603.1339686595;68829;68994.31005689979;69804.65097674479;71491.64254178696;72505;61640.075398869056;62479.6876015617;65043.34956650467;65078;66085.00872486821;7905.4466187368635;8244.711435099744;8321.16788321163;8327.458715183493;8401.614892008953;49572;49952;49969.75015124901;49972.75013624909;50700.74649626728;66526.33473665395;68476;68663.97004045043;69705.30294696988;70071;11029.61396351156;11119.166062545502;11274.774504510027;11308;11348.773024539629;11799.292042477478;11890.405479726152;12069.75860482803;12083.577074802692;12411.31737754396;11184;11298.774024519627;11425.257358272018;11646.35945022998;11726;9137.269018478373;11295;11475.368854713071;11586.478608462809;11722.472488737856;11290.774184516427;11416.942915285703;11549.307041577533;11551.768964620493;11589.188756786943;9325.86011209846;9620.71137865865;9719.27105467107;9849.26130540198;9931.950340248253;8919.687810926587;9521.57152928106;9595.47224902637;9747.994449611402;9875.407475551203 05:36:01 INFO - PROCESS | 1988 | __end_tp_report 05:36:01 INFO - PROCESS | 1988 | __start_cc_report 05:36:01 INFO - PROCESS | 1988 | _x_x_mozilla_cycle_collect,1109 05:36:01 INFO - PROCESS | 1988 | __end_cc_report 05:36:01 INFO - PROCESS | 1988 | __startTimestamp1457703361336__endTimestamp 05:36:01 INFO - PROCESS | 1988 | 05:36:01 INFO - PROCESS | 1988 | ------- Summary: start ------- 05:36:01 INFO - PROCESS | 1988 | Number of tests: 6 05:36:01 INFO - PROCESS | 1988 | 05:36:01 INFO - PROCESS | 1988 | [#0] dojo.html Cycles:165 Average:5630.71 Median:5864.44 stddev:637.04 (10.9%) stddev-sans-first:614.75 05:36:01 INFO - PROCESS | 1988 | Values: 3411.4 3431.7 3466.8 3470.1 3517.1 4587.9 5543.6 5570.7 5578.8 5596.5 5547.9 5572.9 5622.5 5693.9 5710.9 5038.0 5049.9 5087.8 5101.7 5256.6 5196.5 5208.0 5220.2 5223.6 5238.7 4938.7 5009.4 5037.3 5042.7 5122.6 5073.7 5094.6 5111.9 5142.7 5181.4 5009.7 5033.5 5060.4 5068.2 5084.8 5361.2 5489.0 5495.0 5497.8 5503.4 6159.0 6182.6 6186.7 6192.8 6197.3 5120.7 6236.9 6237.0 6246.4 6261.4 4709.4 5587.6 5687.1 5714.1 5720.3 6218.4 6236.9 6244.2 6253.6 6274.7 5975.6 5991.3 6006.3 6050.8 6054.4 5958.1 6058.0 6071.1 6129.5 6207.4 5047.6 6146.4 6153.6 6157.1 6159.8 6173.2 6183.9 6187.7 6197.8 6214.1 4790.9 4832.8 4847.0 4868.6 4869.0 4356.4 4393.1 4393.3 4413.1 4417.2 5588.2 5631.5 5643.4 5711.5 5762.1 6139.3 6139.8 6146.8 6157.5 6170.5 4728.8 5617.8 5625.1 5627.7 5679.3 5202.8 5263.7 5275.1 5283.2 5356.5 6276.8 6284.3 6285.3 6303.2 6314.4 6076.0 6148.9 6155.8 6167.3 6176.4 5247.3 6101.6 6161.5 6218.5 6260.8 6107.2 6109.1 6132.4 6132.8 6134.1 6147.0 6191.3 6201.3 6211.3 6219.0 5785.3 5867.1 6051.9 6055.1 6084.1 5959.7 5995.5 5996.5 5998.1 6025.2 5729.9 5864.4 5875.3 5877.5 5884.2 5921.3 5973.2 5992.7 5993.9 5996.0 5830.9 5859.5 5869.9 5883.0 5910.0 05:36:01 INFO - PROCESS | 1988 | 05:36:01 INFO - PROCESS | 1988 | [#1] ext.html Cycles:180 Average:63820.37 Median:18920.19 stddev:134178.98 (709.2%) stddev-sans-first:134471.15 05:36:01 INFO - PROCESS | 1988 | Values: 496.9 570.5 599.8 611.7 640.4 30624.7 38186.9 38295.8 38330.4 38424.2 38767.4 39221.0 39308.2 39447.0 39507.2 8545.4 8697.3 9385.2 9626.9 11587.7 9599.5 11628.5 11631.4 11634.9 11639.8 11584.5 11651.2 11672.4 11676.0 11678.4 8785.5 11788.4 12013.9 12025.8 12028.3 9620.9 11635.8 11642.1 11649.8 11654.9 38456.4 38788.0 38821.0 38868.2 38967.6 3203.8 3228.2 3262.4 3321.7 3519.4 29273.9 29323.4 29404.6 29650.4 29826.4 2714.4 2751.6 2763.2 2784.3 2858.3 506039.0 510141.0 510707.0 511208.4 511421.0 45522.8 46451.0 67210.3 67969.0 68217.3 45553.0 45940.0 46023.0 46058.8 46090.0 15851.5 16058.7 16079.9 16091.4 16093.3 12820.7 12858.2 12868.4 12892.3 12898.0 12356.5 14660.5 14986.6 14998.6 15127.5 5549.4 5641.4 6483.9 6563.1 6636.5 904.4 955.1 973.1 1028.6 1040.0 28396.4 28791.9 28952.4 29112.7 29250.4 1081.0 1125.4 1155.1 1157.4 1196.8 12041.7 14580.8 15096.8 15098.1 15234.5 517205.0 522530.0 523644.0 523843.0 524109.4 58238.5 60306.4 60325.0 60332.7 60350.7 1335.2 1340.0 1340.7 1451.2 1489.5 22737.0 29927.0 29957.1 30841.3 30864.0 51380.0 54032.2 54803.5 55020.4 55120.7 477356.0 478246.0 479854.0 479943.0 480274.0 28067.7 32819.3 33467.0 33809.0 34321.0 35793.3 40876.8 41709.0 42054.4 42422.4 28004.0 35678.8 35741.8 36312.0 36341.3 35476.8 35521.8 35831.5 36333.8 36419.3 35338.8 35582.5 35992.5 36412.3 36872.1 30799.0 31651.9 31712.5 31826.7 33877.3 24231.2 24236.0 24818.6 24884.7 25087.6 05:36:01 INFO - PROCESS | 1988 | 05:36:01 INFO - PROCESS | 1988 | [#2] jquery.html Cycles:180 Average:34522.65 Median:2181.68 stddev:104220.43 (4777.1%) stddev-sans-first:104481.22 05:36:01 INFO - PROCESS | 1988 | Values: 357.2 360.8 362.5 370.6 373.4 16899.7 17293.4 19097.6 19788.6 21516.8 19591.8 20431.5 20699.3 20701.7 20721.4 5966.5 6138.4 6192.2 6196.1 6197.4 4258.1 4286.2 4434.7 6093.3 6683.8 6636.7 6638.7 6645.7 6650.0 6655.1 6544.6 6601.4 6602.8 6608.2 6635.4 3794.3 3972.7 3978.8 5546.5 5665.5 23544.4 23967.2 24660.9 24680.0 24836.1 2107.4 2170.5 2192.9 2203.4 2329.9 13715.5 14134.0 14158.2 14987.0 15006.2 1715.2 1764.1 1779.9 1792.9 1825.7 101958.5 103471.0 104490.5 104966.0 105290.5 10442.4 10550.5 10780.2 10825.2 10904.7 12967.3 12975.2 13011.5 13016.9 13030.1 8531.3 8731.3 8741.0 8833.6 8835.5 8984.3 8984.6 9049.6 9111.5 9118.6 6232.4 6325.8 6347.8 6367.7 6433.4 1795.1 1811.3 1815.6 1860.8 1861.6 920.5 923.3 943.8 978.0 999.7 20187.8 20236.4 20863.9 20953.2 21341.4 850.6 873.6 984.9 1004.4 1045.8 10488.3 10999.9 11399.0 11454.4 11486.8 583743.0 635993.0 642654.0 645371.0 649530.0 79408.8 102333.5 108559.0 113169.9 114982.3 1053.1 1055.6 1056.6 1063.8 1073.2 18620.5 18672.1 18867.9 18900.3 19049.4 48742.3 49377.8 49484.3 49697.5 50090.5 63217.0 65341.7 65559.0 65965.7 67144.7 7755.5 7847.3 8086.2 8166.4 8281.9 9539.5 11155.6 12166.3 12816.3 13729.0 10110.3 10968.5 11429.7 11495.5 11875.3 10319.3 11451.5 11478.8 11518.3 11717.7 9397.9 11557.4 11871.4 12023.0 12059.9 8090.5 8198.8 8281.5 8317.8 8498.5 11591.7 11600.9 11883.9 11922.5 11945.3 05:36:01 INFO - PROCESS | 1988 | 05:36:01 INFO - PROCESS | 1988 | [#3] mootools.html Cycles:180 Average:5964.28 Median:5324.75 stddev:3080.73 (57.9%) stddev-sans-first:3070.64 05:36:01 INFO - PROCESS | 1988 | Values: 1445.3 1601.4 1631.5 1904.2 2029.0 7117.5 7853.8 8727.7 8749.2 8761.7 8533.2 8589.4 8689.2 8696.0 8739.4 2186.7 2453.2 2484.8 2485.2 2487.0 2462.4 2525.8 2526.0 2526.5 2532.0 2430.4 2459.9 2479.8 2482.0 2485.7 2175.2 2400.4 2467.8 2468.5 2473.2 2420.0 2457.2 2461.4 2464.1 2466.9 8559.1 8663.3 8674.3 8677.9 8688.0 5287.7 5397.3 5441.2 5441.5 5452.3 3547.7 3557.4 3612.3 3699.0 3705.1 1032.9 1040.9 1048.8 1088.5 1622.5 11134.9 11155.9 11167.3 11167.6 11187.3 4456.8 4649.1 4687.8 4714.7 4726.5 8881.3 8931.6 8937.9 8942.6 8950.2 5227.7 5264.1 5284.3 5318.8 5330.7 4462.8 4573.4 4830.3 4904.1 4960.8 3679.2 3716.5 3732.2 3755.9 3779.8 1168.6 1178.3 1182.1 1195.1 1197.0 1239.7 1242.8 1264.0 1264.2 1269.9 8118.6 8141.6 8271.3 8301.3 8346.7 1119.5 1153.4 1210.7 1213.9 1239.2 6250.9 6308.7 6374.6 6377.6 6390.9 10226.6 10548.7 10560.6 10653.7 10701.3 9800.7 10597.0 10687.6 10695.3 10702.5 8006.9 8122.1 8156.0 8196.3 8220.4 7916.0 7975.9 8015.8 8059.5 8070.3 9338.3 9346.3 9406.5 9493.8 9559.9 9599.5 9641.2 9785.1 10004.5 10014.3 6847.4 7030.6 7215.5 7497.2 7617.9 8195.8 8204.2 8250.4 8257.5 8261.3 7183.4 7209.0 7210.7 7407.6 7416.6 6315.3 7263.8 7374.4 7534.3 7577.4 7654.2 7674.2 7695.7 7727.2 7750.1 6915.1 7012.3 7062.1 7069.3 7109.9 7077.2 7160.2 7160.6 7175.6 7252.6 05:36:01 INFO - PROCESS | 1988 | 05:36:01 INFO - PROCESS | 1988 | [#4] prototype.html Cycles:180 Average:5767.35 Median:6556.85 stddev:1842.66 (28.1%) stddev-sans-first:1801.73 05:36:01 INFO - PROCESS | 1988 | Values: 310.5 316.6 328.2 334.4 335.9 5270.8 6534.2 6570.8 6602.2 6603.9 5905.7 6048.7 6445.7 6542.9 6571.8 4625.8 4697.8 4724.4 4811.3 4862.3 4798.4 4823.3 4919.6 4924.9 4935.6 3871.0 4803.0 4816.3 4816.5 4825.4 4555.8 4651.7 4672.8 4683.6 4684.4 4116.4 4118.5 4121.3 4124.2 4129.0 6314.2 6318.2 6321.3 6325.3 6351.0 5693.5 5694.9 5703.5 5708.3 5719.3 6792.5 7025.3 7029.1 7039.8 7043.0 4676.9 4689.1 4693.4 4694.7 4695.1 7458.8 7474.4 7483.0 7489.7 7490.9 4758.9 4762.2 4763.0 4766.5 4769.6 4809.3 4824.9 4826.3 4826.8 4830.7 5692.1 5695.3 5695.7 5707.1 5707.1 6794.9 7114.4 7137.3 7147.9 7152.9 1639.4 1679.7 1680.1 1680.7 1682.4 1071.2 1091.2 1102.9 1103.8 1108.1 6411.2 6588.4 6600.6 6612.3 6613.1 6166.5 7130.2 7243.4 7284.6 7298.9 6085.5 6589.8 6646.6 6693.7 6720.2 3843.1 3844.5 3880.2 3888.2 3894.9 7332.0 7428.2 7727.7 7727.9 7770.5 7580.6 7614.8 7616.8 7631.6 7632.6 7734.9 7750.0 7754.0 7768.9 7769.3 7358.0 7373.6 7378.9 7389.3 7414.2 5574.4 6141.3 6987.7 7194.0 7295.1 7644.0 7645.8 7699.1 7707.2 7708.3 4585.2 4607.6 4629.4 4630.9 4632.5 7251.7 7263.8 7269.1 7270.7 7273.2 6816.9 7034.8 7042.7 7089.4 7093.8 7010.3 7040.1 7069.6 7071.5 7079.4 6867.2 6877.1 6878.5 6881.3 6909.7 7005.9 7024.4 7032.1 7040.8 7047.1 6598.7 6633.6 6903.2 6924.8 6967.6 05:36:01 INFO - PROCESS | 1988 | 05:36:01 INFO - PROCESS | 1988 | [#5] yui.html Cycles:180 Average:17652.87 Median:632.76 stddev:24095.09 (3808.0%) stddev-sans-first:24129.01 05:36:01 INFO - PROCESS | 1988 | Values: 689.9 719.0 750.1 752.6 797.1 14797.8 15033.8 15040.7 15042.8 15045.6 13746.4 13864.0 14215.2 14393.0 14425.0 743.7 753.9 922.2 924.4 942.4 940.5 942.3 943.0 944.1 946.9 984.0 984.2 985.1 986.2 987.2 772.8 961.4 972.0 979.7 982.5 727.8 727.9 728.2 729.0 729.5 15203.1 15276.3 15285.1 15292.4 15307.3 10538.5 10664.6 12564.2 12632.2 12939.9 10060.5 10095.3 10274.0 10797.7 10912.9 3582.9 3650.5 3657.0 3667.7 3674.8 83546.0 83671.6 84117.6 84656.3 84758.0 9340.1 9427.3 9692.3 9748.5 9797.2 21150.9 21194.2 21223.8 21268.1 21275.6 7410.5 7599.0 7639.3 7724.1 7732.4 4012.5 4110.3 4118.8 4137.5 4168.3 3576.6 3616.9 3619.6 3626.4 3632.4 636.4 653.7 654.3 656.0 667.2 573.8 584.7 594.1 607.7 629.1 8064.4 8178.5 8244.8 8353.0 8380.1 558.2 573.6 590.5 595.3 602.8 3724.8 3813.9 3845.2 3867.3 3890.1 74197.3 75985.0 76294.6 76577.0 86603.1 68829.0 68994.3 69804.7 71491.6 72505.0 61640.1 62479.7 65043.3 65078.0 66085.0 7905.4 8244.7 8321.2 8327.5 8401.6 49572.0 49952.0 49969.8 49972.8 50700.7 66526.3 68476.0 68664.0 69705.3 70071.0 11029.6 11119.2 11274.8 11308.0 11348.8 11799.3 11890.4 12069.8 12083.6 12411.3 11184.0 11298.8 11425.3 11646.4 11726.0 9137.3 11295.0 11475.4 11586.5 11722.5 11290.8 11416.9 11549.3 11551.8 11589.2 9325.9 9620.7 9719.3 9849.3 9932.0 8919.7 9521.6 9595.5 9748.0 9875.4 05:36:01 INFO - PROCESS | 1988 | -------- Summary: end -------- 05:36:01 INFO - PROCESS | 1988 | 05:36:01 INFO - TEST-INFO | 1988: exit 0 05:36:01 INFO - TEST-OK | dromaeo_css | took 1113779ms 05:36:01 INFO - TEST-START | kraken 05:36:01 INFO - operating with platform_type : mac_ 05:36:01 INFO - Initialising browser for kraken test... 05:36:01 INFO - TEST-INFO | started process 1993 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpYCwbql/profile http://localhost:51903/getInfo.html) 05:36:04 INFO - PROCESS | 1993 | __metrics Screen width/height:1600/1200 05:36:04 INFO - PROCESS | 1993 | colorDepth:24 05:36:04 INFO - PROCESS | 1993 | Browser inner width/height: 1024/689 05:36:04 INFO - PROCESS | 1993 | __metrics 05:36:04 INFO - PROCESS | 1993 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:36:04 ERROR - PROCESS | 1993 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:36:04 INFO - TEST-INFO | 1993: exit 0 05:36:04 INFO - Browser initialized. 05:36:04 INFO - Running cycle 1/1 for kraken test... 05:36:04 INFO - TEST-INFO | started process 1995 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/T/tmpYCwbql/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:36:16 INFO - PROCESS | 1995 | RSS: Main: 243056640 05:36:16 INFO - PROCESS | 1995 | 05:36:19 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51903/tests/kraken/driver.html?testName=audio-beat-detection) 05:36:19 INFO - PROCESS | 1995 | RSS: Main: 290140160 05:36:19 INFO - PROCESS | 1995 | 05:36:22 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51903/tests/kraken/driver.html?testName=audio-dft) 05:36:23 INFO - PROCESS | 1995 | RSS: Main: 299950080 05:36:23 INFO - PROCESS | 1995 | 05:36:26 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51903/tests/kraken/driver.html?testName=audio-fft) 05:36:27 INFO - PROCESS | 1995 | RSS: Main: 287268864 05:36:27 INFO - PROCESS | 1995 | 05:36:29 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51903/tests/kraken/driver.html?testName=audio-oscillator) 05:36:29 INFO - PROCESS | 1995 | RSS: Main: 289513472 05:36:29 INFO - PROCESS | 1995 | 05:36:31 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51903/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:32 INFO - PROCESS | 1995 | RSS: Main: 291069952 05:36:32 INFO - PROCESS | 1995 | 05:36:35 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51903/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:35 INFO - PROCESS | 1995 | RSS: Main: 292593664 05:36:35 INFO - PROCESS | 1995 | 05:36:38 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51903/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:39 INFO - PROCESS | 1995 | RSS: Main: 291827712 05:36:39 INFO - PROCESS | 1995 | 05:36:41 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51903/tests/kraken/driver.html?testName=json-parse-financial) 05:36:42 INFO - PROCESS | 1995 | RSS: Main: 291454976 05:36:42 INFO - PROCESS | 1995 | 05:36:44 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51903/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:44 INFO - PROCESS | 1995 | RSS: Main: 324927488 05:36:44 INFO - PROCESS | 1995 | 05:36:46 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51903/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:47 INFO - PROCESS | 1995 | RSS: Main: 324857856 05:36:47 INFO - PROCESS | 1995 | 05:36:49 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51903/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:49 INFO - PROCESS | 1995 | RSS: Main: 331862016 05:36:49 INFO - PROCESS | 1995 | 05:36:52 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:52 INFO - PROCESS | 1995 | RSS: Main: 331735040 05:36:52 INFO - PROCESS | 1995 | 05:36:55 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:55 INFO - PROCESS | 1995 | RSS: Main: 332681216 05:36:55 INFO - PROCESS | 1995 | 05:36:57 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:51903/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51903/tests/kraken/driver.html?testName=ai-astar) 05:36:58 INFO - PROCESS | 1995 | RSS: Main: 392568832 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | __start_tp_report 05:36:58 INFO - PROCESS | 1995 | _x_x_mozilla_page_load 05:36:58 INFO - PROCESS | 1995 | _x_x_mozilla_page_load_details 05:36:58 INFO - PROCESS | 1995 | |i|pagename|runs| 05:36:58 INFO - PROCESS | 1995 | |0;ai-astar;111;110;111;110;110;111;115;111;111;110 05:36:58 INFO - PROCESS | 1995 | |1;audio-beat-detection;158;126;130;188;147;174;140;115;160;119 05:36:58 INFO - PROCESS | 1995 | |2;audio-dft;195;258;215;186;198;264;186;187;189;182 05:36:58 INFO - PROCESS | 1995 | |3;audio-fft;76;72;86;76;56;56;58;75;77;55 05:36:58 INFO - PROCESS | 1995 | |4;audio-oscillator;99;126;171;112;78;82;114;75;80;120 05:36:58 INFO - PROCESS | 1995 | |5;imaging-gaussian-blur;87;84;86;83;87;83;86;83;86;84 05:36:58 INFO - PROCESS | 1995 | |6;imaging-darkroom;92;92;93;92;92;91;92;93;92;92 05:36:58 INFO - PROCESS | 1995 | |7;imaging-desaturate;84;86;87;83;86;84;83;85;85;84 05:36:58 INFO - PROCESS | 1995 | |8;json-parse-financial;55;54;53;55;53;54;55;64;56;54 05:36:58 INFO - PROCESS | 1995 | |9;json-stringify-tinderbox;66;64;71;77;71;67;66;73;68;68 05:36:58 INFO - PROCESS | 1995 | |10;stanford-crypto-aes;84;83;82;81;83;82;82;79;83;83 05:36:58 INFO - PROCESS | 1995 | |11;stanford-crypto-ccm;121;133;121;123;117;123;123;117;119;118 05:36:58 INFO - PROCESS | 1995 | |12;stanford-crypto-pbkdf2;136;121;136;137;137;117;137;136;137;137 05:36:58 INFO - PROCESS | 1995 | |13;stanford-crypto-sha256-iterative;67;67;67;67;72;88;94;95;92;66 05:36:58 INFO - PROCESS | 1995 | __end_tp_report 05:36:58 INFO - PROCESS | 1995 | __start_cc_report 05:36:58 INFO - PROCESS | 1995 | _x_x_mozilla_cycle_collect,1207 05:36:58 INFO - PROCESS | 1995 | __end_cc_report 05:36:58 INFO - PROCESS | 1995 | __startTimestamp1457703418058__endTimestamp 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | ------- Summary: start ------- 05:36:58 INFO - PROCESS | 1995 | Number of tests: 14 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:1.49 (1.3%) stddev-sans-first:1.58 05:36:58 INFO - PROCESS | 1995 | Values: 111.0 110.0 111.0 110.0 110.0 111.0 115.0 111.0 111.0 110.0 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:152.50 stddev:24.20 (15.9%) stddev-sans-first:25.25 05:36:58 INFO - PROCESS | 1995 | Values: 158.0 126.0 130.0 188.0 147.0 174.0 140.0 115.0 160.0 119.0 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#2] audio-dft Cycles:10 Average:206.00 Median:196.50 stddev:30.48 (15.5%) stddev-sans-first:32.07 05:36:58 INFO - PROCESS | 1995 | Values: 195.0 258.0 215.0 186.0 198.0 264.0 186.0 187.0 189.0 182.0 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#3] audio-fft Cycles:10 Average:68.70 Median:75.50 stddev:11.30 (15.0%) stddev-sans-first:11.68 05:36:58 INFO - PROCESS | 1995 | Values: 76.0 72.0 86.0 76.0 56.0 56.0 58.0 75.0 77.0 55.0 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#4] audio-oscillator Cycles:10 Average:105.70 Median:76.50 stddev:29.75 (38.9%) stddev-sans-first:31.46 05:36:58 INFO - PROCESS | 1995 | Values: 99.0 126.0 171.0 112.0 78.0 82.0 114.0 75.0 80.0 120.0 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#5] imaging-gaussian-blur Cycles:10 Average:84.90 Median:86.00 stddev:1.66 (1.9%) stddev-sans-first:1.58 05:36:58 INFO - PROCESS | 1995 | Values: 87.0 84.0 86.0 83.0 87.0 83.0 86.0 83.0 86.0 84.0 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#6] imaging-darkroom Cycles:10 Average:92.10 Median:92.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:36:58 INFO - PROCESS | 1995 | Values: 92.0 92.0 93.0 92.0 92.0 91.0 92.0 93.0 92.0 92.0 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.34 (1.6%) stddev-sans-first:1.39 05:36:58 INFO - PROCESS | 1995 | Values: 84.0 86.0 87.0 83.0 86.0 84.0 83.0 85.0 85.0 84.0 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:3.20 (5.8%) stddev-sans-first:3.39 05:36:58 INFO - PROCESS | 1995 | Values: 55.0 54.0 53.0 55.0 53.0 54.0 55.0 64.0 56.0 54.0 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.50 stddev:3.90 (5.6%) stddev-sans-first:3.97 05:36:58 INFO - PROCESS | 1995 | Values: 66.0 64.0 71.0 77.0 71.0 67.0 66.0 73.0 68.0 68.0 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:83.00 stddev:1.40 (1.7%) stddev-sans-first:1.32 05:36:58 INFO - PROCESS | 1995 | Values: 84.0 83.0 82.0 81.0 83.0 82.0 82.0 79.0 83.0 83.0 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#11] stanford-crypto-ccm Cycles:10 Average:121.50 Median:122.00 stddev:4.70 (3.8%) stddev-sans-first:4.98 05:36:58 INFO - PROCESS | 1995 | Values: 121.0 133.0 121.0 123.0 117.0 123.0 123.0 117.0 119.0 118.0 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:133.10 Median:137.00 stddev:7.50 (5.5%) stddev-sans-first:7.89 05:36:58 INFO - PROCESS | 1995 | Values: 136.0 121.0 136.0 137.0 137.0 117.0 137.0 136.0 137.0 137.0 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - PROCESS | 1995 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.50 Median:80.00 stddev:12.92 (16.2%) stddev-sans-first:13.13 05:36:58 INFO - PROCESS | 1995 | Values: 67.0 67.0 67.0 67.0 72.0 88.0 94.0 95.0 92.0 66.0 05:36:58 INFO - PROCESS | 1995 | -------- Summary: end -------- 05:36:58 INFO - PROCESS | 1995 | 05:36:58 INFO - TEST-INFO | 1995: exit 0 05:36:58 INFO - TEST-OK | kraken | took 56942ms 05:36:58 INFO - SUITE-END | took 1170s 05:36:59 INFO - Completed test suite (00:19:31) 05:36:59 INFO - javascript benchmark 05:36:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3411.4371128763746, 3431.6739909708585, 3466.7919924804505, 3470.149813295743, 3517.138301116225, 4587.931181032287, 5543.6396634218745, 5570.749316280767, 5578.776848926038, 5596.496315331619, 5547.916781248285, 5572.86067848304, 5622.522085622727, 5693.914591281124, 5710.857228569288, 5037.974810125944, 5049.949500504994, 5087.771050302746, 5101.693898366091, 5256.632035757499, 5196.480351964811, 5208.036513245042, 5220.216967454874, 5223.608229382792, 5238.685678859261, 4938.678985865908, 5009.398872135331, 5037.269595908573, 5042.672226305279, 5122.564582010534, 5073.746312684388, 5094.566961808251, 5111.923321150186, 5142.717150556718, 5181.35233095863, 5009.699418034929, 5033.546980771712, 5060.392752869642, 5068.189089745623, 5084.847454576368, 5361.169018802092, 5488.9725551372385, 5495.010898038351, 5497.8075767348355, 5503.449655034465, 6158.9692051539905, 6182.598131121463, 6186.690665466754, 6192.81421557354, 6197.256329240475, 5120.718360490171, 6236.875262494725, 6237.0, 6246.437820596123, 6261.436470717657, 4709.387779588632, 5587.552995760329, 5687.0900655895275, 5714.085746280575, 5720.313562372458, 6218.440340369298, 6236.875262494725, 6244.188255526752, 6253.624782513064, 6274.686265686697, 5975.581709280309, 5991.281046274475, 6006.279246490449, 6050.788222412194, 6054.424829641177, 5958.106284057426, 6058.0, 6071.089336599457, 6129.450483693955, 6207.441330280206, 5047.596192304607, 6146.371211628922, 6153.5692501525355, 6157.107219453154, 6159.81520554384, 6173.197484327009, 6183.938160618426, 6187.690615469209, 6197.752089916443, 6214.067889816473, 4790.856274311776, 4832.806687732451, 4847.0, 4868.634852386085, 4868.95131048685, 4356.433663623772, 4393.0994146199955, 4393.340998850134, 4413.095315460323, 4417.204903117406, 5588.161775733673, 5631.465010823965, 5643.435656434323, 5711.457411545896, 5762.1068734346245, 6139.308154112039, 6139.815805525842, 6146.815595532141, 6157.507399408037, 6170.5372097092895, 4728.834490792806, 5617.8033768817895, 5625.071863142617, 5627.662340259598, 5679.261695979496, 5202.76587553561, 5263.6578622389425, 5275.129603615361, 5283.181106928432, 5356.464353564613, 6276.811695649138, 6284.308726040132, 6285.308616052231, 6303.212098487689, 6314.431701146918, 6075.969620151871, 6148.877022459616, 6155.753769849156, 6167.259928808572, 6176.3514830943905, 5247.291615631841, 6101.610781564156, 6161.476274516716, 6218.471429928507, 6260.843478913063, 6107.175531303217, 6109.053096770008, 6132.41742034506, 6132.846678832886, 6134.141220229082, 6147.0, 6191.25704915413, 6201.317855036033, 6211.3167551570195, 6219.0, 5785.27684039495, 5867.090600956859, 6051.939480605313, 6055.061465472859, 6084.056971169476, 5959.67221802805, 5995.490383317292, 5996.460318571175, 5998.130271110752, 6025.156478092983, 5729.942700572941, 5864.44287792659, 5875.294964604275, 5877.529797616266, 5884.176215329943, 5921.289445266596, 5973.223480947449, 5992.67040312787, 5993.910091348546, 5996.010658241341, 5830.912536311874, 5859.5019423349495, 5869.8553782012095, 5882.970585147218, 5909.970450147722], "unit": "score", "name": "dojo.html", "value": 5592.576723322581}, {"lowerIsBetter": false, "replicates": [496.8633625752918, 570.5293133165137, 599.841042123837, 611.7461253579764, 640.4236187431312, 30624.693753062464, 38186.85439436814, 38295.80852095739, 38330.42504362433, 38424.231515369676, 38767.418488722695, 39221.0, 39308.21383572327, 39447.0, 39507.20985580287, 8545.401821872472, 8697.347698922575, 9385.155336019758, 9626.903730962671, 11587.710307242301, 9599.4720290384, 11628.534858605646, 11631.418429078554, 11634.883651163507, 11639.767204655902, 11584.53661853529, 11651.242669226516, 11672.41637918105, 11676.0, 11678.357690327028, 8785.516796576187, 11788.410579471036, 12013.879861201363, 12025.819612705816, 12028.27830330183, 9620.855687164698, 11635.825462617982, 11642.126840486997, 11649.76700465986, 11654.883451165464, 38456.423153652715, 38788.03029924246, 38821.0, 38868.22263554741, 38967.63613273522, 3203.823789691566, 3228.209088773242, 3262.429074911881, 3321.717653999413, 3519.384107781128, 29273.85363073171, 29323.41353172946, 29404.558931616044, 29650.406991860043, 29826.40347193066, 2714.4028313770937, 2751.6422865027616, 2763.22864596819, 2784.3456787654886, 2858.2711408590885, 506039.0, 510141.0, 510707.0, 511208.44395778154, 511420.9999999963, 45522.77238613852, 46451.0, 67210.32789672138, 67969.0, 68217.3178268221, 45553.0, 45940.0, 46023.0, 46058.76970615125, 46090.0, 15851.524454266391, 16058.67882642364, 16079.919600402158, 16091.436799711953, 16093.275802588678, 12820.743585128244, 12858.228506289652, 12868.356582170854, 12892.290923999082, 12897.968162546973, 12356.505739770488, 14660.486882959045, 14986.550403487912, 14998.625034374229, 15127.47053853132, 5549.417311182348, 5641.379448260688, 6483.870322593521, 6563.113979612691, 6636.5354425190735, 904.3895370624801, 955.1165172215811, 973.090160699748, 1028.6142696488816, 1040.0119886108228, 28396.432071358457, 28791.856040719664, 28952.394284514496, 29112.708872911, 29250.414991700047, 1080.9567617295377, 1125.4372813593204, 1155.0817100405197, 1157.3518829455531, 1196.842246641027, 12041.698957526132, 14580.781288280685, 15096.773548396783, 15098.094114353175, 15234.542963711106, 517205.0, 522530.0, 523644.0, 523843.0, 524109.3794531003, 58238.505689658756, 60306.396936030076, 60325.0, 60332.69833650804, 60350.69824650849, 1335.2389138191331, 1339.9799003014768, 1340.7452584009202, 1451.1945870042016, 1489.4935721854622, 22737.0, 29927.0, 29957.101286961428, 30841.30372829426, 30864.0, 51380.0, 54032.18951715806, 54803.451965479835, 55020.44979550153, 55120.724396379366, 477356.0, 478246.0, 479854.0, 479943.0, 480274.0, 28067.71932280651, 32819.34361312808, 33467.0, 33809.0, 34321.0, 35793.28413431769, 40876.79561602173, 41708.957276068344, 42054.36918446287, 42422.36366454567, 28004.0, 35678.821605891804, 35741.82129089338, 36312.0, 36341.27317453583, 35476.82261588779, 35521.82239088788, 35831.46252806262, 36333.818330909235, 36419.27161456809, 35338.82330588331, 35582.46626300556, 35992.4601130978, 36412.27175456529, 36872.07819804527, 30799.0, 31651.892183773456, 31712.524312134876, 31826.681733182373, 33877.322453551285, 24231.192333230952, 24236.0, 24818.627720583845, 24884.659602741063, 25087.623685645096], "unit": "score", "name": "ext.html", "value": 19453.129588875676}, {"lowerIsBetter": false, "replicates": [357.16245404526387, 360.80155914247166, 362.5486269594357, 370.56643726839593, 373.441704651546, 16899.746503802453, 17293.39473118441, 19097.61804763904, 19788.60422791543, 21516.784832151672, 19591.804081959177, 20431.489212769688, 20699.275525356614, 20701.689474657855, 20721.378358649228, 5966.522678185735, 6138.416850399205, 6192.195014648089, 6196.101565273033, 6197.380261973789, 4258.127083947783, 4286.2499062664065, 4434.68957172998, 6093.299270583873, 6683.799486015428, 6636.668166591675, 6638.73445062197, 6645.734170633169, 6650.0, 6655.134832471772, 6544.574602650812, 6601.438877695402, 6602.801915942506, 6608.173978252718, 6635.369639884203, 3794.2790869734663, 3972.741771784825, 3978.781167035812, 5546.473085056913, 5665.518430933375, 23544.411389715224, 23967.16114935969, 24660.876695616585, 24680.0, 24836.130735424354, 2107.388857231401, 2170.4899348653053, 2192.8684278943315, 2203.3830527452337, 2329.94175145621, 13715.451381944711, 14134.0, 14158.150510969272, 14987.0, 15006.249687515581, 1715.185286988683, 1764.0562299169883, 1779.919903604341, 1792.937247196355, 1825.7261410788356, 101958.47062294072, 103471.0, 104490.47754761254, 104966.0, 105290.47354763254, 10442.373457592417, 10550.472476376304, 10780.245382823285, 10825.188110891715, 10904.672859814218, 12967.286799225945, 12975.156614820007, 13011.544595939286, 13016.934915325552, 13030.08789384734, 8531.274841638406, 8731.345149113842, 8741.038485766561, 8833.60248788806, 8835.514046727363, 8984.32617553686, 8984.550772461482, 9049.638014479347, 9111.453312801254, 9118.58966346516, 6232.407921247474, 6325.841853953688, 6347.809565713036, 6367.713452894631, 6433.4209921106385, 1795.1473050301263, 1811.3388613156367, 1815.5551889787087, 1860.776706795166, 1861.5997560524552, 920.4707293306376, 923.2660035271975, 943.8253923024263, 977.9511024448891, 999.7103736180392, 20187.79812201859, 20236.392908212776, 20863.895680521804, 20953.16187352489, 21341.359759206938, 850.5917159763349, 873.554487211514, 984.9261305402124, 1004.3622299839654, 1045.7542477517777, 10488.31825931312, 10999.900009998935, 11399.031017431664, 11454.370009649549, 11486.827697584544, 583743.0, 635993.0, 642654.0, 645371.0, 649530.0, 79408.80886786587, 102333.48833255786, 108559.0, 113169.86830131758, 114982.27526587108, 1053.062774131024, 1055.6410820321128, 1056.5720883042227, 1063.8457423673678, 1073.1910339497003, 18620.5344866374, 18672.066396680384, 18867.90566047161, 18900.338488152847, 19049.428517144508, 48742.29401970914, 49377.76555585995, 49484.257736133266, 49697.503024969286, 50090.499095008585, 63217.0, 65341.67329163514, 65559.0, 65965.67017164883, 67144.65710685856, 7755.534667919943, 7847.332976697045, 8086.231807978233, 8166.387520935835, 8281.917180828115, 9539.47532885698, 11155.609553665583, 12166.330851803235, 12816.333876595983, 13729.0, 10110.292279540361, 10968.519249901481, 11429.714257143638, 11495.482703278205, 11875.287482751062, 10319.277650564389, 11451.48468318911, 11478.82781758291, 11518.251313664585, 11717.707057323634, 9397.906020939703, 11557.364344960772, 11871.406429678655, 12023.0, 12059.939700301793, 8090.474119182234, 8198.83602327962, 8281.54451505173, 8317.83364332722, 8498.53258070812, 11591.6522504325, 11600.88399115998, 11883.940580297043, 11922.463489143183, 11945.283283003047], "unit": "score", "name": "jquery.html", "value": 9555.984865838504}, {"lowerIsBetter": false, "replicates": [1445.3423692220028, 1601.3914712409282, 1631.5105468359493, 1904.2192700992596, 2029.0260674876058, 7117.537360071592, 7853.76438706839, 8727.694530691435, 8749.21257086862, 8761.737147885558, 8533.232009119178, 8589.398742088057, 8689.174528419806, 8695.956520217405, 8739.431936924095, 2186.7157269555014, 2453.227233421471, 2484.776370126688, 2485.1798906360946, 2486.962695559568, 2462.4213309872166, 2525.7726804587583, 2525.987370063147, 2526.494701059786, 2531.974680253192, 2430.44099857033, 2459.8524088554655, 2479.814013948952, 2481.950360992779, 2485.701715794098, 2175.1516908405733, 2400.351904985644, 2467.76556227159, 2468.456939473313, 2473.2209354053416, 2419.987900060506, 2457.2382561405843, 2461.4461746107163, 2464.137551856854, 2466.90132394704, 8559.101294364064, 8663.306935445149, 8674.262687671555, 8677.913220867773, 8688.044315125331, 5287.709175995319, 5397.325334333208, 5441.238226648273, 5441.483059109418, 5452.345718513804, 3547.6629720176543, 3557.3596752584526, 3612.313660404541, 3698.9815050924844, 3705.110773414388, 1032.948352582368, 1040.93754374737, 1048.7535429174138, 1088.4666513408451, 1622.4970259219679, 11134.888651113548, 11155.944220278847, 11167.274127181707, 11167.553297868075, 11187.328760274328, 4456.821727130879, 4649.093426781745, 4687.7656117194, 4714.717116972993, 4726.480087190406, 8881.33389995753, 8931.598078086372, 8937.865932011026, 8942.642294308154, 8950.194482496607, 5227.738613069331, 5264.131418316011, 5284.313039304942, 5318.787248510016, 5330.706811125426, 4462.750429879639, 4573.359729637853, 4830.275458681226, 4904.141775189328, 4960.751962401865, 3679.2089700714473, 3716.4611131385795, 3732.1789206374556, 3755.9436608450897, 3779.7543159694533, 1168.649405178443, 1178.281248438452, 1182.1429463638792, 1195.0738177912187, 1197.024425093546, 1239.6962744127748, 1242.8446444194476, 1263.9557615483413, 1264.2288204195434, 1269.853966793812, 8118.594070296462, 8141.633626486822, 8271.296939760188, 8301.2943899768, 8346.707865224687, 1119.5018216893404, 1153.3944679043402, 1210.6791700199453, 1213.925675776926, 1239.1821397877359, 6250.905367266879, 6308.7476500940365, 6374.553781235269, 6377.617342959345, 6390.9041364378645, 10226.59093636261, 10548.683539493828, 10560.630377936735, 10653.733656658645, 10701.304415213142, 9800.705978820646, 10596.993285637853, 10687.572497100184, 10695.304805187638, 10702.46487675613, 8006.919930800734, 8122.147174546588, 8155.999999999882, 8196.262336389753, 8220.38347123968, 7916.0, 7975.920240797518, 8015.799605009922, 8059.476134051268, 8070.314023308085, 9338.299627528098, 9346.252299816135, 9406.482643454401, 9493.762655933657, 9559.856602150834, 9599.47202903847, 9641.180499657326, 9785.07041831025, 10004.549795259376, 10014.3490673106, 6847.383735463832, 7030.613316267654, 7215.494915355875, 7497.175310715926, 7617.923820761722, 8195.79510512218, 8204.179582041748, 8250.422470427013, 8257.545834979133, 8261.297789687944, 7183.389411900047, 7209.0, 7210.675519601526, 7407.59258240802, 7416.6291685414435, 6315.27374351937, 7263.782086537412, 7374.446916481178, 7534.284242996907, 7577.393808495417, 7654.15804261542, 7674.194209607911, 7695.653695583824, 7727.227277272228, 7750.147483776893, 6915.066466027223, 7012.298770123151, 7062.117235345582, 7069.328413800681, 7109.857802844018, 7077.186123595647, 7160.212376638669, 7160.64196790148, 7175.641217938978, 7252.5648461092505], "unit": "score", "name": "mootools.html", "value": 4898.786130674455}, {"lowerIsBetter": false, "replicates": [310.492345015899, 316.5726269536126, 328.1910091624146, 334.35690863722283, 335.9260962588231, 5270.8418747437545, 6534.183227096613, 6570.835729106769, 6602.207735071786, 6603.867922641544, 5905.704714764255, 6048.697565121748, 6445.742170313193, 6542.8691426171445, 6571.769988050419, 4625.8149674013, 4697.765111744417, 4724.433068031841, 4811.254255590372, 4862.270659401082, 4798.392538499606, 4823.324734537167, 4919.557239848413, 4924.876878078041, 4935.605151587883, 3870.980645096771, 4803.0, 4816.349792777965, 4816.470188279286, 4825.396825396825, 4555.772211389434, 4651.651126165517, 4672.789724462407, 4683.601893839028, 4684.391029166187, 4116.444280022189, 4118.5057793065025, 4121.29937910553, 4124.216398884232, 4128.979355103235, 6314.210723659543, 6318.241810982666, 6321.304656487782, 6325.272593651743, 6351.047342898602, 5693.459121383462, 5694.886102277931, 5703.458171473745, 5708.286464191976, 5719.28508936383, 6792.524523283372, 7025.262347453546, 7029.121359830021, 7039.788806335818, 7042.964785176093, 4676.883077923045, 4689.062187562501, 4693.389859318301, 4694.718316900997, 4695.060987802419, 7458.776236712907, 7474.439417043689, 7482.962585187093, 7489.7378591749575, 7490.887636685454, 4758.904821903542, 4762.190427627312, 4763.0, 4766.451858036301, 4769.570738633471, 4809.254565542346, 4824.903501930012, 4826.276058591239, 4826.7827947742435, 4830.7101573905675, 5692.089265717465, 5695.316562012585, 5695.7152142392715, 5707.058335374617, 5707.143928410772, 6794.864102717918, 7114.359707626339, 7137.286271372925, 7147.857042859114, 7152.9284707152265, 1639.3934244329437, 1679.6892574873443, 1680.134730613735, 1680.6974744546098, 1682.385929135881, 1071.1912506058031, 1091.2143256855052, 1102.862142232221, 1103.8178700514486, 1108.1024370260116, 6411.230652321751, 6588.439982601437, 6600.636964966973, 6612.272650008592, 6613.074169616258, 6166.506679465632, 7130.180029296697, 7243.384312333511, 7284.635768211569, 7298.927010729931, 6085.482733967574, 6589.80230593083, 6646.634435106115, 6693.698783554752, 6720.193576770819, 3843.0968722350785, 3844.5386553613744, 3880.20455806559, 3888.2417928504237, 3894.90262743428, 7331.963340183265, 7428.220036896156, 7727.690892364355, 7727.922720772833, 7770.53376797394, 7580.620968951641, 7614.791710404032, 7616.8476630467085, 7631.618419079024, 7632.618369081523, 7734.922650773533, 7750.0, 7753.961230194039, 7768.883466748003, 7769.261920117579, 7357.963210183915, 7373.5575865448245, 7378.852422951403, 7389.298016688406, 7414.184439711736, 5574.358948720949, 6141.263048434216, 6987.7204911802955, 7193.964030179815, 7295.124585049828, 7644.044494438195, 7645.847083058196, 7699.114601820638, 7707.229277072248, 7708.267714567107, 4585.220512512814, 4607.6083532900075, 4629.421322334708, 4630.884227894329, 4632.5135860734135, 7251.673674684546, 7263.782086537412, 7269.127704675473, 7270.6728197230195, 7273.199948005821, 6816.931830681629, 7034.824129396806, 7042.683079261548, 7089.361957423856, 7093.822654433474, 7010.298970102949, 7040.0847889774, 7069.646517674199, 7071.5049946505305, 7079.398251148504, 6867.175938887365, 6877.071595334566, 6878.518503704692, 6881.277465866012, 6909.689063992032, 7005.859882802213, 7024.367806897404, 7032.12098487689, 7040.823979400556, 7047.083879095685, 6598.67006649656, 6633.6019838809825, 6903.240643529108, 6924.757633482804, 6967.581945083311], "unit": "score", "name": "prototype.html", "value": 5153.240923752228}, {"lowerIsBetter": false, "replicates": [689.8827199376107, 718.989215161773, 750.0811505905267, 752.6011214056549, 797.1351084073782, 14797.778033329496, 15033.774493382594, 15040.6991860163, 15042.849571504295, 15045.623859403493, 13746.381412836421, 13864.029517933723, 14215.152030236055, 14393.0, 14425.0, 743.7099531182816, 753.8605358008758, 922.1700469577384, 924.4360939826701, 942.3921570586967, 940.5062342270295, 942.3497786527308, 942.9717108486722, 944.0606596436555, 946.9100435458621, 983.9704808855746, 984.2273815055183, 985.1133979418508, 986.1568359052978, 987.2003677021636, 772.8261141243231, 961.4135377419768, 971.9757006074834, 979.6718099436697, 982.4547376206202, 727.7743899391205, 727.9381252593536, 728.2499026003226, 728.9744858929965, 729.4529103172621, 15203.087814731152, 15276.312565934448, 15285.082895026222, 15292.388304467808, 15307.311170997333, 10538.473076346152, 10664.573417063308, 12564.183328083736, 12632.178908370926, 12939.87060129396, 10060.496975151287, 10095.29332946694, 10273.962380542602, 10797.676069717922, 10912.890871091267, 3582.8925132246072, 3650.5254316938895, 3657.0491672165163, 3667.7065834733426, 3674.761140525857, 83546.0, 83671.5816420914, 84117.57941210255, 84656.30687386218, 84758.0, 9340.112689294507, 9427.292953028551, 9692.321537492307, 9748.46383448903, 9797.216222702167, 21150.894245528983, 21194.15223391047, 21223.78776212249, 21268.149274028867, 21275.574488510454, 7410.5183163094225, 7598.962005189938, 7639.274268944441, 7724.0731112266885, 7732.381409487228, 4012.518497780285, 4110.321796903478, 4118.814653340607, 4137.524184718796, 4168.270552653274, 3576.588692300367, 3616.8553257869917, 3619.6380361963593, 3626.401643728755, 3632.3824949758605, 636.4431122767578, 653.650297091054, 654.2966311215463, 655.9996006090654, 667.2260178193272, 573.7934343636288, 584.6696616411799, 594.1384991761876, 607.696151924038, 629.0689779126918, 8064.435489515678, 8178.5092894426525, 8244.8351032979, 8353.0, 8380.110277681164, 558.187836697604, 573.6242760991557, 590.5364289033089, 595.2975488923025, 602.7739597650881, 3724.7951362675312, 3813.923721525554, 3845.2309538092495, 3867.323218436762, 3890.0858298299877, 74197.25802742012, 75985.0, 76294.61852690701, 76577.0, 86603.1339686595, 68829.0, 68994.31005689979, 69804.65097674479, 71491.64254178696, 72505.0, 61640.075398869056, 62479.6876015617, 65043.34956650467, 65078.0, 66085.00872486821, 7905.4466187368635, 8244.711435099744, 8321.16788321163, 8327.458715183493, 8401.614892008953, 49572.0, 49952.0, 49969.75015124901, 49972.75013624909, 50700.74649626728, 66526.33473665395, 68476.0, 68663.97004045043, 69705.30294696988, 70071.0, 11029.61396351156, 11119.166062545502, 11274.774504510027, 11308.0, 11348.773024539629, 11799.292042477478, 11890.405479726152, 12069.75860482803, 12083.577074802692, 12411.31737754396, 11184.0, 11298.774024519627, 11425.257358272018, 11646.35945022998, 11726.0, 9137.269018478373, 11295.0, 11475.368854713071, 11586.478608462809, 11722.472488737856, 11290.774184516427, 11416.942915285703, 11549.307041577533, 11551.768964620493, 11589.188756786943, 9325.86011209846, 9620.71137865865, 9719.27105467107, 9849.26130540198, 9931.950340248253, 8919.687810926587, 9521.57152928106, 9595.47224902637, 9747.994449611402, 9875.407475551203], "unit": "score", "name": "yui.html", "value": 6889.219849158616}], "name": "dromaeo_css", "value": 7519.83746988598}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 110.0, 111.0, 110.0, 110.0, 111.0, 115.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [158.0, 126.0, 130.0, 188.0, 147.0, 174.0, 140.0, 115.0, 160.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [195.0, 258.0, 215.0, 186.0, 198.0, 264.0, 186.0, 187.0, 189.0, 182.0], "unit": "score", "name": "audio-dft", "value": 206.0}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 86.0, 76.0, 56.0, 56.0, 58.0, 75.0, 77.0, 55.0], "unit": "score", "name": "audio-fft", "value": 68.7}, {"lowerIsBetter": true, "replicates": [99.0, 126.0, 171.0, 112.0, 78.0, 82.0, 114.0, 75.0, 80.0, 120.0], "unit": "score", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 86.0, 83.0, 87.0, 83.0, 86.0, 83.0, 86.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 84.9}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 93.0, 92.0, 92.0, 91.0, 92.0, 93.0, 92.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 92.1}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 87.0, 83.0, 86.0, 84.0, 83.0, 85.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 84.7}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 53.0, 55.0, 53.0, 54.0, 55.0, 64.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 71.0, 77.0, 71.0, 67.0, 66.0, 73.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 82.0, 81.0, 83.0, 82.0, 82.0, 79.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [121.0, 133.0, 121.0, 123.0, 117.0, 123.0, 123.0, 117.0, 119.0, 118.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.5}, {"lowerIsBetter": true, "replicates": [136.0, 121.0, 136.0, 137.0, 137.0, 117.0, 137.0, 136.0, 137.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 133.1}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 67.0, 72.0, 88.0, 94.0, 95.0, 92.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 77.5}], "name": "kraken", "value": 1437.5}]} 05:36:59 INFO - Return code: 0 05:36:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:36:59 ERROR - # TBPL SUCCESS # 05:36:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:36:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:36:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:36:59 INFO - 2016-03-11 05:36:59.394 screenresolution[1999:29252] starting screenresolution argv=screenresolution get 05:36:59 INFO - 2016-03-11 05:36:59.397 screenresolution[1999:29252] Display 0: 1600x1200x32@60 05:36:59 INFO - 2016-03-11 05:36:59.403 screenresolution[2000:29255] starting screenresolution argv=screenresolution list 05:36:59 INFO - Available Modes on Display 0 05:36:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:36:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:36:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:36:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:36:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:36:59 INFO - Intel Iris: 05:36:59 INFO - Chipset Model: Intel Iris 05:36:59 INFO - Type: GPU 05:36:59 INFO - Bus: Built-In 05:36:59 INFO - VRAM (Dynamic, Max): 1536 MB 05:36:59 INFO - Vendor: Intel (0x8086) 05:36:59 INFO - Device ID: 0x0a2e 05:36:59 INFO - Revision ID: 0x0009 05:36:59 INFO - Displays: 05:36:59 INFO - Display: 05:36:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:36:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:36:59 INFO - Display Serial Number: 1600x1200 60 05:36:59 INFO - Main Display: Yes 05:36:59 INFO - Mirror: Off 05:36:59 INFO - Online: Yes 05:36:59 INFO - Rotation: Supported 05:36:59 INFO - Return code: 0 05:36:59 INFO - Running post-action listener: _resource_record_post_action 05:36:59 INFO - Running post-run listener: _resource_record_post_run 05:37:00 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 2461696; Write bytes: 706681344; Read time: 46; Write time: 2067 05:37:00 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 401488384; Write bytes: 397039616; Read time: 30562; Write time: 752 05:37:00 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 2461696; Write bytes: 299391488; Read time: 46; Write time: 1275 05:37:00 INFO - Running post-run listener: _upload_blobber_files 05:37:00 INFO - Blob upload gear active. 05:37:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:37:00 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 05:37:00 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'] 05:37:00 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 05:37:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:37:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:37:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:37:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:01 INFO - (blobuploader) - INFO - Done attempting. 05:37:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:37:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:37:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:37:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:37:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:37:02 INFO - (blobuploader) - INFO - Done attempting. 05:37:02 INFO - (blobuploader) - INFO - Iteration through files over. 05:37:02 INFO - Return code: 0 05:37:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:37:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:37:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee4cc1e6bcb6f0d683b7344a3a49bd1831163c6ec450d42312f4a5f907fb4a7259dd0df085531ffbf0b48ab72f484d934c226ffb37efcea237ef75a1c2ad1a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fc642206965178fb8191095dd65c12d9334d8528c2e1c1801d88709af2b07d659b4db6f68b46040f002c745d852776db8246707286b814f6e1eb5be8beaf175"} 05:37:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:37:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:37:02 INFO - Contents: 05:37:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee4cc1e6bcb6f0d683b7344a3a49bd1831163c6ec450d42312f4a5f907fb4a7259dd0df085531ffbf0b48ab72f484d934c226ffb37efcea237ef75a1c2ad1a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fc642206965178fb8191095dd65c12d9334d8528c2e1c1801d88709af2b07d659b4db6f68b46040f002c745d852776db8246707286b814f6e1eb5be8beaf175"} 05:37:02 INFO - Running post-run listener: copy_logs_to_upload_dir 05:37:02 INFO - Copying logs to upload dir... 05:37:02 INFO - mkdir: /builds/slave/test/build/upload/logs 05:37:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.002559 ========= master_lag: 3.68 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-11 05:37:06.636120) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-03-11 05:37:06.641006) ========= 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.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee4cc1e6bcb6f0d683b7344a3a49bd1831163c6ec450d42312f4a5f907fb4a7259dd0df085531ffbf0b48ab72f484d934c226ffb37efcea237ef75a1c2ad1a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fc642206965178fb8191095dd65c12d9334d8528c2e1c1801d88709af2b07d659b4db6f68b46040f002c745d852776db8246707286b814f6e1eb5be8beaf175"} build_url:https://queue.taskcluster.net/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/TesB0D5HSomkM_SCOt7f3w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee4cc1e6bcb6f0d683b7344a3a49bd1831163c6ec450d42312f4a5f907fb4a7259dd0df085531ffbf0b48ab72f484d934c226ffb37efcea237ef75a1c2ad1a96", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8fc642206965178fb8191095dd65c12d9334d8528c2e1c1801d88709af2b07d659b4db6f68b46040f002c745d852776db8246707286b814f6e1eb5be8beaf175"}' ========= master_lag: 5.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 5 secs) (at 2016-03-11 05:37:11.780590) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 05:37:11.780958) ========= 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.Dk3zF6VTqH/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.TtzKRpnvp5/Listeners TMPDIR=/var/folders/y0/2qrs5c4s7zx7vn2wp253cdm000000w/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.005219 ========= master_lag: 1.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-11 05:37:12.854242) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 05:37:12.854567) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-11 05:37:12.859327) ========= ========= Total master_lag: 10.09 =========