builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0068 starttime: 1459850400.62 results: success (0) buildid: 20160405014234 builduid: 74c6a64f51ee4055bd6ad8f46f57eb0a revision: 4b3a929c9249504adb088b24cc37ae7be06ba4ea ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:00.623070) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:00.623438) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:00.623732) ========= 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.lDL36FD0QD/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.fpjAPkULGq/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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.005628 basedir: '/builds/slave/test' ========= master_lag: 0.10 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:00.732573) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:00.732864) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:00.789029) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:00.789318) ========= 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.lDL36FD0QD/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.fpjAPkULGq/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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.005478 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:00.847787) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:00.848076) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:00.848466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:00.848758) ========= 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.lDL36FD0QD/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.fpjAPkULGq/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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-04-05 03:00:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 178M=0s 2016-04-05 03:00:01 (178 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192359 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:01.057240) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:01.057590) ========= 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.lDL36FD0QD/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.fpjAPkULGq/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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.027498 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:01.113268) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 03:00:01.113631) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4b3a929c9249504adb088b24cc37ae7be06ba4ea --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 4b3a929c9249504adb088b24cc37ae7be06ba4ea --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lDL36FD0QD/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.fpjAPkULGq/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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-04-05 03:00:01,188 truncating revision to first 12 chars 2016-04-05 03:00:01,188 Setting DEBUG logging. 2016-04-05 03:00:01,189 attempt 1/10 2016-04-05 03:00:01,189 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4b3a929c9249?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-05 03:00:02,180 unpacking tar archive at: fx-team-4b3a929c9249/testing/mozharness/ program finished with exit code 0 elapsedTime=1.240054 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-05 03:00:02.376645) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:02.377090) ========= echo 4b3a929c9249504adb088b24cc37ae7be06ba4ea in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4b3a929c9249504adb088b24cc37ae7be06ba4ea'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.lDL36FD0QD/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.fpjAPkULGq/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 4b3a929c9249504adb088b24cc37ae7be06ba4ea program finished with exit code 0 elapsedTime=0.005142 script_repo_revision: '4b3a929c9249504adb088b24cc37ae7be06ba4ea' ========= master_lag: 0.22 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:02.599702) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:02.600090) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-05 03:00:02.619753) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-05 03:00:02.620143) ========= /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.lDL36FD0QD/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.fpjAPkULGq/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 03:00:02 INFO - MultiFileLogger online at 20160405 03:00:02 in /builds/slave/test 03:00:02 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 03:00:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:00:02 INFO - {'append_to_log': False, 03:00:02 INFO - 'base_work_dir': '/builds/slave/test', 03:00:02 INFO - 'blob_upload_branch': 'Fx-Team', 03:00:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:00:02 INFO - 'branch': 'Fx-Team', 03:00:02 INFO - 'buildbot_json_path': 'buildprops.json', 03:00:02 INFO - 'config_files': ('talos/mac_config.py',), 03:00:02 INFO - 'default_actions': ('clobber', 03:00:02 INFO - 'read-buildbot-config', 03:00:02 INFO - 'download-and-extract', 03:00:02 INFO - 'populate-webroot', 03:00:02 INFO - 'create-virtualenv', 03:00:02 INFO - 'install', 03:00:02 INFO - 'run-tests'), 03:00:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:00:02 INFO - 'download_minidump_stackwalk': True, 03:00:02 INFO - 'download_symbols': 'ondemand', 03:00:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:00:02 INFO - 'tooltool.py': '/tools/tooltool.py', 03:00:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:00:02 INFO - '/tools/misc-python/virtualenv.py')}, 03:00:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:00:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:00:02 INFO - 'installer_path': 'installer.exe', 03:00:02 INFO - 'log_level': 'info', 03:00:02 INFO - 'log_name': 'talos', 03:00:02 INFO - 'log_to_console': True, 03:00:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:00:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:00:02 INFO - 'opt_config_files': (), 03:00:02 INFO - 'pip_index': False, 03:00:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:02 INFO - 'cmd': ('bash', 03:00:02 INFO - '-c', 03:00:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:02 INFO - 'enabled': True, 03:00:02 INFO - 'halt_on_failure': False, 03:00:02 INFO - 'name': 'check_screen_resolution'},), 03:00:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:00:02 INFO - 'cmd': ('bash', 03:00:02 INFO - '-c', 03:00:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:00:02 INFO - 'enabled': True, 03:00:02 INFO - 'halt_on_failure': False, 03:00:02 INFO - 'name': 'check_screen_resolution'},), 03:00:02 INFO - 'run_cmd_checks_enabled': True, 03:00:02 INFO - 'sps_profile': False, 03:00:02 INFO - 'sps_profile_interval': 0, 03:00:02 INFO - 'suite': 'dromaeojs', 03:00:02 INFO - 'system_bits': '32', 03:00:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:00:02 INFO - 'title': 't-yosemite-r7-0068', 03:00:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:00:02 INFO - 'use_talos_json': True, 03:00:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:00:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:00:02 INFO - 'work_dir': 'build'} 03:00:02 INFO - ##### 03:00:02 INFO - ##### Running clobber step. 03:00:02 INFO - ##### 03:00:02 INFO - Running pre-action listener: _resource_record_pre_action 03:00:02 INFO - Running main action method: clobber 03:00:02 INFO - rmtree: /builds/slave/test/build 03:00:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:00:04 INFO - Running post-action listener: _resource_record_post_action 03:00:04 INFO - ##### 03:00:04 INFO - ##### Running read-buildbot-config step. 03:00:04 INFO - ##### 03:00:04 INFO - Running pre-action listener: _resource_record_pre_action 03:00:04 INFO - Running main action method: read_buildbot_config 03:00:04 INFO - Using buildbot properties: 03:00:04 INFO - { 03:00:04 INFO - "project": "", 03:00:04 INFO - "product": "firefox", 03:00:04 INFO - "script_repo_revision": "production", 03:00:04 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 03:00:04 INFO - "repository": "", 03:00:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 03:00:04 INFO - "buildid": "20160405014234", 03:00:04 INFO - "pgo_build": "False", 03:00:04 INFO - "basedir": "/builds/slave/test", 03:00:04 INFO - "buildnumber": 675, 03:00:04 INFO - "slavename": "t-yosemite-r7-0068", 03:00:04 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 03:00:04 INFO - "platform": "yosemite_r7", 03:00:04 INFO - "scheduler": "tests-fx-team-macosx64-talos", 03:00:04 INFO - "branch": "fx-team", 03:00:04 INFO - "repo_path": "integration/fx-team", 03:00:04 INFO - "revision": "4b3a929c9249504adb088b24cc37ae7be06ba4ea", 03:00:04 INFO - "stage_platform": "macosx64", 03:00:04 INFO - "builduid": "74c6a64f51ee4055bd6ad8f46f57eb0a", 03:00:04 INFO - "slavebuilddir": "test" 03:00:04 INFO - } 03:00:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 03:00:04 INFO - Running post-action listener: _resource_record_post_action 03:00:04 INFO - ##### 03:00:04 INFO - ##### Running download-and-extract step. 03:00:04 INFO - ##### 03:00:04 INFO - Running pre-action listener: _resource_record_pre_action 03:00:04 INFO - Running main action method: download_and_extract 03:00:04 INFO - mkdir: /builds/slave/test/build/tests 03:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:04 INFO - https://queue.taskcluster.net/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 03:00:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:00:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 03:00:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/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 03:00:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/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 03:00:05 INFO - Downloaded 1199 bytes. 03:00:05 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 03:00:05 INFO - Using the following test package requirements: 03:00:05 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:00:05 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 03:00:05 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 03:00:05 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'jsshell-mac.zip'], 03:00:05 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 03:00:05 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 03:00:05 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 03:00:05 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 03:00:05 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 03:00:05 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 03:00:05 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 03:00:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:00:05 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')]} 03:00:05 INFO - https://queue.taskcluster.net/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:00:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:00:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:00:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/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 03:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/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 03:00:06 INFO - Downloaded 17959886 bytes. 03:00:06 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'] 03:00:06 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 03:00:09 INFO - Return code: 0 03:00:09 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 03:00:09 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')]} 03:00:09 INFO - https://queue.taskcluster.net/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:00:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:00:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 03:00:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/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 03:00:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/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 03:00:10 INFO - Downloaded 17959886 bytes. 03:00:10 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'] 03:00:10 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 03:00:14 INFO - Return code: 0 03:00: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')]} 03:00:14 INFO - https://queue.taskcluster.net/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:00:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:00:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 03:00:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/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 03:00:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/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 03:00:15 INFO - Downloaded 10847584 bytes. 03:00:15 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'] 03:00:15 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 03:00:16 INFO - Return code: 0 03:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:16 INFO - https://queue.taskcluster.net/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:00:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:00:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:00:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 03:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eWu2LSrZQRK8XkguVxMoWw/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 03:00:19 INFO - Downloaded 111349695 bytes. 03:00:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:00:19 INFO - mkdir: /builds/slave/test/properties 03:00:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:00:19 INFO - Writing to file /builds/slave/test/properties/build_url 03:00:19 INFO - Contents: 03:00:19 INFO - build_url:https://queue.taskcluster.net/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 03:00:19 INFO - Running post-action listener: _resource_record_post_action 03:00:19 INFO - Running post-action listener: set_extra_try_arguments 03:00:19 INFO - ##### 03:00:19 INFO - ##### Running populate-webroot step. 03:00:19 INFO - ##### 03:00:19 INFO - Running pre-action listener: _resource_record_pre_action 03:00:19 INFO - Running main action method: populate_webroot 03:00:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:00:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:00:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:00:19 INFO - '--tppagecycles', 03:00:19 INFO - '7'], 03:00:19 INFO - 'tests': ['tsvgm']}}, 03:00:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:00:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:00:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:00:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:00:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:00:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:00:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:19 INFO - 'talos_options': ['--e10s'], 03:00:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:19 INFO - 'tests': ['damp', 'tps']}, 03:00:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:19 INFO - 'talos_options': ['--e10s'], 03:00:19 INFO - 'tests': ['damp', 'tps']}, 03:00:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:00:19 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 03:00:19 INFO - 'tests': ['dromaeo_dom']}, 03:00:19 INFO - 'other': {'tests': ['a11yr', 03:00:19 INFO - 'ts_paint', 03:00:19 INFO - 'tpaint', 03:00:19 INFO - 'sessionrestore', 03:00:19 INFO - 'sessionrestore_no_auto_restore', 03:00:19 INFO - 'tabpaint']}, 03:00:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:00:19 INFO - 'tests': ['a11yr', 03:00:19 INFO - 'ts_paint', 03:00:19 INFO - 'tpaint', 03:00:19 INFO - 'sessionrestore', 03:00:19 INFO - 'sessionrestore_no_auto_restore', 03:00:19 INFO - 'tabpaint']}, 03:00:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:00:19 INFO - 'tests': ['a11yr', 03:00:19 INFO - 'ts_paint', 03:00:19 INFO - 'tpaint', 03:00:19 INFO - 'sessionrestore', 03:00:19 INFO - 'sessionrestore_no_auto_restore', 03:00:19 INFO - 'tabpaint']}, 03:00:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:00:19 INFO - 'tests': ['a11yr', 03:00:19 INFO - 'ts_paint', 03:00:19 INFO - 'tpaint', 03:00:19 INFO - 'sessionrestore', 03:00:19 INFO - 'sessionrestore_no_auto_restore', 03:00:19 INFO - 'tabpaint']}, 03:00:19 INFO - 'other_l64': {'tests': ['a11yr', 03:00:19 INFO - 'ts_paint', 03:00:19 INFO - 'tpaint', 03:00:19 INFO - 'sessionrestore', 03:00:19 INFO - 'sessionrestore_no_auto_restore', 03:00:19 INFO - 'tabpaint']}, 03:00:19 INFO - 'other_nol64': {'tests': ['a11yr', 03:00:19 INFO - 'ts_paint', 03:00:19 INFO - 'tpaint', 03:00:19 INFO - 'sessionrestore', 03:00:19 INFO - 'sessionrestore_no_auto_restore', 03:00:19 INFO - 'tabpaint']}, 03:00:19 INFO - 'svgr': {'tests': ['tsvgx', 03:00:19 INFO - 'tsvgr_opacity', 03:00:19 INFO - 'tart', 03:00:19 INFO - 'tscrollx', 03:00:19 INFO - 'cart']}, 03:00:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:00:19 INFO - 'tests': ['tsvgx', 03:00:19 INFO - 'tsvgr_opacity', 03:00:19 INFO - 'tart', 03:00:19 INFO - 'tscrollx', 03:00:19 INFO - 'cart']}, 03:00:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:19 INFO - 'tests': ['tp5o']}, 03:00:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:19 INFO - 'talos_options': ['--e10s'], 03:00:19 INFO - 'tests': ['tp5o']}, 03:00:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:19 INFO - 'talos_options': ['--xperf_path', 03:00:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:19 INFO - 'tests': ['tp5n']}, 03:00:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:00:19 INFO - 'talos_options': ['--e10s', 03:00:19 INFO - '--xperf_path', 03:00:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:19 INFO - 'tests': ['tp5n']}}, 03:00:19 INFO - 'talos.zip': {'path': '', 03:00:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:00:19 INFO - Running post-action listener: _resource_record_post_action 03:00:19 INFO - ##### 03:00:19 INFO - ##### Running create-virtualenv step. 03:00:19 INFO - ##### 03:00:19 INFO - Running pre-action listener: _resource_record_pre_action 03:00:19 INFO - Running main action method: create_virtualenv 03:00:19 INFO - Creating virtualenv /builds/slave/test/build/venv 03:00:19 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 03:00:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:00:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:00:19 INFO - Using real prefix '/tools/python27' 03:00:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:00:20 INFO - Installing distribute.............................................................................................................................................................................................done. 03:00:23 INFO - Installing pip.................done. 03:00:23 INFO - Return code: 0 03:00:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:00:23 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')]} 03:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:23 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')]} 03:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:23 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 0x1073f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107407420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90ad74550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107296e00>, '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 0x1070bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.lDL36FD0QD/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.fpjAPkULGq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 03:00:23 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 03:00:23 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 03:00:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDL36FD0QD/Render', 03:00:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:23 INFO - 'HOME': '/Users/cltbld', 03:00:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:23 INFO - 'LOGNAME': 'cltbld', 03:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:23 INFO - 'MOZ_NO_REMOTE': '1', 03:00:23 INFO - 'NO_EM_RESTART': '1', 03:00:23 INFO - 'PAGER': '/bin/cat', 03:00:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:23 INFO - 'PWD': '/builds/slave/test', 03:00:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:23 INFO - 'SHELL': '/bin/bash', 03:00:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpjAPkULGq/Listeners', 03:00:23 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 03:00:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:23 INFO - 'USER': 'cltbld', 03:00:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:23 INFO - 'XPC_FLAGS': '0x0', 03:00:23 INFO - 'XPC_SERVICE_NAME': '0', 03:00:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:23 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 03:00:23 INFO - Cleaning up... 03:00:23 INFO - Return code: 0 03:00:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:00:23 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')]} 03:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:23 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')]} 03:00:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:23 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 0x1073f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107407420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90ad74550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107296e00>, '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 0x1070bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.lDL36FD0QD/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.fpjAPkULGq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 03:00:23 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 03:00:23 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 03:00:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDL36FD0QD/Render', 03:00:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:23 INFO - 'HOME': '/Users/cltbld', 03:00:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:23 INFO - 'LOGNAME': 'cltbld', 03:00:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:23 INFO - 'MOZ_NO_REMOTE': '1', 03:00:23 INFO - 'NO_EM_RESTART': '1', 03:00:23 INFO - 'PAGER': '/bin/cat', 03:00:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:23 INFO - 'PWD': '/builds/slave/test', 03:00:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:23 INFO - 'SHELL': '/bin/bash', 03:00:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpjAPkULGq/Listeners', 03:00:23 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 03:00:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:23 INFO - 'USER': 'cltbld', 03:00:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:23 INFO - 'XPC_FLAGS': '0x0', 03:00:23 INFO - 'XPC_SERVICE_NAME': '0', 03:00:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:24 INFO - Downloading/unpacking psutil>=0.7.1 03:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:00:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:26 INFO - Installing collected packages: psutil 03:00:26 INFO - Running setup.py install for psutil 03:00:26 INFO - building 'psutil._psutil_osx' extension 03:00:26 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 03:00:27 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 03:00:27 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 03:00:27 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 03:00:27 INFO - building 'psutil._psutil_posix' extension 03:00:27 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 03:00:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:00:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:00:27 INFO - ^ 03:00:27 INFO - 1 warning generated. 03:00:27 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 03:00:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:27 INFO - Successfully installed psutil 03:00:27 INFO - Cleaning up... 03:00:27 INFO - Return code: 0 03:00:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:00:27 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')]} 03:00:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:27 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')]} 03:00:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:27 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 0x1073f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107407420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90ad74550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107296e00>, '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 0x1070bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.lDL36FD0QD/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.fpjAPkULGq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 03:00:27 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 03:00:27 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 03:00:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDL36FD0QD/Render', 03:00:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:27 INFO - 'HOME': '/Users/cltbld', 03:00:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:27 INFO - 'LOGNAME': 'cltbld', 03:00:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:27 INFO - 'MOZ_NO_REMOTE': '1', 03:00:27 INFO - 'NO_EM_RESTART': '1', 03:00:27 INFO - 'PAGER': '/bin/cat', 03:00:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:27 INFO - 'PWD': '/builds/slave/test', 03:00:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:27 INFO - 'SHELL': '/bin/bash', 03:00:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpjAPkULGq/Listeners', 03:00:27 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 03:00:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:27 INFO - 'USER': 'cltbld', 03:00:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:27 INFO - 'XPC_FLAGS': '0x0', 03:00:27 INFO - 'XPC_SERVICE_NAME': '0', 03:00:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:28 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:00:28 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 03:00:28 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 03:00:28 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 03:00:28 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 03:00:28 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 03:00:28 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 03:00:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:00:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:00:30 INFO - Installing collected packages: mozsystemmonitor 03:00:30 INFO - Running setup.py install for mozsystemmonitor 03:00:30 INFO - Successfully installed mozsystemmonitor 03:00:30 INFO - Cleaning up... 03:00:30 INFO - Return code: 0 03:00:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:00:30 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')]} 03:00:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:31 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 0x1073f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107407420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90ad74550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107296e00>, '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 0x1070bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.lDL36FD0QD/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.fpjAPkULGq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 03:00:31 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 03:00:31 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 03:00:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDL36FD0QD/Render', 03:00:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:31 INFO - 'HOME': '/Users/cltbld', 03:00:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:31 INFO - 'LOGNAME': 'cltbld', 03:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:31 INFO - 'MOZ_NO_REMOTE': '1', 03:00:31 INFO - 'NO_EM_RESTART': '1', 03:00:31 INFO - 'PAGER': '/bin/cat', 03:00:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:31 INFO - 'PWD': '/builds/slave/test', 03:00:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:31 INFO - 'SHELL': '/bin/bash', 03:00:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpjAPkULGq/Listeners', 03:00:31 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 03:00:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:31 INFO - 'USER': 'cltbld', 03:00:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:31 INFO - 'XPC_FLAGS': '0x0', 03:00:31 INFO - 'XPC_SERVICE_NAME': '0', 03:00:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:31 INFO - Downloading/unpacking blobuploader==1.2.4 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:34 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00:35 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 03:00:35 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 03:00:35 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 03:00:35 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 03:00:35 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 03:00:35 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 03:00:35 INFO - Downloading docopt-0.6.1.tar.gz 03:00:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:35 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:35 INFO - Running setup.py install for blobuploader 03:00:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:36 INFO - Running setup.py install for requests 03:00:36 INFO - Running setup.py install for docopt 03:00:36 INFO - Successfully installed blobuploader requests docopt 03:00:36 INFO - Cleaning up... 03:00:36 INFO - Return code: 0 03:00:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:36 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 0x1073f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107407420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90ad74550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107296e00>, '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 0x1070bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.lDL36FD0QD/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.fpjAPkULGq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 03:00:36 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 03:00:36 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 03:00:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDL36FD0QD/Render', 03:00:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:36 INFO - 'HOME': '/Users/cltbld', 03:00:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:36 INFO - 'LOGNAME': 'cltbld', 03:00:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:36 INFO - 'MOZ_NO_REMOTE': '1', 03:00:36 INFO - 'NO_EM_RESTART': '1', 03:00:36 INFO - 'PAGER': '/bin/cat', 03:00:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:36 INFO - 'PWD': '/builds/slave/test', 03:00:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:36 INFO - 'SHELL': '/bin/bash', 03:00:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpjAPkULGq/Listeners', 03:00:36 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 03:00:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:36 INFO - 'USER': 'cltbld', 03:00:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:36 INFO - 'XPC_FLAGS': '0x0', 03:00:36 INFO - 'XPC_SERVICE_NAME': '0', 03:00:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:37 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-1I1qJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:37 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-LJWR7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:37 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-RGzq40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:37 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-y9IAhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:37 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-B_gup0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:37 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-0kexJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:37 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-QeoxdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:37 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-lU8uc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:37 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-uqzYqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:38 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-cJqpYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:38 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-zitusl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:38 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-9FZPAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:38 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-vHECY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:38 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-PyGshW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:38 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-Aw5bwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:38 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-dFgbXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:38 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-5bdosp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:38 INFO - Running setup.py install for manifestparser 03:00:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:39 INFO - Running setup.py install for mozcrash 03:00:39 INFO - Running setup.py install for mozdebug 03:00:39 INFO - Running setup.py install for mozdevice 03:00:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:00:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:39 INFO - Running setup.py install for mozfile 03:00:39 INFO - Running setup.py install for mozhttpd 03:00:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:39 INFO - Running setup.py install for mozinfo 03:00:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:39 INFO - Running setup.py install for mozInstall 03:00:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:40 INFO - Running setup.py install for mozleak 03:00:40 INFO - Running setup.py install for mozlog 03:00:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:40 INFO - Running setup.py install for moznetwork 03:00:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:40 INFO - Running setup.py install for mozprocess 03:00:40 INFO - Running setup.py install for mozprofile 03:00:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:40 INFO - Running setup.py install for mozrunner 03:00:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:41 INFO - Running setup.py install for mozscreenshot 03:00:41 INFO - Running setup.py install for moztest 03:00:41 INFO - Running setup.py install for mozversion 03:00:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:41 INFO - Cleaning up... 03:00:41 INFO - Return code: 0 03:00:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:00:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:41 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 0x1073f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107407420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90ad74550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107296e00>, '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 0x1070bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.lDL36FD0QD/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.fpjAPkULGq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 03:00:41 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 03:00:41 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 03:00:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDL36FD0QD/Render', 03:00:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:41 INFO - 'HOME': '/Users/cltbld', 03:00:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:41 INFO - 'LOGNAME': 'cltbld', 03:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:41 INFO - 'MOZ_NO_REMOTE': '1', 03:00:41 INFO - 'NO_EM_RESTART': '1', 03:00:41 INFO - 'PAGER': '/bin/cat', 03:00:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:41 INFO - 'PWD': '/builds/slave/test', 03:00:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:41 INFO - 'SHELL': '/bin/bash', 03:00:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpjAPkULGq/Listeners', 03:00:41 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 03:00:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:41 INFO - 'USER': 'cltbld', 03:00:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:41 INFO - 'XPC_FLAGS': '0x0', 03:00:41 INFO - 'XPC_SERVICE_NAME': '0', 03:00:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:41 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-VKHjOX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:41 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)) 03:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:41 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-wu5KqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:41 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)) 03:00:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:41 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-RIzshN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:42 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)) 03:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:42 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-APob62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:42 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)) 03:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:42 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-9DSA1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:42 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)) 03:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:42 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-_VeGLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:42 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)) 03:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:42 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-yZFia7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:42 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)) 03:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:42 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-NK_p8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:42 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)) 03:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:42 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-ZeU45B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:42 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)) 03:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:42 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-4O0qLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:42 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)) 03:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:42 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-2BTRpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:42 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)) 03:00:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:42 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-6kHwxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:43 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)) 03:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:43 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-RfmccV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:43 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)) 03:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:43 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-zoQlvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:43 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)) 03:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:43 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-BEbgKd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:43 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)) 03:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:43 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-tvvjC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:43 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)) 03:00:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:43 INFO - Running setup.py (path:/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/pip-70MIwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:43 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)) 03:00:43 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)) 03:00:43 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)) 03:00:43 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)) 03:00:43 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)) 03:00:43 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)) 03:00:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:43 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 03:00:43 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 03:00:43 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 03:00:43 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 03:00:43 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 03:00:43 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 03:00:46 INFO - Downloading blessings-1.6.tar.gz 03:00:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:46 INFO - Installing collected packages: blessings 03:00:46 INFO - Running setup.py install for blessings 03:00:46 INFO - Successfully installed blessings 03:00:46 INFO - Cleaning up... 03:00:46 INFO - Return code: 0 03:00:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:46 INFO - Reading from file tmpfile_stdout 03:00:46 INFO - Current package versions: 03:00:46 INFO - blessings == 1.6 03:00:46 INFO - blobuploader == 1.2.4 03:00:46 INFO - docopt == 0.6.1 03:00:46 INFO - manifestparser == 1.1 03:00:46 INFO - mozInstall == 1.12 03:00:46 INFO - mozcrash == 0.17 03:00:46 INFO - mozdebug == 0.1 03:00:46 INFO - mozdevice == 0.48 03:00:46 INFO - mozfile == 1.2 03:00:46 INFO - mozhttpd == 0.7 03:00:46 INFO - mozinfo == 0.9 03:00:46 INFO - mozleak == 0.1 03:00:46 INFO - mozlog == 3.1 03:00:46 INFO - moznetwork == 0.27 03:00:46 INFO - mozprocess == 0.22 03:00:46 INFO - mozprofile == 0.28 03:00:46 INFO - mozrunner == 6.11 03:00:46 INFO - mozscreenshot == 0.1 03:00:46 INFO - mozsystemmonitor == 0.0 03:00:46 INFO - moztest == 0.7 03:00:46 INFO - mozversion == 1.4 03:00:46 INFO - psutil == 3.1.1 03:00:46 INFO - requests == 1.2.3 03:00:46 INFO - wsgiref == 0.1.2 03:00:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:46 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')]} 03:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:46 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')]} 03:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:46 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 0x1073f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107407420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90ad74550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107296e00>, '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 0x1070bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.lDL36FD0QD/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.fpjAPkULGq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 03:00:46 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 03:00:46 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 03:00:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDL36FD0QD/Render', 03:00:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:46 INFO - 'HOME': '/Users/cltbld', 03:00:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:46 INFO - 'LOGNAME': 'cltbld', 03:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:46 INFO - 'MOZ_NO_REMOTE': '1', 03:00:46 INFO - 'NO_EM_RESTART': '1', 03:00:46 INFO - 'PAGER': '/bin/cat', 03:00:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:46 INFO - 'PWD': '/builds/slave/test', 03:00:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:46 INFO - 'SHELL': '/bin/bash', 03:00:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpjAPkULGq/Listeners', 03:00:46 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 03:00:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:46 INFO - 'USER': 'cltbld', 03:00:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:46 INFO - 'XPC_FLAGS': '0x0', 03:00:46 INFO - 'XPC_SERVICE_NAME': '0', 03:00:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:46 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)) 03:00:46 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)) 03:00:46 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)) 03:00:46 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)) 03:00:46 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)) 03:00:46 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)) 03:00:46 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)) 03:00:46 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)) 03:00:46 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)) 03:00:46 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)) 03:00:46 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)) 03:00:46 INFO - Cleaning up... 03:00:46 INFO - Return code: 0 03:00:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00:46 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')]} 03:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:46 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')]} 03:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:46 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 0x1073f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107407420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90ad74550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107296e00>, '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 0x1070bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.lDL36FD0QD/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.fpjAPkULGq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 03:00:46 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 03:00:46 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 03:00:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDL36FD0QD/Render', 03:00:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:46 INFO - 'HOME': '/Users/cltbld', 03:00:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:46 INFO - 'LOGNAME': 'cltbld', 03:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:46 INFO - 'MOZ_NO_REMOTE': '1', 03:00:46 INFO - 'NO_EM_RESTART': '1', 03:00:46 INFO - 'PAGER': '/bin/cat', 03:00:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:46 INFO - 'PWD': '/builds/slave/test', 03:00:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:46 INFO - 'SHELL': '/bin/bash', 03:00:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpjAPkULGq/Listeners', 03:00:46 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 03:00:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:46 INFO - 'USER': 'cltbld', 03:00:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:46 INFO - 'XPC_FLAGS': '0x0', 03:00:46 INFO - 'XPC_SERVICE_NAME': '0', 03:00:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:47 INFO - Downloading/unpacking jsonschema 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:49 INFO - Downloading/unpacking functools32 (from jsonschema) 03:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:49 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:50 INFO - warning: no files found matching '*.txt' 03:00:50 INFO - no previously-included directories found matching 'build' 03:00:50 INFO - no previously-included directories found matching 'dist' 03:00:50 INFO - no previously-included directories found matching '.git*' 03:00:50 INFO - Installing collected packages: jsonschema, functools32 03:00:50 INFO - Running setup.py install for functools32 03:00:50 INFO - warning: no files found matching '*.txt' 03:00:50 INFO - no previously-included directories found matching 'build' 03:00:50 INFO - no previously-included directories found matching 'dist' 03:00:50 INFO - no previously-included directories found matching '.git*' 03:00:50 INFO - Successfully installed jsonschema functools32 03:00:50 INFO - Cleaning up... 03:00:50 INFO - Return code: 0 03:00:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:00:50 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')]} 03:00:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:50 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')]} 03:00:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:50 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 0x1073f7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107407420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd90ad74550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107296e00>, '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 0x1070bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, '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.lDL36FD0QD/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.fpjAPkULGq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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 03:00:50 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 03:00:50 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 03:00:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDL36FD0QD/Render', 03:00:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:50 INFO - 'HOME': '/Users/cltbld', 03:00:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:50 INFO - 'LOGNAME': 'cltbld', 03:00:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:50 INFO - 'MOZ_NO_REMOTE': '1', 03:00:50 INFO - 'NO_EM_RESTART': '1', 03:00:50 INFO - 'PAGER': '/bin/cat', 03:00:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:50 INFO - 'PWD': '/builds/slave/test', 03:00:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:50 INFO - 'SHELL': '/bin/bash', 03:00:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpjAPkULGq/Listeners', 03:00:50 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 03:00:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:50 INFO - 'USER': 'cltbld', 03:00:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:50 INFO - 'XPC_FLAGS': '0x0', 03:00:50 INFO - 'XPC_SERVICE_NAME': '0', 03:00:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:50 INFO - Downloading/unpacking flake8 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00: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 03:00:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:00:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:00:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:00:53 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 03:00:53 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 03:00:53 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 03:00:53 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 03:00:53 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 03:00:53 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 03:00:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:00:53 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 03:00:53 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 03:00:53 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 03:00:53 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 03:00:53 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 03:00:53 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 03:00:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:00:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:00:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:00:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:00:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:00:54 INFO - no previously-included directories found matching 'docs/_build' 03:00:54 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:00:54 INFO - Running setup.py install for pep8 03:00:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:00:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:00:54 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:00:54 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:00:54 INFO - no previously-included directories found matching 'docs/_build' 03:00:54 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:00:54 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:00:54 INFO - Cleaning up... 03:00:54 INFO - Return code: 0 03:00:54 INFO - Running post-action listener: _resource_record_post_action 03:00:54 INFO - Running post-action listener: _start_resource_monitoring 03:00:54 INFO - Starting resource monitoring. 03:00:54 INFO - ##### 03:00:54 INFO - ##### Running install step. 03:00:54 INFO - ##### 03:00:54 INFO - Running pre-action listener: _resource_record_pre_action 03:00:54 INFO - Running main action method: install 03:00:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:54 INFO - Reading from file tmpfile_stdout 03:00:54 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:54 INFO - Reading from file tmpfile_stdout 03:00:54 INFO - Output received: 03:00:54 INFO - Usage: mozinstall [options] installer 03:00:54 INFO - Options: 03:00:54 INFO - -h, --help show this help message and exit 03:00:54 INFO - -d DEST, --destination=DEST 03:00:54 INFO - Directory to install application into. [default: 03:00:54 INFO - "/builds/slave/test"] 03:00:54 INFO - --app=APP Application being installed. [default: firefox] 03:00:54 INFO - mkdir: /builds/slave/test/build/application 03:00:54 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'] 03:00:54 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 03:01:28 INFO - Reading from file tmpfile_stdout 03:01:28 INFO - Output received: 03:01:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:01:28 INFO - Running post-action listener: _resource_record_post_action 03:01:28 INFO - ##### 03:01:28 INFO - ##### Running run-tests step. 03:01:28 INFO - ##### 03:01:28 INFO - Running pre-action listener: _resource_record_pre_action 03:01:28 INFO - Running main action method: run_tests 03:01:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:01:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:01:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:01:28 INFO - 2016-04-05 03:01:28.538 screenresolution[1646:7608] starting screenresolution argv=screenresolution get 03:01:28 INFO - 2016-04-05 03:01:28.540 screenresolution[1646:7608] Display 0: 1600x1200x32@60 03:01:28 INFO - 2016-04-05 03:01:28.546 screenresolution[1647:7610] starting screenresolution argv=screenresolution list 03:01:28 INFO - Available Modes on Display 0 03:01:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:01:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:01:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:01:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:01:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:01:28 INFO - Intel Iris: 03:01:28 INFO - Chipset Model: Intel Iris 03:01:28 INFO - Type: GPU 03:01:28 INFO - Bus: Built-In 03:01:28 INFO - VRAM (Dynamic, Max): 1536 MB 03:01:28 INFO - Vendor: Intel (0x8086) 03:01:28 INFO - Device ID: 0x0a2e 03:01:28 INFO - Revision ID: 0x0009 03:01:28 INFO - Displays: 03:01:28 INFO - Display: 03:01:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:01:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:01:28 INFO - Display Serial Number: 1600x1200 60 03:01:28 INFO - Main Display: Yes 03:01:28 INFO - Mirror: Off 03:01:28 INFO - Online: Yes 03:01:28 INFO - Rotation: Supported 03:01:28 INFO - Return code: 0 03:01:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:01:28 INFO - Python 2.7.3 03:01:28 INFO - Return code: 0 03:01:28 INFO - grabbing minidump binary from tooltool 03:01:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:28 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 0x107296e00>, '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 0x1070bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107291b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:01:28 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 03:01:28 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 03:01:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:01:28 INFO - Return code: 0 03:01:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:01:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:01:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:01:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:01:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:01:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:01:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:01:30 INFO - Return code: 0 03:01:30 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/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0068', '--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 03:01:30 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/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0068 --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 03:01:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.lDL36FD0QD/Render', 03:01:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:01:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:01:30 INFO - 'HOME': '/Users/cltbld', 03:01:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:01:30 INFO - 'LOGNAME': 'cltbld', 03:01:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:01:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:30 INFO - 'MOZ_NO_REMOTE': '1', 03:01:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:01:30 INFO - 'NO_EM_RESTART': '1', 03:01:30 INFO - 'PAGER': '/bin/cat', 03:01:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:30 INFO - 'PWD': '/builds/slave/test', 03:01:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:01:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:01:30 INFO - 'SHELL': '/bin/bash', 03:01:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fpjAPkULGq/Listeners', 03:01:30 INFO - 'TMPDIR': '/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/', 03:01:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:01:30 INFO - 'USER': 'cltbld', 03:01:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:01:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:30 INFO - 'XPC_FLAGS': '0x0', 03:01:30 INFO - 'XPC_SERVICE_NAME': '0', 03:01:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:01:30 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/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0068', '--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 03:01:30 INFO - mozversion application_buildid: 20160405014234 03:01:30 INFO - mozversion application_changeset: 4b3a929c9249504adb088b24cc37ae7be06ba4ea 03:01:30 INFO - mozversion application_display_name: Nightly 03:01:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:01:30 INFO - mozversion application_name: Firefox 03:01:30 INFO - mozversion application_remotingname: firefox 03:01:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:01:30 INFO - mozversion application_vendor: Mozilla 03:01:30 INFO - mozversion application_version: 48.0a1 03:01:30 INFO - mozversion platform_buildid: 20160405014234 03:01:30 INFO - mozversion platform_changeset: 4b3a929c9249504adb088b24cc37ae7be06ba4ea 03:01:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:01:30 INFO - mozversion platform_version: 48.0a1 03:01:30 INFO - using testdate: 1459850490 03:01:30 INFO - actual date: 1459850490 03:01:30 INFO - starting webserver on 'localhost:49275' 03:01:30 INFO - SUITE-START | Running 2 tests 03:01:30 INFO - TEST-START | dromaeo_css 03:01:30 INFO - operating with platform_type : mac_ 03:01:30 INFO - Initialising browser for dromaeo_css test... 03:01:30 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmphNpPY_/profile http://localhost:49275/getInfo.html) 03:01:32 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 03:01:32 INFO - PROCESS | 1665 | colorDepth:24 03:01:32 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 03:01:32 INFO - PROCESS | 1665 | __metrics 03:01:32 INFO - PROCESS | 1665 | 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" 03:01:32 ERROR - PROCESS | 1665 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:01:33 INFO - TEST-INFO | 1665: exit 0 03:01:33 INFO - Browser initialized. 03:01:33 INFO - Running cycle 1/1 for dromaeo_css test... 03:01:33 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmphNpPY_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:45 INFO - PROCESS | 1667 | RSS: Main: 236142592 03:01:45 INFO - PROCESS | 1667 | 03:02:36 INFO - PROCESS | 1667 | 1459850556325 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] 03:04:46 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 03:04:47 INFO - PROCESS | 1667 | RSS: Main: 333778944 03:04:47 INFO - PROCESS | 1667 | 03:07:49 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 03:07:50 INFO - PROCESS | 1667 | RSS: Main: 361844736 03:07:50 INFO - PROCESS | 1667 | 03:10:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 03:10:53 INFO - PROCESS | 1667 | RSS: Main: 358244352 03:10:53 INFO - PROCESS | 1667 | 03:13:55 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 03:13:55 INFO - PROCESS | 1667 | RSS: Main: 324796416 03:13:55 INFO - PROCESS | 1667 | 03:16:58 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 03:16:59 INFO - PROCESS | 1667 | RSS: Main: 327102464 03:16:59 INFO - PROCESS | 1667 | 03:20:01 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 03:20:02 INFO - PROCESS | 1667 | RSS: Main: 372187136 03:20:02 INFO - PROCESS | 1667 | 03:20:02 INFO - PROCESS | 1667 | __start_tp_report 03:20:02 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 03:20:02 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 03:20:02 INFO - PROCESS | 1667 | |i|pagename|runs| 03:20:02 INFO - PROCESS | 1667 | |0;dojo.html;3441.5353927219826;3486.3375958567854;3516.982415087927;3529.5411596492454;3555.6799888010073;5588.692621905793;5621;5628.099504079348;5648.068068768654;5654.971725141379;5606.467385598372;5633.436656334365;5642.407547207536;5649.039663257246;5650.406707295737;4273.636740877014;5099.71951542665;5103.106956282654;5137.614678899079;5203.4016088149965;5213.582913366921;5214.139666954948;5215.295935048758;5220.973895130538;5227.999999999981;5135.35808023997;5153.123968925273;5188.7146206958605;5188.818391356303;5199.350081239845;5172.172452407615;5206.140986737184;5222.4255331913455;5248.763805628718;5293.179557168645;5026.773795179189;5065.290859279704;5141.76862041209;5156.510131537498;5178.792848286064;5521;5525.392206857243;5533.418991005967;5539.723013849331;5586.385497595261;6102.938970610326;6114.0828875669;6118;6128.693565321761;6130.17242672238;5238.947610523884;6132.724027418777;6142.86713775973;6179.969100154515;6218.782342617987;4733.242681170997;5725.599208055438;5725.6850873202375;5737.254156959611;5768.250127483442;6279.434850863444;6280.403361680633;6290.402411770874;6291.5281353898645;6327;4605.424321959755;5896.292444906639;6063.029915213545;6099.0374119281705;6140.3552626974415;6177;6203.31763506014;6211.223597050369;6211.565190436626;6213.099100630474;5920.703964801743;6041.5468839837185;6109.266887973383;6118.632882027093;6163.476104531165;6111.98679349419;6159.291681456601;6194.907076393858;6211;6211.254649442096;4868.464468908417;4878.341423907727;4879.316895634614;4884;4905.950940490549;4255.510616279105;4297.978510107429;4398.296272596369;4420.403245561808;4423.004823914658;5661.433856614306;5722.971385143048;5725.8568535786935;5745.569082318842;5766.740496677659;6253.468455181361;6255.96872015637;6262.3111457739615;6272.498200143978;6279.497640188774;5575.4424557544735;5686.516646085046;5702.087665973424;5708.058170401837;5759.913601295984;5283.233931079972;5292.417834038252;5329.733513324319;5362.839114826562;5380.515753582118;6270.7805226816845;6274.403931626488;6295.024271237966;6299.464545513591;6307.337729538424;6116.305337586134;6208.068789681584;6232.657203853832;6295.96852015737;6305.274893387135;6226.346233645583;6245.437910588069;6261.24865016201;6297.1813664223355;6320;6112.235970503687;6129.049997250433;6134.355892631388;6143.201383820075;6148.200733904564;6091.42131497507;6154.169187159855;6272.466840318441;6276;6277.623342599459;6040.244969378828;6041.546883983631;6043.395660433922;6044.546659000504;6102.481289090477;5049.671771334852;5743.4543718346695;5935.080062590306;5985.880282394241;6007;5723.971380143073;5803.65178089316;5811.912821307768;5865.296164460292;5909.468147866713;6079.3008803988105;6083.300420451705;6092.543059270483;6105.829739181415;6135.969320153371;5886.735096920735;5893.410658934244;5903.822885313448;5906.26171728534;5944.851378715567 03:20:02 INFO - PROCESS | 1667 | |1;ext.html;426.3668452348264;522.6785526900952;580.6080895395606;633.2337871175876;640.1773720768812;29977.999999999975;30646.241838234553;30669.233269168228;30718.07845764625;31403.05790826273;32970.67029329706;33467.33065338692;40775.796121019426;40948.38577421333;40962.79518602403;9634.807303853919;9787.119159275664;9791.11879930806;9797.06927841854;9800.558974846113;9620.71137865865;9781.364211326276;9783.532470129501;9795.755106122368;9824.21406287499;9730.708078757612;9792.657256996006;9802.362846414995;9821.803563928717;9826.263030272758;9791.16775074116;9792;9846.60613575456;9858.65494707689;9887.505624718735;9606.039396060409;9727.270454715925;9743.123118919331;9745.415275083447;9746.610135594568;39857.40213896765;39965.20069598592;40037.59962400368;40121.19757604861;40125.59874401248;2884.2356775454523;3209.1014515935344;3277.6394596594355;3323.7673362864607;3377.7466689998105;26190.214293571033;26712.530810805398;29009.56485652717;30115.247118821986;30142.246443839078;2730.57676060211;2802.607634931111;2864.6562412510425;2869.3113652723196;2875.8418286994206;435459;436344;437632;439484;439672;46852.82867928261;51306;61884.38115618786;62285.68857155776;62560.55432516643;46324;46332.76833615878;46430.96397468307;46459.53540464552;46587.06825863464;15544.76682849758;15781.447649332218;15784.052956822627;15801.920990395205;15808.762868556982;12608.180468269533;12635.241885486901;12686;12700.301483418501;12700.555480558136;14701.852981470262;14704.705905882036;14992.925035374972;15017;15128.697426051418;6303.46420554258;6491.318411566812;6513.413792758674;6552.213734351908;6570.8357291068105;961.485605201214;988.5946761827616;989.7723523589615;1089.3518356577824;1091.6997825597866;25231.495370092496;29409.85295073511;29536.704632953824;30241.546376804366;30688.53967190494;1060.2101434431245;1102.1403305421784;1109.046220250584;1154.5266440759249;1224.3205021213312;12247.571335003233;14831.851681483264;14969.476068337555;15101.3204405802;15466.14936178521;532925;533864;538936;538995;539202;59483.10775338373;59857.401425986056;60019;60037.799244014874;60123.69938150281;1326.389860664086;1440.4454285100103;1465.5749832548443;1469.9191544465157;1545.358676149408;28572.85713571419;28667.56998645064;28792.712072879003;29272.56091158592;29350.412991739617;39780.2043959125;56803;57562.42437575738;57610.71194644;57656.55858603569;404337;410521;412429.75702429516;413542;413692;38069;43481.13037739291;43852.78073609739;43921.56078439303;44847.77576112099;42813.785931070146;43311.783441082596;43313.350299744896;43728;45255.0948981012;36152.915412537666;36222;36446.63553364432;36809.26381472302;36957.07607309839;35823.46264806082;36583.37318667224;36850.44724329084;36954.63045369512;37781;37071.07322316964;37880.810595946845;38110.42834357431;38135;38141.046473838374;32665.578668665126;32839.50740738843;32917.72069630933;33198;33530.329393411506;24694.753052469245;24746;25158.24525264245;25173.24480265595;25333.746662533875 03:20:02 INFO - PROCESS | 1667 | |2;jquery.html;358.77038695235046;360.07460825678004;360.88090929993103;372.78192257529344;374.33181770539574;20019.299324523643;20688.68966965495;21098.472538186554;21315.253966111188;21589.352319430443;20321.59356812863;20469.795302046976;21144.788552114474;21399.93000349984;21425.035873385736;5636.915446268309;5814;5841.85395365115;5847.239858818348;5854.912176317359;5608.775648974036;5794.855128621797;5890.145928840316;5896.292444906617;5900.085486749561;5876.559258055641;5881.206037184989;5895.852603684921;5897.852553686171;5904.675242861641;5756.338021127582;5770.567207459437;5880.882382352351;6027;6042.728077236491;5703.686297253649;5734.541236701054;5737.110747834093;5740.339860916007;5741.856453588652;21254.893725531274;24298.514029719307;25241;25448.36379090519;25482.10812621568;1954.5797653504565;2115.132795553831;2160.1359456217483;2365.0894405653776;2390.25901970388;9611.279154063403;9821.116099551004;10320.483975801255;12410.81383779244;15091.094534327865;1580.1467207707824;1722.6210233748554;1779.9644007119784;1800.0189896506436;1821.2532861526843;82101;95971.0402895969;98030;99447;103807.48096259471;10841.945790270998;10882.347059176474;10939.671809845717;11099.278546894426;11230.15773816967;12320.691982700504;12670;12702.42839072244;13171.538996135088;13823.447062117402;6484.740610375627;6632.933670663231;7670.539767613961;8202.548859812767;8428.873566896502;8522.829543409222;8562.058173600899;8584.914150858536;8624.870626940601;8709.303255739525;4322.37325587788;4428.2914733642465;4441.978899600674;4474.440694913136;4494.438195225597;1561.718890599703;1779.3416435918793;1823.781146262457;1879.4925370149983;1881.7647794025747;891.157855826251;911.3438324406417;936.8735220745249;975.7024107647236;1039.5270152080784;15142.470013549473;20724.58550828975;20772.1691132353;20906.68639970371;20975.951202440123;925.167349385545;951.8001219743793;958.7938593202495;997.7804882925744;1006.6879267427121;10419.270651054354;10970.725731856768;11237.83143252852;11339.319640821577;11345.205835591429;537983;544482;544817.2759136179;673870;678769;73886;114554;130571;131338;134775.32612337073;1018.8675472188568;1020.3520764314566;1044.206403133624;1059.422614675004;1066.461436974323;18424.723629145843;18691.345802896834;18762.061896904826;18964.43106706801;19046.523836904187;30206.697933020387;42387;51172.74413627908;51625.48374516207;53975;64671.67664161649;66240.33759662342;70794.64602676954;78129.21870781446;79890;7731.226877312224;7865.960670196841;7915.366770658448;8012.879806803019;8202.466839655403;11443.370614616277;11650.941745291218;12502.812232837865;12794.616161515169;12813.679658008625;8288;8975.596098175729;10806.459677016275;10836.783264334827;10966.17753668494;10186.439745814052;10595.894041059799;10726.946365268124;10823.621173258898;11056.889431105908;10186.185105191418;10430.26988110825;10482.842757358798;11056;11391.54433822671;7743.728969486041;7787.415943804124;7810.88283675734;7880.881786773089;8125.634346454305;7884.132745398117;8106.756797296091;9063.637454501746;10158.628585140912;11157.553697851996 03:20:02 INFO - PROCESS | 1667 | |3;mootools.html;1591.2521115075913;1615.7980252468442;1905.4950438133897;1991.8406527477803;2040.8367330613544;7071.823204419886;8730.432521886072;8821.86767198491;8837.955810220948;8839.513826739527;7759.573223472707;7965.123836377994;8423.199796019384;8629.223369896708;8637;2423.3699238198105;2462.7167875694345;2462.827602067856;2466.3957330453973;2468.9259322220364;2149.419656692692;2416.7462416446283;2417.601095819188;2500.062476571286;2501;2041.4998325410295;2196.0556960506974;2410.5901996660523;2443.8044956403533;2456.3245107595376;2393.2939782764124;2424.73327933928;2429.6112621980396;2450.6079027355718;2457.397937505305;2354.281374596537;2402.25530085674;2402.5074859653905;2406.9650050478285;2424.3211900667666;8216.178382161796;8389.748307550783;8875;8975.596098175532;8985.146411091002;5368.973155134238;5521.917171242435;5536.778528858841;5539.972300138514;5550.361708403505;3051.771117166199;3268.477043673001;3280.9671903281137;3507.5615548056494;3623.438367053111;1026.7073883943115;1043.7286305560533;1054.3410368519676;1070.7911957168355;1071.8874518175635;11251.43742812856;11481.196316257865;11493.770124597544;11614.70963225926;11849.644510664693;4481.551844815557;4538.659600529973;4601.838935637236;4654.860354189312;4655.51117132703;9392.718218453458;9392.812143757223;9400.90599094014;9410.247180225566;9414.058594140668;5286.762095705702;5325.920111198335;5326.813561525328;5332;5335.67985920846;4964.90070198594;4964.975175124101;4974.602031837517;4975.328330675385;4978.103941290602;3124.937501249962;3749.887503374903;3755.586885442599;3804.6766024887643;3807.0101773538527;1126.8364739699632;1129.1249281806665;1189;1195.5994741761433;1197.21582363552;1315.9342032898317;1317.4005827348533;1351.8377794664702;1380.130517773816;1382.7303675783328;8070;8257.38069644767;8269.04905935825;8269.643151701735;8276.710315138942;1169.3159501691437;1193.3734789235548;1195.635331223985;1196.8264601632889;1234.1422711215619;6280.434760871452;6287.779927702509;6415.294317625057;6432.549721519449;6439.130717353191;10531.210159238088;10710.357378557312;10765.515551800188;10777.78444431107;10914.890851091388;10381.325213861075;10669.83995240072;10702.625408110678;10712.78574428507;10768.623098191525;8270.627821748036;8374.874376884352;8389.958050209832;8441.620127094295;8461.365397595206;7617.771466856003;7913.841723165619;7961.8407631848195;7966.960165199369;7967.56178410193;9206.493642849708;9539.904600953902;9547.952260238655;9555.331126821335;9642.373245739005;9671.70984870455;9854.704358869245;9860.85208721884;9879.901200988186;9946.850797238192;6918.308169183041;7017;7038.577685338896;7107.147142342952;7122.287771222836;8225.383096267684;8250.54621995796;8277.95861020691;8306.54314012735;8309.127541608286;7319.853602927805;7427.1087469501845;7472.327490525879;7544.509606875536;7596;7142.107236595426;7332.633368331455;7335.7432489862595;7424.777256682308;7478.626068696434;7662.463627546018;7751.651175696994;7754.7673569793;7763;7766.650500727594;6930.930690693029;7024.051753013277;7027.262137475696;7037.612931288828;7048.330408611174;6832.385085342343;7101.4673899458785;7103.964480177773;7122.786316410516;7135.750248741269 03:20:02 INFO - PROCESS | 1667 | |4;prototype.html;323.5373416015098;324.62505805794314;330.5834648343087;331.6236072058213;334.64193313154937;6570.277269500363;6574.506911981596;6581.407673309402;6585.934140658592;6603.702833372492;6430.967845160768;6478.870422591545;6508.316626754194;6513.088167656532;6516.543841931067;4660.557247061541;4740.668153229275;4750.453697824742;4857.392825896763;4921.753912304388;4838.661293709441;4871.926921096168;4899.167141585921;4925.113479573675;4925.729084900329;4847.709137451747;4855.344528488662;4858.902821943559;4872.707637541741;4875.609951203913;4599.908001839961;4688.085823264481;4783.689060211075;4797.568218860284;4816.349792778;4122.216778812016;4137.110521237918;4145.398917156996;4151.941254979961;4161.146964872224;6279.488204718104;6309.400606942333;6320.778772742978;6321.336259692758;6351.618902865843;5703.287089113861;5706.029974904276;5714.342850572196;5725.341585717654;5729.742161602738;6730.56251343666;7000.264972177899;7002.124734408199;7016;7021.368076873106;4651.697639653412;4707.905841883177;4715.339852420664;4718.575328220477;4725.66920315578;6012.917674818531;7360.300771426706;7396.297351751521;7409.666565004588;7444.590547519884;4753.904921901542;4760.809567617326;4761.6904901181315;4763.69036012658;4776.331313616097;4823.686460380064;4839.758012099381;4839.903201935942;4842.080004799077;4846.442659094249;5674.007048766532;5691.971540142273;5695.316562012585;5696.259486266758;5697.202391665171;6672.7330906764155;7031.507794454441;7032.402245809061;7065.046218760402;7103.502754807114;1643.1209303022824;1683.5791052236941;1687.6540309236823;1688.8226736192769;1690.0535700008036;1020.4285600063839;1045.6444808765057;1080.330195278932;1089.629525961177;1115.052205625212;6548.443382312556;6651.102101216371;6727.730890764413;6730.899036514358;6733.3266673333255;7350.96324518374;7363.337299643058;7368.189499155089;7369.226231245642;7382.261773822682;6722.1261236039;6726.804767735384;6729.966350168218;6743.9325606743305;6745.190577130776;3717.628237176261;3829.468212714881;3869.4195870619633;3880.9611903881164;3890.824912878927;6900.171979362408;7369.520981136317;7674.270944260286;7719.112302085332;7729.995100636994;7541.132769731441;7558.697652093964;7570.697172113164;7582.848343033108;7584;7657.808554786175;7677.539347639159;7685.077790665156;7686.57723825195;7696.807579810549;7083.574985500886;7348.926510734825;7353.5955522446775;7358.558486490828;7366.337029667356;7178.784636460915;7220.675069621774;7229.240929702306;7230.6384680764695;7236.20401755817;6813.1142951415995;7106.609136497542;7627.5042122261875;7664.386849051951;7683.961580192064;4157.605027522381;4773.236282194832;4775.403074615673;4784.665073444826;4786.545278198566;6989.7553585624255;7325.864491003903;7346.59593722329;7349.6692648832;7350.852982940418;6955.304469553004;6971.930280697128;6974.163100427981;6977.860442791014;6990.475714321345;7035.0150978861975;7039.824004399726;7042.929570704432;7051.717931282691;7059.611721355374;6858.451323894176;6864.519483636098;6884.4148247399535;6886.931130688829;6899.655017249218;6811.9659401702675;7028.683709232994;7055.611941343275;7056.929430705833;7092.148942126978;5590.273264475755;6695.4308883745425;6738.35985581369;6741.685371352539;6807.285235050248 03:20:02 INFO - PROCESS | 1667 | |5;yui.html;687.7352219395533;747.8167848877026;762.4053238473989;766.0768773627777;772.4862966127525;11699.532018719252;15222.923885380558;15226.086434813906;15252;15260.999999999985;13848.515301964433;14039.157650540974;14059.15645061297;14072.507462238824;14081.718365632682;732.8204589875488;741.6440108747804;911.8495448251048;914.5564401265381;935.2237642756496;811.9188081191893;929.5120061967488;931.417863835103;934.3693007220133;936.0826390137669;983.7048885334407;989.60910440376;991.1773228220595;993.2798720927342;995.8954309797475;769.4806005945992;967.2987084363815;987.916027137687;989.3470309595632;989.915857152143;730.6931088942657;732.2713899669862;734.2804052029041;736.3409748275317;738.966746496409;14656.780148297785;14724.631884202874;14725.926370368186;14772.113673179536;14778.408863645442;12398.504059837596;12531.93734031324;12626.621201363974;12758.872411275861;12855.550055748005;9746.658866939622;9848.310618256724;9882.80234395308;10196.796064078751;10494.108000819939;3484.303139372136;3516.859325626972;3519.137811236238;3677.42999835026;3717.182219911615;79432.80850787243;80103;80136;80205;80615;9217.451868066371;9309.069093090637;9456;9660.75848103803;10017.348872323275;21085.894570527355;21292;21306.893465532885;21326.253581124587;21338.893305533373;7428.591427471433;7547.5848828314965;7665;7740.7677769667;7849.607519623996;4060.8578699745367;4082.2856000199845;4118.258713431551;4133.627973482401;4136.9793151034055;2797.2866918935947;3261.4129456698024;3262.5921759780026;3262.951055734166;3268.477043673001;562.5134258866051;612.3080918561997;634.6858305138986;658.9934100659028;670.966451677424;579.9449052340021;582.6231891942731;583.9474447299764;600.1717629671114;600.6576251536583;8146.185381461806;8176.6320515576945;8383.771798405935;8480.236778689947;8508.489490630458;566.1988286574451;595.4700316718124;608.6652341212404;612.1888497740423;633.8985762278013;3696.5933747287777;3745.4756334113245;3800.2518841332744;3848.5574158972076;3885.1646895917515;91345.54327228454;92511.53744231236;93496;93554;93968.53015734878;74206.6289668559;76564.61717691376;77828;78622.21377786263;79044.60477697574;63041.36958630447;65789;65921;68045.65977170083;68769.65615171992;7114.893276600958;8176.46852954556;8548.316134709085;8687.956560217159;8732.170443807829;49435;49735.75132124316;49848;52091.21863172131;52191.47808521866;67327.66336168288;70070.94893576499;71368;74262.62868685622;75951.62024189843;11482;11624.128190385585;11716.882831171579;11882.28706277626;12100.515979360727;11924.105692073303;12040.75918481608;12075.698107547381;12107.394630268627;12387;11486;11566.47950842231;11590;11627.011704005254;11946.641600751991;11412.885871141183;11568.190226684052;11740.941295293469;11842.82235766447;12017.416255505108;11149.665510034712;11310.547578096784;11311.886881131413;11336.036436902956;11517.07863370945;9295.209907157967;9403.43579385239;9713.125818676353;9847.029668481162;10017.949910250401;9625.56684949193;9681.273904457054;9686.467244301632;9738.123568878835;9739.172170365599 03:20:02 INFO - PROCESS | 1667 | __end_tp_report 03:20:02 INFO - PROCESS | 1667 | __start_cc_report 03:20:02 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1055 03:20:02 INFO - PROCESS | 1667 | __end_cc_report 03:20:02 INFO - PROCESS | 1667 | __startTimestamp1459851602224__endTimestamp 03:20:02 INFO - PROCESS | 1667 | 03:20:02 INFO - PROCESS | 1667 | ------- Summary: start ------- 03:20:02 INFO - PROCESS | 1667 | Number of tests: 6 03:20:02 INFO - PROCESS | 1667 | 03:20:02 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5671.79 Median:5865.30 stddev:637.00 (10.9%) stddev-sans-first:614.45 03:20:02 INFO - PROCESS | 1667 | Values: 3441.5 3486.3 3517.0 3529.5 3555.7 5588.7 5621.0 5628.1 5648.1 5655.0 5606.5 5633.4 5642.4 5649.0 5650.4 4273.6 5099.7 5103.1 5137.6 5203.4 5213.6 5214.1 5215.3 5221.0 5228.0 5135.4 5153.1 5188.7 5188.8 5199.4 5172.2 5206.1 5222.4 5248.8 5293.2 5026.8 5065.3 5141.8 5156.5 5178.8 5521.0 5525.4 5533.4 5539.7 5586.4 6102.9 6114.1 6118.0 6128.7 6130.2 5238.9 6132.7 6142.9 6180.0 6218.8 4733.2 5725.6 5725.7 5737.3 5768.3 6279.4 6280.4 6290.4 6291.5 6327.0 4605.4 5896.3 6063.0 6099.0 6140.4 6177.0 6203.3 6211.2 6211.6 6213.1 5920.7 6041.5 6109.3 6118.6 6163.5 6112.0 6159.3 6194.9 6211.0 6211.3 4868.5 4878.3 4879.3 4884.0 4906.0 4255.5 4298.0 4398.3 4420.4 4423.0 5661.4 5723.0 5725.9 5745.6 5766.7 6253.5 6256.0 6262.3 6272.5 6279.5 5575.4 5686.5 5702.1 5708.1 5759.9 5283.2 5292.4 5329.7 5362.8 5380.5 6270.8 6274.4 6295.0 6299.5 6307.3 6116.3 6208.1 6232.7 6296.0 6305.3 6226.3 6245.4 6261.2 6297.2 6320.0 6112.2 6129.0 6134.4 6143.2 6148.2 6091.4 6154.2 6272.5 6276.0 6277.6 6040.2 6041.5 6043.4 6044.5 6102.5 5049.7 5743.5 5935.1 5985.9 6007.0 5724.0 5803.7 5811.9 5865.3 5909.5 6079.3 6083.3 6092.5 6105.8 6136.0 5886.7 5893.4 5903.8 5906.3 5944.9 03:20:02 INFO - PROCESS | 1667 | 03:20:02 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:60463.11 Median:39818.80 stddev:123545.88 (310.3%) stddev-sans-first:123810.23 03:20:02 INFO - PROCESS | 1667 | Values: 426.4 522.7 580.6 633.2 640.2 29978.0 30646.2 30669.2 30718.1 31403.1 32970.7 33467.3 40775.8 40948.4 40962.8 9634.8 9787.1 9791.1 9797.1 9800.6 9620.7 9781.4 9783.5 9795.8 9824.2 9730.7 9792.7 9802.4 9821.8 9826.3 9791.2 9792.0 9846.6 9858.7 9887.5 9606.0 9727.3 9743.1 9745.4 9746.6 39857.4 39965.2 40037.6 40121.2 40125.6 2884.2 3209.1 3277.6 3323.8 3377.7 26190.2 26712.5 29009.6 30115.2 30142.2 2730.6 2802.6 2864.7 2869.3 2875.8 435459.0 436344.0 437632.0 439484.0 439672.0 46852.8 51306.0 61884.4 62285.7 62560.6 46324.0 46332.8 46431.0 46459.5 46587.1 15544.8 15781.4 15784.1 15801.9 15808.8 12608.2 12635.2 12686.0 12700.3 12700.6 14701.9 14704.7 14992.9 15017.0 15128.7 6303.5 6491.3 6513.4 6552.2 6570.8 961.5 988.6 989.8 1089.4 1091.7 25231.5 29409.9 29536.7 30241.5 30688.5 1060.2 1102.1 1109.0 1154.5 1224.3 12247.6 14831.9 14969.5 15101.3 15466.1 532925.0 533864.0 538936.0 538995.0 539202.0 59483.1 59857.4 60019.0 60037.8 60123.7 1326.4 1440.4 1465.6 1469.9 1545.4 28572.9 28667.6 28792.7 29272.6 29350.4 39780.2 56803.0 57562.4 57610.7 57656.6 404337.0 410521.0 412429.8 413542.0 413692.0 38069.0 43481.1 43852.8 43921.6 44847.8 42813.8 43311.8 43313.4 43728.0 45255.1 36152.9 36222.0 36446.6 36809.3 36957.1 35823.5 36583.4 36850.4 36954.6 37781.0 37071.1 37880.8 38110.4 38135.0 38141.0 32665.6 32839.5 32917.7 33198.0 33530.3 24694.8 24746.0 25158.2 25173.2 25333.7 03:20:02 INFO - PROCESS | 1667 | 03:20:02 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:33479.56 Median:15282.73 stddev:99411.46 (650.5%) stddev-sans-first:99659.22 03:20:02 INFO - PROCESS | 1667 | Values: 358.8 360.1 360.9 372.8 374.3 20019.3 20688.7 21098.5 21315.3 21589.4 20321.6 20469.8 21144.8 21399.9 21425.0 5636.9 5814.0 5841.9 5847.2 5854.9 5608.8 5794.9 5890.1 5896.3 5900.1 5876.6 5881.2 5895.9 5897.9 5904.7 5756.3 5770.6 5880.9 6027.0 6042.7 5703.7 5734.5 5737.1 5740.3 5741.9 21254.9 24298.5 25241.0 25448.4 25482.1 1954.6 2115.1 2160.1 2365.1 2390.3 9611.3 9821.1 10320.5 12410.8 15091.1 1580.1 1722.6 1780.0 1800.0 1821.3 82101.0 95971.0 98030.0 99447.0 103807.5 10841.9 10882.3 10939.7 11099.3 11230.2 12320.7 12670.0 12702.4 13171.5 13823.4 6484.7 6632.9 7670.5 8202.5 8428.9 8522.8 8562.1 8584.9 8624.9 8709.3 4322.4 4428.3 4442.0 4474.4 4494.4 1561.7 1779.3 1823.8 1879.5 1881.8 891.2 911.3 936.9 975.7 1039.5 15142.5 20724.6 20772.2 20906.7 20976.0 925.2 951.8 958.8 997.8 1006.7 10419.3 10970.7 11237.8 11339.3 11345.2 537983.0 544482.0 544817.3 673870.0 678769.0 73886.0 114554.0 130571.0 131338.0 134775.3 1018.9 1020.4 1044.2 1059.4 1066.5 18424.7 18691.3 18762.1 18964.4 19046.5 30206.7 42387.0 51172.7 51625.5 53975.0 64671.7 66240.3 70794.6 78129.2 79890.0 7731.2 7866.0 7915.4 8012.9 8202.5 11443.4 11650.9 12502.8 12794.6 12813.7 8288.0 8975.6 10806.5 10836.8 10966.2 10186.4 10595.9 10726.9 10823.6 11056.9 10186.2 10430.3 10482.8 11056.0 11391.5 7743.7 7787.4 7810.9 7880.9 8125.6 7884.1 8106.8 9063.6 10158.6 11157.6 03:20:02 INFO - PROCESS | 1667 | 03:20:02 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5996.75 Median:5445.45 stddev:3143.53 (57.7%) stddev-sans-first:3134.91 03:20:02 INFO - PROCESS | 1667 | Values: 1591.3 1615.8 1905.5 1991.8 2040.8 7071.8 8730.4 8821.9 8838.0 8839.5 7759.6 7965.1 8423.2 8629.2 8637.0 2423.4 2462.7 2462.8 2466.4 2468.9 2149.4 2416.7 2417.6 2500.1 2501.0 2041.5 2196.1 2410.6 2443.8 2456.3 2393.3 2424.7 2429.6 2450.6 2457.4 2354.3 2402.3 2402.5 2407.0 2424.3 8216.2 8389.7 8875.0 8975.6 8985.1 5369.0 5521.9 5536.8 5540.0 5550.4 3051.8 3268.5 3281.0 3507.6 3623.4 1026.7 1043.7 1054.3 1070.8 1071.9 11251.4 11481.2 11493.8 11614.7 11849.6 4481.6 4538.7 4601.8 4654.9 4655.5 9392.7 9392.8 9400.9 9410.2 9414.1 5286.8 5325.9 5326.8 5332.0 5335.7 4964.9 4965.0 4974.6 4975.3 4978.1 3124.9 3749.9 3755.6 3804.7 3807.0 1126.8 1129.1 1189.0 1195.6 1197.2 1315.9 1317.4 1351.8 1380.1 1382.7 8070.0 8257.4 8269.0 8269.6 8276.7 1169.3 1193.4 1195.6 1196.8 1234.1 6280.4 6287.8 6415.3 6432.5 6439.1 10531.2 10710.4 10765.5 10777.8 10914.9 10381.3 10669.8 10702.6 10712.8 10768.6 8270.6 8374.9 8390.0 8441.6 8461.4 7617.8 7913.8 7961.8 7967.0 7967.6 9206.5 9539.9 9548.0 9555.3 9642.4 9671.7 9854.7 9860.9 9879.9 9946.9 6918.3 7017.0 7038.6 7107.1 7122.3 8225.4 8250.5 8278.0 8306.5 8309.1 7319.9 7427.1 7472.3 7544.5 7596.0 7142.1 7332.6 7335.7 7424.8 7478.6 7662.5 7751.7 7754.8 7763.0 7766.7 6930.9 7024.1 7027.3 7037.6 7048.3 6832.4 7101.5 7104.0 7122.8 7135.8 03:20:02 INFO - PROCESS | 1667 | 03:20:02 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5784.84 Median:6583.67 stddev:1827.81 (27.8%) stddev-sans-first:1786.38 03:20:02 INFO - PROCESS | 1667 | Values: 323.5 324.6 330.6 331.6 334.6 6570.3 6574.5 6581.4 6585.9 6603.7 6431.0 6478.9 6508.3 6513.1 6516.5 4660.6 4740.7 4750.5 4857.4 4921.8 4838.7 4871.9 4899.2 4925.1 4925.7 4847.7 4855.3 4858.9 4872.7 4875.6 4599.9 4688.1 4783.7 4797.6 4816.3 4122.2 4137.1 4145.4 4151.9 4161.1 6279.5 6309.4 6320.8 6321.3 6351.6 5703.3 5706.0 5714.3 5725.3 5729.7 6730.6 7000.3 7002.1 7016.0 7021.4 4651.7 4707.9 4715.3 4718.6 4725.7 6012.9 7360.3 7396.3 7409.7 7444.6 4753.9 4760.8 4761.7 4763.7 4776.3 4823.7 4839.8 4839.9 4842.1 4846.4 5674.0 5692.0 5695.3 5696.3 5697.2 6672.7 7031.5 7032.4 7065.0 7103.5 1643.1 1683.6 1687.7 1688.8 1690.1 1020.4 1045.6 1080.3 1089.6 1115.1 6548.4 6651.1 6727.7 6730.9 6733.3 7351.0 7363.3 7368.2 7369.2 7382.3 6722.1 6726.8 6730.0 6743.9 6745.2 3717.6 3829.5 3869.4 3881.0 3890.8 6900.2 7369.5 7674.3 7719.1 7730.0 7541.1 7558.7 7570.7 7582.8 7584.0 7657.8 7677.5 7685.1 7686.6 7696.8 7083.6 7348.9 7353.6 7358.6 7366.3 7178.8 7220.7 7229.2 7230.6 7236.2 6813.1 7106.6 7627.5 7664.4 7684.0 4157.6 4773.2 4775.4 4784.7 4786.5 6989.8 7325.9 7346.6 7349.7 7350.9 6955.3 6971.9 6974.2 6977.9 6990.5 7035.0 7039.8 7042.9 7051.7 7059.6 6858.5 6864.5 6884.4 6886.9 6899.7 6812.0 7028.7 7055.6 7056.9 7092.1 5590.3 6695.4 6738.4 6741.7 6807.3 03:20:02 INFO - PROCESS | 1667 | 03:20:02 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:18323.21 Median:31837.63 stddev:25696.65 (80.7%) stddev-sans-first:25734.61 03:20:02 INFO - PROCESS | 1667 | Values: 687.7 747.8 762.4 766.1 772.5 11699.5 15222.9 15226.1 15252.0 15261.0 13848.5 14039.2 14059.2 14072.5 14081.7 732.8 741.6 911.8 914.6 935.2 811.9 929.5 931.4 934.4 936.1 983.7 989.6 991.2 993.3 995.9 769.5 967.3 987.9 989.3 989.9 730.7 732.3 734.3 736.3 739.0 14656.8 14724.6 14725.9 14772.1 14778.4 12398.5 12531.9 12626.6 12758.9 12855.6 9746.7 9848.3 9882.8 10196.8 10494.1 3484.3 3516.9 3519.1 3677.4 3717.2 79432.8 80103.0 80136.0 80205.0 80615.0 9217.5 9309.1 9456.0 9660.8 10017.3 21085.9 21292.0 21306.9 21326.3 21338.9 7428.6 7547.6 7665.0 7740.8 7849.6 4060.9 4082.3 4118.3 4133.6 4137.0 2797.3 3261.4 3262.6 3263.0 3268.5 562.5 612.3 634.7 659.0 671.0 579.9 582.6 583.9 600.2 600.7 8146.2 8176.6 8383.8 8480.2 8508.5 566.2 595.5 608.7 612.2 633.9 3696.6 3745.5 3800.3 3848.6 3885.2 91345.5 92511.5 93496.0 93554.0 93968.5 74206.6 76564.6 77828.0 78622.2 79044.6 63041.4 65789.0 65921.0 68045.7 68769.7 7114.9 8176.5 8548.3 8688.0 8732.2 49435.0 49735.8 49848.0 52091.2 52191.5 67327.7 70070.9 71368.0 74262.6 75951.6 11482.0 11624.1 11716.9 11882.3 12100.5 11924.1 12040.8 12075.7 12107.4 12387.0 11486.0 11566.5 11590.0 11627.0 11946.6 11412.9 11568.2 11740.9 11842.8 12017.4 11149.7 11310.5 11311.9 11336.0 11517.1 9295.2 9403.4 9713.1 9847.0 10017.9 9625.6 9681.3 9686.5 9738.1 9739.2 03:20:02 INFO - PROCESS | 1667 | -------- Summary: end -------- 03:20:02 INFO - PROCESS | 1667 | 03:20:02 INFO - TEST-INFO | 1667: exit 0 03:20:02 INFO - TEST-OK | dromaeo_css | took 1112376ms 03:20:02 INFO - TEST-START | kraken 03:20:02 INFO - operating with platform_type : mac_ 03:20:02 INFO - Initialising browser for kraken test... 03:20:02 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpx8Zhlz/profile http://localhost:49275/getInfo.html) 03:20:04 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 03:20:04 INFO - PROCESS | 1674 | colorDepth:24 03:20:04 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 03:20:04 INFO - PROCESS | 1674 | __metrics 03:20:04 INFO - PROCESS | 1674 | 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" 03:20:04 ERROR - PROCESS | 1674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:20:05 INFO - TEST-INFO | 1674: exit 0 03:20:05 INFO - Browser initialized. 03:20:05 INFO - Running cycle 1/1 for kraken test... 03:20:05 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/T/tmpx8Zhlz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:20:17 INFO - PROCESS | 1676 | RSS: Main: 235982848 03:20:17 INFO - PROCESS | 1676 | 03:20:19 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 03:20:20 INFO - PROCESS | 1676 | RSS: Main: 282116096 03:20:20 INFO - PROCESS | 1676 | 03:20:23 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 03:20:23 INFO - PROCESS | 1676 | RSS: Main: 292761600 03:20:23 INFO - PROCESS | 1676 | 03:20:27 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 03:20:27 INFO - PROCESS | 1676 | RSS: Main: 278503424 03:20:27 INFO - PROCESS | 1676 | 03:20:29 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 03:20:30 INFO - PROCESS | 1676 | RSS: Main: 280748032 03:20:30 INFO - PROCESS | 1676 | 03:20:32 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:20:33 INFO - PROCESS | 1676 | RSS: Main: 280371200 03:20:33 INFO - PROCESS | 1676 | 03:20:35 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:36 INFO - PROCESS | 1676 | RSS: Main: 280903680 03:20:36 INFO - PROCESS | 1676 | 03:20:39 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:40 INFO - PROCESS | 1676 | RSS: Main: 281116672 03:20:40 INFO - PROCESS | 1676 | 03:20:42 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 03:20:43 INFO - PROCESS | 1676 | RSS: Main: 281411584 03:20:43 INFO - PROCESS | 1676 | 03:20:45 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:45 INFO - PROCESS | 1676 | RSS: Main: 314892288 03:20:45 INFO - PROCESS | 1676 | 03:20:47 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:48 INFO - PROCESS | 1676 | RSS: Main: 314466304 03:20:48 INFO - PROCESS | 1676 | 03:20:50 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:50 INFO - PROCESS | 1676 | RSS: Main: 321863680 03:20:50 INFO - PROCESS | 1676 | 03:20:53 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:54 INFO - PROCESS | 1676 | RSS: Main: 322850816 03:20:54 INFO - PROCESS | 1676 | 03:20:56 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:57 INFO - PROCESS | 1676 | RSS: Main: 322998272 03:20:57 INFO - PROCESS | 1676 | 03:20:58 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 03:20:59 INFO - PROCESS | 1676 | RSS: Main: 385617920 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | __start_tp_report 03:20:59 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 03:20:59 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 03:20:59 INFO - PROCESS | 1676 | |i|pagename|runs| 03:20:59 INFO - PROCESS | 1676 | |0;ai-astar;109;107;109;109;111;110;115;110;110;109 03:20:59 INFO - PROCESS | 1676 | |1;audio-beat-detection;158;125;142;162;158;171;139;120;163;119 03:20:59 INFO - PROCESS | 1676 | |2;audio-dft;183;183;185;184;185;184;185;186;180;181 03:20:59 INFO - PROCESS | 1676 | |3;audio-fft;75;75;84;84;78;84;83;94;82;74 03:20:59 INFO - PROCESS | 1676 | |4;audio-oscillator;88;99;125;79;77;80;113;78;79;117 03:20:59 INFO - PROCESS | 1676 | |5;imaging-gaussian-blur;87;83;87;84;87;84;87;83;86;83 03:20:59 INFO - PROCESS | 1676 | |6;imaging-darkroom;101;91;132;149;132;92;104;149;93;94 03:20:59 INFO - PROCESS | 1676 | |7;imaging-desaturate;87;86;84;97;135;143;84;87;85;84 03:20:59 INFO - PROCESS | 1676 | |8;json-parse-financial;57;56;53;54;52;54;55;64;55;53 03:20:59 INFO - PROCESS | 1676 | |9;json-stringify-tinderbox;63;68;76;70;69;68;66;68;66;67 03:20:59 INFO - PROCESS | 1676 | |10;stanford-crypto-aes;84;84;83;83;82;82;83;82;84;85 03:20:59 INFO - PROCESS | 1676 | |11;stanford-crypto-ccm;143;134;108;126;130;129;132;122;118;142 03:20:59 INFO - PROCESS | 1676 | |12;stanford-crypto-pbkdf2;142;130;140;143;140;128;138;172;168;138 03:20:59 INFO - PROCESS | 1676 | |13;stanford-crypto-sha256-iterative;68;66;69;67;66;68;67;66;68;66 03:20:59 INFO - PROCESS | 1676 | __end_tp_report 03:20:59 INFO - PROCESS | 1676 | __start_cc_report 03:20:59 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1304 03:20:59 INFO - PROCESS | 1676 | __end_cc_report 03:20:59 INFO - PROCESS | 1676 | __startTimestamp1459851659090__endTimestamp 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | ------- Summary: start ------- 03:20:59 INFO - PROCESS | 1676 | Number of tests: 14 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#0] ai-astar Cycles:10 Average:109.90 Median:110.00 stddev:2.08 (1.9%) stddev-sans-first:2.18 03:20:59 INFO - PROCESS | 1676 | Values: 109.0 107.0 109.0 109.0 111.0 110.0 115.0 110.0 110.0 109.0 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#1] audio-beat-detection Cycles:10 Average:145.70 Median:158.00 stddev:19.35 (12.2%) stddev-sans-first:20.00 03:20:59 INFO - PROCESS | 1676 | Values: 158.0 125.0 142.0 162.0 158.0 171.0 139.0 120.0 163.0 119.0 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.50 stddev:1.90 (1.0%) stddev-sans-first:2.00 03:20:59 INFO - PROCESS | 1676 | Values: 183.0 183.0 185.0 184.0 185.0 184.0 185.0 186.0 180.0 181.0 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#3] audio-fft Cycles:10 Average:81.30 Median:83.50 stddev:6.06 (7.3%) stddev-sans-first:5.98 03:20:59 INFO - PROCESS | 1676 | Values: 75.0 75.0 84.0 84.0 78.0 84.0 83.0 94.0 82.0 74.0 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:79.00 stddev:18.56 (23.5%) stddev-sans-first:19.58 03:20:59 INFO - PROCESS | 1676 | Values: 88.0 99.0 125.0 79.0 77.0 80.0 113.0 78.0 79.0 117.0 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#5] imaging-gaussian-blur Cycles:10 Average:85.10 Median:86.50 stddev:1.85 (2.1%) stddev-sans-first:1.83 03:20:59 INFO - PROCESS | 1676 | Values: 87.0 83.0 87.0 84.0 87.0 84.0 87.0 83.0 86.0 83.0 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#6] imaging-darkroom Cycles:10 Average:113.70 Median:120.00 stddev:24.08 (20.1%) stddev-sans-first:25.10 03:20:59 INFO - PROCESS | 1676 | Values: 101.0 91.0 132.0 149.0 132.0 92.0 104.0 149.0 93.0 94.0 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:85.50 stddev:22.44 (26.2%) stddev-sans-first:23.49 03:20:59 INFO - PROCESS | 1676 | Values: 87.0 86.0 84.0 97.0 135.0 143.0 84.0 87.0 85.0 84.0 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:3.40 (6.2%) stddev-sans-first:3.55 03:20:59 INFO - PROCESS | 1676 | Values: 57.0 56.0 53.0 54.0 52.0 54.0 55.0 64.0 55.0 53.0 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:3.38 (5.0%) stddev-sans-first:3.04 03:20:59 INFO - PROCESS | 1676 | Values: 63.0 68.0 76.0 70.0 69.0 68.0 66.0 68.0 66.0 67.0 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.50 stddev:1.03 (1.2%) stddev-sans-first:1.05 03:20:59 INFO - PROCESS | 1676 | Values: 84.0 84.0 83.0 83.0 82.0 82.0 83.0 82.0 84.0 85.0 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#11] stanford-crypto-ccm Cycles:10 Average:128.40 Median:131.00 stddev:10.63 (8.1%) stddev-sans-first:9.87 03:20:59 INFO - PROCESS | 1676 | Values: 143.0 134.0 108.0 126.0 130.0 129.0 132.0 122.0 118.0 142.0 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:141.00 stddev:14.61 (10.4%) stddev-sans-first:15.48 03:20:59 INFO - PROCESS | 1676 | Values: 142.0 130.0 140.0 143.0 140.0 128.0 138.0 172.0 168.0 138.0 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - PROCESS | 1676 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.10 (1.6%) stddev-sans-first:1.12 03:20:59 INFO - PROCESS | 1676 | Values: 68.0 66.0 69.0 67.0 66.0 68.0 67.0 66.0 68.0 66.0 03:20:59 INFO - PROCESS | 1676 | -------- Summary: end -------- 03:20:59 INFO - PROCESS | 1676 | 03:20:59 INFO - TEST-INFO | 1676: exit 0 03:20:59 INFO - TEST-OK | kraken | took 57036ms 03:20:59 INFO - SUITE-END | took 1169s 03:20:59 INFO - Completed test suite (00:19:29) 03:20:59 INFO - javascript benchmark 03:20:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3441.5353927219826, 3486.3375958567854, 3516.982415087927, 3529.5411596492454, 3555.6799888010073, 5588.692621905793, 5621.0, 5628.099504079348, 5648.068068768654, 5654.971725141379, 5606.467385598372, 5633.436656334365, 5642.407547207536, 5649.039663257246, 5650.406707295737, 4273.636740877014, 5099.71951542665, 5103.106956282654, 5137.614678899079, 5203.4016088149965, 5213.582913366921, 5214.139666954948, 5215.295935048758, 5220.973895130538, 5227.999999999981, 5135.35808023997, 5153.123968925273, 5188.7146206958605, 5188.818391356303, 5199.350081239845, 5172.172452407615, 5206.140986737184, 5222.4255331913455, 5248.763805628718, 5293.179557168645, 5026.773795179189, 5065.290859279704, 5141.76862041209, 5156.510131537498, 5178.792848286064, 5521.0, 5525.392206857243, 5533.418991005967, 5539.723013849331, 5586.385497595261, 6102.938970610326, 6114.0828875669, 6118.0, 6128.693565321761, 6130.17242672238, 5238.947610523884, 6132.724027418777, 6142.86713775973, 6179.969100154515, 6218.782342617987, 4733.242681170997, 5725.599208055438, 5725.6850873202375, 5737.254156959611, 5768.250127483442, 6279.434850863444, 6280.403361680633, 6290.402411770874, 6291.5281353898645, 6327.0, 4605.424321959755, 5896.292444906639, 6063.029915213545, 6099.0374119281705, 6140.3552626974415, 6177.0, 6203.31763506014, 6211.223597050369, 6211.565190436626, 6213.099100630474, 5920.703964801743, 6041.5468839837185, 6109.266887973383, 6118.632882027093, 6163.476104531165, 6111.98679349419, 6159.291681456601, 6194.907076393858, 6211.0, 6211.254649442096, 4868.464468908417, 4878.341423907727, 4879.316895634614, 4884.0, 4905.950940490549, 4255.510616279105, 4297.978510107429, 4398.296272596369, 4420.403245561808, 4423.004823914658, 5661.433856614306, 5722.971385143048, 5725.8568535786935, 5745.569082318842, 5766.740496677659, 6253.468455181361, 6255.96872015637, 6262.3111457739615, 6272.498200143978, 6279.497640188774, 5575.4424557544735, 5686.516646085046, 5702.087665973424, 5708.058170401837, 5759.913601295984, 5283.233931079972, 5292.417834038252, 5329.733513324319, 5362.839114826562, 5380.515753582118, 6270.7805226816845, 6274.403931626488, 6295.024271237966, 6299.464545513591, 6307.337729538424, 6116.305337586134, 6208.068789681584, 6232.657203853832, 6295.96852015737, 6305.274893387135, 6226.346233645583, 6245.437910588069, 6261.24865016201, 6297.1813664223355, 6320.0, 6112.235970503687, 6129.049997250433, 6134.355892631388, 6143.201383820075, 6148.200733904564, 6091.42131497507, 6154.169187159855, 6272.466840318441, 6276.0, 6277.623342599459, 6040.244969378828, 6041.546883983631, 6043.395660433922, 6044.546659000504, 6102.481289090477, 5049.671771334852, 5743.4543718346695, 5935.080062590306, 5985.880282394241, 6007.0, 5723.971380143073, 5803.65178089316, 5811.912821307768, 5865.296164460292, 5909.468147866713, 6079.3008803988105, 6083.300420451705, 6092.543059270483, 6105.829739181415, 6135.969320153371, 5886.735096920735, 5893.410658934244, 5903.822885313448, 5906.26171728534, 5944.851378715567], "unit": "score", "name": "dojo.html", "value": 5633.605653857665}, {"lowerIsBetter": false, "replicates": [426.3668452348264, 522.6785526900952, 580.6080895395606, 633.2337871175876, 640.1773720768812, 29977.999999999975, 30646.241838234553, 30669.233269168228, 30718.07845764625, 31403.05790826273, 32970.67029329706, 33467.33065338692, 40775.796121019426, 40948.38577421333, 40962.79518602403, 9634.807303853919, 9787.119159275664, 9791.11879930806, 9797.06927841854, 9800.558974846113, 9620.71137865865, 9781.364211326276, 9783.532470129501, 9795.755106122368, 9824.21406287499, 9730.708078757612, 9792.657256996006, 9802.362846414995, 9821.803563928717, 9826.263030272758, 9791.16775074116, 9792.0, 9846.60613575456, 9858.65494707689, 9887.505624718735, 9606.039396060409, 9727.270454715925, 9743.123118919331, 9745.415275083447, 9746.610135594568, 39857.40213896765, 39965.20069598592, 40037.59962400368, 40121.19757604861, 40125.59874401248, 2884.2356775454523, 3209.1014515935344, 3277.6394596594355, 3323.7673362864607, 3377.7466689998105, 26190.214293571033, 26712.530810805398, 29009.56485652717, 30115.247118821986, 30142.246443839078, 2730.57676060211, 2802.607634931111, 2864.6562412510425, 2869.3113652723196, 2875.8418286994206, 435459.0, 436344.0, 437632.0, 439484.0, 439672.0, 46852.82867928261, 51306.0, 61884.38115618786, 62285.68857155776, 62560.55432516643, 46324.0, 46332.76833615878, 46430.96397468307, 46459.53540464552, 46587.06825863464, 15544.76682849758, 15781.447649332218, 15784.052956822627, 15801.920990395205, 15808.762868556982, 12608.180468269533, 12635.241885486901, 12686.0, 12700.301483418501, 12700.555480558136, 14701.852981470262, 14704.705905882036, 14992.925035374972, 15017.0, 15128.697426051418, 6303.46420554258, 6491.318411566812, 6513.413792758674, 6552.213734351908, 6570.8357291068105, 961.485605201214, 988.5946761827616, 989.7723523589615, 1089.3518356577824, 1091.6997825597866, 25231.495370092496, 29409.85295073511, 29536.704632953824, 30241.546376804366, 30688.53967190494, 1060.2101434431245, 1102.1403305421784, 1109.046220250584, 1154.5266440759249, 1224.3205021213312, 12247.571335003233, 14831.851681483264, 14969.476068337555, 15101.3204405802, 15466.14936178521, 532925.0, 533864.0, 538936.0, 538995.0, 539202.0, 59483.10775338373, 59857.401425986056, 60019.0, 60037.799244014874, 60123.69938150281, 1326.389860664086, 1440.4454285100103, 1465.5749832548443, 1469.9191544465157, 1545.358676149408, 28572.85713571419, 28667.56998645064, 28792.712072879003, 29272.56091158592, 29350.412991739617, 39780.2043959125, 56803.0, 57562.42437575738, 57610.71194644, 57656.55858603569, 404337.0, 410521.0, 412429.75702429516, 413542.0, 413692.0, 38069.0, 43481.13037739291, 43852.78073609739, 43921.56078439303, 44847.77576112099, 42813.785931070146, 43311.783441082596, 43313.350299744896, 43728.0, 45255.0948981012, 36152.915412537666, 36222.0, 36446.63553364432, 36809.26381472302, 36957.07607309839, 35823.46264806082, 36583.37318667224, 36850.44724329084, 36954.63045369512, 37781.0, 37071.07322316964, 37880.810595946845, 38110.42834357431, 38135.0, 38141.046473838374, 32665.578668665126, 32839.50740738843, 32917.72069630933, 33198.0, 33530.329393411506, 24694.753052469245, 24746.0, 25158.24525264245, 25173.24480265595, 25333.746662533875], "unit": "score", "name": "ext.html", "value": 19187.233020710206}, {"lowerIsBetter": false, "replicates": [358.77038695235046, 360.07460825678004, 360.88090929993103, 372.78192257529344, 374.33181770539574, 20019.299324523643, 20688.68966965495, 21098.472538186554, 21315.253966111188, 21589.352319430443, 20321.59356812863, 20469.795302046976, 21144.788552114474, 21399.93000349984, 21425.035873385736, 5636.915446268309, 5814.0, 5841.85395365115, 5847.239858818348, 5854.912176317359, 5608.775648974036, 5794.855128621797, 5890.145928840316, 5896.292444906617, 5900.085486749561, 5876.559258055641, 5881.206037184989, 5895.852603684921, 5897.852553686171, 5904.675242861641, 5756.338021127582, 5770.567207459437, 5880.882382352351, 6027.0, 6042.728077236491, 5703.686297253649, 5734.541236701054, 5737.110747834093, 5740.339860916007, 5741.856453588652, 21254.893725531274, 24298.514029719307, 25241.0, 25448.36379090519, 25482.10812621568, 1954.5797653504565, 2115.132795553831, 2160.1359456217483, 2365.0894405653776, 2390.25901970388, 9611.279154063403, 9821.116099551004, 10320.483975801255, 12410.81383779244, 15091.094534327865, 1580.1467207707824, 1722.6210233748554, 1779.9644007119784, 1800.0189896506436, 1821.2532861526843, 82101.0, 95971.0402895969, 98030.0, 99447.0, 103807.48096259471, 10841.945790270998, 10882.347059176474, 10939.671809845717, 11099.278546894426, 11230.15773816967, 12320.691982700504, 12670.0, 12702.42839072244, 13171.538996135088, 13823.447062117402, 6484.740610375627, 6632.933670663231, 7670.539767613961, 8202.548859812767, 8428.873566896502, 8522.829543409222, 8562.058173600899, 8584.914150858536, 8624.870626940601, 8709.303255739525, 4322.37325587788, 4428.2914733642465, 4441.978899600674, 4474.440694913136, 4494.438195225597, 1561.718890599703, 1779.3416435918793, 1823.781146262457, 1879.4925370149983, 1881.7647794025747, 891.157855826251, 911.3438324406417, 936.8735220745249, 975.7024107647236, 1039.5270152080784, 15142.470013549473, 20724.58550828975, 20772.1691132353, 20906.68639970371, 20975.951202440123, 925.167349385545, 951.8001219743793, 958.7938593202495, 997.7804882925744, 1006.6879267427121, 10419.270651054354, 10970.725731856768, 11237.83143252852, 11339.319640821577, 11345.205835591429, 537983.0, 544482.0, 544817.2759136179, 673870.0, 678769.0, 73886.0, 114554.0, 130571.0, 131338.0, 134775.32612337073, 1018.8675472188568, 1020.3520764314566, 1044.206403133624, 1059.422614675004, 1066.461436974323, 18424.723629145843, 18691.345802896834, 18762.061896904826, 18964.43106706801, 19046.523836904187, 30206.697933020387, 42387.0, 51172.74413627908, 51625.48374516207, 53975.0, 64671.67664161649, 66240.33759662342, 70794.64602676954, 78129.21870781446, 79890.0, 7731.226877312224, 7865.960670196841, 7915.366770658448, 8012.879806803019, 8202.466839655403, 11443.370614616277, 11650.941745291218, 12502.812232837865, 12794.616161515169, 12813.679658008625, 8288.0, 8975.596098175729, 10806.459677016275, 10836.783264334827, 10966.17753668494, 10186.439745814052, 10595.894041059799, 10726.946365268124, 10823.621173258898, 11056.889431105908, 10186.185105191418, 10430.26988110825, 10482.842757358798, 11056.0, 11391.54433822671, 7743.728969486041, 7787.415943804124, 7810.88283675734, 7880.881786773089, 8125.634346454305, 7884.132745398117, 8106.756797296091, 9063.637454501746, 10158.628585140912, 11157.553697851996], "unit": "score", "name": "jquery.html", "value": 9242.731400204546}, {"lowerIsBetter": false, "replicates": [1591.2521115075913, 1615.7980252468442, 1905.4950438133897, 1991.8406527477803, 2040.8367330613544, 7071.823204419886, 8730.432521886072, 8821.86767198491, 8837.955810220948, 8839.513826739527, 7759.573223472707, 7965.123836377994, 8423.199796019384, 8629.223369896708, 8637.0, 2423.3699238198105, 2462.7167875694345, 2462.827602067856, 2466.3957330453973, 2468.9259322220364, 2149.419656692692, 2416.7462416446283, 2417.601095819188, 2500.062476571286, 2501.0, 2041.4998325410295, 2196.0556960506974, 2410.5901996660523, 2443.8044956403533, 2456.3245107595376, 2393.2939782764124, 2424.73327933928, 2429.6112621980396, 2450.6079027355718, 2457.397937505305, 2354.281374596537, 2402.25530085674, 2402.5074859653905, 2406.9650050478285, 2424.3211900667666, 8216.178382161796, 8389.748307550783, 8875.0, 8975.596098175532, 8985.146411091002, 5368.973155134238, 5521.917171242435, 5536.778528858841, 5539.972300138514, 5550.361708403505, 3051.771117166199, 3268.477043673001, 3280.9671903281137, 3507.5615548056494, 3623.438367053111, 1026.7073883943115, 1043.7286305560533, 1054.3410368519676, 1070.7911957168355, 1071.8874518175635, 11251.43742812856, 11481.196316257865, 11493.770124597544, 11614.70963225926, 11849.644510664693, 4481.551844815557, 4538.659600529973, 4601.838935637236, 4654.860354189312, 4655.51117132703, 9392.718218453458, 9392.812143757223, 9400.90599094014, 9410.247180225566, 9414.058594140668, 5286.762095705702, 5325.920111198335, 5326.813561525328, 5332.0, 5335.67985920846, 4964.90070198594, 4964.975175124101, 4974.602031837517, 4975.328330675385, 4978.103941290602, 3124.937501249962, 3749.887503374903, 3755.586885442599, 3804.6766024887643, 3807.0101773538527, 1126.8364739699632, 1129.1249281806665, 1189.0, 1195.5994741761433, 1197.21582363552, 1315.9342032898317, 1317.4005827348533, 1351.8377794664702, 1380.130517773816, 1382.7303675783328, 8070.0, 8257.38069644767, 8269.04905935825, 8269.643151701735, 8276.710315138942, 1169.3159501691437, 1193.3734789235548, 1195.635331223985, 1196.8264601632889, 1234.1422711215619, 6280.434760871452, 6287.779927702509, 6415.294317625057, 6432.549721519449, 6439.130717353191, 10531.210159238088, 10710.357378557312, 10765.515551800188, 10777.78444431107, 10914.890851091388, 10381.325213861075, 10669.83995240072, 10702.625408110678, 10712.78574428507, 10768.623098191525, 8270.627821748036, 8374.874376884352, 8389.958050209832, 8441.620127094295, 8461.365397595206, 7617.771466856003, 7913.841723165619, 7961.8407631848195, 7966.960165199369, 7967.56178410193, 9206.493642849708, 9539.904600953902, 9547.952260238655, 9555.331126821335, 9642.373245739005, 9671.70984870455, 9854.704358869245, 9860.85208721884, 9879.901200988186, 9946.850797238192, 6918.308169183041, 7017.0, 7038.577685338896, 7107.147142342952, 7122.287771222836, 8225.383096267684, 8250.54621995796, 8277.95861020691, 8306.54314012735, 8309.127541608286, 7319.853602927805, 7427.1087469501845, 7472.327490525879, 7544.509606875536, 7596.0, 7142.107236595426, 7332.633368331455, 7335.7432489862595, 7424.777256682308, 7478.626068696434, 7662.463627546018, 7751.651175696994, 7754.7673569793, 7763.0, 7766.650500727594, 6930.930690693029, 7024.051753013277, 7027.262137475696, 7037.612931288828, 7048.330408611174, 6832.385085342343, 7101.4673899458785, 7103.964480177773, 7122.786316410516, 7135.750248741269], "unit": "score", "name": "mootools.html", "value": 4900.709779323033}, {"lowerIsBetter": false, "replicates": [323.5373416015098, 324.62505805794314, 330.5834648343087, 331.6236072058213, 334.64193313154937, 6570.277269500363, 6574.506911981596, 6581.407673309402, 6585.934140658592, 6603.702833372492, 6430.967845160768, 6478.870422591545, 6508.316626754194, 6513.088167656532, 6516.543841931067, 4660.557247061541, 4740.668153229275, 4750.453697824742, 4857.392825896763, 4921.753912304388, 4838.661293709441, 4871.926921096168, 4899.167141585921, 4925.113479573675, 4925.729084900329, 4847.709137451747, 4855.344528488662, 4858.902821943559, 4872.707637541741, 4875.609951203913, 4599.908001839961, 4688.085823264481, 4783.689060211075, 4797.568218860284, 4816.349792778, 4122.216778812016, 4137.110521237918, 4145.398917156996, 4151.941254979961, 4161.146964872224, 6279.488204718104, 6309.400606942333, 6320.778772742978, 6321.336259692758, 6351.618902865843, 5703.287089113861, 5706.029974904276, 5714.342850572196, 5725.341585717654, 5729.742161602738, 6730.56251343666, 7000.264972177899, 7002.124734408199, 7016.0, 7021.368076873106, 4651.697639653412, 4707.905841883177, 4715.339852420664, 4718.575328220477, 4725.66920315578, 6012.917674818531, 7360.300771426706, 7396.297351751521, 7409.666565004588, 7444.590547519884, 4753.904921901542, 4760.809567617326, 4761.6904901181315, 4763.69036012658, 4776.331313616097, 4823.686460380064, 4839.758012099381, 4839.903201935942, 4842.080004799077, 4846.442659094249, 5674.007048766532, 5691.971540142273, 5695.316562012585, 5696.259486266758, 5697.202391665171, 6672.7330906764155, 7031.507794454441, 7032.402245809061, 7065.046218760402, 7103.502754807114, 1643.1209303022824, 1683.5791052236941, 1687.6540309236823, 1688.8226736192769, 1690.0535700008036, 1020.4285600063839, 1045.6444808765057, 1080.330195278932, 1089.629525961177, 1115.052205625212, 6548.443382312556, 6651.102101216371, 6727.730890764413, 6730.899036514358, 6733.3266673333255, 7350.96324518374, 7363.337299643058, 7368.189499155089, 7369.226231245642, 7382.261773822682, 6722.1261236039, 6726.804767735384, 6729.966350168218, 6743.9325606743305, 6745.190577130776, 3717.628237176261, 3829.468212714881, 3869.4195870619633, 3880.9611903881164, 3890.824912878927, 6900.171979362408, 7369.520981136317, 7674.270944260286, 7719.112302085332, 7729.995100636994, 7541.132769731441, 7558.697652093964, 7570.697172113164, 7582.848343033108, 7584.0, 7657.808554786175, 7677.539347639159, 7685.077790665156, 7686.57723825195, 7696.807579810549, 7083.574985500886, 7348.926510734825, 7353.5955522446775, 7358.558486490828, 7366.337029667356, 7178.784636460915, 7220.675069621774, 7229.240929702306, 7230.6384680764695, 7236.20401755817, 6813.1142951415995, 7106.609136497542, 7627.5042122261875, 7664.386849051951, 7683.961580192064, 4157.605027522381, 4773.236282194832, 4775.403074615673, 4784.665073444826, 4786.545278198566, 6989.7553585624255, 7325.864491003903, 7346.59593722329, 7349.6692648832, 7350.852982940418, 6955.304469553004, 6971.930280697128, 6974.163100427981, 6977.860442791014, 6990.475714321345, 7035.0150978861975, 7039.824004399726, 7042.929570704432, 7051.717931282691, 7059.611721355374, 6858.451323894176, 6864.519483636098, 6884.4148247399535, 6886.931130688829, 6899.655017249218, 6811.9659401702675, 7028.683709232994, 7055.611941343275, 7056.929430705833, 7092.148942126978, 5590.273264475755, 6695.4308883745425, 6738.35985581369, 6741.685371352539, 6807.285235050248], "unit": "score", "name": "prototype.html", "value": 5171.453222987242}, {"lowerIsBetter": false, "replicates": [687.7352219395533, 747.8167848877026, 762.4053238473989, 766.0768773627777, 772.4862966127525, 11699.532018719252, 15222.923885380558, 15226.086434813906, 15252.0, 15260.999999999985, 13848.515301964433, 14039.157650540974, 14059.15645061297, 14072.507462238824, 14081.718365632682, 732.8204589875488, 741.6440108747804, 911.8495448251048, 914.5564401265381, 935.2237642756496, 811.9188081191893, 929.5120061967488, 931.417863835103, 934.3693007220133, 936.0826390137669, 983.7048885334407, 989.60910440376, 991.1773228220595, 993.2798720927342, 995.8954309797475, 769.4806005945992, 967.2987084363815, 987.916027137687, 989.3470309595632, 989.915857152143, 730.6931088942657, 732.2713899669862, 734.2804052029041, 736.3409748275317, 738.966746496409, 14656.780148297785, 14724.631884202874, 14725.926370368186, 14772.113673179536, 14778.408863645442, 12398.504059837596, 12531.93734031324, 12626.621201363974, 12758.872411275861, 12855.550055748005, 9746.658866939622, 9848.310618256724, 9882.80234395308, 10196.796064078751, 10494.108000819939, 3484.303139372136, 3516.859325626972, 3519.137811236238, 3677.42999835026, 3717.182219911615, 79432.80850787243, 80103.0, 80136.0, 80205.0, 80615.0, 9217.451868066371, 9309.069093090637, 9456.0, 9660.75848103803, 10017.348872323275, 21085.894570527355, 21292.0, 21306.893465532885, 21326.253581124587, 21338.893305533373, 7428.591427471433, 7547.5848828314965, 7665.0, 7740.7677769667, 7849.607519623996, 4060.8578699745367, 4082.2856000199845, 4118.258713431551, 4133.627973482401, 4136.9793151034055, 2797.2866918935947, 3261.4129456698024, 3262.5921759780026, 3262.951055734166, 3268.477043673001, 562.5134258866051, 612.3080918561997, 634.6858305138986, 658.9934100659028, 670.966451677424, 579.9449052340021, 582.6231891942731, 583.9474447299764, 600.1717629671114, 600.6576251536583, 8146.185381461806, 8176.6320515576945, 8383.771798405935, 8480.236778689947, 8508.489490630458, 566.1988286574451, 595.4700316718124, 608.6652341212404, 612.1888497740423, 633.8985762278013, 3696.5933747287777, 3745.4756334113245, 3800.2518841332744, 3848.5574158972076, 3885.1646895917515, 91345.54327228454, 92511.53744231236, 93496.0, 93554.0, 93968.53015734878, 74206.6289668559, 76564.61717691376, 77828.0, 78622.21377786263, 79044.60477697574, 63041.36958630447, 65789.0, 65921.0, 68045.65977170083, 68769.65615171992, 7114.893276600958, 8176.46852954556, 8548.316134709085, 8687.956560217159, 8732.170443807829, 49435.0, 49735.75132124316, 49848.0, 52091.21863172131, 52191.47808521866, 67327.66336168288, 70070.94893576499, 71368.0, 74262.62868685622, 75951.62024189843, 11482.0, 11624.128190385585, 11716.882831171579, 11882.28706277626, 12100.515979360727, 11924.105692073303, 12040.75918481608, 12075.698107547381, 12107.394630268627, 12387.0, 11486.0, 11566.47950842231, 11590.0, 11627.011704005254, 11946.641600751991, 11412.885871141183, 11568.190226684052, 11740.941295293469, 11842.82235766447, 12017.416255505108, 11149.665510034712, 11310.547578096784, 11311.886881131413, 11336.036436902956, 11517.07863370945, 9295.209907157967, 9403.43579385239, 9713.125818676353, 9847.029668481162, 10017.949910250401, 9625.56684949193, 9681.273904457054, 9686.467244301632, 9738.123568878835, 9739.172170365599], "unit": "score", "name": "yui.html", "value": 6927.523572120992}], "name": "dromaeo_css", "value": 7481.931714956643}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 107.0, 109.0, 109.0, 111.0, 110.0, 115.0, 110.0, 110.0, 109.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [158.0, 125.0, 142.0, 162.0, 158.0, 171.0, 139.0, 120.0, 163.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 145.7}, {"lowerIsBetter": true, "replicates": [183.0, 183.0, 185.0, 184.0, 185.0, 184.0, 185.0, 186.0, 180.0, 181.0], "unit": "score", "name": "audio-dft", "value": 183.6}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 84.0, 84.0, 78.0, 84.0, 83.0, 94.0, 82.0, 74.0], "unit": "score", "name": "audio-fft", "value": 81.3}, {"lowerIsBetter": true, "replicates": [88.0, 99.0, 125.0, 79.0, 77.0, 80.0, 113.0, 78.0, 79.0, 117.0], "unit": "score", "name": "audio-oscillator", "value": 93.5}, {"lowerIsBetter": true, "replicates": [87.0, 83.0, 87.0, 84.0, 87.0, 84.0, 87.0, 83.0, 86.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.1}, {"lowerIsBetter": true, "replicates": [101.0, 91.0, 132.0, 149.0, 132.0, 92.0, 104.0, 149.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 113.7}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 84.0, 97.0, 135.0, 143.0, 84.0, 87.0, 85.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [57.0, 56.0, 53.0, 54.0, 52.0, 54.0, 55.0, 64.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [63.0, 68.0, 76.0, 70.0, 69.0, 68.0, 66.0, 68.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 83.0, 83.0, 82.0, 82.0, 83.0, 82.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.2}, {"lowerIsBetter": true, "replicates": [143.0, 134.0, 108.0, 126.0, 130.0, 129.0, 132.0, 122.0, 118.0, 142.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.4}, {"lowerIsBetter": true, "replicates": [142.0, 130.0, 140.0, 143.0, 140.0, 128.0, 138.0, 172.0, 168.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 69.0, 67.0, 66.0, 68.0, 67.0, 66.0, 68.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.1}], "name": "kraken", "value": 1456.0000000000002}]} 03:20:59 INFO - Return code: 0 03:20:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:20:59 ERROR - # TBPL SUCCESS # 03:20:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:20:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:20:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:20:59 INFO - 2016-04-05 03:20:59.912 screenresolution[1680:9713] starting screenresolution argv=screenresolution get 03:20:59 INFO - 2016-04-05 03:20:59.915 screenresolution[1680:9713] Display 0: 1600x1200x32@60 03:20:59 INFO - 2016-04-05 03:20:59.921 screenresolution[1681:9716] starting screenresolution argv=screenresolution list 03:20:59 INFO - Available Modes on Display 0 03:20:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:20:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:20:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:20:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:21:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:21:00 INFO - Intel Iris: 03:21:00 INFO - Chipset Model: Intel Iris 03:21:00 INFO - Type: GPU 03:21:00 INFO - Bus: Built-In 03:21:00 INFO - VRAM (Dynamic, Max): 1536 MB 03:21:00 INFO - Vendor: Intel (0x8086) 03:21:00 INFO - Device ID: 0x0a2e 03:21:00 INFO - Revision ID: 0x0009 03:21:00 INFO - Displays: 03:21:00 INFO - Display: 03:21:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:21:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:21:00 INFO - Display Serial Number: 1600x1200 60 03:21:00 INFO - Main Display: Yes 03:21:00 INFO - Mirror: Off 03:21:00 INFO - Online: Yes 03:21:00 INFO - Rotation: Supported 03:21:00 INFO - Return code: 0 03:21:00 INFO - Running post-action listener: _resource_record_post_action 03:21:00 INFO - Running post-run listener: _resource_record_post_run 03:21:01 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 37545472; Write bytes: 701335040; Read time: 394; Write time: 1981 03:21:01 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 385333760; Write bytes: 374831104; Read time: 28555; Write time: 712 03:21:01 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 31358464; Write bytes: 297303552; Read time: 310; Write time: 1214 03:21:01 INFO - Running post-run listener: _upload_blobber_files 03:21:01 INFO - Blob upload gear active. 03:21:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:21:01 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 03:21:01 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'] 03:21:01 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 03:21:01 INFO - (blobuploader) - INFO - Open directory for files ... 03:21:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:21:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:21:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:02 INFO - (blobuploader) - INFO - Done attempting. 03:21:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:21:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:21:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:21:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:21:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:21:03 INFO - (blobuploader) - INFO - Done attempting. 03:21:03 INFO - (blobuploader) - INFO - Iteration through files over. 03:21:03 INFO - Return code: 0 03:21:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:21:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:21:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a56fa91993e6256da8b4863422df7ee368176714ef2338e347ec27eca7614a38ddd502a8482031a859a1bdc9855c40e0da4d5e3f0f143a8bbe8bdbc6901f3e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3b2384232f2a82fa6cd3db364aa9897033d833f5e27b92cc97e243c230fa3db89bedc30294b9808e64fe799628e4833383151127c634b95a82bbe568a4ab988"} 03:21:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:21:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:21:03 INFO - Contents: 03:21:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5a56fa91993e6256da8b4863422df7ee368176714ef2338e347ec27eca7614a38ddd502a8482031a859a1bdc9855c40e0da4d5e3f0f143a8bbe8bdbc6901f3e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3b2384232f2a82fa6cd3db364aa9897033d833f5e27b92cc97e243c230fa3db89bedc30294b9808e64fe799628e4833383151127c634b95a82bbe568a4ab988"} 03:21:03 INFO - Running post-run listener: copy_logs_to_upload_dir 03:21:03 INFO - Copying logs to upload dir... 03:21:03 INFO - mkdir: /builds/slave/test/build/upload/logs 03:21:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.232986 ========= master_lag: 6.78 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-05 03:21:10.635538) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-05 03:21:10.644080) ========= 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.lDL36FD0QD/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.fpjAPkULGq/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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/5a56fa91993e6256da8b4863422df7ee368176714ef2338e347ec27eca7614a38ddd502a8482031a859a1bdc9855c40e0da4d5e3f0f143a8bbe8bdbc6901f3e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3b2384232f2a82fa6cd3db364aa9897033d833f5e27b92cc97e243c230fa3db89bedc30294b9808e64fe799628e4833383151127c634b95a82bbe568a4ab988"} build_url:https://queue.taskcluster.net/v1/task/eWu2LSrZQRK8XkguVxMoWw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011278 build_url: 'https://queue.taskcluster.net/v1/task/eWu2LSrZQRK8XkguVxMoWw/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/5a56fa91993e6256da8b4863422df7ee368176714ef2338e347ec27eca7614a38ddd502a8482031a859a1bdc9855c40e0da4d5e3f0f143a8bbe8bdbc6901f3e9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3b2384232f2a82fa6cd3db364aa9897033d833f5e27b92cc97e243c230fa3db89bedc30294b9808e64fe799628e4833383151127c634b95a82bbe568a4ab988"}' ========= master_lag: 2.14 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-04-05 03:21:12.794632) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-04-05 03:21:12.802249) ========= 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.lDL36FD0QD/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.fpjAPkULGq/Listeners TMPDIR=/var/folders/20/pddrbtw532x46dt2fvfy5szh00000w/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.005263 ========= master_lag: 3.75 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-04-05 03:21:16.553944) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 03:21:16.554285) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-05 03:21:16.592049) ========= ========= Total master_lag: 13.11 =========