builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0183 starttime: 1458731802.87 results: success (0) buildid: 20160323021420 builduid: 4ee69a05ea024cf9bec811e8bf2e6334 revision: b39f70d900f792128d6f34b11210460817820c5a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:42.873062) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:42.873467) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:42.873762) ========= 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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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.006007 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:42.906507) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:42.909921) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:42.941947) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:42.942289) ========= 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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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.005178 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:42.996578) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:42.996884) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:42.997228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:42.997493) ========= 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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-23 04:16:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.8M=0.001s 2016-03-23 04:16:43 (11.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.093897 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:43.113466) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:43.113785) ========= 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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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.019831 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:43.175978) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-23 04:16:43.176317) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b39f70d900f792128d6f34b11210460817820c5a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b39f70d900f792128d6f34b11210460817820c5a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Q3NVokG3bm/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.1yIWNSqOkC/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-23 04:16:43,253 truncating revision to first 12 chars 2016-03-23 04:16:43,253 Setting DEBUG logging. 2016-03-23 04:16:43,254 attempt 1/10 2016-03-23 04:16:43,254 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b39f70d900f7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 04:16:43,989 unpacking tar archive at: mozilla-aurora-b39f70d900f7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.986166 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-23 04:16:44.185152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:44.185500) ========= echo b39f70d900f792128d6f34b11210460817820c5a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b39f70d900f792128d6f34b11210460817820c5a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Q3NVokG3bm/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.1yIWNSqOkC/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 b39f70d900f792128d6f34b11210460817820c5a program finished with exit code 0 elapsedTime=0.004958 script_repo_revision: 'b39f70d900f792128d6f34b11210460817820c5a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:44.242140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:44.242444) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 04:16:44.265104) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-23 04:16:44.265435) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Q3NVokG3bm/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.1yIWNSqOkC/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:16:44 INFO - MultiFileLogger online at 20160323 04:16:44 in /builds/slave/test 04:16:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 04:16:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:16:44 INFO - {'append_to_log': False, 04:16:44 INFO - 'base_work_dir': '/builds/slave/test', 04:16:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 04:16:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:16:44 INFO - 'branch': 'Mozilla-Aurora', 04:16:44 INFO - 'buildbot_json_path': 'buildprops.json', 04:16:44 INFO - 'config_files': ('talos/mac_config.py',), 04:16:44 INFO - 'default_actions': ('clobber', 04:16:44 INFO - 'read-buildbot-config', 04:16:44 INFO - 'download-and-extract', 04:16:44 INFO - 'populate-webroot', 04:16:44 INFO - 'create-virtualenv', 04:16:44 INFO - 'install', 04:16:44 INFO - 'run-tests'), 04:16:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:16:44 INFO - 'download_minidump_stackwalk': True, 04:16:44 INFO - 'download_symbols': 'ondemand', 04:16:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:16:44 INFO - 'tooltool.py': '/tools/tooltool.py', 04:16:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:16:44 INFO - '/tools/misc-python/virtualenv.py')}, 04:16:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:16:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:16:44 INFO - 'installer_path': 'installer.exe', 04:16:44 INFO - 'log_level': 'info', 04:16:44 INFO - 'log_name': 'talos', 04:16:44 INFO - 'log_to_console': True, 04:16:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:16:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:16:44 INFO - 'opt_config_files': (), 04:16:44 INFO - 'pip_index': False, 04:16:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:16:44 INFO - 'cmd': ('bash', 04:16:44 INFO - '-c', 04:16:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:16:44 INFO - 'enabled': True, 04:16:44 INFO - 'halt_on_failure': False, 04:16:44 INFO - 'name': 'check_screen_resolution'},), 04:16:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:16:44 INFO - 'cmd': ('bash', 04:16:44 INFO - '-c', 04:16:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:16:44 INFO - 'enabled': True, 04:16:44 INFO - 'halt_on_failure': False, 04:16:44 INFO - 'name': 'check_screen_resolution'},), 04:16:44 INFO - 'run_cmd_checks_enabled': True, 04:16:44 INFO - 'sps_profile': False, 04:16:44 INFO - 'sps_profile_interval': 0, 04:16:44 INFO - 'suite': 'dromaeojs', 04:16:44 INFO - 'system_bits': '32', 04:16:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:16:44 INFO - 'title': 't-yosemite-r7-0183', 04:16:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:16:44 INFO - 'use_talos_json': True, 04:16:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:16:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:16:44 INFO - 'work_dir': 'build'} 04:16:44 INFO - ##### 04:16:44 INFO - ##### Running clobber step. 04:16:44 INFO - ##### 04:16:44 INFO - Running pre-action listener: _resource_record_pre_action 04:16:44 INFO - Running main action method: clobber 04:16:44 INFO - rmtree: /builds/slave/test/build 04:16:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:16:46 INFO - Running post-action listener: _resource_record_post_action 04:16:46 INFO - ##### 04:16:46 INFO - ##### Running read-buildbot-config step. 04:16:46 INFO - ##### 04:16:46 INFO - Running pre-action listener: _resource_record_pre_action 04:16:46 INFO - Running main action method: read_buildbot_config 04:16:46 INFO - Using buildbot properties: 04:16:46 INFO - { 04:16:46 INFO - "project": "", 04:16:46 INFO - "product": "firefox", 04:16:46 INFO - "script_repo_revision": "production", 04:16:46 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 04:16:46 INFO - "repository": "", 04:16:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 04:16:46 INFO - "buildid": "20160323021420", 04:16:46 INFO - "pgo_build": "False", 04:16:46 INFO - "basedir": "/builds/slave/test", 04:16:46 INFO - "buildnumber": 136, 04:16:46 INFO - "slavename": "t-yosemite-r7-0183", 04:16:46 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 04:16:46 INFO - "platform": "yosemite_r7", 04:16:46 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 04:16:46 INFO - "branch": "mozilla-aurora", 04:16:46 INFO - "repo_path": "releases/mozilla-aurora", 04:16:46 INFO - "revision": "b39f70d900f792128d6f34b11210460817820c5a", 04:16:46 INFO - "stage_platform": "macosx64", 04:16:46 INFO - "builduid": "4ee69a05ea024cf9bec811e8bf2e6334", 04:16:46 INFO - "slavebuilddir": "test" 04:16:46 INFO - } 04:16:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 04:16:46 INFO - Running post-action listener: _resource_record_post_action 04:16:46 INFO - ##### 04:16:46 INFO - ##### Running download-and-extract step. 04:16:46 INFO - ##### 04:16:46 INFO - Running pre-action listener: _resource_record_pre_action 04:16:46 INFO - Running main action method: download_and_extract 04:16:46 INFO - mkdir: /builds/slave/test/build/tests 04:16: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')]} 04:16:46 INFO - https://queue.taskcluster.net/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:16:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 04:16:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 04:16:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 04:16:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 04:16:47 INFO - Downloaded 1277 bytes. 04:16:47 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 04:16:47 INFO - Using the following test package requirements: 04:16:47 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 04:16:47 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:16:47 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 04:16:47 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:16:47 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 04:16:47 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:16:47 INFO - u'jsshell-mac.zip'], 04:16:47 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:16:47 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 04:16:47 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 04:16:47 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:16:47 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 04:16:47 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:16:47 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 04:16:47 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:16:47 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 04:16:47 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 04:16:47 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 04:16:47 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 04:16:47 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 04:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:47 INFO - https://queue.taskcluster.net/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:16:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:16:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:16:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:16:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:16:49 INFO - Downloaded 17869029 bytes. 04:16:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:16:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:16:52 INFO - Return code: 0 04:16:52 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 04:16:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:52 INFO - https://queue.taskcluster.net/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:16:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:16:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:16:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 04:16:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 04:16:53 INFO - Downloaded 17869029 bytes. 04:16:53 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:16:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:16:57 INFO - Return code: 0 04:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:57 INFO - https://queue.taskcluster.net/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:16:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 04:16:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 04:16:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 04:16:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 04:16:58 INFO - Downloaded 10845161 bytes. 04:16:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:16:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:16:58 INFO - Return code: 0 04:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:58 INFO - https://queue.taskcluster.net/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 04:16:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 04:16:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 04:16:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 04:16:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 04:17:04 INFO - Downloaded 114959497 bytes. 04:17:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 04:17:04 INFO - mkdir: /builds/slave/test/properties 04:17:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:17:04 INFO - Writing to file /builds/slave/test/properties/build_url 04:17:04 INFO - Contents: 04:17:04 INFO - build_url:https://queue.taskcluster.net/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 04:17:05 INFO - Running post-action listener: _resource_record_post_action 04:17:05 INFO - Running post-action listener: set_extra_try_arguments 04:17:05 INFO - ##### 04:17:05 INFO - ##### Running populate-webroot step. 04:17:05 INFO - ##### 04:17:05 INFO - Running pre-action listener: _resource_record_pre_action 04:17:05 INFO - Running main action method: populate_webroot 04:17:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:17:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:17:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:17:05 INFO - '--tppagecycles', 04:17:05 INFO - '7'], 04:17:05 INFO - 'tests': ['tsvgm']}}, 04:17:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:17:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:17:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:17:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:17:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:17:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:17:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:17:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:05 INFO - 'talos_options': ['--e10s'], 04:17:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:17:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:05 INFO - 'tests': ['damp', 'tps']}, 04:17:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:05 INFO - 'talos_options': ['--e10s'], 04:17:05 INFO - 'tests': ['damp', 'tps']}, 04:17:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:17:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:17:05 INFO - 'other': {'tests': ['a11yr', 04:17:05 INFO - 'ts_paint', 04:17:05 INFO - 'tpaint', 04:17:05 INFO - 'sessionrestore', 04:17:05 INFO - 'sessionrestore_no_auto_restore', 04:17:05 INFO - 'tabpaint']}, 04:17:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:17:05 INFO - 'tests': ['a11yr', 04:17:05 INFO - 'ts_paint', 04:17:05 INFO - 'tpaint', 04:17:05 INFO - 'sessionrestore', 04:17:05 INFO - 'sessionrestore_no_auto_restore', 04:17:05 INFO - 'tabpaint']}, 04:17:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:17:05 INFO - 'tests': ['a11yr', 04:17:05 INFO - 'ts_paint', 04:17:05 INFO - 'tpaint', 04:17:05 INFO - 'sessionrestore', 04:17:05 INFO - 'sessionrestore_no_auto_restore', 04:17:05 INFO - 'tabpaint']}, 04:17:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:17:05 INFO - 'tests': ['a11yr', 04:17:05 INFO - 'ts_paint', 04:17:05 INFO - 'tpaint', 04:17:05 INFO - 'sessionrestore', 04:17:05 INFO - 'sessionrestore_no_auto_restore', 04:17:05 INFO - 'tabpaint']}, 04:17:05 INFO - 'other_l64': {'tests': ['a11yr', 04:17:05 INFO - 'ts_paint', 04:17:05 INFO - 'tpaint', 04:17:05 INFO - 'sessionrestore', 04:17:05 INFO - 'sessionrestore_no_auto_restore', 04:17:05 INFO - 'tabpaint']}, 04:17:05 INFO - 'other_nol64': {'tests': ['a11yr', 04:17:05 INFO - 'ts_paint', 04:17:05 INFO - 'tpaint', 04:17:05 INFO - 'sessionrestore', 04:17:05 INFO - 'sessionrestore_no_auto_restore', 04:17:05 INFO - 'tabpaint']}, 04:17:05 INFO - 'svgr': {'tests': ['tsvgx', 04:17:05 INFO - 'tsvgr_opacity', 04:17:05 INFO - 'tart', 04:17:05 INFO - 'tscrollx', 04:17:05 INFO - 'cart']}, 04:17:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:17:05 INFO - 'tests': ['tsvgx', 04:17:05 INFO - 'tsvgr_opacity', 04:17:05 INFO - 'tart', 04:17:05 INFO - 'tscrollx', 04:17:05 INFO - 'cart']}, 04:17:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:05 INFO - 'tests': ['tp5o']}, 04:17:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:05 INFO - 'talos_options': ['--e10s'], 04:17:05 INFO - 'tests': ['tp5o']}, 04:17:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:05 INFO - 'talos_options': ['--xperf_path', 04:17:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:17:05 INFO - 'tests': ['tp5n']}, 04:17:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:17:05 INFO - 'talos_options': ['--e10s', 04:17:05 INFO - '--xperf_path', 04:17:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:17:05 INFO - 'tests': ['tp5n']}}, 04:17:05 INFO - 'talos.zip': {'path': '', 04:17:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:17:05 INFO - Running post-action listener: _resource_record_post_action 04:17:05 INFO - ##### 04:17:05 INFO - ##### Running create-virtualenv step. 04:17:05 INFO - ##### 04:17:05 INFO - Running pre-action listener: _resource_record_pre_action 04:17:05 INFO - Running main action method: create_virtualenv 04:17:05 INFO - Creating virtualenv /builds/slave/test/build/venv 04:17:05 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 04:17:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:17:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:17:05 INFO - Using real prefix '/tools/python27' 04:17:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:17:06 INFO - Installing distribute.............................................................................................................................................................................................done. 04:17:08 INFO - Installing pip.................done. 04:17:08 INFO - Return code: 0 04:17:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:08 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 0x108859a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088604c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc881c1dff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fdd30>, '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 0x108561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f4b20>, '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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:17:08 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 04:17:08 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 04:17:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q3NVokG3bm/Render', 04:17:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:08 INFO - 'HOME': '/Users/cltbld', 04:17:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:08 INFO - 'LOGNAME': 'cltbld', 04:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:08 INFO - 'MOZ_NO_REMOTE': '1', 04:17:08 INFO - 'NO_EM_RESTART': '1', 04:17:08 INFO - 'PAGER': '/bin/cat', 04:17:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:08 INFO - 'PWD': '/builds/slave/test', 04:17:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:08 INFO - 'SHELL': '/bin/bash', 04:17:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1yIWNSqOkC/Listeners', 04:17:08 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:17:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:08 INFO - 'USER': 'cltbld', 04:17:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:08 INFO - 'XPC_FLAGS': '0x0', 04:17:08 INFO - 'XPC_SERVICE_NAME': '0', 04:17:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:09 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 04:17:09 INFO - Cleaning up... 04:17:09 INFO - Return code: 0 04:17:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:09 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 0x108859a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088604c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc881c1dff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fdd30>, '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 0x108561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f4b20>, '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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:17:09 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 04:17:09 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 04:17:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q3NVokG3bm/Render', 04:17:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:09 INFO - 'HOME': '/Users/cltbld', 04:17:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:09 INFO - 'LOGNAME': 'cltbld', 04:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:09 INFO - 'MOZ_NO_REMOTE': '1', 04:17:09 INFO - 'NO_EM_RESTART': '1', 04:17:09 INFO - 'PAGER': '/bin/cat', 04:17:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:09 INFO - 'PWD': '/builds/slave/test', 04:17:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:09 INFO - 'SHELL': '/bin/bash', 04:17:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1yIWNSqOkC/Listeners', 04:17:09 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:17:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:09 INFO - 'USER': 'cltbld', 04:17:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:09 INFO - 'XPC_FLAGS': '0x0', 04:17:09 INFO - 'XPC_SERVICE_NAME': '0', 04:17:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:09 INFO - Downloading/unpacking psutil>=0.7.1 04:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:17:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:11 INFO - Installing collected packages: psutil 04:17:11 INFO - Running setup.py install for psutil 04:17:12 INFO - building 'psutil._psutil_osx' extension 04:17:12 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 04:17:12 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 04:17:12 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 04:17:12 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 04:17:12 INFO - building 'psutil._psutil_posix' extension 04:17:12 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 04:17:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:17:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:17:12 INFO - ^ 04:17:12 INFO - 1 warning generated. 04:17:12 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 04:17:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:17:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:17:12 INFO - Successfully installed psutil 04:17:12 INFO - Cleaning up... 04:17:12 INFO - Return code: 0 04:17:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108859a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088604c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc881c1dff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fdd30>, '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 0x108561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f4b20>, '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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:17:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:17:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q3NVokG3bm/Render', 04:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:12 INFO - 'HOME': '/Users/cltbld', 04:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:12 INFO - 'LOGNAME': 'cltbld', 04:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:12 INFO - 'MOZ_NO_REMOTE': '1', 04:17:12 INFO - 'NO_EM_RESTART': '1', 04:17:12 INFO - 'PAGER': '/bin/cat', 04:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:12 INFO - 'PWD': '/builds/slave/test', 04:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:12 INFO - 'SHELL': '/bin/bash', 04:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1yIWNSqOkC/Listeners', 04:17:12 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:12 INFO - 'USER': 'cltbld', 04:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:12 INFO - 'XPC_FLAGS': '0x0', 04:17:12 INFO - 'XPC_SERVICE_NAME': '0', 04:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:13 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:17:13 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 04:17:13 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 04:17:13 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 04:17:13 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 04:17:13 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 04:17:13 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 04:17:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:17:15 INFO - Installing collected packages: mozsystemmonitor 04:17:15 INFO - Running setup.py install for mozsystemmonitor 04:17:15 INFO - Successfully installed mozsystemmonitor 04:17:15 INFO - Cleaning up... 04:17:15 INFO - Return code: 0 04:17:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:15 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 0x108859a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088604c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc881c1dff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fdd30>, '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 0x108561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f4b20>, '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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:17:15 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 04:17:15 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 04:17:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q3NVokG3bm/Render', 04:17:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:15 INFO - 'HOME': '/Users/cltbld', 04:17:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:15 INFO - 'LOGNAME': 'cltbld', 04:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:15 INFO - 'MOZ_NO_REMOTE': '1', 04:17:15 INFO - 'NO_EM_RESTART': '1', 04:17:15 INFO - 'PAGER': '/bin/cat', 04:17:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:15 INFO - 'PWD': '/builds/slave/test', 04:17:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:15 INFO - 'SHELL': '/bin/bash', 04:17:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1yIWNSqOkC/Listeners', 04:17:15 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:17:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:15 INFO - 'USER': 'cltbld', 04:17:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:15 INFO - 'XPC_FLAGS': '0x0', 04:17:15 INFO - 'XPC_SERVICE_NAME': '0', 04:17:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:16 INFO - Downloading/unpacking blobuploader==1.2.4 04:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:18 INFO - Downloading blobuploader-1.2.4.tar.gz 04:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:17:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:17:18 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 04:17:18 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 04:17:18 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 04:17:18 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 04:17:18 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 04:17:18 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 04:17:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:17:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:19 INFO - Downloading docopt-0.6.1.tar.gz 04:17:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:17:19 INFO - Installing collected packages: blobuploader, requests, docopt 04:17:19 INFO - Running setup.py install for blobuploader 04:17:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:17:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:17:19 INFO - Running setup.py install for requests 04:17:20 INFO - Running setup.py install for docopt 04:17:20 INFO - Successfully installed blobuploader requests docopt 04:17:20 INFO - Cleaning up... 04:17:20 INFO - Return code: 0 04:17:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:20 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')]} 04:17:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:20 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')]} 04:17:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:20 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 0x108859a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088604c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc881c1dff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fdd30>, '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 0x108561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f4b20>, '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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:17:20 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 04:17:20 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 04:17:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q3NVokG3bm/Render', 04:17:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:20 INFO - 'HOME': '/Users/cltbld', 04:17:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:20 INFO - 'LOGNAME': 'cltbld', 04:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:20 INFO - 'MOZ_NO_REMOTE': '1', 04:17:20 INFO - 'NO_EM_RESTART': '1', 04:17:20 INFO - 'PAGER': '/bin/cat', 04:17:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:20 INFO - 'PWD': '/builds/slave/test', 04:17:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:20 INFO - 'SHELL': '/bin/bash', 04:17:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1yIWNSqOkC/Listeners', 04:17:20 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:17:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:20 INFO - 'USER': 'cltbld', 04:17:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:20 INFO - 'XPC_FLAGS': '0x0', 04:17:20 INFO - 'XPC_SERVICE_NAME': '0', 04:17:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:20 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-0XEG01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:20 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-LRr57v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:21 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-es2W8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:21 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-7BcOi_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:21 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-1zAhnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:21 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-IF8KH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:21 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-j5EXGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:21 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-nwqU2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:21 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-itu7ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:21 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-plUQbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:21 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-oml_bq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:21 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-vJH_rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:22 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-MhNri2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:22 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-xfXVaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:22 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-uPAutT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:22 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-4v06D0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:22 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-tM9xAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:17:22 INFO - Running setup.py install for manifestparser 04:17:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:17:22 INFO - Running setup.py install for mozcrash 04:17:22 INFO - Running setup.py install for mozdebug 04:17:22 INFO - Running setup.py install for mozdevice 04:17:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:17:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:17:23 INFO - Running setup.py install for mozfile 04:17:23 INFO - Running setup.py install for mozhttpd 04:17:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:17:23 INFO - Running setup.py install for mozinfo 04:17:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:17:23 INFO - Running setup.py install for mozInstall 04:17:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:17:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:17:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:17:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:17:23 INFO - Running setup.py install for mozleak 04:17:23 INFO - Running setup.py install for mozlog 04:17:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:17:24 INFO - Running setup.py install for moznetwork 04:17:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:17:24 INFO - Running setup.py install for mozprocess 04:17:24 INFO - Running setup.py install for mozprofile 04:17:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:17:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:17:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:17:24 INFO - Running setup.py install for mozrunner 04:17:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:17:24 INFO - Running setup.py install for mozscreenshot 04:17:24 INFO - Running setup.py install for moztest 04:17:24 INFO - Running setup.py install for mozversion 04:17:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:17:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:17:25 INFO - Cleaning up... 04:17:25 INFO - Return code: 0 04:17:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17:25 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')]} 04:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:25 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')]} 04:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:25 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 0x108859a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088604c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc881c1dff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fdd30>, '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 0x108561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f4b20>, '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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:17:25 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 04:17:25 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 04:17:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q3NVokG3bm/Render', 04:17:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:25 INFO - 'HOME': '/Users/cltbld', 04:17:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:25 INFO - 'LOGNAME': 'cltbld', 04:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:25 INFO - 'MOZ_NO_REMOTE': '1', 04:17:25 INFO - 'NO_EM_RESTART': '1', 04:17:25 INFO - 'PAGER': '/bin/cat', 04:17:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:25 INFO - 'PWD': '/builds/slave/test', 04:17:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:25 INFO - 'SHELL': '/bin/bash', 04:17:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1yIWNSqOkC/Listeners', 04:17:25 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:17:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:25 INFO - 'USER': 'cltbld', 04:17:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:25 INFO - 'XPC_FLAGS': '0x0', 04:17:25 INFO - 'XPC_SERVICE_NAME': '0', 04:17:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:17:25 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-kVAb_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:17:25 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)) 04:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:17:25 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-8_X7sI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:17:25 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)) 04:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:17:25 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-PRYhae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:17:25 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)) 04:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:17:25 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-5QXrIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:17:25 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)) 04:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:17:25 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-Sp4zSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:17:25 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)) 04:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:17:25 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-esMAPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:17:26 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)) 04:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:17:26 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-vHkmdt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:17:26 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)) 04:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:17:26 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-HsbrJ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:17:26 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)) 04:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:17:26 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-y6WZ9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:17:26 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)) 04:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:17:26 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-dzBDXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:17:26 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)) 04:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:17:26 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-HatAGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:17:26 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)) 04:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:17:26 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-tQjrLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:17:26 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)) 04:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:17:26 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-i0nmrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:17:26 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)) 04:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:17:26 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-JnWtPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:17:26 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)) 04:17:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:26 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-VxA75p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:17:27 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)) 04:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:17:27 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-drNNvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:17:27 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)) 04:17:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:17:27 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-O4Ge85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:17:27 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)) 04:17:27 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)) 04:17:27 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)) 04:17:27 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)) 04:17:27 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)) 04:17:27 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)) 04:17:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:29 INFO - Downloading blessings-1.6.tar.gz 04:17:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:17:29 INFO - Installing collected packages: blessings 04:17:29 INFO - Running setup.py install for blessings 04:17:29 INFO - Successfully installed blessings 04:17:29 INFO - Cleaning up... 04:17:30 INFO - Return code: 0 04:17:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:17:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:30 INFO - Reading from file tmpfile_stdout 04:17:30 INFO - Current package versions: 04:17:30 INFO - blessings == 1.6 04:17:30 INFO - blobuploader == 1.2.4 04:17:30 INFO - docopt == 0.6.1 04:17:30 INFO - manifestparser == 1.1 04:17:30 INFO - mozInstall == 1.12 04:17:30 INFO - mozcrash == 0.17 04:17:30 INFO - mozdebug == 0.1 04:17:30 INFO - mozdevice == 0.48 04:17:30 INFO - mozfile == 1.2 04:17:30 INFO - mozhttpd == 0.7 04:17:30 INFO - mozinfo == 0.9 04:17:30 INFO - mozleak == 0.1 04:17:30 INFO - mozlog == 3.1 04:17:30 INFO - moznetwork == 0.27 04:17:30 INFO - mozprocess == 0.22 04:17:30 INFO - mozprofile == 0.28 04:17:30 INFO - mozrunner == 6.11 04:17:30 INFO - mozscreenshot == 0.1 04:17:30 INFO - mozsystemmonitor == 0.0 04:17:30 INFO - moztest == 0.7 04:17:30 INFO - mozversion == 1.4 04:17:30 INFO - psutil == 3.1.1 04:17:30 INFO - requests == 1.2.3 04:17:30 INFO - wsgiref == 0.1.2 04:17:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:30 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 0x108859a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088604c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc881c1dff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fdd30>, '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 0x108561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f4b20>, '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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:17:30 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 04:17:30 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 04:17:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q3NVokG3bm/Render', 04:17:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:30 INFO - 'HOME': '/Users/cltbld', 04:17:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:30 INFO - 'LOGNAME': 'cltbld', 04:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:30 INFO - 'MOZ_NO_REMOTE': '1', 04:17:30 INFO - 'NO_EM_RESTART': '1', 04:17:30 INFO - 'PAGER': '/bin/cat', 04:17:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:30 INFO - 'PWD': '/builds/slave/test', 04:17:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:30 INFO - 'SHELL': '/bin/bash', 04:17:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1yIWNSqOkC/Listeners', 04:17:30 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:17:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:30 INFO - 'USER': 'cltbld', 04:17:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:30 INFO - 'XPC_FLAGS': '0x0', 04:17:30 INFO - 'XPC_SERVICE_NAME': '0', 04:17:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:30 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)) 04:17:30 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)) 04:17:30 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)) 04:17:30 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)) 04:17:30 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)) 04:17:30 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)) 04:17:30 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)) 04:17:30 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)) 04:17:30 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)) 04:17:30 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)) 04:17:30 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)) 04:17:30 INFO - Cleaning up... 04:17:30 INFO - Return code: 0 04:17:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:17: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')]} 04:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17: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')]} 04:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:30 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 0x108859a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088604c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc881c1dff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fdd30>, '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 0x108561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f4b20>, '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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:17:30 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 04:17:30 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 04:17:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q3NVokG3bm/Render', 04:17:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:30 INFO - 'HOME': '/Users/cltbld', 04:17:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:30 INFO - 'LOGNAME': 'cltbld', 04:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:30 INFO - 'MOZ_NO_REMOTE': '1', 04:17:30 INFO - 'NO_EM_RESTART': '1', 04:17:30 INFO - 'PAGER': '/bin/cat', 04:17:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:30 INFO - 'PWD': '/builds/slave/test', 04:17:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:30 INFO - 'SHELL': '/bin/bash', 04:17:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1yIWNSqOkC/Listeners', 04:17:30 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:17:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:30 INFO - 'USER': 'cltbld', 04:17:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:30 INFO - 'XPC_FLAGS': '0x0', 04:17:30 INFO - 'XPC_SERVICE_NAME': '0', 04:17:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:30 INFO - Downloading/unpacking jsonschema 04:17:30 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 04:17:30 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 04:17:30 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 04:17:30 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 04:17:30 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 04:17:30 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 04:17:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:17:33 INFO - Downloading/unpacking functools32 (from jsonschema) 04:17:33 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 04:17:33 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 04:17:33 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 04:17:33 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 04:17:33 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 04:17:33 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 04:17:33 INFO - Downloading functools32-3.2.3-2.tar.gz 04:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:17:33 INFO - warning: no files found matching '*.txt' 04:17:33 INFO - no previously-included directories found matching 'build' 04:17:33 INFO - no previously-included directories found matching 'dist' 04:17:33 INFO - no previously-included directories found matching '.git*' 04:17:33 INFO - Installing collected packages: jsonschema, functools32 04:17:33 INFO - Running setup.py install for functools32 04:17:33 INFO - warning: no files found matching '*.txt' 04:17:33 INFO - no previously-included directories found matching 'build' 04:17:33 INFO - no previously-included directories found matching 'dist' 04:17:33 INFO - no previously-included directories found matching '.git*' 04:17:33 INFO - Successfully installed jsonschema functools32 04:17:33 INFO - Cleaning up... 04:17:33 INFO - Return code: 0 04:17:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:17:33 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 0x108859a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1088604c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc881c1dff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1086fdd30>, '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 0x108561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f4b20>, '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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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 04:17:33 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 04:17:33 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 04:17:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q3NVokG3bm/Render', 04:17:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:17:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:17:33 INFO - 'HOME': '/Users/cltbld', 04:17:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:17:33 INFO - 'LOGNAME': 'cltbld', 04:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:17:33 INFO - 'MOZ_NO_REMOTE': '1', 04:17:33 INFO - 'NO_EM_RESTART': '1', 04:17:33 INFO - 'PAGER': '/bin/cat', 04:17:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:17:33 INFO - 'PWD': '/builds/slave/test', 04:17:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:17:33 INFO - 'SHELL': '/bin/bash', 04:17:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1yIWNSqOkC/Listeners', 04:17:33 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:17:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:17:33 INFO - 'USER': 'cltbld', 04:17:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:17:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:17:33 INFO - 'XPC_FLAGS': '0x0', 04:17:33 INFO - 'XPC_SERVICE_NAME': '0', 04:17:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:17:34 INFO - Downloading/unpacking flake8 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17: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 04:17:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:17:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:17:36 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 04:17:36 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 04:17:36 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 04:17:36 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 04:17:36 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 04:17:36 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 04:17:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:17:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:17:36 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 04:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:37 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:17:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:17:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:17:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:37 INFO - no previously-included directories found matching 'docs/_build' 04:17:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:17:37 INFO - Running setup.py install for pep8 04:17:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:17:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:17:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:17:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:17:38 INFO - no previously-included directories found matching 'docs/_build' 04:17:38 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:17:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:17:38 INFO - Cleaning up... 04:17:38 INFO - Return code: 0 04:17:38 INFO - Running post-action listener: _resource_record_post_action 04:17:38 INFO - Running post-action listener: _start_resource_monitoring 04:17:38 INFO - Starting resource monitoring. 04:17:38 INFO - ##### 04:17:38 INFO - ##### Running install step. 04:17:38 INFO - ##### 04:17:38 INFO - Running pre-action listener: _resource_record_pre_action 04:17:38 INFO - Running main action method: install 04:17:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:17:38 INFO - Reading from file tmpfile_stdout 04:17:38 INFO - Detecting whether we're running mozinstall >=1.0... 04:17:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:17:38 INFO - Reading from file tmpfile_stdout 04:17:38 INFO - Output received: 04:17:38 INFO - Usage: mozinstall [options] installer 04:17:38 INFO - Options: 04:17:38 INFO - -h, --help show this help message and exit 04:17:38 INFO - -d DEST, --destination=DEST 04:17:38 INFO - Directory to install application into. [default: 04:17:38 INFO - "/builds/slave/test"] 04:17:38 INFO - --app=APP Application being installed. [default: firefox] 04:17:38 INFO - mkdir: /builds/slave/test/build/application 04:17:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:17:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 04:18:10 INFO - Reading from file tmpfile_stdout 04:18:10 INFO - Output received: 04:18:10 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 04:18:10 INFO - Running post-action listener: _resource_record_post_action 04:18:10 INFO - ##### 04:18:10 INFO - ##### Running run-tests step. 04:18:10 INFO - ##### 04:18:10 INFO - Running pre-action listener: _resource_record_pre_action 04:18:10 INFO - Running main action method: run_tests 04:18:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:18:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:18:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:18:10 INFO - 2016-03-23 04:18:10.314 screenresolution[1942:18495] starting screenresolution argv=screenresolution get 04:18:10 INFO - 2016-03-23 04:18:10.317 screenresolution[1942:18495] Display 0: 1600x1200x32@60 04:18:10 INFO - 2016-03-23 04:18:10.323 screenresolution[1943:18497] starting screenresolution argv=screenresolution list 04:18:10 INFO - Available Modes on Display 0 04:18:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:18:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:18:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:18:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:18:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:18:10 INFO - Intel Iris: 04:18:10 INFO - Chipset Model: Intel Iris 04:18:10 INFO - Type: GPU 04:18:10 INFO - Bus: Built-In 04:18:10 INFO - VRAM (Dynamic, Max): 1536 MB 04:18:10 INFO - Vendor: Intel (0x8086) 04:18:10 INFO - Device ID: 0x0a2e 04:18:10 INFO - Revision ID: 0x0009 04:18:10 INFO - Displays: 04:18:10 INFO - Display: 04:18:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:18:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:18:10 INFO - Display Serial Number: 1600x1200 60 04:18:10 INFO - Main Display: Yes 04:18:10 INFO - Mirror: Off 04:18:10 INFO - Online: Yes 04:18:10 INFO - Rotation: Supported 04:18:10 INFO - Return code: 0 04:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:18:10 INFO - Python 2.7.3 04:18:10 INFO - Return code: 0 04:18:10 INFO - grabbing minidump binary from tooltool 04:18:10 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')]} 04:18:10 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 0x1086fdd30>, '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 0x108561db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1086f4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:18:10 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 04:18:10 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 04:18:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:18:10 INFO - Return code: 0 04:18:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:18:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:18:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:18:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:18:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:18:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:18:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:18:11 INFO - Return code: 0 04:18:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0183', '--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 04:18:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0183 --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 04:18:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q3NVokG3bm/Render', 04:18:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:18:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:18:11 INFO - 'HOME': '/Users/cltbld', 04:18:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:18:11 INFO - 'LOGNAME': 'cltbld', 04:18:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:18:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:18:11 INFO - 'MOZ_NO_REMOTE': '1', 04:18:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:18:11 INFO - 'NO_EM_RESTART': '1', 04:18:11 INFO - 'PAGER': '/bin/cat', 04:18:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:18:11 INFO - 'PWD': '/builds/slave/test', 04:18:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:18:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:18:11 INFO - 'SHELL': '/bin/bash', 04:18:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1yIWNSqOkC/Listeners', 04:18:11 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 04:18:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:18:11 INFO - 'USER': 'cltbld', 04:18:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:18:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:18:11 INFO - 'XPC_FLAGS': '0x0', 04:18:11 INFO - 'XPC_SERVICE_NAME': '0', 04:18:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:18:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0183', '--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 04:18:12 INFO - mozversion application_buildid: 20160323021420 04:18:12 INFO - mozversion application_changeset: b39f70d900f792128d6f34b11210460817820c5a 04:18:12 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:18:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:18:12 INFO - mozversion application_name: Firefox 04:18:12 INFO - mozversion application_remotingname: firefox-dev 04:18:12 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:18:12 INFO - mozversion application_vendor: Mozilla 04:18:12 INFO - mozversion application_version: 47.0a2 04:18:12 INFO - mozversion platform_buildid: 20160323021420 04:18:12 INFO - mozversion platform_changeset: b39f70d900f792128d6f34b11210460817820c5a 04:18:12 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:18:12 INFO - mozversion platform_version: 47.0a2 04:18:12 INFO - using testdate: 1458731892 04:18:12 INFO - actual date: 1458731892 04:18:12 INFO - starting webserver on 'localhost:57284' 04:18:12 INFO - SUITE-START | Running 2 tests 04:18:12 INFO - TEST-START | dromaeo_css 04:18:12 INFO - operating with platform_type : mac_ 04:18:12 INFO - Initialising browser for dromaeo_css test... 04:18:12 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmpybb4G5/profile http://localhost:57284/getInfo.html) 04:18:14 INFO - PROCESS | 1961 | __metrics Screen width/height:1600/1200 04:18:14 INFO - PROCESS | 1961 | colorDepth:24 04:18:14 INFO - PROCESS | 1961 | Browser inner width/height: 1024/689 04:18:14 INFO - PROCESS | 1961 | __metrics 04:18:14 INFO - PROCESS | 1961 | 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" 04:18:14 INFO - PROCESS | 1961 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:18:14 INFO - TEST-INFO | 1961: exit 0 04:18:14 INFO - Browser initialized. 04:18:14 INFO - Running cycle 1/1 for dromaeo_css test... 04:18:14 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmpybb4G5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:26 INFO - PROCESS | 1963 | RSS: Main: 210608128 04:18:26 INFO - PROCESS | 1963 | 04:19:18 INFO - PROCESS | 1963 | 1458731958113 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] 04:21:28 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57284/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57284/tests/dromaeo/cssquery-ext.html) 04:21:29 INFO - PROCESS | 1963 | RSS: Main: 352555008 04:21:29 INFO - PROCESS | 1963 | 04:24:32 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57284/tests/dromaeo/cssquery-ext.html (next: http://localhost:57284/tests/dromaeo/cssquery-jquery.html) 04:24:32 INFO - PROCESS | 1963 | RSS: Main: 348426240 04:24:32 INFO - PROCESS | 1963 | 04:27:34 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57284/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57284/tests/dromaeo/cssquery-mootools.html) 04:27:35 INFO - PROCESS | 1963 | RSS: Main: 350339072 04:27:35 INFO - PROCESS | 1963 | 04:30:37 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57284/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57284/tests/dromaeo/cssquery-prototype.html) 04:30:37 INFO - PROCESS | 1963 | RSS: Main: 307519488 04:30:37 INFO - PROCESS | 1963 | 04:33:41 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57284/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57284/tests/dromaeo/cssquery-yui.html) 04:33:41 INFO - PROCESS | 1963 | RSS: Main: 309080064 04:33:41 INFO - PROCESS | 1963 | 04:36:44 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57284/tests/dromaeo/cssquery-yui.html (next: http://localhost:57284/tests/dromaeo/cssquery-dojo.html) 04:36:44 INFO - PROCESS | 1963 | RSS: Main: 356782080 04:36:44 INFO - PROCESS | 1963 | 04:36:44 INFO - PROCESS | 1963 | __start_tp_report 04:36:44 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 04:36:44 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 04:36:44 INFO - PROCESS | 1963 | |i|pagename|runs| 04:36:44 INFO - PROCESS | 1963 | |0;dojo.html;2952.4095180963786;3436.501707252448;3471.409860323745;3492.807895565744;3527.0476971217754;5682.573806964484;5703.458171473709;5705.828825135242;5706.286714160725;5738.0532212184935;5657.20799088128;5715.742791574378;5719.399463056381;5722.198892155091;5725.398833122515;5174.353205849269;5183.818566350188;5213.661112027725;5240.135377662681;5260.894782104356;5288.788448462057;5295.549878260353;5305.310309659739;5306.575473962093;5309.30978972733;5238.52853243208;5292.603054770889;5302.522772950434;5303.098473259555;5312.1766126250495;3854.2676891390547;5277.683338999673;5283.709395983238;5315.654482458666;5334.199870019489;5032.974835125838;5248.396434410053;5254.8686282842855;5272.6836389816735;5274.604404669665;5542.806001789958;5573.331200255955;5594.804181853616;5598.272224610815;5604.187392828057;6117.005394430413;6143.539234557381;6160.784372546984;6170.691465426711;6178.289496707846;5258.447862974409;6129.695011270001;6156.4766994805495;6208.255009398856;6282.4974002079725;5824.446677565625;5845.064789633639;5868.911966320551;5872.882542349129;5895.852603684943;6149.077638354193;6326.240851097898;6328.905066424008;6334.398232167937;6345.650989195547;6071.089336599545;6086.061889446035;6101.938980610137;6102.237220347457;6102.6574153686115;6206.255249370104;6217.409346112112;6254.843628909313;6266.310705822356;6285.528585356116;6174.228221472316;6203.16257305267;6234.719437625317;6237.064440333987;6243.843903902348;6248.9062664060075;6252.187215662026;6254.249490061131;6264.874702506016;6267.310595834455;4860.975695121572;4912.508749125131;4937.629677774181;4971.552560269593;4986.476419975923;4362.389265502832;4370.759608221579;4372.715773474714;4373.868783936487;4393.406890069864;5760.8271751847515;5782.277215348082;5805.7387417566315;5809.8547536311935;5827.388124246978;6146.432659671755;6195.659238741912;6308.27454842699;6318.936810631927;6342.587731797418;5717.599768016282;5724.484796368347;5743.310802703702;5760.337561180518;5772;5325.094733895247;5386.48828361305;5406.189071639207;5410.458954104558;5417.864553386118;6312.337204593543;6372.203474565679;6397.584157029778;6399.168108145911;6401.42387185137;6305.054241863757;6322.336154703874;6333;6336.271328797247;6338.65137417428;6244.594101383395;6253.78111766086;6390.648514331757;6405.519586030973;6521.64130972801;6183.598066125687;6185.257769067561;6225.875482490415;6236.812895613139;6241.282252541016;6233.283172435228;6288.937110628835;6289.937100628935;6294.496440284858;6320.62076275425;4620.306953956799;5738.483536481736;5950.613210141327;6122.142899993915;6132.264128304632;6119.679700974729;6124.869201255597;6135.263768347827;6143.419763699347;6147.586055207238;5965.612235204698;5977.103434484862;5985.790497332572;5995.970020149872;6014.458698717136;5972.283326000907;6015.308239552332;6044.788432404845;6129.20597562684;6130;5930.733117009659;5936.139259807217;6043.758249669964;6062.090686396899;6062.666553339609 04:36:44 INFO - PROCESS | 1963 | |1;ext.html;461.93071039344113;591.3377017740132;614.9016157414811;665.1618960110261;668.8428219368449;22101.005454754533;31628.89298874537;31654.52518212229;31707.52438713418;39602.40596391056;42867.35698964518;43181.35227971575;43390.481333153344;43396;43430.565694343044;9660.178884794801;9897.40615563065;9901.900980990205;9904.851427228561;9923.652672156475;9680.370775899544;9811.705648830546;9818.410895346266;9842.212622990144;9874.654387096452;9781.315307928448;9873.358231714916;9876.209903207762;9878.259130565237;10032.799344013116;9935.056169663907;9999.750006249902;10007.799844003152;10013.499325033756;10017;8364.665413383458;9848.458334791656;9859;9860.260480463994;9885.950570247174;41986.79006604947;42298.365524517154;42323.36514952278;42456.78771606153;42507;3203.7116659500757;3276.562677872307;3317.817520036397;3352.396568617648;3364;28414.28964275889;28627.57058644122;29592.96424625128;30301.545476817864;30585;2344.296710986714;2801.7758579313604;2828.9957065241956;2972.9851350743324;2975.3454240067367;507838.4608076936;512729.9999999963;512809;513448;514190;49718;72551;73104.90342644864;73207;73326.26673733194;49308;49492;49582.76043098951;49600.255996160085;49730.50269497331;16824.663506729798;17183.31266749341;17195.484135475956;17215.82784172167;17229.22468488921;13546.796798048037;13587.048906576445;13613.251271179983;13613.659658508617;13658.931705341409;15277.847221527643;15309.770353444706;15313.693726125415;15328.923355383151;15443;5180.352455943007;6050.6974651267265;6288.99376099831;6615.867682646416;6798.898016529756;1010.1514727628827;1047.3454091193005;1121.9887801122047;1164.778692048508;1172.0974849365941;25014;30714.692853071185;31598.894038708993;33170.55164535903;33317.50023749645;1018.1600179851652;1152.2222499812592;1184.135581025856;1230.39095647655;1244.0669497876593;12992.545260915822;14384.777293929923;14685.045472044283;14936.103833770008;15335.386584536494;667790;676769;683053;684537;684687;43172.568274317484;61769.69115154396;61824;62011.68994155;65060;1437.3172742947017;1551.8292987771335;1582.0982040237184;1614.53178578211;1616.0223065045477;29409.264768380104;29653.703462965095;29832.403351933273;30047.248818779706;30468.085957421314;48592.271115933996;48617;49262;49344.51966441012;49405;361981;363315;363544;363909;364312;29172.124836254945;33402.49896251607;34320.65679343174;34412.48381274333;34460.655393446745;40949;41348.58651413448;41399.75800725983;42933.355999659405;43042.35436468393;35329;35632.82183589065;36481.45277820888;36549.634503654626;37295.81352093222;36120;36188.819055904554;36432.82824765394;36696.449553256185;36916.44625330569;36161;36334.636653633126;37301.62698372982;37307.6269237315;37379.626203737615;31770.841145794122;32348.676513234568;32378.514322285657;32459;32544.67455325511;24792.25623231306;25045.49909001846;25297.49405011926;26397.076102336327;26407.471850563266 04:36:44 INFO - PROCESS | 1963 | |2;jquery.html;370.5738400839036;374.33929115111823;376.1067464771167;378.4625831319528;381.8930699404168;20477.283295084675;20510.794892051075;21156.047977840997;21428.8928555357;21453.4636634084;12058.397080146002;12514.249145051303;12622.873771262308;12627.747445051093;12641.62075137745;4823.951760482403;6178.814635560941;6191.133241346192;6200.751969921198;6201.503879689637;6140.478059364937;6153.692315384235;6193.535484838632;6212.378762123774;6224.937750622504;5931.940680593182;6138.508919286469;6152.984757515027;6157.876842463148;6177.3822617738315;5294.682319060868;5529.225908372831;6096.634201947897;6134.202553668017;6151.477124444427;5201.765920533585;5345.1714984177515;5364.91952620711;5374.978754036721;5376.91934620981;14212.50256241037;14343.856561434357;18926.62146757071;26844.731552684418;26866;2104.095239047209;2199.846010779246;2457.45935894103;2824.053941929456;2827.1801177658454;10208.48957552127;10279.331843430153;10314.690559283234;10328.380297182193;10520.736981575445;1752.4304601004596;1772.0785191700243;1780.4391616640717;1800.612868233336;1811.4927820210362;100751;102970.97029029689;103661;104415.4779226099;106249.46875265574;11858.703532411586;11928.224665396721;11947.283163010246;11947.940260298643;11952.820707689392;14428.350724217435;14555.41778328855;14558.708825823423;14566;14573.927130364493;9156.587953542106;9173.449593024307;9195.172434480928;9196.402233854778;9319.813603728024;9476;9489.857652135224;9499.38254013487;9547.997460266712;9562.61749530025;4618.445786505574;4689.460712018094;4713.481517033124;4720.45714742809;4734.786934587952;1707.1293640243566;1846.8707190496536;1894.3180455036177;1949.4249196487071;1955.1104247567323;912.7900582865979;1024.1294899335505;1043.1706793099504;1052.8420736889527;1060.1518784972145;19799.60400791976;20367.898160509103;20509.692354614694;20742;20950.266740664003;991.4893829677721;1024.7233247023412;1054.3410368519676;1100.834874768791;1128.1426116151783;10876.72808179786;11193.49629266685;11202.887971120184;11209.943950280196;11226.382548959722;604985;623942;630534;632584.6966121396;645630;71379;72258.2774172262;90287;108026.45986770016;110953.44523277493;971.4268581536927;1011.367895065584;1037.1288117980932;1038.4755698372273;1042.379784028517;14723.631909202355;18136.18387172554;18482.445526634223;18530.444086676882;18796.154173061972;38416;39989.60010399975;51825;52235;52478.21282680686;70245.64877175786;71560.64219678869;73646.52706945938;73932.89100663603;75331.62334188294;8027.518348899085;8092.352611790925;8315.792105197419;8339.24946754795;8387.329013679013;11849.526018959144;12112.667606563447;13187.944964403017;13385.86614133885;13446;7516.924830751841;11306.265092768943;11513;11683.707907302385;11721.355325456841;10897.073748731129;11077.667669969915;11293;11344.20590558686;11656.009239214762;11451.770964580828;11550.364729939934;11786;11892.048636109264;11931.940340298243;7942.205779422012;8062;8153.877691834746;8221.958890205511;8238.176182381714;10394.428306443218;11399.772004560029;11701.414929253673;11783.882161178279;11787.41062946832 04:36:44 INFO - PROCESS | 1963 | |3;mootools.html;1494.6861159156576;1591.5941434934093;1652.8264532224116;1789.337944960365;1960.2942940541402;8260;8917.955410222949;9087.000429952699;9109.863352049724;9111.77220569486;8665.653373865038;8937.838081049455;8969.910300896989;8979.820403591924;9004.324675649319;2183.377737344857;2534.721180670125;2553.48930213957;2558.1941688368106;2564.1410127607273;2469.296250568588;2535.429528356114;2550.1711943618307;2552.2853600991657;2559.897604095834;2523.2556395863267;2542.4406630541253;2561.0524106080775;2561.6285638582394;2568.7816535594498;2520.621906713998;2544.300317412708;2555.2078855554837;2560.385507478192;2560.4751026039617;2512.5477414065463;2532.7214006459276;2535.049356491316;2546.2997675639162;2563.4104156044027;9060.864087038699;9132.04113568079;9151.725448236497;9152.4966126863;9178.586963586655;5624.184493248456;5759.280089988752;5773.162891380768;5805.042168042311;5818.5926985111055;3646.6535679110707;3746.606606306326;3769.4157405602177;3778.395456726938;3817.3319669058083;1031.1905154453793;1042.67677020124;1046.204884287939;1064.4677661169414;1074.9301295415773;12604.621861344174;12624.053196010336;12631.93684031574;12647.114701970866;12653.30406827624;4997.30037794709;5027.723475208825;5094.949050509522;5097;5113.693178409233;10541.631042913461;10546;10559.47202639865;10559.63041293551;10581.153507719364;5608.85977850557;5613.354464236583;5692.743826527733;5716.742746576331;5734.827955161351;4601.677882548256;4704.835330763407;4918.5819205367225;5042.142835717937;5181.740912954338;3342.8997130086136;4047.8785636430953;4075.3683179107284;4099.364598487239;4117.485314335708;1227.2329793878826;1233.864274929757;1244.1337993010484;1249.681331260541;1303.2897071096274;1066.4987455895716;1077.472038701031;1232.1559731583714;1351.4323983926774;1439.2372042817324;8254.463459875089;8258.587070646443;8355.164483551718;8368.37237207212;8370.58147092655;1257.3273298785107;1258.5657948008106;1258.8489381274123;1273.1342686972762;1278.4502663854632;6197.442230199304;6245.437910588069;6318.210223722035;6333.588316759396;6356.650384228912;10853.34879907208;11291.266067705574;11348.659540213806;11458.140639451907;11508.424578771028;10464.424456654804;10866.72833179161;11131.554737810397;11323.660290191307;11348.773024539463;8509.106543812934;8704.173103555153;8735.432196907053;8745.912540874637;8768.824623507495;8326.70856520019;8339.54132522717;8362.45644033136;8432.241098301183;8432.494050356998;9766.56050477716;9820.803583928424;9847.556859941176;9868.062534059252;9924.15644670211;8753.212210901049;10136.44249566281;10146.289759717045;10396;10459.163266938778;6183.628982261079;6329.778457753957;7586.393088553013;7633.351165151024;7745.690172393041;7308.59802710856;8238;8380.706675266336;8434.536100514531;8438.493690378597;7361;7458.105027396748;7521.435892307989;7611;7648.770536883902;7364.3003914628025;7420.962895185706;7423.962880185564;7516.5114267572435;7580.924190758243;7983.72056978003;8012;8035.276825085771;8037.276645101969;8043.1554686757045;7170.67731952053;7208.279172082959;7212.386947109554;7244.927550724636;7250.093738282715;7352.669129889061;7369.77890663281;7384.113906331275;7387.224341444071;7424.70301187968 04:36:44 INFO - PROCESS | 1963 | |4;prototype.html;332.0635807024192;333.4265064089765;335.51518056408486;335.6341587669438;342.1924258749351;6575.0466182403525;6683.231428385737;6808.693608787604;6846.178458584976;6865.107536020317;6575.276719560845;6581.90127148092;6589.308122647125;6603.141591593098;6608.801735947917;4755.64332675049;4837.298591704201;4879.731614761186;4931.26031095335;4961.70229786214;4916.213405855064;4930.260460930871;4947.8268260610885;4958.132326842788;4974.37820272466;4913.3612630358;4922.237053256733;4927.236278376858;4932.284818701286;4932.506749325057;4224.78876056196;4551.613112885409;4701.130290896178;4831.975840120777;4838.177509823321;4230.78846057699;4236.428082208924;4248.87253382399;4251.3622956556455;4257.40396344512;5410.3507579090365;6229.6573688447115;6235.968820155916;6301.4328710416285;6329.936700632981;4737.715737055753;5649.717514124319;5842.182094506772;5868.794592189295;5879.970600147015;6854.759951560613;7050.118735158106;7065.858682826315;7068.681909314093;7069.434445244419;3942.231264903345;4704.623630109583;4765.1660959331975;4791.496892826238;4791.664583479158;7421.5176013559485;7467.402607791418;7474.813129671747;7492.887606685904;7500.549967001997;4024.4566983457444;4865.513448655177;4871.561559459666;4883.145449546315;4887.560119589254;4301.5698430156735;4934.062528119646;4942.851714448572;4944.653874228769;4956.975215123901;4752.334673145762;5810.564207684441;5836.883262334814;5839.948809214297;5845.853853653693;6525.869482610321;6838.14523184602;6939.618320992394;7080.716771329089;7114.928850711427;1662.6508433228917;1670.5740036290667;1674.9581260468585;1677.6812405642888;1677.8909370890854;971.7813491964392;1039.282894802599;1117.7261570915016;1128.6839684888243;1147.145376694368;6627.304133066055;6759.155105611799;6761.121054263012;6765.323467653294;6792.694328755218;7411.184769675331;7419.814504637319;7420.740274090489;7447.962760186165;7448.73929412468;6708.798736037927;6715.7985260442265;6727.360900714522;6737.225219099866;6740.393364597112;3797.3354662933875;3874.903127421837;3924.3917192835156;3927.1752931884625;3931.724779265424;5713.771449142071;6251.374862513712;7494.17564067963;7799.220077992155;7853.568053757098;5649.491545760901;6745.831354216086;7624.656890439944;7669.194734552903;7691.769246922601;7761.61191940412;7763.417743669247;7777.455578109478;7784.026996625422;7785.999999999886;5425.891482170414;7156.570605763671;7279.708811647475;7399.038125043709;7423.331900128798;7299.5620262784405;7306.525075870051;7308.634568271459;7322.450816188913;7328.523645962995;6306.684665766602;7676.923230767621;7689.3464055555905;7715.4599178057;7749.65126569317;4842.878928026827;4860.635452341018;4861.513848615252;4864.878378040577;4872.269159626085;7154.928450715634;7345.008423862924;7374.483786135133;7376.520526165782;7392.149902761252;7136.215016348301;7155.356017958408;7157.248488908798;7163.140423149255;7165.3909417698;7091.680874360769;7130.465215108991;7133.750318738819;7139.357457828821;7142.214356420685;6557.475401967736;6953.756618518328;6956;6965.373116419547;6987.441004719509;6912.930870691229;7098.858022839411;7127.85744285101;7128.750493732695;7167.3549380556;6720.0591917132615;6825.385715285648;6913.446924245947;6926.0649812276715;6979.162500499972 04:36:44 INFO - PROCESS | 1963 | |5;yui.html;720.8702433561963;790.5019837502374;790.6675307841867;793.2464159048901;796.390761067783;15014.24928753562;15306.923465382657;15334;15348.309326080325;15363.078215307076;16264.43074492393;16635.08507032113;16654.417095401663;16660.50018499444;16663.41678041269;809.5142914251461;827.7061643116697;980.6175591519313;982.9655962041312;1002.3634991780199;1001.3991605036992;1004.5630150884352;1007;1008.8335424654923;1009.7324209084599;1060.4379678770226;1065.9680209593726;1066.4880857188516;1066.7119877633033;1067.807794596976;830.5847076461769;844.5777111444309;844.8943882014748;1025.646152077532;1052.4790228836737;781.8279978404798;782.7886470652949;783.4476693930765;784.6939693519532;784.7606480023591;15777.97443166202;15854.841451585451;15866.52400427989;15867.44463943768;15885.523434296989;12433.689157771038;12469.376531173404;12596.307203103826;12735.108542402035;12749.490020399173;10180.541875615616;10188.286819922609;10222.948885255526;10228.846567301496;10318.896811031944;3528.823558822074;3594.8382322795537;3604.8284307600134;3678.889633311005;3692.095436618046;81378.59310703409;81440.59279703622;83012.16987830105;83337;83397.16219864613;7835.255650713173;9459.148676619137;9484.57319420614;9664.743583334122;9790.461524616072;21214.36356909295;21275.148994040374;21286.254981075588;21306.467338316357;23334.416639583807;7723.382129429632;7848.960755196187;8046.356291496666;8124.22819832115;8192.877106843402;4151.647109995623;4215.57844215576;4215.810288537024;4409.052053808383;4486.484054333793;3745.850165993384;3765.1904840459433;3796.032011837019;3799.2021675447913;3807.2195199983935;660.6267458885715;678.3691167214439;681.924988251292;686.5400181878153;686.7767975408012;482.85272991737156;540.8485624025279;580.7571796355802;628.5914155798768;656.9737210511526;8081.595920203967;8320.500769953822;8325.583720813935;8419.621117049748;8422.751828395722;500.5420040662753;578.8089930322983;582.9446202610745;602.7498588085983;612.1307743004854;3955.050787810962;3970.285348637215;4019.346893373571;4022.255882661717;4034.8587799426878;93521.06478935259;93575.32123393803;94880;94901.5254923721;96294.55558166633;74911.62544187244;76192;80371.7944230837;82398.17601823906;82575;65417.345826541125;65959.67020164868;67732.661336693;67793.66103169453;68372.3162768366;7784.338331241908;7913.68345266206;8029.277365037175;8073.898389714143;8161.755147345589;46524.534754653374;46809.531904680516;47762;48095.5190448091;49831.252531211336;61076.083858741265;70208.94686579808;70847.64576177087;71283.64358178384;71713;10045.045720656526;10135.7466063349;10517.9474102629;10548.367097974146;11198.60804871858;10863.619773307897;10871.239013268996;11071.833922491009;11239.887601124212;11828.349440780496;10349.430781307101;10366.68899932973;10475.790484190426;10829.783404331713;10877.347359158475;8656.653733850575;10360.119389851947;10435.794067792192;10461.320014199053;10792.136629069813;8860.202581767671;9343.579538920629;9918.752031199278;10305.74235644115;10819.837702434626;7044.506884518035;8892.510911899908;8930.374873758774;9098.954505227432;9183.724488265363;9038.367314287936;9115.544222788967;9136.63453461854;9162.267018638626;9289.674861379819 04:36:44 INFO - PROCESS | 1963 | __end_tp_report 04:36:44 INFO - PROCESS | 1963 | __start_cc_report 04:36:44 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,1280 04:36:44 INFO - PROCESS | 1963 | __end_cc_report 04:36:44 INFO - PROCESS | 1963 | __startTimestamp1458733004660__endTimestamp 04:36:44 INFO - PROCESS | 1963 | 04:36:44 INFO - PROCESS | 1963 | ------- Summary: start ------- 04:36:44 INFO - PROCESS | 1963 | Number of tests: 6 04:36:44 INFO - PROCESS | 1963 | 04:36:44 INFO - PROCESS | 1963 | [#0] dojo.html Cycles:165 Average:5742.77 Median:5972.28 stddev:662.44 (11.1%) stddev-sans-first:627.26 04:36:44 INFO - PROCESS | 1963 | Values: 2952.4 3436.5 3471.4 3492.8 3527.0 5682.6 5703.5 5705.8 5706.3 5738.1 5657.2 5715.7 5719.4 5722.2 5725.4 5174.4 5183.8 5213.7 5240.1 5260.9 5288.8 5295.5 5305.3 5306.6 5309.3 5238.5 5292.6 5302.5 5303.1 5312.2 3854.3 5277.7 5283.7 5315.7 5334.2 5033.0 5248.4 5254.9 5272.7 5274.6 5542.8 5573.3 5594.8 5598.3 5604.2 6117.0 6143.5 6160.8 6170.7 6178.3 5258.4 6129.7 6156.5 6208.3 6282.5 5824.4 5845.1 5868.9 5872.9 5895.9 6149.1 6326.2 6328.9 6334.4 6345.7 6071.1 6086.1 6101.9 6102.2 6102.7 6206.3 6217.4 6254.8 6266.3 6285.5 6174.2 6203.2 6234.7 6237.1 6243.8 6248.9 6252.2 6254.2 6264.9 6267.3 4861.0 4912.5 4937.6 4971.6 4986.5 4362.4 4370.8 4372.7 4373.9 4393.4 5760.8 5782.3 5805.7 5809.9 5827.4 6146.4 6195.7 6308.3 6318.9 6342.6 5717.6 5724.5 5743.3 5760.3 5772.0 5325.1 5386.5 5406.2 5410.5 5417.9 6312.3 6372.2 6397.6 6399.2 6401.4 6305.1 6322.3 6333.0 6336.3 6338.7 6244.6 6253.8 6390.6 6405.5 6521.6 6183.6 6185.3 6225.9 6236.8 6241.3 6233.3 6288.9 6289.9 6294.5 6320.6 4620.3 5738.5 5950.6 6122.1 6132.3 6119.7 6124.9 6135.3 6143.4 6147.6 5965.6 5977.1 5985.8 5996.0 6014.5 5972.3 6015.3 6044.8 6129.2 6130.0 5930.7 5936.1 6043.8 6062.1 6062.7 04:36:44 INFO - PROCESS | 1963 | 04:36:44 INFO - PROCESS | 1963 | [#1] ext.html Cycles:180 Average:65464.60 Median:199939.32 stddev:143021.69 (71.5%) stddev-sans-first:143339.63 04:36:44 INFO - PROCESS | 1963 | Values: 461.9 591.3 614.9 665.2 668.8 22101.0 31628.9 31654.5 31707.5 39602.4 42867.4 43181.4 43390.5 43396.0 43430.6 9660.2 9897.4 9901.9 9904.9 9923.7 9680.4 9811.7 9818.4 9842.2 9874.7 9781.3 9873.4 9876.2 9878.3 10032.8 9935.1 9999.8 10007.8 10013.5 10017.0 8364.7 9848.5 9859.0 9860.3 9886.0 41986.8 42298.4 42323.4 42456.8 42507.0 3203.7 3276.6 3317.8 3352.4 3364.0 28414.3 28627.6 29593.0 30301.5 30585.0 2344.3 2801.8 2829.0 2973.0 2975.3 507838.5 512730.0 512809.0 513448.0 514190.0 49718.0 72551.0 73104.9 73207.0 73326.3 49308.0 49492.0 49582.8 49600.3 49730.5 16824.7 17183.3 17195.5 17215.8 17229.2 13546.8 13587.0 13613.3 13613.7 13658.9 15277.8 15309.8 15313.7 15328.9 15443.0 5180.4 6050.7 6289.0 6615.9 6798.9 1010.2 1047.3 1122.0 1164.8 1172.1 25014.0 30714.7 31598.9 33170.6 33317.5 1018.2 1152.2 1184.1 1230.4 1244.1 12992.5 14384.8 14685.0 14936.1 15335.4 667790.0 676769.0 683053.0 684537.0 684687.0 43172.6 61769.7 61824.0 62011.7 65060.0 1437.3 1551.8 1582.1 1614.5 1616.0 29409.3 29653.7 29832.4 30047.2 30468.1 48592.3 48617.0 49262.0 49344.5 49405.0 361981.0 363315.0 363544.0 363909.0 364312.0 29172.1 33402.5 34320.7 34412.5 34460.7 40949.0 41348.6 41399.8 42933.4 43042.4 35329.0 35632.8 36481.5 36549.6 37295.8 36120.0 36188.8 36432.8 36696.4 36916.4 36161.0 36334.6 37301.6 37307.6 37379.6 31770.8 32348.7 32378.5 32459.0 32544.7 24792.3 25045.5 25297.5 26397.1 26407.5 04:36:44 INFO - PROCESS | 1963 | 04:36:44 INFO - PROCESS | 1963 | [#2] jquery.html Cycles:180 Average:33840.24 Median:20626.40 stddev:103447.52 (501.5%) stddev-sans-first:103707.18 04:36:44 INFO - PROCESS | 1963 | Values: 370.6 374.3 376.1 378.5 381.9 20477.3 20510.8 21156.0 21428.9 21453.5 12058.4 12514.2 12622.9 12627.7 12641.6 4824.0 6178.8 6191.1 6200.8 6201.5 6140.5 6153.7 6193.5 6212.4 6224.9 5931.9 6138.5 6153.0 6157.9 6177.4 5294.7 5529.2 6096.6 6134.2 6151.5 5201.8 5345.2 5364.9 5375.0 5376.9 14212.5 14343.9 18926.6 26844.7 26866.0 2104.1 2199.8 2457.5 2824.1 2827.2 10208.5 10279.3 10314.7 10328.4 10520.7 1752.4 1772.1 1780.4 1800.6 1811.5 100751.0 102971.0 103661.0 104415.5 106249.5 11858.7 11928.2 11947.3 11947.9 11952.8 14428.4 14555.4 14558.7 14566.0 14573.9 9156.6 9173.4 9195.2 9196.4 9319.8 9476.0 9489.9 9499.4 9548.0 9562.6 4618.4 4689.5 4713.5 4720.5 4734.8 1707.1 1846.9 1894.3 1949.4 1955.1 912.8 1024.1 1043.2 1052.8 1060.2 19799.6 20367.9 20509.7 20742.0 20950.3 991.5 1024.7 1054.3 1100.8 1128.1 10876.7 11193.5 11202.9 11209.9 11226.4 604985.0 623942.0 630534.0 632584.7 645630.0 71379.0 72258.3 90287.0 108026.5 110953.4 971.4 1011.4 1037.1 1038.5 1042.4 14723.6 18136.2 18482.4 18530.4 18796.2 38416.0 39989.6 51825.0 52235.0 52478.2 70245.6 71560.6 73646.5 73932.9 75331.6 8027.5 8092.4 8315.8 8339.2 8387.3 11849.5 12112.7 13187.9 13385.9 13446.0 7516.9 11306.3 11513.0 11683.7 11721.4 10897.1 11077.7 11293.0 11344.2 11656.0 11451.8 11550.4 11786.0 11892.0 11931.9 7942.2 8062.0 8153.9 8222.0 8238.2 10394.4 11399.8 11701.4 11783.9 11787.4 04:36:44 INFO - PROCESS | 1963 | 04:36:44 INFO - PROCESS | 1963 | [#3] mootools.html Cycles:180 Average:6251.20 Median:5095.97 stddev:3314.63 (65.0%) stddev-sans-first:3304.64 04:36:44 INFO - PROCESS | 1963 | Values: 1494.7 1591.6 1652.8 1789.3 1960.3 8260.0 8918.0 9087.0 9109.9 9111.8 8665.7 8937.8 8969.9 8979.8 9004.3 2183.4 2534.7 2553.5 2558.2 2564.1 2469.3 2535.4 2550.2 2552.3 2559.9 2523.3 2542.4 2561.1 2561.6 2568.8 2520.6 2544.3 2555.2 2560.4 2560.5 2512.5 2532.7 2535.0 2546.3 2563.4 9060.9 9132.0 9151.7 9152.5 9178.6 5624.2 5759.3 5773.2 5805.0 5818.6 3646.7 3746.6 3769.4 3778.4 3817.3 1031.2 1042.7 1046.2 1064.5 1074.9 12604.6 12624.1 12631.9 12647.1 12653.3 4997.3 5027.7 5094.9 5097.0 5113.7 10541.6 10546.0 10559.5 10559.6 10581.2 5608.9 5613.4 5692.7 5716.7 5734.8 4601.7 4704.8 4918.6 5042.1 5181.7 3342.9 4047.9 4075.4 4099.4 4117.5 1227.2 1233.9 1244.1 1249.7 1303.3 1066.5 1077.5 1232.2 1351.4 1439.2 8254.5 8258.6 8355.2 8368.4 8370.6 1257.3 1258.6 1258.8 1273.1 1278.5 6197.4 6245.4 6318.2 6333.6 6356.7 10853.3 11291.3 11348.7 11458.1 11508.4 10464.4 10866.7 11131.6 11323.7 11348.8 8509.1 8704.2 8735.4 8745.9 8768.8 8326.7 8339.5 8362.5 8432.2 8432.5 9766.6 9820.8 9847.6 9868.1 9924.2 8753.2 10136.4 10146.3 10396.0 10459.2 6183.6 6329.8 7586.4 7633.4 7745.7 7308.6 8238.0 8380.7 8434.5 8438.5 7361.0 7458.1 7521.4 7611.0 7648.8 7364.3 7421.0 7424.0 7516.5 7580.9 7983.7 8012.0 8035.3 8037.3 8043.2 7170.7 7208.3 7212.4 7244.9 7250.1 7352.7 7369.8 7384.1 7387.2 7424.7 04:36:44 INFO - PROCESS | 1963 | 04:36:44 INFO - PROCESS | 1963 | [#4] prototype.html Cycles:180 Average:5792.74 Median:6605.97 stddev:1842.08 (27.9%) stddev-sans-first:1801.07 04:36:44 INFO - PROCESS | 1963 | Values: 332.1 333.4 335.5 335.6 342.2 6575.0 6683.2 6808.7 6846.2 6865.1 6575.3 6581.9 6589.3 6603.1 6608.8 4755.6 4837.3 4879.7 4931.3 4961.7 4916.2 4930.3 4947.8 4958.1 4974.4 4913.4 4922.2 4927.2 4932.3 4932.5 4224.8 4551.6 4701.1 4832.0 4838.2 4230.8 4236.4 4248.9 4251.4 4257.4 5410.4 6229.7 6236.0 6301.4 6329.9 4737.7 5649.7 5842.2 5868.8 5880.0 6854.8 7050.1 7065.9 7068.7 7069.4 3942.2 4704.6 4765.2 4791.5 4791.7 7421.5 7467.4 7474.8 7492.9 7500.5 4024.5 4865.5 4871.6 4883.1 4887.6 4301.6 4934.1 4942.9 4944.7 4957.0 4752.3 5810.6 5836.9 5839.9 5845.9 6525.9 6838.1 6939.6 7080.7 7114.9 1662.7 1670.6 1675.0 1677.7 1677.9 971.8 1039.3 1117.7 1128.7 1147.1 6627.3 6759.2 6761.1 6765.3 6792.7 7411.2 7419.8 7420.7 7448.0 7448.7 6708.8 6715.8 6727.4 6737.2 6740.4 3797.3 3874.9 3924.4 3927.2 3931.7 5713.8 6251.4 7494.2 7799.2 7853.6 5649.5 6745.8 7624.7 7669.2 7691.8 7761.6 7763.4 7777.5 7784.0 7786.0 5425.9 7156.6 7279.7 7399.0 7423.3 7299.6 7306.5 7308.6 7322.5 7328.5 6306.7 7676.9 7689.3 7715.5 7749.7 4842.9 4860.6 4861.5 4864.9 4872.3 7154.9 7345.0 7374.5 7376.5 7392.1 7136.2 7155.4 7157.2 7163.1 7165.4 7091.7 7130.5 7133.8 7139.4 7142.2 6557.5 6953.8 6956.0 6965.4 6987.4 6912.9 7098.9 7127.9 7128.8 7167.4 6720.1 6825.4 6913.4 6926.1 6979.2 04:36:44 INFO - PROCESS | 1963 | 04:36:44 INFO - PROCESS | 1963 | [#5] yui.html Cycles:180 Average:18308.03 Median:520.70 stddev:25952.59 (4984.2%) stddev-sans-first:25991.79 04:36:44 INFO - PROCESS | 1963 | Values: 720.9 790.5 790.7 793.2 796.4 15014.2 15306.9 15334.0 15348.3 15363.1 16264.4 16635.1 16654.4 16660.5 16663.4 809.5 827.7 980.6 983.0 1002.4 1001.4 1004.6 1007.0 1008.8 1009.7 1060.4 1066.0 1066.5 1066.7 1067.8 830.6 844.6 844.9 1025.6 1052.5 781.8 782.8 783.4 784.7 784.8 15778.0 15854.8 15866.5 15867.4 15885.5 12433.7 12469.4 12596.3 12735.1 12749.5 10180.5 10188.3 10222.9 10228.8 10318.9 3528.8 3594.8 3604.8 3678.9 3692.1 81378.6 81440.6 83012.2 83337.0 83397.2 7835.3 9459.1 9484.6 9664.7 9790.5 21214.4 21275.1 21286.3 21306.5 23334.4 7723.4 7849.0 8046.4 8124.2 8192.9 4151.6 4215.6 4215.8 4409.1 4486.5 3745.9 3765.2 3796.0 3799.2 3807.2 660.6 678.4 681.9 686.5 686.8 482.9 540.8 580.8 628.6 657.0 8081.6 8320.5 8325.6 8419.6 8422.8 500.5 578.8 582.9 602.7 612.1 3955.1 3970.3 4019.3 4022.3 4034.9 93521.1 93575.3 94880.0 94901.5 96294.6 74911.6 76192.0 80371.8 82398.2 82575.0 65417.3 65959.7 67732.7 67793.7 68372.3 7784.3 7913.7 8029.3 8073.9 8161.8 46524.5 46809.5 47762.0 48095.5 49831.3 61076.1 70208.9 70847.6 71283.6 71713.0 10045.0 10135.7 10517.9 10548.4 11198.6 10863.6 10871.2 11071.8 11239.9 11828.3 10349.4 10366.7 10475.8 10829.8 10877.3 8656.7 10360.1 10435.8 10461.3 10792.1 8860.2 9343.6 9918.8 10305.7 10819.8 7044.5 8892.5 8930.4 9099.0 9183.7 9038.4 9115.5 9136.6 9162.3 9289.7 04:36:44 INFO - PROCESS | 1963 | -------- Summary: end -------- 04:36:44 INFO - PROCESS | 1963 | 04:36:45 INFO - TEST-INFO | 1963: exit 0 04:36:45 INFO - TEST-OK | dromaeo_css | took 1113182ms 04:36:45 INFO - TEST-START | kraken 04:36:45 INFO - operating with platform_type : mac_ 04:36:45 INFO - Initialising browser for kraken test... 04:36:45 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmpCv_xoQ/profile http://localhost:57284/getInfo.html) 04:36:47 INFO - PROCESS | 1967 | __metrics Screen width/height:1600/1200 04:36:47 INFO - PROCESS | 1967 | colorDepth:24 04:36:47 INFO - PROCESS | 1967 | Browser inner width/height: 1024/689 04:36:47 INFO - PROCESS | 1967 | __metrics 04:36:47 INFO - PROCESS | 1967 | 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" 04:36:47 INFO - PROCESS | 1967 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:36:48 INFO - TEST-INFO | 1967: exit 0 04:36:48 INFO - Browser initialized. 04:36:48 INFO - Running cycle 1/1 for kraken test... 04:36:48 INFO - TEST-INFO | started process 1969 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmpCv_xoQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:00 INFO - PROCESS | 1969 | RSS: Main: 210829312 04:37:00 INFO - PROCESS | 1969 | 04:37:02 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57284/tests/kraken/driver.html?testName=audio-beat-detection) 04:37:03 INFO - PROCESS | 1969 | RSS: Main: 265162752 04:37:03 INFO - PROCESS | 1969 | 04:37:05 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57284/tests/kraken/driver.html?testName=audio-dft) 04:37:06 INFO - PROCESS | 1969 | RSS: Main: 276271104 04:37:06 INFO - PROCESS | 1969 | 04:37:09 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57284/tests/kraken/driver.html?testName=audio-fft) 04:37:10 INFO - PROCESS | 1969 | RSS: Main: 264581120 04:37:10 INFO - PROCESS | 1969 | 04:37:12 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57284/tests/kraken/driver.html?testName=audio-oscillator) 04:37:12 INFO - PROCESS | 1969 | RSS: Main: 266797056 04:37:12 INFO - PROCESS | 1969 | 04:37:14 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57284/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:37:15 INFO - PROCESS | 1969 | RSS: Main: 266739712 04:37:15 INFO - PROCESS | 1969 | 04:37:18 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57284/tests/kraken/driver.html?testName=imaging-darkroom) 04:37:18 INFO - PROCESS | 1969 | RSS: Main: 267997184 04:37:18 INFO - PROCESS | 1969 | 04:37:21 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57284/tests/kraken/driver.html?testName=imaging-desaturate) 04:37:22 INFO - PROCESS | 1969 | RSS: Main: 267337728 04:37:22 INFO - PROCESS | 1969 | 04:37:24 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57284/tests/kraken/driver.html?testName=json-parse-financial) 04:37:25 INFO - PROCESS | 1969 | RSS: Main: 268759040 04:37:25 INFO - PROCESS | 1969 | 04:37:26 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57284/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:37:27 INFO - PROCESS | 1969 | RSS: Main: 301707264 04:37:27 INFO - PROCESS | 1969 | 04:37:29 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57284/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:37:29 INFO - PROCESS | 1969 | RSS: Main: 302505984 04:37:29 INFO - PROCESS | 1969 | 04:37:31 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57284/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:37:32 INFO - PROCESS | 1969 | RSS: Main: 308117504 04:37:32 INFO - PROCESS | 1969 | 04:37:35 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:37:35 INFO - PROCESS | 1969 | RSS: Main: 310591488 04:37:35 INFO - PROCESS | 1969 | 04:37:38 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:37:38 INFO - PROCESS | 1969 | RSS: Main: 310005760 04:37:38 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | Cycle 1(1): loaded http://localhost:57284/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57284/tests/kraken/driver.html?testName=ai-astar) 04:37:40 INFO - PROCESS | 1969 | RSS: Main: 369930240 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | __start_tp_report 04:37:40 INFO - PROCESS | 1969 | _x_x_mozilla_page_load 04:37:40 INFO - PROCESS | 1969 | _x_x_mozilla_page_load_details 04:37:40 INFO - PROCESS | 1969 | |i|pagename|runs| 04:37:40 INFO - PROCESS | 1969 | |0;ai-astar;111;109;110;110;112;111;119;112;110;112 04:37:40 INFO - PROCESS | 1969 | |1;audio-beat-detection;153;118;153;146;119;137;121;180;175;139 04:37:40 INFO - PROCESS | 1969 | |2;audio-dft;181;184;183;183;186;188;187;181;185;194 04:37:40 INFO - PROCESS | 1969 | |3;audio-fft;73;70;75;117;64;56;58;58;114;56 04:37:40 INFO - PROCESS | 1969 | |4;audio-oscillator;90;96;129;80;77;84;116;76;77;113 04:37:40 INFO - PROCESS | 1969 | |5;imaging-gaussian-blur;87;85;88;84;87;84;89;88;88;84 04:37:40 INFO - PROCESS | 1969 | |6;imaging-darkroom;91;92;92;92;92;93;91;92;91;92 04:37:40 INFO - PROCESS | 1969 | |7;imaging-desaturate;84;84;91;86;87;87;84;84;84;87 04:37:40 INFO - PROCESS | 1969 | |8;json-parse-financial;58;58;59;58;58;58;59;70;54;52 04:37:40 INFO - PROCESS | 1969 | |9;json-stringify-tinderbox;62;74;68;72;68;65;66;67;66;66 04:37:40 INFO - PROCESS | 1969 | |10;stanford-crypto-aes;81;80;79;79;80;79;80;78;80;82 04:37:40 INFO - PROCESS | 1969 | |11;stanford-crypto-ccm;116;116;127;117;117;117;117;121;123;130 04:37:40 INFO - PROCESS | 1969 | |12;stanford-crypto-pbkdf2;133;124;133;134;134;124;132;131;134;133 04:37:40 INFO - PROCESS | 1969 | |13;stanford-crypto-sha256-iterative;66;65;65;65;64;65;65;65;68;65 04:37:40 INFO - PROCESS | 1969 | __end_tp_report 04:37:40 INFO - PROCESS | 1969 | __start_cc_report 04:37:40 INFO - PROCESS | 1969 | _x_x_mozilla_cycle_collect,1201 04:37:40 INFO - PROCESS | 1969 | __end_cc_report 04:37:40 INFO - PROCESS | 1969 | __startTimestamp1458733060583__endTimestamp 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | ------- Summary: start ------- 04:37:40 INFO - PROCESS | 1969 | Number of tests: 14 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.50 stddev:2.80 (2.5%) stddev-sans-first:2.96 04:37:40 INFO - PROCESS | 1969 | Values: 111.0 109.0 110.0 110.0 112.0 111.0 119.0 112.0 110.0 112.0 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#1] audio-beat-detection Cycles:10 Average:144.10 Median:149.50 stddev:21.93 (14.7%) stddev-sans-first:23.02 04:37:40 INFO - PROCESS | 1969 | Values: 153.0 118.0 153.0 146.0 119.0 137.0 121.0 180.0 175.0 139.0 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#2] audio-dft Cycles:10 Average:185.20 Median:185.50 stddev:3.88 (2.1%) stddev-sans-first:3.81 04:37:40 INFO - PROCESS | 1969 | Values: 181.0 184.0 183.0 183.0 186.0 188.0 187.0 181.0 185.0 194.0 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#3] audio-fft Cycles:10 Average:74.10 Median:61.00 stddev:22.92 (37.6%) stddev-sans-first:24.30 04:37:40 INFO - PROCESS | 1969 | Values: 73.0 70.0 75.0 117.0 64.0 56.0 58.0 58.0 114.0 56.0 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:78.50 stddev:19.11 (24.3%) stddev-sans-first:20.22 04:37:40 INFO - PROCESS | 1969 | Values: 90.0 96.0 129.0 80.0 77.0 84.0 116.0 76.0 77.0 113.0 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.50 stddev:1.96 (2.2%) stddev-sans-first:2.06 04:37:40 INFO - PROCESS | 1969 | Values: 87.0 85.0 88.0 84.0 87.0 84.0 89.0 88.0 88.0 84.0 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#6] imaging-darkroom Cycles:10 Average:91.80 Median:92.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 04:37:40 INFO - PROCESS | 1969 | Values: 91.0 92.0 92.0 92.0 92.0 93.0 91.0 92.0 91.0 92.0 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.50 stddev:2.30 (2.7%) stddev-sans-first:2.35 04:37:40 INFO - PROCESS | 1969 | Values: 84.0 84.0 91.0 86.0 87.0 87.0 84.0 84.0 84.0 87.0 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#8] json-parse-financial Cycles:10 Average:58.40 Median:58.00 stddev:4.67 (8.1%) stddev-sans-first:4.95 04:37:40 INFO - PROCESS | 1969 | Values: 58.0 58.0 59.0 58.0 58.0 58.0 59.0 70.0 54.0 52.0 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.50 stddev:3.44 (5.1%) stddev-sans-first:3.04 04:37:40 INFO - PROCESS | 1969 | Values: 62.0 74.0 68.0 72.0 68.0 65.0 66.0 67.0 66.0 66.0 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:80.00 stddev:1.14 (1.4%) stddev-sans-first:1.12 04:37:40 INFO - PROCESS | 1969 | Values: 81.0 80.0 79.0 79.0 80.0 79.0 80.0 78.0 80.0 82.0 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#11] stanford-crypto-ccm Cycles:10 Average:120.10 Median:119.00 stddev:5.02 (4.2%) stddev-sans-first:5.10 04:37:40 INFO - PROCESS | 1969 | Values: 116.0 116.0 127.0 117.0 117.0 117.0 117.0 121.0 123.0 130.0 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:131.20 Median:133.00 stddev:3.91 (2.9%) stddev-sans-first:4.09 04:37:40 INFO - PROCESS | 1969 | Values: 133.0 124.0 133.0 134.0 134.0 124.0 132.0 131.0 134.0 133.0 04:37:40 INFO - PROCESS | 1969 | 04:37:40 INFO - PROCESS | 1969 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.00 stddev:1.06 (1.6%) stddev-sans-first:1.09 04:37:40 INFO - PROCESS | 1969 | Values: 66.0 65.0 65.0 65.0 64.0 65.0 65.0 65.0 68.0 65.0 04:37:40 INFO - PROCESS | 1969 | -------- Summary: end -------- 04:37:40 INFO - PROCESS | 1969 | 04:37:41 INFO - TEST-INFO | 1969: exit 0 04:37:41 INFO - TEST-OK | kraken | took 56200ms 04:37:41 INFO - SUITE-END | took 1169s 04:37:41 INFO - Completed test suite (00:19:29) 04:37:41 INFO - javascript benchmark 04:37:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2952.4095180963786, 3436.501707252448, 3471.409860323745, 3492.807895565744, 3527.0476971217754, 5682.573806964484, 5703.458171473709, 5705.828825135242, 5706.286714160725, 5738.0532212184935, 5657.20799088128, 5715.742791574378, 5719.399463056381, 5722.198892155091, 5725.398833122515, 5174.353205849269, 5183.818566350188, 5213.661112027725, 5240.135377662681, 5260.894782104356, 5288.788448462057, 5295.549878260353, 5305.310309659739, 5306.575473962093, 5309.30978972733, 5238.52853243208, 5292.603054770889, 5302.522772950434, 5303.098473259555, 5312.1766126250495, 3854.2676891390547, 5277.683338999673, 5283.709395983238, 5315.654482458666, 5334.199870019489, 5032.974835125838, 5248.396434410053, 5254.8686282842855, 5272.6836389816735, 5274.604404669665, 5542.806001789958, 5573.331200255955, 5594.804181853616, 5598.272224610815, 5604.187392828057, 6117.005394430413, 6143.539234557381, 6160.784372546984, 6170.691465426711, 6178.289496707846, 5258.447862974409, 6129.695011270001, 6156.4766994805495, 6208.255009398856, 6282.4974002079725, 5824.446677565625, 5845.064789633639, 5868.911966320551, 5872.882542349129, 5895.852603684943, 6149.077638354193, 6326.240851097898, 6328.905066424008, 6334.398232167937, 6345.650989195547, 6071.089336599545, 6086.061889446035, 6101.938980610137, 6102.237220347457, 6102.6574153686115, 6206.255249370104, 6217.409346112112, 6254.843628909313, 6266.310705822356, 6285.528585356116, 6174.228221472316, 6203.16257305267, 6234.719437625317, 6237.064440333987, 6243.843903902348, 6248.9062664060075, 6252.187215662026, 6254.249490061131, 6264.874702506016, 6267.310595834455, 4860.975695121572, 4912.508749125131, 4937.629677774181, 4971.552560269593, 4986.476419975923, 4362.389265502832, 4370.759608221579, 4372.715773474714, 4373.868783936487, 4393.406890069864, 5760.8271751847515, 5782.277215348082, 5805.7387417566315, 5809.8547536311935, 5827.388124246978, 6146.432659671755, 6195.659238741912, 6308.27454842699, 6318.936810631927, 6342.587731797418, 5717.599768016282, 5724.484796368347, 5743.310802703702, 5760.337561180518, 5772.0, 5325.094733895247, 5386.48828361305, 5406.189071639207, 5410.458954104558, 5417.864553386118, 6312.337204593543, 6372.203474565679, 6397.584157029778, 6399.168108145911, 6401.42387185137, 6305.054241863757, 6322.336154703874, 6333.0, 6336.271328797247, 6338.65137417428, 6244.594101383395, 6253.78111766086, 6390.648514331757, 6405.519586030973, 6521.64130972801, 6183.598066125687, 6185.257769067561, 6225.875482490415, 6236.812895613139, 6241.282252541016, 6233.283172435228, 6288.937110628835, 6289.937100628935, 6294.496440284858, 6320.62076275425, 4620.306953956799, 5738.483536481736, 5950.613210141327, 6122.142899993915, 6132.264128304632, 6119.679700974729, 6124.869201255597, 6135.263768347827, 6143.419763699347, 6147.586055207238, 5965.612235204698, 5977.103434484862, 5985.790497332572, 5995.970020149872, 6014.458698717136, 5972.283326000907, 6015.308239552332, 6044.788432404845, 6129.20597562684, 6130.0, 5930.733117009659, 5936.139259807217, 6043.758249669964, 6062.090686396899, 6062.666553339609], "unit": "score", "name": "dojo.html", "value": 5700.47486550433}, {"lowerIsBetter": false, "replicates": [461.93071039344113, 591.3377017740132, 614.9016157414811, 665.1618960110261, 668.8428219368449, 22101.005454754533, 31628.89298874537, 31654.52518212229, 31707.52438713418, 39602.40596391056, 42867.35698964518, 43181.35227971575, 43390.481333153344, 43396.0, 43430.565694343044, 9660.178884794801, 9897.40615563065, 9901.900980990205, 9904.851427228561, 9923.652672156475, 9680.370775899544, 9811.705648830546, 9818.410895346266, 9842.212622990144, 9874.654387096452, 9781.315307928448, 9873.358231714916, 9876.209903207762, 9878.259130565237, 10032.799344013116, 9935.056169663907, 9999.750006249902, 10007.799844003152, 10013.499325033756, 10017.0, 8364.665413383458, 9848.458334791656, 9859.0, 9860.260480463994, 9885.950570247174, 41986.79006604947, 42298.365524517154, 42323.36514952278, 42456.78771606153, 42507.0, 3203.7116659500757, 3276.562677872307, 3317.817520036397, 3352.396568617648, 3364.0, 28414.28964275889, 28627.57058644122, 29592.96424625128, 30301.545476817864, 30585.0, 2344.296710986714, 2801.7758579313604, 2828.9957065241956, 2972.9851350743324, 2975.3454240067367, 507838.4608076936, 512729.9999999963, 512809.0, 513448.0, 514190.0, 49718.0, 72551.0, 73104.90342644864, 73207.0, 73326.26673733194, 49308.0, 49492.0, 49582.76043098951, 49600.255996160085, 49730.50269497331, 16824.663506729798, 17183.31266749341, 17195.484135475956, 17215.82784172167, 17229.22468488921, 13546.796798048037, 13587.048906576445, 13613.251271179983, 13613.659658508617, 13658.931705341409, 15277.847221527643, 15309.770353444706, 15313.693726125415, 15328.923355383151, 15443.0, 5180.352455943007, 6050.6974651267265, 6288.99376099831, 6615.867682646416, 6798.898016529756, 1010.1514727628827, 1047.3454091193005, 1121.9887801122047, 1164.778692048508, 1172.0974849365941, 25014.0, 30714.692853071185, 31598.894038708993, 33170.55164535903, 33317.50023749645, 1018.1600179851652, 1152.2222499812592, 1184.135581025856, 1230.39095647655, 1244.0669497876593, 12992.545260915822, 14384.777293929923, 14685.045472044283, 14936.103833770008, 15335.386584536494, 667790.0, 676769.0, 683053.0, 684537.0, 684687.0, 43172.568274317484, 61769.69115154396, 61824.0, 62011.68994155, 65060.0, 1437.3172742947017, 1551.8292987771335, 1582.0982040237184, 1614.53178578211, 1616.0223065045477, 29409.264768380104, 29653.703462965095, 29832.403351933273, 30047.248818779706, 30468.085957421314, 48592.271115933996, 48617.0, 49262.0, 49344.51966441012, 49405.0, 361981.0, 363315.0, 363544.0, 363909.0, 364312.0, 29172.124836254945, 33402.49896251607, 34320.65679343174, 34412.48381274333, 34460.655393446745, 40949.0, 41348.58651413448, 41399.75800725983, 42933.355999659405, 43042.35436468393, 35329.0, 35632.82183589065, 36481.45277820888, 36549.634503654626, 37295.81352093222, 36120.0, 36188.819055904554, 36432.82824765394, 36696.449553256185, 36916.44625330569, 36161.0, 36334.636653633126, 37301.62698372982, 37307.6269237315, 37379.626203737615, 31770.841145794122, 32348.676513234568, 32378.514322285657, 32459.0, 32544.67455325511, 24792.25623231306, 25045.49909001846, 25297.49405011926, 26397.076102336327, 26407.471850563266], "unit": "score", "name": "ext.html", "value": 19629.102342355633}, {"lowerIsBetter": false, "replicates": [370.5738400839036, 374.33929115111823, 376.1067464771167, 378.4625831319528, 381.8930699404168, 20477.283295084675, 20510.794892051075, 21156.047977840997, 21428.8928555357, 21453.4636634084, 12058.397080146002, 12514.249145051303, 12622.873771262308, 12627.747445051093, 12641.62075137745, 4823.951760482403, 6178.814635560941, 6191.133241346192, 6200.751969921198, 6201.503879689637, 6140.478059364937, 6153.692315384235, 6193.535484838632, 6212.378762123774, 6224.937750622504, 5931.940680593182, 6138.508919286469, 6152.984757515027, 6157.876842463148, 6177.3822617738315, 5294.682319060868, 5529.225908372831, 6096.634201947897, 6134.202553668017, 6151.477124444427, 5201.765920533585, 5345.1714984177515, 5364.91952620711, 5374.978754036721, 5376.91934620981, 14212.50256241037, 14343.856561434357, 18926.62146757071, 26844.731552684418, 26866.0, 2104.095239047209, 2199.846010779246, 2457.45935894103, 2824.053941929456, 2827.1801177658454, 10208.48957552127, 10279.331843430153, 10314.690559283234, 10328.380297182193, 10520.736981575445, 1752.4304601004596, 1772.0785191700243, 1780.4391616640717, 1800.612868233336, 1811.4927820210362, 100751.0, 102970.97029029689, 103661.0, 104415.4779226099, 106249.46875265574, 11858.703532411586, 11928.224665396721, 11947.283163010246, 11947.940260298643, 11952.820707689392, 14428.350724217435, 14555.41778328855, 14558.708825823423, 14566.0, 14573.927130364493, 9156.587953542106, 9173.449593024307, 9195.172434480928, 9196.402233854778, 9319.813603728024, 9476.0, 9489.857652135224, 9499.38254013487, 9547.997460266712, 9562.61749530025, 4618.445786505574, 4689.460712018094, 4713.481517033124, 4720.45714742809, 4734.786934587952, 1707.1293640243566, 1846.8707190496536, 1894.3180455036177, 1949.4249196487071, 1955.1104247567323, 912.7900582865979, 1024.1294899335505, 1043.1706793099504, 1052.8420736889527, 1060.1518784972145, 19799.60400791976, 20367.898160509103, 20509.692354614694, 20742.0, 20950.266740664003, 991.4893829677721, 1024.7233247023412, 1054.3410368519676, 1100.834874768791, 1128.1426116151783, 10876.72808179786, 11193.49629266685, 11202.887971120184, 11209.943950280196, 11226.382548959722, 604985.0, 623942.0, 630534.0, 632584.6966121396, 645630.0, 71379.0, 72258.2774172262, 90287.0, 108026.45986770016, 110953.44523277493, 971.4268581536927, 1011.367895065584, 1037.1288117980932, 1038.4755698372273, 1042.379784028517, 14723.631909202355, 18136.18387172554, 18482.445526634223, 18530.444086676882, 18796.154173061972, 38416.0, 39989.60010399975, 51825.0, 52235.0, 52478.21282680686, 70245.64877175786, 71560.64219678869, 73646.52706945938, 73932.89100663603, 75331.62334188294, 8027.518348899085, 8092.352611790925, 8315.792105197419, 8339.24946754795, 8387.329013679013, 11849.526018959144, 12112.667606563447, 13187.944964403017, 13385.86614133885, 13446.0, 7516.924830751841, 11306.265092768943, 11513.0, 11683.707907302385, 11721.355325456841, 10897.073748731129, 11077.667669969915, 11293.0, 11344.20590558686, 11656.009239214762, 11451.770964580828, 11550.364729939934, 11786.0, 11892.048636109264, 11931.940340298243, 7942.205779422012, 8062.0, 8153.877691834746, 8221.958890205511, 8238.176182381714, 10394.428306443218, 11399.772004560029, 11701.414929253673, 11783.882161178279, 11787.41062946832], "unit": "score", "name": "jquery.html", "value": 9396.829856611515}, {"lowerIsBetter": false, "replicates": [1494.6861159156576, 1591.5941434934093, 1652.8264532224116, 1789.337944960365, 1960.2942940541402, 8260.0, 8917.955410222949, 9087.000429952699, 9109.863352049724, 9111.77220569486, 8665.653373865038, 8937.838081049455, 8969.910300896989, 8979.820403591924, 9004.324675649319, 2183.377737344857, 2534.721180670125, 2553.48930213957, 2558.1941688368106, 2564.1410127607273, 2469.296250568588, 2535.429528356114, 2550.1711943618307, 2552.2853600991657, 2559.897604095834, 2523.2556395863267, 2542.4406630541253, 2561.0524106080775, 2561.6285638582394, 2568.7816535594498, 2520.621906713998, 2544.300317412708, 2555.2078855554837, 2560.385507478192, 2560.4751026039617, 2512.5477414065463, 2532.7214006459276, 2535.049356491316, 2546.2997675639162, 2563.4104156044027, 9060.864087038699, 9132.04113568079, 9151.725448236497, 9152.4966126863, 9178.586963586655, 5624.184493248456, 5759.280089988752, 5773.162891380768, 5805.042168042311, 5818.5926985111055, 3646.6535679110707, 3746.606606306326, 3769.4157405602177, 3778.395456726938, 3817.3319669058083, 1031.1905154453793, 1042.67677020124, 1046.204884287939, 1064.4677661169414, 1074.9301295415773, 12604.621861344174, 12624.053196010336, 12631.93684031574, 12647.114701970866, 12653.30406827624, 4997.30037794709, 5027.723475208825, 5094.949050509522, 5097.0, 5113.693178409233, 10541.631042913461, 10546.0, 10559.47202639865, 10559.63041293551, 10581.153507719364, 5608.85977850557, 5613.354464236583, 5692.743826527733, 5716.742746576331, 5734.827955161351, 4601.677882548256, 4704.835330763407, 4918.5819205367225, 5042.142835717937, 5181.740912954338, 3342.8997130086136, 4047.8785636430953, 4075.3683179107284, 4099.364598487239, 4117.485314335708, 1227.2329793878826, 1233.864274929757, 1244.1337993010484, 1249.681331260541, 1303.2897071096274, 1066.4987455895716, 1077.472038701031, 1232.1559731583714, 1351.4323983926774, 1439.2372042817324, 8254.463459875089, 8258.587070646443, 8355.164483551718, 8368.37237207212, 8370.58147092655, 1257.3273298785107, 1258.5657948008106, 1258.8489381274123, 1273.1342686972762, 1278.4502663854632, 6197.442230199304, 6245.437910588069, 6318.210223722035, 6333.588316759396, 6356.650384228912, 10853.34879907208, 11291.266067705574, 11348.659540213806, 11458.140639451907, 11508.424578771028, 10464.424456654804, 10866.72833179161, 11131.554737810397, 11323.660290191307, 11348.773024539463, 8509.106543812934, 8704.173103555153, 8735.432196907053, 8745.912540874637, 8768.824623507495, 8326.70856520019, 8339.54132522717, 8362.45644033136, 8432.241098301183, 8432.494050356998, 9766.56050477716, 9820.803583928424, 9847.556859941176, 9868.062534059252, 9924.15644670211, 8753.212210901049, 10136.44249566281, 10146.289759717045, 10396.0, 10459.163266938778, 6183.628982261079, 6329.778457753957, 7586.393088553013, 7633.351165151024, 7745.690172393041, 7308.59802710856, 8238.0, 8380.706675266336, 8434.536100514531, 8438.493690378597, 7361.0, 7458.105027396748, 7521.435892307989, 7611.0, 7648.770536883902, 7364.3003914628025, 7420.962895185706, 7423.962880185564, 7516.5114267572435, 7580.924190758243, 7983.72056978003, 8012.0, 8035.276825085771, 8037.276645101969, 8043.1554686757045, 7170.67731952053, 7208.279172082959, 7212.386947109554, 7244.927550724636, 7250.093738282715, 7352.669129889061, 7369.77890663281, 7384.113906331275, 7387.224341444071, 7424.70301187968], "unit": "score", "name": "mootools.html", "value": 5087.04001082991}, {"lowerIsBetter": false, "replicates": [332.0635807024192, 333.4265064089765, 335.51518056408486, 335.6341587669438, 342.1924258749351, 6575.0466182403525, 6683.231428385737, 6808.693608787604, 6846.178458584976, 6865.107536020317, 6575.276719560845, 6581.90127148092, 6589.308122647125, 6603.141591593098, 6608.801735947917, 4755.64332675049, 4837.298591704201, 4879.731614761186, 4931.26031095335, 4961.70229786214, 4916.213405855064, 4930.260460930871, 4947.8268260610885, 4958.132326842788, 4974.37820272466, 4913.3612630358, 4922.237053256733, 4927.236278376858, 4932.284818701286, 4932.506749325057, 4224.78876056196, 4551.613112885409, 4701.130290896178, 4831.975840120777, 4838.177509823321, 4230.78846057699, 4236.428082208924, 4248.87253382399, 4251.3622956556455, 4257.40396344512, 5410.3507579090365, 6229.6573688447115, 6235.968820155916, 6301.4328710416285, 6329.936700632981, 4737.715737055753, 5649.717514124319, 5842.182094506772, 5868.794592189295, 5879.970600147015, 6854.759951560613, 7050.118735158106, 7065.858682826315, 7068.681909314093, 7069.434445244419, 3942.231264903345, 4704.623630109583, 4765.1660959331975, 4791.496892826238, 4791.664583479158, 7421.5176013559485, 7467.402607791418, 7474.813129671747, 7492.887606685904, 7500.549967001997, 4024.4566983457444, 4865.513448655177, 4871.561559459666, 4883.145449546315, 4887.560119589254, 4301.5698430156735, 4934.062528119646, 4942.851714448572, 4944.653874228769, 4956.975215123901, 4752.334673145762, 5810.564207684441, 5836.883262334814, 5839.948809214297, 5845.853853653693, 6525.869482610321, 6838.14523184602, 6939.618320992394, 7080.716771329089, 7114.928850711427, 1662.6508433228917, 1670.5740036290667, 1674.9581260468585, 1677.6812405642888, 1677.8909370890854, 971.7813491964392, 1039.282894802599, 1117.7261570915016, 1128.6839684888243, 1147.145376694368, 6627.304133066055, 6759.155105611799, 6761.121054263012, 6765.323467653294, 6792.694328755218, 7411.184769675331, 7419.814504637319, 7420.740274090489, 7447.962760186165, 7448.73929412468, 6708.798736037927, 6715.7985260442265, 6727.360900714522, 6737.225219099866, 6740.393364597112, 3797.3354662933875, 3874.903127421837, 3924.3917192835156, 3927.1752931884625, 3931.724779265424, 5713.771449142071, 6251.374862513712, 7494.17564067963, 7799.220077992155, 7853.568053757098, 5649.491545760901, 6745.831354216086, 7624.656890439944, 7669.194734552903, 7691.769246922601, 7761.61191940412, 7763.417743669247, 7777.455578109478, 7784.026996625422, 7785.999999999886, 5425.891482170414, 7156.570605763671, 7279.708811647475, 7399.038125043709, 7423.331900128798, 7299.5620262784405, 7306.525075870051, 7308.634568271459, 7322.450816188913, 7328.523645962995, 6306.684665766602, 7676.923230767621, 7689.3464055555905, 7715.4599178057, 7749.65126569317, 4842.878928026827, 4860.635452341018, 4861.513848615252, 4864.878378040577, 4872.269159626085, 7154.928450715634, 7345.008423862924, 7374.483786135133, 7376.520526165782, 7392.149902761252, 7136.215016348301, 7155.356017958408, 7157.248488908798, 7163.140423149255, 7165.3909417698, 7091.680874360769, 7130.465215108991, 7133.750318738819, 7139.357457828821, 7142.214356420685, 6557.475401967736, 6953.756618518328, 6956.0, 6965.373116419547, 6987.441004719509, 6912.930870691229, 7098.858022839411, 7127.85744285101, 7128.750493732695, 7167.3549380556, 6720.0591917132615, 6825.385715285648, 6913.446924245947, 6926.0649812276715, 6979.162500499972], "unit": "score", "name": "prototype.html", "value": 5183.354752776629}, {"lowerIsBetter": false, "replicates": [720.8702433561963, 790.5019837502374, 790.6675307841867, 793.2464159048901, 796.390761067783, 15014.24928753562, 15306.923465382657, 15334.0, 15348.309326080325, 15363.078215307076, 16264.43074492393, 16635.08507032113, 16654.417095401663, 16660.50018499444, 16663.41678041269, 809.5142914251461, 827.7061643116697, 980.6175591519313, 982.9655962041312, 1002.3634991780199, 1001.3991605036992, 1004.5630150884352, 1007.0, 1008.8335424654923, 1009.7324209084599, 1060.4379678770226, 1065.9680209593726, 1066.4880857188516, 1066.7119877633033, 1067.807794596976, 830.5847076461769, 844.5777111444309, 844.8943882014748, 1025.646152077532, 1052.4790228836737, 781.8279978404798, 782.7886470652949, 783.4476693930765, 784.6939693519532, 784.7606480023591, 15777.97443166202, 15854.841451585451, 15866.52400427989, 15867.44463943768, 15885.523434296989, 12433.689157771038, 12469.376531173404, 12596.307203103826, 12735.108542402035, 12749.490020399173, 10180.541875615616, 10188.286819922609, 10222.948885255526, 10228.846567301496, 10318.896811031944, 3528.823558822074, 3594.8382322795537, 3604.8284307600134, 3678.889633311005, 3692.095436618046, 81378.59310703409, 81440.59279703622, 83012.16987830105, 83337.0, 83397.16219864613, 7835.255650713173, 9459.148676619137, 9484.57319420614, 9664.743583334122, 9790.461524616072, 21214.36356909295, 21275.148994040374, 21286.254981075588, 21306.467338316357, 23334.416639583807, 7723.382129429632, 7848.960755196187, 8046.356291496666, 8124.22819832115, 8192.877106843402, 4151.647109995623, 4215.57844215576, 4215.810288537024, 4409.052053808383, 4486.484054333793, 3745.850165993384, 3765.1904840459433, 3796.032011837019, 3799.2021675447913, 3807.2195199983935, 660.6267458885715, 678.3691167214439, 681.924988251292, 686.5400181878153, 686.7767975408012, 482.85272991737156, 540.8485624025279, 580.7571796355802, 628.5914155798768, 656.9737210511526, 8081.595920203967, 8320.500769953822, 8325.583720813935, 8419.621117049748, 8422.751828395722, 500.5420040662753, 578.8089930322983, 582.9446202610745, 602.7498588085983, 612.1307743004854, 3955.050787810962, 3970.285348637215, 4019.346893373571, 4022.255882661717, 4034.8587799426878, 93521.06478935259, 93575.32123393803, 94880.0, 94901.5254923721, 96294.55558166633, 74911.62544187244, 76192.0, 80371.7944230837, 82398.17601823906, 82575.0, 65417.345826541125, 65959.67020164868, 67732.661336693, 67793.66103169453, 68372.3162768366, 7784.338331241908, 7913.68345266206, 8029.277365037175, 8073.898389714143, 8161.755147345589, 46524.534754653374, 46809.531904680516, 47762.0, 48095.5190448091, 49831.252531211336, 61076.083858741265, 70208.94686579808, 70847.64576177087, 71283.64358178384, 71713.0, 10045.045720656526, 10135.7466063349, 10517.9474102629, 10548.367097974146, 11198.60804871858, 10863.619773307897, 10871.239013268996, 11071.833922491009, 11239.887601124212, 11828.349440780496, 10349.430781307101, 10366.68899932973, 10475.790484190426, 10829.783404331713, 10877.347359158475, 8656.653733850575, 10360.119389851947, 10435.794067792192, 10461.320014199053, 10792.136629069813, 8860.202581767671, 9343.579538920629, 9918.752031199278, 10305.74235644115, 10819.837702434626, 7044.506884518035, 8892.510911899908, 8930.374873758774, 9098.954505227432, 9183.724488265363, 9038.367314287936, 9115.544222788967, 9136.63453461854, 9162.267018638626, 9289.674861379819], "unit": "score", "name": "yui.html", "value": 6962.712296142343}], "name": "dromaeo_css", "value": 7602.331063543633}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 110.0, 110.0, 112.0, 111.0, 119.0, 112.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [153.0, 118.0, 153.0, 146.0, 119.0, 137.0, 121.0, 180.0, 175.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 144.1}, {"lowerIsBetter": true, "replicates": [181.0, 184.0, 183.0, 183.0, 186.0, 188.0, 187.0, 181.0, 185.0, 194.0], "unit": "score", "name": "audio-dft", "value": 185.2}, {"lowerIsBetter": true, "replicates": [73.0, 70.0, 75.0, 117.0, 64.0, 56.0, 58.0, 58.0, 114.0, 56.0], "unit": "score", "name": "audio-fft", "value": 74.1}, {"lowerIsBetter": true, "replicates": [90.0, 96.0, 129.0, 80.0, 77.0, 84.0, 116.0, 76.0, 77.0, 113.0], "unit": "score", "name": "audio-oscillator", "value": 93.8}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 88.0, 84.0, 87.0, 84.0, 89.0, 88.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.4}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 92.0, 92.0, 92.0, 93.0, 91.0, 92.0, 91.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 91.8}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 91.0, 86.0, 87.0, 87.0, 84.0, 84.0, 84.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 85.8}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 59.0, 58.0, 58.0, 58.0, 59.0, 70.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 58.4}, {"lowerIsBetter": true, "replicates": [62.0, 74.0, 68.0, 72.0, 68.0, 65.0, 66.0, 67.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.4}, {"lowerIsBetter": true, "replicates": [81.0, 80.0, 79.0, 79.0, 80.0, 79.0, 80.0, 78.0, 80.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.8}, {"lowerIsBetter": true, "replicates": [116.0, 116.0, 127.0, 117.0, 117.0, 117.0, 117.0, 121.0, 123.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 120.1}, {"lowerIsBetter": true, "replicates": [133.0, 124.0, 133.0, 134.0, 134.0, 124.0, 132.0, 131.0, 134.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 131.2}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 68.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.3}], "name": "kraken", "value": 1394.9999999999998}]} 04:37:41 INFO - Return code: 0 04:37:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:37:41 INFO - # TBPL SUCCESS # 04:37:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:37:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:37:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:37:41 INFO - 2016-03-23 04:37:41.875 screenresolution[1973:20440] starting screenresolution argv=screenresolution get 04:37:41 INFO - 2016-03-23 04:37:41.877 screenresolution[1973:20440] Display 0: 1600x1200x32@60 04:37:41 INFO - 2016-03-23 04:37:41.883 screenresolution[1974:20443] starting screenresolution argv=screenresolution list 04:37:41 INFO - Available Modes on Display 0 04:37:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:37:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:37:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:37:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:37:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:37:42 INFO - Intel Iris: 04:37:42 INFO - Chipset Model: Intel Iris 04:37:42 INFO - Type: GPU 04:37:42 INFO - Bus: Built-In 04:37:42 INFO - VRAM (Dynamic, Max): 1536 MB 04:37:42 INFO - Vendor: Intel (0x8086) 04:37:42 INFO - Device ID: 0x0a2e 04:37:42 INFO - Revision ID: 0x0009 04:37:42 INFO - Displays: 04:37:42 INFO - Display: 04:37:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:37:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:37:42 INFO - Display Serial Number: 1600x1200 60 04:37:42 INFO - Main Display: Yes 04:37:42 INFO - Mirror: Off 04:37:42 INFO - Online: Yes 04:37:42 INFO - Rotation: Supported 04:37:42 INFO - Return code: 0 04:37:42 INFO - Running post-action listener: _resource_record_post_action 04:37:42 INFO - Running post-run listener: _resource_record_post_run 04:37:43 INFO - Total resource usage - Wall time: 1203s; CPU: 52.0%; Read bytes: 241664; Write bytes: 662160384; Read time: 6; Write time: 2527 04:37:43 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 361851392; Write bytes: 364054528; Read time: 28189; Write time: 673 04:37:43 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 241664; Write bytes: 297257984; Read time: 6; Write time: 1851 04:37:43 INFO - Running post-run listener: _upload_blobber_files 04:37:43 INFO - Blob upload gear active. 04:37:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:37:43 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 04:37:43 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:37:43 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:37:43 INFO - (blobuploader) - INFO - Open directory for files ... 04:37:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:37:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:37:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:44 INFO - (blobuploader) - INFO - Done attempting. 04:37:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:37:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:37:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:37:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:37:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:37:45 INFO - (blobuploader) - INFO - Done attempting. 04:37:45 INFO - (blobuploader) - INFO - Iteration through files over. 04:37:45 INFO - Return code: 0 04:37:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:37:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:37:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/466f6bf5b8b2fa70cb914747bad5cc5c82bf208db7eaec9fea1f886aeff0166bf08a2eccf45693f5ae920848ee0ed03d0576b69fd1727039c98cb74aabda3b2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c95356c02c218e3d00fe27bad053da77f1776c0ea1e7d4626c09aa8fee62f4e127c916b7f7cb135cd476e18be9689b4b92269b3909ed0189c3946bd9c6bbd754"} 04:37:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:37:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:37:45 INFO - Contents: 04:37:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/466f6bf5b8b2fa70cb914747bad5cc5c82bf208db7eaec9fea1f886aeff0166bf08a2eccf45693f5ae920848ee0ed03d0576b69fd1727039c98cb74aabda3b2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c95356c02c218e3d00fe27bad053da77f1776c0ea1e7d4626c09aa8fee62f4e127c916b7f7cb135cd476e18be9689b4b92269b3909ed0189c3946bd9c6bbd754"} 04:37:45 INFO - Running post-run listener: copy_logs_to_upload_dir 04:37:45 INFO - Copying logs to upload dir... 04:37:45 INFO - mkdir: /builds/slave/test/build/upload/logs 04:37:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.160670 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-03-23 04:37:45.459656) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 04:37:45.463196) ========= 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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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/Mozilla-Aurora/sha512/466f6bf5b8b2fa70cb914747bad5cc5c82bf208db7eaec9fea1f886aeff0166bf08a2eccf45693f5ae920848ee0ed03d0576b69fd1727039c98cb74aabda3b2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c95356c02c218e3d00fe27bad053da77f1776c0ea1e7d4626c09aa8fee62f4e127c916b7f7cb135cd476e18be9689b4b92269b3909ed0189c3946bd9c6bbd754"} build_url:https://queue.taskcluster.net/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010455 build_url: 'https://queue.taskcluster.net/v1/task/DZa97uSeRciV1i-P_IWiRQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/466f6bf5b8b2fa70cb914747bad5cc5c82bf208db7eaec9fea1f886aeff0166bf08a2eccf45693f5ae920848ee0ed03d0576b69fd1727039c98cb74aabda3b2b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c95356c02c218e3d00fe27bad053da77f1776c0ea1e7d4626c09aa8fee62f4e127c916b7f7cb135cd476e18be9689b4b92269b3909ed0189c3946bd9c6bbd754"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 04:37:45.490931) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:37:45.491216) ========= 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.Q3NVokG3bm/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.1yIWNSqOkC/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/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.005085 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:37:45.544959) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 04:37:45.545233) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 04:37:45.545586) ========= ========= Total master_lag: 0.31 =========