builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0135 starttime: 1458861016.51 results: success (0) buildid: 20160324142802 builduid: 7840e4b0294b412b89ce348f15452a29 revision: a4481ccef67e4732e005b3538df8d8e61890bcdc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 16:10:16.511239) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-24 16:10:16.511699) ========= ========= Started set props: basedir (results: 0, elapsed: 6 secs) (at 2016-03-24 16:10:16.511998) ========= 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.BSAqMFOKi2/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.SdSv848icr/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005728 basedir: '/builds/slave/test' ========= master_lag: 6.42 ========= ========= Finished set props: basedir (results: 0, elapsed: 6 secs) (at 2016-03-24 16:10:22.936810) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-03-24 16:10:22.937083) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 7 secs) (at 2016-03-24 16:10:30.779296) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 16:10:30.779698) ========= 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.BSAqMFOKi2/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.SdSv848icr/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005459 ========= master_lag: 1.57 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-24 16:10:32.357989) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 16:10:32.358318) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-24 16:10:32.361686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-24 16:10:32.361960) ========= 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.BSAqMFOKi2/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.SdSv848icr/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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-24 16:10:32-- 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% 5.99M=0.002s 2016-03-24 16:10:33 (5.99 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.681080 ========= master_lag: 1.75 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-24 16:10:34.796053) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 16:10:34.796390) ========= 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.BSAqMFOKi2/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.SdSv848icr/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.019509 ========= master_lag: 0.62 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 16:10:35.439805) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-24 16:10:35.440157) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a4481ccef67e4732e005b3538df8d8e61890bcdc --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 a4481ccef67e4732e005b3538df8d8e61890bcdc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BSAqMFOKi2/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.SdSv848icr/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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-24 16:10:35,722 truncating revision to first 12 chars 2016-03-24 16:10:35,722 Setting DEBUG logging. 2016-03-24 16:10:35,723 attempt 1/10 2016-03-24 16:10:35,723 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a4481ccef67e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-24 16:10:37,291 unpacking tar archive at: mozilla-aurora-a4481ccef67e/testing/mozharness/ program finished with exit code 0 elapsedTime=2.147856 ========= master_lag: 0.26 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-24 16:10:37.852607) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-24 16:10:37.852980) ========= echo a4481ccef67e4732e005b3538df8d8e61890bcdc in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a4481ccef67e4732e005b3538df8d8e61890bcdc'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BSAqMFOKi2/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.SdSv848icr/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 a4481ccef67e4732e005b3538df8d8e61890bcdc program finished with exit code 0 elapsedTime=0.004976 script_repo_revision: 'a4481ccef67e4732e005b3538df8d8e61890bcdc' ========= master_lag: 1.01 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 1 secs) (at 2016-03-24 16:10:38.864570) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 16:10:38.864893) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-24 16:10:39.380644) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-03-24 16:10:39.381031) ========= /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.BSAqMFOKi2/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.SdSv848icr/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 16:10:39 INFO - MultiFileLogger online at 20160324 16:10:39 in /builds/slave/test 16:10:39 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 16:10:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:10:39 INFO - {'append_to_log': False, 16:10:39 INFO - 'base_work_dir': '/builds/slave/test', 16:10:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:10:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:10:39 INFO - 'branch': 'Mozilla-Aurora', 16:10:39 INFO - 'buildbot_json_path': 'buildprops.json', 16:10:39 INFO - 'config_files': ('talos/mac_config.py',), 16:10:39 INFO - 'default_actions': ('clobber', 16:10:39 INFO - 'read-buildbot-config', 16:10:39 INFO - 'download-and-extract', 16:10:39 INFO - 'populate-webroot', 16:10:39 INFO - 'create-virtualenv', 16:10:39 INFO - 'install', 16:10:39 INFO - 'run-tests'), 16:10:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:10:39 INFO - 'download_minidump_stackwalk': True, 16:10:39 INFO - 'download_symbols': 'ondemand', 16:10:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:10:39 INFO - 'tooltool.py': '/tools/tooltool.py', 16:10:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:10:39 INFO - '/tools/misc-python/virtualenv.py')}, 16:10:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:10:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:10:39 INFO - 'installer_path': 'installer.exe', 16:10:39 INFO - 'log_level': 'info', 16:10:39 INFO - 'log_name': 'talos', 16:10:39 INFO - 'log_to_console': True, 16:10:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:10:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:10:39 INFO - 'opt_config_files': (), 16:10:39 INFO - 'pip_index': False, 16:10:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:10:39 INFO - 'cmd': ('bash', 16:10:39 INFO - '-c', 16:10:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:10:39 INFO - 'enabled': True, 16:10:39 INFO - 'halt_on_failure': False, 16:10:39 INFO - 'name': 'check_screen_resolution'},), 16:10:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:10:39 INFO - 'cmd': ('bash', 16:10:39 INFO - '-c', 16:10:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:10:39 INFO - 'enabled': True, 16:10:39 INFO - 'halt_on_failure': False, 16:10:39 INFO - 'name': 'check_screen_resolution'},), 16:10:39 INFO - 'run_cmd_checks_enabled': True, 16:10:39 INFO - 'sps_profile': False, 16:10:39 INFO - 'sps_profile_interval': 0, 16:10:39 INFO - 'suite': 'dromaeojs', 16:10:39 INFO - 'system_bits': '32', 16:10:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:10:39 INFO - 'title': 't-yosemite-r7-0135', 16:10:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:10:39 INFO - 'use_talos_json': True, 16:10:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:10:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:10:39 INFO - 'work_dir': 'build'} 16:10:39 INFO - ##### 16:10:39 INFO - ##### Running clobber step. 16:10:39 INFO - ##### 16:10:39 INFO - Running pre-action listener: _resource_record_pre_action 16:10:39 INFO - Running main action method: clobber 16:10:39 INFO - rmtree: /builds/slave/test/build 16:10:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:10:41 INFO - Running post-action listener: _resource_record_post_action 16:10:41 INFO - ##### 16:10:41 INFO - ##### Running read-buildbot-config step. 16:10:41 INFO - ##### 16:10:41 INFO - Running pre-action listener: _resource_record_pre_action 16:10:41 INFO - Running main action method: read_buildbot_config 16:10:41 INFO - Using buildbot properties: 16:10:41 INFO - { 16:10:41 INFO - "project": "", 16:10:41 INFO - "product": "firefox", 16:10:41 INFO - "script_repo_revision": "production", 16:10:41 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:10:41 INFO - "repository": "", 16:10:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:10:41 INFO - "buildid": "20160324142802", 16:10:41 INFO - "pgo_build": "False", 16:10:41 INFO - "basedir": "/builds/slave/test", 16:10:41 INFO - "buildnumber": 250, 16:10:41 INFO - "slavename": "t-yosemite-r7-0135", 16:10:41 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:10:41 INFO - "platform": "yosemite_r7", 16:10:41 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:10:41 INFO - "branch": "mozilla-aurora", 16:10:41 INFO - "repo_path": "releases/mozilla-aurora", 16:10:41 INFO - "revision": "a4481ccef67e4732e005b3538df8d8e61890bcdc", 16:10:41 INFO - "stage_platform": "macosx64", 16:10:41 INFO - "builduid": "7840e4b0294b412b89ce348f15452a29", 16:10:41 INFO - "slavebuilddir": "test" 16:10:41 INFO - } 16:10:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 16:10:41 INFO - Running post-action listener: _resource_record_post_action 16:10:41 INFO - ##### 16:10:41 INFO - ##### Running download-and-extract step. 16:10:41 INFO - ##### 16:10:41 INFO - Running pre-action listener: _resource_record_pre_action 16:10:41 INFO - Running main action method: download_and_extract 16:10:41 INFO - mkdir: /builds/slave/test/build/tests 16:10:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:41 INFO - https://queue.taskcluster.net/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:10:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 16:10:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 16:10:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/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 16:10:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/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 16:10:43 INFO - Downloaded 1277 bytes. 16:10:43 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 16:10:43 INFO - Using the following test package requirements: 16:10:43 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:10:43 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:10:43 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 16:10:43 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:10:43 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 16:10:43 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:10:43 INFO - u'jsshell-mac.zip'], 16:10:43 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:10:43 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 16:10:43 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:10:43 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:10:43 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 16:10:43 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:10:43 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 16:10:43 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:10:43 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 16:10:43 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 16:10:43 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 16:10:43 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 16:10:43 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:10:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:10:43 INFO - https://queue.taskcluster.net/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:10:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:10:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:10:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/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 16:10:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/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 16:10:48 INFO - Downloaded 17869024 bytes. 16:10:48 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'] 16:10:48 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 16:10:51 INFO - Return code: 0 16:10:51 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 16:10:51 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')]} 16:10:51 INFO - https://queue.taskcluster.net/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:10:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:10:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 16:10:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/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 16:10:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/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 16:10:57 INFO - Downloaded 17869024 bytes. 16:10:57 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'] 16:10:57 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 16:11:01 INFO - Return code: 0 16:11:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:01 INFO - https://queue.taskcluster.net/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:11:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 16:11:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 16:11:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/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 16:11:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/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 16:11:06 INFO - Downloaded 10845161 bytes. 16:11:06 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'] 16:11:06 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 16:11:06 INFO - Return code: 0 16:11:06 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')]} 16:11:06 INFO - https://queue.taskcluster.net/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 16:11:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:11:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:11:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 16:11:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DTkWQjA9Rhy59Z207fL7GQ/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 16:11:21 INFO - Downloaded 114962562 bytes. 16:11:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:11:21 INFO - mkdir: /builds/slave/test/properties 16:11:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:11:21 INFO - Writing to file /builds/slave/test/properties/build_url 16:11:21 INFO - Contents: 16:11:21 INFO - build_url:https://queue.taskcluster.net/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 16:11:23 INFO - Running post-action listener: _resource_record_post_action 16:11:23 INFO - Running post-action listener: set_extra_try_arguments 16:11:23 INFO - ##### 16:11:23 INFO - ##### Running populate-webroot step. 16:11:23 INFO - ##### 16:11:23 INFO - Running pre-action listener: _resource_record_pre_action 16:11:23 INFO - Running main action method: populate_webroot 16:11:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:11:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:11:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:11:23 INFO - '--tppagecycles', 16:11:23 INFO - '7'], 16:11:23 INFO - 'tests': ['tsvgm']}}, 16:11:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:11:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:11:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:11:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:11:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:11:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'tests': ['damp', 'tps']}, 16:11:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['damp', 'tps']}, 16:11:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:11:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:11:23 INFO - 'other': {'tests': ['a11yr', 16:11:23 INFO - 'ts_paint', 16:11:23 INFO - 'tpaint', 16:11:23 INFO - 'sessionrestore', 16:11:23 INFO - 'sessionrestore_no_auto_restore', 16:11:23 INFO - 'tabpaint']}, 16:11:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['a11yr', 16:11:23 INFO - 'ts_paint', 16:11:23 INFO - 'tpaint', 16:11:23 INFO - 'sessionrestore', 16:11:23 INFO - 'sessionrestore_no_auto_restore', 16:11:23 INFO - 'tabpaint']}, 16:11:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['a11yr', 16:11:23 INFO - 'ts_paint', 16:11:23 INFO - 'tpaint', 16:11:23 INFO - 'sessionrestore', 16:11:23 INFO - 'sessionrestore_no_auto_restore', 16:11:23 INFO - 'tabpaint']}, 16:11:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['a11yr', 16:11:23 INFO - 'ts_paint', 16:11:23 INFO - 'tpaint', 16:11:23 INFO - 'sessionrestore', 16:11:23 INFO - 'sessionrestore_no_auto_restore', 16:11:23 INFO - 'tabpaint']}, 16:11:23 INFO - 'other_l64': {'tests': ['a11yr', 16:11:23 INFO - 'ts_paint', 16:11:23 INFO - 'tpaint', 16:11:23 INFO - 'sessionrestore', 16:11:23 INFO - 'sessionrestore_no_auto_restore', 16:11:23 INFO - 'tabpaint']}, 16:11:23 INFO - 'other_nol64': {'tests': ['a11yr', 16:11:23 INFO - 'ts_paint', 16:11:23 INFO - 'tpaint', 16:11:23 INFO - 'sessionrestore', 16:11:23 INFO - 'sessionrestore_no_auto_restore', 16:11:23 INFO - 'tabpaint']}, 16:11:23 INFO - 'svgr': {'tests': ['tsvgx', 16:11:23 INFO - 'tsvgr_opacity', 16:11:23 INFO - 'tart', 16:11:23 INFO - 'tscrollx', 16:11:23 INFO - 'cart']}, 16:11:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['tsvgx', 16:11:23 INFO - 'tsvgr_opacity', 16:11:23 INFO - 'tart', 16:11:23 INFO - 'tscrollx', 16:11:23 INFO - 'cart']}, 16:11:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'tests': ['tp5o']}, 16:11:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'talos_options': ['--e10s'], 16:11:23 INFO - 'tests': ['tp5o']}, 16:11:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'talos_options': ['--xperf_path', 16:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:23 INFO - 'tests': ['tp5n']}, 16:11:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:11:23 INFO - 'talos_options': ['--e10s', 16:11:23 INFO - '--xperf_path', 16:11:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:11:23 INFO - 'tests': ['tp5n']}}, 16:11:23 INFO - 'talos.zip': {'path': '', 16:11:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:11:23 INFO - Running post-action listener: _resource_record_post_action 16:11:23 INFO - ##### 16:11:23 INFO - ##### Running create-virtualenv step. 16:11:23 INFO - ##### 16:11:23 INFO - Running pre-action listener: _resource_record_pre_action 16:11:23 INFO - Running main action method: create_virtualenv 16:11:23 INFO - Creating virtualenv /builds/slave/test/build/venv 16:11:23 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 16:11:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:11:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:11:23 INFO - Using real prefix '/tools/python27' 16:11:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:11:24 INFO - Installing distribute.............................................................................................................................................................................................done. 16:11:26 INFO - Installing pip.................done. 16:11:26 INFO - Return code: 0 16:11:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f0d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6cad4fae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77d30>, '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 0x10eddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef6eb20>, '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.BSAqMFOKi2/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.SdSv848icr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 16:11:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:11:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:11:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BSAqMFOKi2/Render', 16:11:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:26 INFO - 'HOME': '/Users/cltbld', 16:11:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:26 INFO - 'LOGNAME': 'cltbld', 16:11:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:26 INFO - 'MOZ_NO_REMOTE': '1', 16:11:26 INFO - 'NO_EM_RESTART': '1', 16:11:26 INFO - 'PAGER': '/bin/cat', 16:11:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:26 INFO - 'PWD': '/builds/slave/test', 16:11:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:26 INFO - 'SHELL': '/bin/bash', 16:11:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SdSv848icr/Listeners', 16:11:26 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 16:11:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:26 INFO - 'USER': 'cltbld', 16:11:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:26 INFO - 'XPC_FLAGS': '0x0', 16:11:26 INFO - 'XPC_SERVICE_NAME': '0', 16:11:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:27 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 16:11:27 INFO - Cleaning up... 16:11:27 INFO - Return code: 0 16:11:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f0d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6cad4fae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77d30>, '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 0x10eddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef6eb20>, '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.BSAqMFOKi2/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.SdSv848icr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 16:11:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:11:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BSAqMFOKi2/Render', 16:11:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:27 INFO - 'HOME': '/Users/cltbld', 16:11:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:27 INFO - 'LOGNAME': 'cltbld', 16:11:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:27 INFO - 'MOZ_NO_REMOTE': '1', 16:11:27 INFO - 'NO_EM_RESTART': '1', 16:11:27 INFO - 'PAGER': '/bin/cat', 16:11:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:27 INFO - 'PWD': '/builds/slave/test', 16:11:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:27 INFO - 'SHELL': '/bin/bash', 16:11:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SdSv848icr/Listeners', 16:11:27 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 16:11:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:27 INFO - 'USER': 'cltbld', 16:11:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:27 INFO - 'XPC_FLAGS': '0x0', 16:11:27 INFO - 'XPC_SERVICE_NAME': '0', 16:11:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:27 INFO - Downloading/unpacking psutil>=0.7.1 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:11:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:31 INFO - Installing collected packages: psutil 16:11:31 INFO - Running setup.py install for psutil 16:11:31 INFO - building 'psutil._psutil_osx' extension 16:11:31 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 16:11:32 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 16:11:32 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 16:11:32 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 16:11:32 INFO - building 'psutil._psutil_posix' extension 16:11:32 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 16:11:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:11:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:11:32 INFO - ^ 16:11:32 INFO - 1 warning generated. 16:11:32 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 16:11:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:11:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:11:32 INFO - Successfully installed psutil 16:11:32 INFO - Cleaning up... 16:11:32 INFO - Return code: 0 16:11:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:32 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 0x10f0d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6cad4fae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77d30>, '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 0x10eddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef6eb20>, '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.BSAqMFOKi2/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.SdSv848icr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 16:11:32 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 16:11:32 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 16:11:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BSAqMFOKi2/Render', 16:11:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:32 INFO - 'HOME': '/Users/cltbld', 16:11:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:32 INFO - 'LOGNAME': 'cltbld', 16:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:32 INFO - 'MOZ_NO_REMOTE': '1', 16:11:32 INFO - 'NO_EM_RESTART': '1', 16:11:32 INFO - 'PAGER': '/bin/cat', 16:11:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:32 INFO - 'PWD': '/builds/slave/test', 16:11:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:32 INFO - 'SHELL': '/bin/bash', 16:11:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SdSv848icr/Listeners', 16:11:32 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 16:11:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:32 INFO - 'USER': 'cltbld', 16:11:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:32 INFO - 'XPC_FLAGS': '0x0', 16:11:32 INFO - 'XPC_SERVICE_NAME': '0', 16:11:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:11:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:11:35 INFO - Installing collected packages: mozsystemmonitor 16:11:35 INFO - Running setup.py install for mozsystemmonitor 16:11:36 INFO - Successfully installed mozsystemmonitor 16:11:36 INFO - Cleaning up... 16:11:36 INFO - Return code: 0 16:11:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:36 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 0x10f0d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6cad4fae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77d30>, '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 0x10eddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef6eb20>, '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.BSAqMFOKi2/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.SdSv848icr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 16:11:36 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 16:11:36 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 16:11:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BSAqMFOKi2/Render', 16:11:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:36 INFO - 'HOME': '/Users/cltbld', 16:11:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:36 INFO - 'LOGNAME': 'cltbld', 16:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:36 INFO - 'MOZ_NO_REMOTE': '1', 16:11:36 INFO - 'NO_EM_RESTART': '1', 16:11:36 INFO - 'PAGER': '/bin/cat', 16:11:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:36 INFO - 'PWD': '/builds/slave/test', 16:11:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:36 INFO - 'SHELL': '/bin/bash', 16:11:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SdSv848icr/Listeners', 16:11:36 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 16:11:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:36 INFO - 'USER': 'cltbld', 16:11:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:36 INFO - 'XPC_FLAGS': '0x0', 16:11:36 INFO - 'XPC_SERVICE_NAME': '0', 16:11:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:36 INFO - Downloading/unpacking blobuploader==1.2.4 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11: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 16:11:39 INFO - Downloading blobuploader-1.2.4.tar.gz 16:11:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:11:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:11:39 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 16:11:39 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 16:11:39 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 16:11:39 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 16:11:39 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 16:11:39 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 16:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:11:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:40 INFO - Downloading docopt-0.6.1.tar.gz 16:11:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:11:40 INFO - Installing collected packages: blobuploader, requests, docopt 16:11:40 INFO - Running setup.py install for blobuploader 16:11:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:11:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:11:40 INFO - Running setup.py install for requests 16:11:41 INFO - Running setup.py install for docopt 16:11:41 INFO - Successfully installed blobuploader requests docopt 16:11:41 INFO - Cleaning up... 16:11:41 INFO - Return code: 0 16:11:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:11:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:41 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 0x10f0d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6cad4fae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77d30>, '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 0x10eddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef6eb20>, '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.BSAqMFOKi2/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.SdSv848icr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 16:11:41 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 16:11:41 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 16:11:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BSAqMFOKi2/Render', 16:11:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:41 INFO - 'HOME': '/Users/cltbld', 16:11:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:41 INFO - 'LOGNAME': 'cltbld', 16:11:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:41 INFO - 'MOZ_NO_REMOTE': '1', 16:11:41 INFO - 'NO_EM_RESTART': '1', 16:11:41 INFO - 'PAGER': '/bin/cat', 16:11:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:41 INFO - 'PWD': '/builds/slave/test', 16:11:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:41 INFO - 'SHELL': '/bin/bash', 16:11:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SdSv848icr/Listeners', 16:11:41 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 16:11:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:41 INFO - 'USER': 'cltbld', 16:11:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:41 INFO - 'XPC_FLAGS': '0x0', 16:11:41 INFO - 'XPC_SERVICE_NAME': '0', 16:11:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:41 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-aYnTtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:42 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-JD2q5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:42 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-j5o109-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:11:42 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-vu169R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:42 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-0aWLa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:42 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-E6yWUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:42 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Fz_whn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:42 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Cf4VhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:42 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-IJiuXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:42 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-CulQWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:42 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-oncWIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:43 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-fI0yeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:43 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-8kWC1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:43 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-Sa1afX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:43 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-0lhg2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:43 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-IQ_ee7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:43 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-6ww9ZQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:11:43 INFO - Running setup.py install for manifestparser 16:11:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:11:43 INFO - Running setup.py install for mozcrash 16:11:44 INFO - Running setup.py install for mozdebug 16:11:44 INFO - Running setup.py install for mozdevice 16:11:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Running setup.py install for mozfile 16:11:44 INFO - Running setup.py install for mozhttpd 16:11:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Running setup.py install for mozinfo 16:11:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Running setup.py install for mozInstall 16:11:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:11:44 INFO - Running setup.py install for mozleak 16:11:45 INFO - Running setup.py install for mozlog 16:11:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:11:45 INFO - Running setup.py install for moznetwork 16:11:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:11:45 INFO - Running setup.py install for mozprocess 16:11:45 INFO - Running setup.py install for mozprofile 16:11:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:11:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:11:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:11:45 INFO - Running setup.py install for mozrunner 16:11:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:11:45 INFO - Running setup.py install for mozscreenshot 16:11:45 INFO - Running setup.py install for moztest 16:11:46 INFO - Running setup.py install for mozversion 16:11:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:11:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:11:46 INFO - Cleaning up... 16:11:46 INFO - Return code: 0 16:11:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:46 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 0x10f0d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6cad4fae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77d30>, '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 0x10eddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef6eb20>, '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.BSAqMFOKi2/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.SdSv848icr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 16:11:46 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 16:11:46 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 16:11:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BSAqMFOKi2/Render', 16:11:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:46 INFO - 'HOME': '/Users/cltbld', 16:11:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:46 INFO - 'LOGNAME': 'cltbld', 16:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:46 INFO - 'MOZ_NO_REMOTE': '1', 16:11:46 INFO - 'NO_EM_RESTART': '1', 16:11:46 INFO - 'PAGER': '/bin/cat', 16:11:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:46 INFO - 'PWD': '/builds/slave/test', 16:11:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:46 INFO - 'SHELL': '/bin/bash', 16:11:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SdSv848icr/Listeners', 16:11:46 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 16:11:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:46 INFO - 'USER': 'cltbld', 16:11:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:46 INFO - 'XPC_FLAGS': '0x0', 16:11:46 INFO - 'XPC_SERVICE_NAME': '0', 16:11:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:11:46 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-4HRYxI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:11:46 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)) 16:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:11:46 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-XhmVcx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:11:46 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)) 16:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:11:46 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-DXizua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:11:46 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)) 16:11:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:11:46 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-OclBTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:11:47 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)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:11:47 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-XK6pbk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:11:47 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)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:11:47 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-BF1L8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:11:47 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)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:11:47 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-yWqxac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:11:47 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)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:11:47 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-xHde26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:11:47 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)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:11:47 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-9RwtQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:11:47 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)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:11:47 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-lsMC8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:11:47 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)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:11:47 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-RMveFE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:11:47 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)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:11:47 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-CFir79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:11:47 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)) 16:11:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:11:47 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-BNNlXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:11:48 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)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:11:48 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-AMXWoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:11:48 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)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:48 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-JBm4UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:11:48 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)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:11:48 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-1zhJVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:11:48 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)) 16:11:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:11:48 INFO - Running setup.py (path:/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/pip-ewynC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:11:48 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)) 16:11:48 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)) 16:11:48 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)) 16:11:48 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)) 16:11:48 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)) 16:11:48 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)) 16:11:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:11:48 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 16:11:48 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 16:11:48 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 16:11:48 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 16:11:48 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 16:11:48 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 16:11:51 INFO - Downloading blessings-1.6.tar.gz 16:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:11:51 INFO - Installing collected packages: blessings 16:11:51 INFO - Running setup.py install for blessings 16:11:51 INFO - Successfully installed blessings 16:11:51 INFO - Cleaning up... 16:11:51 INFO - Return code: 0 16:11:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:11:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:11:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:11:52 INFO - Reading from file tmpfile_stdout 16:11:52 INFO - Current package versions: 16:11:52 INFO - blessings == 1.6 16:11:52 INFO - blobuploader == 1.2.4 16:11:52 INFO - docopt == 0.6.1 16:11:52 INFO - manifestparser == 1.1 16:11:52 INFO - mozInstall == 1.12 16:11:52 INFO - mozcrash == 0.17 16:11:52 INFO - mozdebug == 0.1 16:11:52 INFO - mozdevice == 0.48 16:11:52 INFO - mozfile == 1.2 16:11:52 INFO - mozhttpd == 0.7 16:11:52 INFO - mozinfo == 0.9 16:11:52 INFO - mozleak == 0.1 16:11:52 INFO - mozlog == 3.1 16:11:52 INFO - moznetwork == 0.27 16:11:52 INFO - mozprocess == 0.22 16:11:52 INFO - mozprofile == 0.28 16:11:52 INFO - mozrunner == 6.11 16:11:52 INFO - mozscreenshot == 0.1 16:11:52 INFO - mozsystemmonitor == 0.0 16:11:52 INFO - moztest == 0.7 16:11:52 INFO - mozversion == 1.4 16:11:52 INFO - psutil == 3.1.1 16:11:52 INFO - requests == 1.2.3 16:11:52 INFO - wsgiref == 0.1.2 16:11:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:52 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 0x10f0d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6cad4fae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77d30>, '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 0x10eddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef6eb20>, '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.BSAqMFOKi2/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.SdSv848icr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 16:11:52 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 16:11:52 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 16:11:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BSAqMFOKi2/Render', 16:11:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:52 INFO - 'HOME': '/Users/cltbld', 16:11:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:52 INFO - 'LOGNAME': 'cltbld', 16:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:52 INFO - 'MOZ_NO_REMOTE': '1', 16:11:52 INFO - 'NO_EM_RESTART': '1', 16:11:52 INFO - 'PAGER': '/bin/cat', 16:11:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:52 INFO - 'PWD': '/builds/slave/test', 16:11:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:52 INFO - 'SHELL': '/bin/bash', 16:11:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SdSv848icr/Listeners', 16:11:52 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 16:11:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:52 INFO - 'USER': 'cltbld', 16:11:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:52 INFO - 'XPC_FLAGS': '0x0', 16:11:52 INFO - 'XPC_SERVICE_NAME': '0', 16:11:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:52 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)) 16:11:52 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)) 16:11:52 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)) 16:11:52 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)) 16:11:52 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)) 16:11:52 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)) 16:11:52 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)) 16:11:52 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)) 16:11:52 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)) 16:11:52 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)) 16:11:52 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)) 16:11:52 INFO - Cleaning up... 16:11:52 INFO - Return code: 0 16:11:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:11: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')]} 16:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11: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')]} 16:11:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:52 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 0x10f0d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6cad4fae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77d30>, '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 0x10eddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef6eb20>, '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.BSAqMFOKi2/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.SdSv848icr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 16:11:52 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 16:11:52 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 16:11:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BSAqMFOKi2/Render', 16:11:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:52 INFO - 'HOME': '/Users/cltbld', 16:11:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:52 INFO - 'LOGNAME': 'cltbld', 16:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:52 INFO - 'MOZ_NO_REMOTE': '1', 16:11:52 INFO - 'NO_EM_RESTART': '1', 16:11:52 INFO - 'PAGER': '/bin/cat', 16:11:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:52 INFO - 'PWD': '/builds/slave/test', 16:11:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:52 INFO - 'SHELL': '/bin/bash', 16:11:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SdSv848icr/Listeners', 16:11:52 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 16:11:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:52 INFO - 'USER': 'cltbld', 16:11:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:52 INFO - 'XPC_FLAGS': '0x0', 16:11:52 INFO - 'XPC_SERVICE_NAME': '0', 16:11:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:52 INFO - Downloading/unpacking jsonschema 16:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:11:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:11:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:11:55 INFO - Downloading/unpacking functools32 (from jsonschema) 16:11:55 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 16:11:55 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 16:11:55 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 16:11:55 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 16:11:55 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 16:11:55 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 16:11:56 INFO - Downloading functools32-3.2.3-2.tar.gz 16:11:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:11:56 INFO - warning: no files found matching '*.txt' 16:11:56 INFO - no previously-included directories found matching 'build' 16:11:56 INFO - no previously-included directories found matching 'dist' 16:11:56 INFO - no previously-included directories found matching '.git*' 16:11:56 INFO - Installing collected packages: jsonschema, functools32 16:11:56 INFO - Running setup.py install for functools32 16:11:56 INFO - warning: no files found matching '*.txt' 16:11:56 INFO - no previously-included directories found matching 'build' 16:11:56 INFO - no previously-included directories found matching 'dist' 16:11:56 INFO - no previously-included directories found matching '.git*' 16:11:56 INFO - Successfully installed jsonschema functools32 16:11:56 INFO - Cleaning up... 16:11:56 INFO - Return code: 0 16:11:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:11:56 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')]} 16:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:56 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')]} 16:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:11:56 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 0x10f0d3a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6cad4fae0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef77d30>, '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 0x10eddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef6eb20>, '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.BSAqMFOKi2/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.SdSv848icr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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 16:11:56 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 16:11:56 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 16:11:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BSAqMFOKi2/Render', 16:11:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:11:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:11:56 INFO - 'HOME': '/Users/cltbld', 16:11:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:11:56 INFO - 'LOGNAME': 'cltbld', 16:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:11:56 INFO - 'MOZ_NO_REMOTE': '1', 16:11:56 INFO - 'NO_EM_RESTART': '1', 16:11:56 INFO - 'PAGER': '/bin/cat', 16:11:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:11:56 INFO - 'PWD': '/builds/slave/test', 16:11:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:11:56 INFO - 'SHELL': '/bin/bash', 16:11:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SdSv848icr/Listeners', 16:11:56 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 16:11:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:11:56 INFO - 'USER': 'cltbld', 16:11:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:11:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:11:56 INFO - 'XPC_FLAGS': '0x0', 16:11:56 INFO - 'XPC_SERVICE_NAME': '0', 16:11:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:11:56 INFO - Downloading/unpacking flake8 16:11:56 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 16:11:56 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 16:11:56 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 16:11:56 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 16:11:56 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 16:11:56 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 16:11:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:11:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:11:59 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 16:11:59 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 16:11:59 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 16:11:59 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 16:11:59 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 16:11:59 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 16:12:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:12:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:12:00 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 16:12:00 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 16:12:00 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 16:12:00 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 16:12:00 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 16:12:00 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 16:12:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:12:00 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 16:12:00 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 16:12:00 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 16:12:00 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 16:12:00 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 16:12:00 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 16:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:12:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:12:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:12:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:12:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:12:00 INFO - no previously-included directories found matching 'docs/_build' 16:12:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:12:01 INFO - Running setup.py install for pep8 16:12:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:12:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:12:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:12:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:12:01 INFO - no previously-included directories found matching 'docs/_build' 16:12:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:12:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:12:01 INFO - Cleaning up... 16:12:01 INFO - Return code: 0 16:12:01 INFO - Running post-action listener: _resource_record_post_action 16:12:01 INFO - Running post-action listener: _start_resource_monitoring 16:12:01 INFO - Starting resource monitoring. 16:12:01 INFO - ##### 16:12:01 INFO - ##### Running install step. 16:12:01 INFO - ##### 16:12:01 INFO - Running pre-action listener: _resource_record_pre_action 16:12:01 INFO - Running main action method: install 16:12:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:12:01 INFO - Reading from file tmpfile_stdout 16:12:01 INFO - Detecting whether we're running mozinstall >=1.0... 16:12:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:12:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:12:01 INFO - Reading from file tmpfile_stdout 16:12:01 INFO - Output received: 16:12:01 INFO - Usage: mozinstall [options] installer 16:12:01 INFO - Options: 16:12:01 INFO - -h, --help show this help message and exit 16:12:01 INFO - -d DEST, --destination=DEST 16:12:01 INFO - Directory to install application into. [default: 16:12:01 INFO - "/builds/slave/test"] 16:12:01 INFO - --app=APP Application being installed. [default: firefox] 16:12:01 INFO - mkdir: /builds/slave/test/build/application 16:12:01 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'] 16:12:01 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 16:12:33 INFO - Reading from file tmpfile_stdout 16:12:33 INFO - Output received: 16:12:33 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:12:33 INFO - Running post-action listener: _resource_record_post_action 16:12:33 INFO - ##### 16:12:33 INFO - ##### Running run-tests step. 16:12:33 INFO - ##### 16:12:33 INFO - Running pre-action listener: _resource_record_pre_action 16:12:33 INFO - Running main action method: run_tests 16:12:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:12:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:12:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:12:33 INFO - 2016-03-24 16:12:33.200 screenresolution[1935:18437] starting screenresolution argv=screenresolution get 16:12:33 INFO - 2016-03-24 16:12:33.203 screenresolution[1935:18437] Display 0: 1600x1200x32@60 16:12:33 INFO - 2016-03-24 16:12:33.209 screenresolution[1936:18439] starting screenresolution argv=screenresolution list 16:12:33 INFO - Available Modes on Display 0 16:12:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:12:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:12:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:12:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:12:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:12:33 INFO - Intel Iris: 16:12:33 INFO - Chipset Model: Intel Iris 16:12:33 INFO - Type: GPU 16:12:33 INFO - Bus: Built-In 16:12:33 INFO - VRAM (Dynamic, Max): 1536 MB 16:12:33 INFO - Vendor: Intel (0x8086) 16:12:33 INFO - Device ID: 0x0a2e 16:12:33 INFO - Revision ID: 0x0009 16:12:33 INFO - Displays: 16:12:33 INFO - Display: 16:12:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:12:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:12:33 INFO - Display Serial Number: 1600x1200 60 16:12:33 INFO - Main Display: Yes 16:12:33 INFO - Mirror: Off 16:12:33 INFO - Online: Yes 16:12:33 INFO - Rotation: Supported 16:12:33 INFO - Return code: 0 16:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:12:33 INFO - Python 2.7.3 16:12:33 INFO - Return code: 0 16:12:33 INFO - grabbing minidump binary from tooltool 16:12: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')]} 16:12:33 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 0x10ef77d30>, '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 0x10eddbdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef6eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:12:33 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 16:12:33 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 16:12:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:12:33 INFO - Return code: 0 16:12:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:12:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:12:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:12:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:12:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:12:34 INFO - Return code: 0 16:12:34 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/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 16:12:34 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/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0135 --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 16:12:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BSAqMFOKi2/Render', 16:12:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:12:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:12:34 INFO - 'HOME': '/Users/cltbld', 16:12:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:12:34 INFO - 'LOGNAME': 'cltbld', 16:12:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:12:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:12:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:12:34 INFO - 'MOZ_NO_REMOTE': '1', 16:12:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:12:34 INFO - 'NO_EM_RESTART': '1', 16:12:34 INFO - 'PAGER': '/bin/cat', 16:12:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:12:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:12:34 INFO - 'PWD': '/builds/slave/test', 16:12:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:12:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:12:34 INFO - 'SHELL': '/bin/bash', 16:12:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SdSv848icr/Listeners', 16:12:34 INFO - 'TMPDIR': '/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/', 16:12:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:12:34 INFO - 'USER': 'cltbld', 16:12:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:12:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:12:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:12:34 INFO - 'XPC_FLAGS': '0x0', 16:12:34 INFO - 'XPC_SERVICE_NAME': '0', 16:12:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:12:34 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/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0135', '--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 16:12:34 INFO - mozversion application_buildid: 20160324142802 16:12:34 INFO - mozversion application_changeset: a4481ccef67e4732e005b3538df8d8e61890bcdc 16:12:34 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:12:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:12:34 INFO - mozversion application_name: Firefox 16:12:34 INFO - mozversion application_remotingname: firefox-dev 16:12:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:12:34 INFO - mozversion application_vendor: Mozilla 16:12:34 INFO - mozversion application_version: 47.0a2 16:12:34 INFO - mozversion platform_buildid: 20160324142802 16:12:34 INFO - mozversion platform_changeset: a4481ccef67e4732e005b3538df8d8e61890bcdc 16:12:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:12:34 INFO - mozversion platform_version: 47.0a2 16:12:34 INFO - using testdate: 1458861154 16:12:34 INFO - actual date: 1458861154 16:12:34 INFO - starting webserver on 'localhost:57310' 16:12:34 INFO - SUITE-START | Running 2 tests 16:12:34 INFO - TEST-START | dromaeo_css 16:12:34 INFO - operating with platform_type : mac_ 16:12:34 INFO - Initialising browser for dromaeo_css test... 16:12:34 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpV0Ze5n/profile http://localhost:57310/getInfo.html) 16:12:37 INFO - PROCESS | 1954 | __metrics Screen width/height:1600/1200 16:12:37 INFO - PROCESS | 1954 | colorDepth:24 16:12:37 INFO - PROCESS | 1954 | Browser inner width/height: 1024/689 16:12:37 INFO - PROCESS | 1954 | __metrics 16:12:37 INFO - PROCESS | 1954 | 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" 16:12:37 INFO - PROCESS | 1954 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:12:37 INFO - TEST-INFO | 1954: exit 0 16:12:37 INFO - Browser initialized. 16:12:37 INFO - Running cycle 1/1 for dromaeo_css test... 16:12:37 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpV0Ze5n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:12:49 INFO - PROCESS | 1956 | RSS: Main: 210763776 16:12:49 INFO - PROCESS | 1956 | 16:13:41 INFO - PROCESS | 1956 | 1458861221247 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] 16:15:51 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:57310/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57310/tests/dromaeo/cssquery-ext.html) 16:15:52 INFO - PROCESS | 1956 | RSS: Main: 327237632 16:15:52 INFO - PROCESS | 1956 | 16:18:55 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:57310/tests/dromaeo/cssquery-ext.html (next: http://localhost:57310/tests/dromaeo/cssquery-jquery.html) 16:18:55 INFO - PROCESS | 1956 | RSS: Main: 341729280 16:18:55 INFO - PROCESS | 1956 | 16:21:57 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:57310/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57310/tests/dromaeo/cssquery-mootools.html) 16:21:58 INFO - PROCESS | 1956 | RSS: Main: 347975680 16:21:58 INFO - PROCESS | 1956 | 16:25:00 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:57310/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57310/tests/dromaeo/cssquery-prototype.html) 16:25:01 INFO - PROCESS | 1956 | RSS: Main: 307961856 16:25:01 INFO - PROCESS | 1956 | 16:28:04 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:57310/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57310/tests/dromaeo/cssquery-yui.html) 16:28:04 INFO - PROCESS | 1956 | RSS: Main: 306393088 16:28:04 INFO - PROCESS | 1956 | 16:31:07 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:57310/tests/dromaeo/cssquery-yui.html (next: http://localhost:57310/tests/dromaeo/cssquery-dojo.html) 16:31:07 INFO - PROCESS | 1956 | RSS: Main: 354045952 16:31:07 INFO - PROCESS | 1956 | 16:31:07 INFO - PROCESS | 1956 | __start_tp_report 16:31:07 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 16:31:07 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 16:31:07 INFO - PROCESS | 1956 | |i|pagename|runs| 16:31:07 INFO - PROCESS | 1956 | |0;dojo.html;3405.761596688232;3454.740894432917;3487.1107867493783;3495.0912762681696;3531.3820081485733;5701.600887937846;5703.885922281552;5708.457696518829;5711.457411545902;5733.48398644122;5706.857328566788;5717.456841600052;5734.483896449318;5746.597738158331;5752.884942301152;5193.610479214055;5205.063088644042;5249.763760630781;5250.7112108834;5256.737163141846;5345.572354211654;5348.518633323;5355.946440535603;5370.409254981949;5375.220593014011;5318.521333080022;5334.199870019509;5358.91961620576;5377.731113444332;5383.596230282725;5367.114426119705;5393.668042890359;5399.1091469907415;5417.674939503642;5465.371482279549;5136.948630513684;5296.841094767163;5328.973355133238;5343.091674415358;5345.957538280037;4773.594244489223;5704.971475142639;5773.971130144364;5777.306723193244;5799.82600521985;6190.226221722285;6338.904916426257;6351.682415879188;6364;6367.554271201017;6252.624842509464;6324.367563243639;6327.5570710050315;6327.810165695037;6371.458426033792;5895.823125306248;5904.291485021825;5910.054391297372;5916.852078698067;5924.555658325643;6254.937450625526;6289.276733175652;6358.904616430757;6367.52243581724;6375.23497180332;6237.4698150657705;6240.31356550779;6242.812715618538;6268.843278917972;6270;6284.994400895835;6297.842553936097;6311.463525600284;6315.400036996478;6324.620522768649;6117.84705382369;6216.720247588779;6222.502199824004;6311.684415779285;6326.9683651581445;6284.528660350492;6288.779892703825;6321.747130114836;6338.714757835908;6364.395382438661;4915.631327650441;4921.87695307613;4939.555440010345;4944.381952255968;4960;4333.371661109185;4367.388565600819;4473.217186992263;4483.103379324149;4500.909981800346;5848.795292164754;5857.472827445466;5860.941390586125;5888.5289176865745;5914.763409463573;6278.372162783685;6317.6209427434505;6320.399562041599;6324.019776934582;6346.2067241594805;5604.159376093618;5837.795677151279;5857.853553661193;5887.381824908409;5896.764129434775;5407.432219616962;5455.18172274162;5455.5908306876345;5459.153831156177;5462.289902312674;6389.9680501597195;6403.455706264926;6421.614703117828;6422.678866056772;6424.678766061678;6224.9377506224355;6253.843653908689;6264.21697287839;6276.184096067482;6314.273858506331;4853.781579828846;5421.620486565903;6371.299157092623;6371.776987805404;6417.326180751141;6307.306196318493;6312.810615681537;6313.842153946188;6317.431431171217;6325.082862984934;6209.844753881009;6214.067889816563;6248.718807653758;6249.000159974382;6267.498600111889;6033.276006879202;6195.81412557624;6205.720742566505;6212.254529456494;6216.968915155576;6074.058520929263;6165;6234.563580549499;6241.188645476059;6241.719122639583;6046.969765151146;6089.421504957022;6106.7862624809695;6118.040554665315;6137.447629713347;6229.3770622939155;6230.408111229426;6248.312685604489;6249.875002500015;6259.561830671809;5944.019236825875;6062.545309101747;6124.479419249235;6130.448259656652;6130.938690613037 16:31:07 INFO - PROCESS | 1956 | |1;ext.html;463.4508107892146;592.796622855603;627.9466245369143;661.6625520984296;669.9464042876571;31319.68680313196;32686.836565817168;32794.8521801737;32936.83531582339;41145.58854411455;35658.2868342633;44034.89912752175;44284.114317713625;44338.113237735226;44392.778036109856;9737.805243895118;9910.405375677447;9937.801243975116;9957.30298879075;9957.551910164024;9750.36622619531;9889.851652225223;9893;9898.257630677728;9908.058734420218;9834.311598188095;10053.899461005369;10069.345492542961;10081.747956301115;10101.797964040716;9978.900210997906;10053.547590358416;10064.698059058166;10069.144122749574;10079.49602519871;9827;9955.950220248926;9956.601735930626;9960;9969.601215951354;43567.78216108931;43930.780346098385;44057.55942440566;44121.77939110316;44130;3261.657525959764;3450.6549345065546;3534.6642069003406;3842.366009608439;4038.9700626340095;27367.86316068427;28649.28376790576;29250.853745731347;29363.41273174546;30219.244518887204;2803.8598070096414;2819.7954226950133;2824.7740180785486;2902.0568315297614;2915.4752144613963;505660;509895.9999999963;511382.4430877859;512139;513839;49050.75474622604;75147;76519;76576.61711691518;76714;51019.23471147936;51179.488205118214;51192.976140477724;51208;51244;17450.47648570545;17678.734818977726;17729.7340539892;17745.46763597094;17810.554736131442;14032.789508157386;14118.858811411754;14120.43518259258;14127.85872141286;14140.363683634261;15757.763633545506;15758.448454304043;15777.368905243662;15786.842131578536;15849.049057056614;6717.5297729159465;6742.157230346207;6781.220159681699;6808.944613584902;6811.046453496514;896.4442045931564;995.7809281957958;1066.7599790047177;1077.5097330714507;1085.5115198160859;30619.387612248076;30634.54048189279;30786;31083;31623.36753264922;1111.4220605285207;1121.1647322744607;1146.8337091121907;1156.6298784389082;1165.1028707895043;15196.620084497756;15561.455349062728;15728;15770.97488663256;15827.208639568205;532680;532837;535793;538680;538847;63707.04439433412;64152.03771943424;64209.357906421275;64242;64352;1487.21177775779;1516.4237589716058;1545.7217700813962;1552.767084937246;1558.9220538973007;29673.25816854596;30774.22966947268;31069.53395699021;31269.374612508076;31577.052688419386;50458;50805;50927.98144037025;51006.48993510017;51138.74430627823;384564;387074;388015;390445;483505;34273.82863085669;34887;35707.82146089253;35745.82127089348;35822.46266305955;44573.10853782841;44748;45358.09283814371;45792.62622121342;45897.54102458933;34384.14039648929;35362.76230331926;36452.27095458129;36828.631713682524;37067.62932370642;29424.705752942198;35093.64906350904;35790.4631430534;36543.45184822177;37322.626773733;37537.97581461841;37810;37860.62139378681;37913.483460661264;38103.2379352417;27681;32244.871429499854;32430.815854533063;33329.33341333208;33581.32837343288;20313.390598282076;21037.84291863962;25095.49809003773;25762.742372576035;25858.612120817827 16:31:07 INFO - PROCESS | 1956 | |2;jquery.html;376.6459528043639;380.9866654667087;382.1840370808325;386.9380899056152;387.3067209694645;20371.28700495481;21190.152393904245;21306.147754089838;21779.455513612167;21855.562888742217;21197.258095966645;21585.596936199137;21721.456963575918;21946.902654867274;22357.44106397341;5747.310322761275;5785.82642520725;5856.707164641773;5931.08068249422;5947.821565353025;4267.8079486423185;4490.887727806815;6255.405736455053;6495.415412612864;6507.154069970898;6366.968165159168;6432.5497215194955;6444.130042444281;6449.967750161242;6453.903191452132;6309.810705678837;6436.227652681661;6458.031295305695;6477.0608261802245;6481.254655714582;5554.583406244547;5602.495775380195;5642.153676948449;5644.407337229614;5646.40712725162;26942.86528567364;26946.865265673743;27191.86404067987;27242.5913611296;27341.589876151873;2073.8133567978803;2503.5493611149986;2600.3499125218696;2678.464307138561;2938.5151450010935;14540.781888271684;15229.466968656154;15357.078575285406;15479.845201548065;15778.763318550116;1689.5353777711105;1775.5472354549636;1782.5900042990056;1789.3021721528614;1803.5220666523383;101685.49157254166;108772.4561377196;110669;113446;114778.42610786976;10797.352158870493;11112.666620001413;11278.774424511465;11335.43322833855;11425.885741142481;13570.59288221355;13645.522406715718;13647;13702.794458082937;13711.931440342734;8932.910670893338;9107.22588579965;9136.406133601295;9191.908080919105;9210.309226808016;6864.5881247124335;8776.464118779315;8860.734177974671;9461.817272840895;9582.425054496613;5378.946210537844;6413.6793160341795;6489.935100648933;6497.480201583862;6525.738970441224;1719.6044909670595;1731.1909055037265;1825.863060270485;1852.7684039495064;1898.364048043893;870.3733312015339;1082.0802318029769;1108.4568561405015;1109.6171820721838;1115.7433790228292;20357.389278321672;21898.23356182526;22145.778542214695;22493.325200243693;22559.984800684007;1040.599369242847;1040.9375437473775;1059.8039362717923;1081.302559848893;1137.141458199071;11628.418579071013;12100.33448160342;12137.939310303569;12153.5138594457;12165.33090680021;515517;674128;679167;681194;692381;93662.06337936534;110453;113955;114829.85170148358;115991.2601310981;1070.710908054821;1086.7772106718262;1104.276698762312;1104.436737264001;1105.4196546812987;19175.32886348971;19714.802851971297;19921.402357929284;19954.60090798147;20296.289629862884;46869;47144.58566243018;47785.80535486501;47882;48258.5174148254;56159.71920140373;62704.68647656915;67554.66222668855;68474.65762671155;70588.29411706023;8139.674413023413;8194.262516373556;8203.630836612247;8363.790905227417;8522.360822938428;8454.813398653772;9521.381110227812;10874.858139895197;12761.298128602644;12971;11719.296842189497;11878.762424751629;11898.464569094238;11926.522939082686;12100.576479823163;9840.409575425498;11348.092152627605;11878.524859005543;11885.465154067915;12050.457729402022;12173.087018473472;12223.44994475233;12259.816102758288;12371.010319174624;12506.562270320495;8452.112528184452;8453.281471075028;8665.870011949952;8797.120287971407;8936.927568691799;11713.707157321136;11887.405629718653;11915.106367022334;12137.514499420278;12197.817032744339 16:31:07 INFO - PROCESS | 1956 | |3;mootools.html;1487.843776403477;1613.4352976458238;1642.4415698662453;1948.756405449319;2061.6804395318723;8282.83434331313;8826.161514656105;8957.596908139132;8968.910310896888;8970.147835955582;8617.698380556682;8904.02055773866;8927.107289271069;8927.776805579848;8942.73171804847;2235.5417139486367;2456.385903524119;2516.484120755241;2559.923202303934;2569.730178331267;2550;2556.156468365444;2558.756918092778;2560.7695307422327;2568.884400201986;2444.9022039118413;2483.056438553347;2558.5906254999204;2559.308986573624;2562.6284188792615;2493.463905260369;2531.6455696202547;2552.068494999321;2561.974380256192;2563.512932542811;2512.133314006665;2539.5809691400896;2549.247971848309;2565.615157726337;2566.0762125634756;8934.553272336358;8990.325725570543;9003.234725048378;9017.458952462874;9032.096790320915;5607.719614019324;5729;5766.682832444214;5767.192593036978;5768.711564421762;3655.1958569114754;3702.500162478058;3787.6780473659774;3805.3721136012523;3808.809559522013;922.5710044829186;1061.8088744026072;1084.3981590217427;1086.2450596835204;1117.4245263689206;12113.39433028345;12315.69210769729;12330.99999999991;12339.259644421363;12353.62939111828;4600.631949444037;4974.726390048582;5044.394672639233;5123.897522049539;5138.203578445347;10613.310134841211;10649.893501065046;10652.520636571373;10661.466926653637;10734.302270352402;5721.170430287585;5727.856803579861;5728.742206600713;5740.68426236561;5747.281589801275;4545.749983750859;4706.129366067288;4924.876878078005;5094;5122.92315615266;4133.729494893974;4162.084341444877;4164.675428116252;4197.727147735387;4205.285101532747;1288.6018669743246;1337.7926421404698;1356.905016648825;1369.2879702554815;1389.0276806235674;1344.267374281019;1384.9376778045012;1405.374608299297;1429.328215738601;1433.4481224728347;7144.214136444987;8264.545450000307;8435.620397082146;8453.492790432594;8458.74623761288;539.2854467830063;540.100732280756;548.9725513724378;551.7792882846813;552.3730565807757;6303.558750887394;6323.20959880015;6378.425941665272;6381.4575761059905;6383.808485745435;9288.674896378729;10591.523381447852;10949.671509854717;10957.17821163416;11065.612703555498;10550.683479495627;10776.407297598551;10836.133109351233;10895;10921.672349829518;8440.198181172778;8527.744167674855;8595.52724600153;8601.5699215039;8604.698835540727;8105.756827294955;8113.675452982051;8119.634616442156;8291;8350.373721970755;7681.308682218627;9735.70792876215;9851.507424628884;9899.554520046471;9969.40183588987;8433.451825631315;9760;9957;10084.546195421077;10207.285490015627;6440.32376600469;6819.18169819605;7610.086789585285;7671.846563068819;7758.844823103619;8354.206350396702;8383;8427.536485493356;8440.788980275542;8442;7351.264873512606;7379.335859772432;7389.556626602421;7529.322360987538;7623.313901748869;6334.556581039283;7337.229590893093;7381.4094872409005;7457.32884040439;7485.1017877855;7720.806979825549;7847.293743562878;7900.68397264103;7936.206379362017;7956.562389068657;7150.463715221484;7163.641817909188;7211.891821622575;7221.4222862171955;7223.819404514929;7181.174164971095;7319.560826350436;7335.559866408033;7336.413086953137;7346.11846578414 16:31:07 INFO - PROCESS | 1956 | |4;prototype.html;329.7823436531889;335.17045312850695;338.8968906210285;340.5198669875473;346.23482104548964;5887.4406931341455;5979.3123790764075;6451.709673064712;6481.935180648192;6517.576357536756;6455.354464553542;6459.192600924885;6473.061406096113;6480.254770701371;6485.870282594346;4635.172544747701;4666.510016448275;4755.096531658991;4776.665633405663;4847.248676455146;4837.105135549917;4838.927416088762;4842.232585106429;4856.587190088847;4880.902381952359;4795.5444232798;4815.181419158734;4826.61387089032;4834.395700537433;4846.39420072491;4585.128825523157;4686.53134686532;4777.020710754287;4809;4841.298011788289;4112.527059388179;4133;4135.483064616923;4148.170365926797;4166.979165104185;6168.352323006065;6171.6297022178815;6190.257169139687;6211.09939058834;6221.222347206599;5616.213730077792;5640.238567793336;5642.520385767174;5646.378898321182;5653.830385088454;5591.161325801122;6827.044213810071;6838.111045564095;6864.4165245954155;6894.207166175904;4265.552117027699;4405.118976204772;4431.889202769924;4443.066955939256;4615.192341340252;7266.527675701115;7286.380657644054;7308.342249197598;7317.524360916524;7323.963380183065;4553.658475614342;4556.658250631216;4561.521040290721;4563.703359281702;4567.977160114245;4625.074985003012;4626.514216007338;4640.373549570765;4645.860624181212;4654.162250794821;5455.509004189642;5455.781768729206;5470.91793623096;5471.480209380103;5472.2338872557875;6629.270780214172;6828.317168283132;6909.723611055501;6915;6932.861342773116;1358.9456421743216;1589.2927647197118;1603.9117848518445;1610.7261765499659;1615.127830971286;962.5235508423235;1030.525958059301;1033.6692258477365;1039.9896001040045;1057.3550134417999;6342.682865856688;6482.773102941374;6495.1556297681;6497;6508.772192973223;7052.188998265266;7061.82345441368;7063;7133.037039999534;7153.213146553875;6436.8390790230615;6438.613683178931;6439.967800160969;6445.16212892321;6457.773977910751;3212.437823380899;3748.5126933498473;3777.7544459610035;3782.71629627779;3784.4512545681273;7097.57414555118;7315.30504602062;7573.962130189314;7600.315971562586;7609.239076092346;5664.405237450091;7467.954486371912;7484.625768711651;7504.137024242173;7511.699532018767;7537.2462753724185;7557.395408367317;7562.281583249583;7563.243675632392;7584.886226706604;7197.964010179916;7201.423886089205;7204.89192662121;7208.098987626547;7215.8556828864175;6791.830204244933;7017.894731578928;7047.189573199148;7119.323664251888;7143.2499587544635;7574.924250757643;7597.506162099446;7639.159692433939;7646.082470103401;7651.808704782425;3972.3644216925154;3995.4006898965386;4721.480637129845;4809.44691360498;4810.374651295449;7122.038524799086;7127.358537731629;7129.572225666477;7133.82165445868;7137.357637812414;6643.302453242533;6888.173419189729;6907.274736152632;6916.550424222611;6922.550034247959;5792.4497172768515;6737;6839.69221385029;6873.518853680194;6890.276520965226;6713.12729345182;6724.562903411263;6726.630035347907;6731.697073631601;6733.494987876027;6846.965765171142;6884;6888.311168883071;6888.380045795702;6888.690008949709;6558.573692709959;6571.835704107244;6650.268470468148;6717.832054198684;6724.966375168093 16:31:07 INFO - PROCESS | 1956 | |5;yui.html;727.8193109449786;744.5495475237482;789.7828097273251;792.4096548071686;800.2517646000994;15351.385944562218;15442.073475591458;16108.919455402707;16153.596160095974;16162;14754.852451475483;14831.851681483182;14921.626959326022;14928;14998.400063997455;821.2977903892175;823.3495538524559;993.7714325705074;1016.187050359713;1017.7201269650831;966.6906589891238;976.4531862157179;978.4667356290838;978.6623614852864;1015.2436434856043;1036.2487196782347;1036.6838114375112;1037.3568387599698;1038.231708535682;1072.0619457974271;843.8312337532518;846.2552953400999;846.7713717296326;1036.0623635609786;1064.834950582657;718.3140101203338;742.2651574940824;798.700487317256;802.5987006496752;804.8108694456798;15384.538463846102;15470.61323466911;15476.458323958608;15490;15496.690066198613;13303.467861285537;13318.334083295797;13347.132436391603;13538.526151584745;13702;10161.441120738356;10262.538185781657;10269.075783179474;10523.631672891488;10762.300450470773;4122.670186385082;4126.979365103155;4136.565660605623;4189.853355132586;4453.176162409932;80854;81702;81980;82752.58623706903;83298;9223.907760922439;9620.95189524048;9854.260930430246;9958.850617240747;10216.795664086825;22067;22177;22267.331980040624;22270.220542280942;22342.21802236914;6297.685115744194;7730.188330225358;7781.144074151839;7848.0974687910475;7887.369010479148;4139.689523285766;4189.392538081961;4201.642860356904;4250.3199488081755;4284;3727.086863718406;3767.020574650611;3774.735768496179;3775.8300876460626;3798.772073675588;670.0518765946229;676.1176664452936;677.0386051806447;678.2539206872401;687.1342108942769;507.0847120946727;545.3237984898697;584.5615788158881;590.3801008940595;593.9940600594025;7839.529628222325;8283.37874659403;8335.291265290602;8353.248207661218;8445.366597505212;591.5651995783096;606.523878755175;609.679918043031;613.2885852411182;615;3687.9858039039477;3749.6250374962287;3796.468494410785;3859.614038596174;3928.1161738609158;87628;92552.53723731473;94056.58915116279;94990.57514137293;96211.03788962161;84952.15047849443;85100;85970;86129;86815;68636.313636864;69217;69469;73784.2621573788;74815.62592187004;8436.32509399259;8486.702965396182;8591.742247732578;8656.870146947675;8752.21230089295;51315;51969.48030519646;52595.73702131465;53649.731751340994;54131.91736165334;69715.95426068714;72414.63792681003;72447;73408.63295683487;75424;10779.568817247537;11103.056240219672;11203.103751700008;11211.775764484502;11320.943395282971;11718.472668729757;11859.466324015613;11930.22453540517;11964.820527692265;12531.624051278477;11008.614698485515;11295.661130166109;11480.712982175512;11530.135239856876;11641.185117041725;11330.60342887995;12002.699932501757;12019.699507512032;12032.278063315878;12053.457594408097;10226.693199204035;11508.654740357802;11533.884661153617;11621.418929053683;11670.474828632561;9136.725898223063;9453.101955314234;9521.19069879068;9625.32622716403;9643.439595901713;8911.821763564822;9639.132478077006;9691.321607487409;9801.852972205565;9812.754681133028 16:31:07 INFO - PROCESS | 1956 | __end_tp_report 16:31:07 INFO - PROCESS | 1956 | __start_cc_report 16:31:07 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,1008 16:31:07 INFO - PROCESS | 1956 | __end_cc_report 16:31:07 INFO - PROCESS | 1956 | __startTimestamp1458862267543__endTimestamp 16:31:07 INFO - PROCESS | 1956 | 16:31:07 INFO - PROCESS | 1956 | ------- Summary: start ------- 16:31:07 INFO - PROCESS | 1956 | Number of tests: 6 16:31:07 INFO - PROCESS | 1956 | 16:31:07 INFO - PROCESS | 1956 | [#0] dojo.html Cycles:165 Average:5813.87 Median:6089.42 stddev:646.59 (10.6%) stddev-sans-first:620.37 16:31:07 INFO - PROCESS | 1956 | Values: 3405.8 3454.7 3487.1 3495.1 3531.4 5701.6 5703.9 5708.5 5711.5 5733.5 5706.9 5717.5 5734.5 5746.6 5752.9 5193.6 5205.1 5249.8 5250.7 5256.7 5345.6 5348.5 5355.9 5370.4 5375.2 5318.5 5334.2 5358.9 5377.7 5383.6 5367.1 5393.7 5399.1 5417.7 5465.4 5136.9 5296.8 5329.0 5343.1 5346.0 4773.6 5705.0 5774.0 5777.3 5799.8 6190.2 6338.9 6351.7 6364.0 6367.6 6252.6 6324.4 6327.6 6327.8 6371.5 5895.8 5904.3 5910.1 5916.9 5924.6 6254.9 6289.3 6358.9 6367.5 6375.2 6237.5 6240.3 6242.8 6268.8 6270.0 6285.0 6297.8 6311.5 6315.4 6324.6 6117.8 6216.7 6222.5 6311.7 6327.0 6284.5 6288.8 6321.7 6338.7 6364.4 4915.6 4921.9 4939.6 4944.4 4960.0 4333.4 4367.4 4473.2 4483.1 4500.9 5848.8 5857.5 5860.9 5888.5 5914.8 6278.4 6317.6 6320.4 6324.0 6346.2 5604.2 5837.8 5857.9 5887.4 5896.8 5407.4 5455.2 5455.6 5459.2 5462.3 6390.0 6403.5 6421.6 6422.7 6424.7 6224.9 6253.8 6264.2 6276.2 6314.3 4853.8 5421.6 6371.3 6371.8 6417.3 6307.3 6312.8 6313.8 6317.4 6325.1 6209.8 6214.1 6248.7 6249.0 6267.5 6033.3 6195.8 6205.7 6212.3 6217.0 6074.1 6165.0 6234.6 6241.2 6241.7 6047.0 6089.4 6106.8 6118.0 6137.4 6229.4 6230.4 6248.3 6249.9 6259.6 5944.0 6062.5 6124.5 6130.4 6130.9 16:31:07 INFO - PROCESS | 1956 | 16:31:07 INFO - PROCESS | 1956 | [#1] ext.html Cycles:180 Average:63243.47 Median:36686.04 stddev:129804.91 (353.8%) stddev-sans-first:130083.47 16:31:07 INFO - PROCESS | 1956 | Values: 463.5 592.8 627.9 661.7 669.9 31319.7 32686.8 32794.9 32936.8 41145.6 35658.3 44034.9 44284.1 44338.1 44392.8 9737.8 9910.4 9937.8 9957.3 9957.6 9750.4 9889.9 9893.0 9898.3 9908.1 9834.3 10053.9 10069.3 10081.7 10101.8 9978.9 10053.5 10064.7 10069.1 10079.5 9827.0 9956.0 9956.6 9960.0 9969.6 43567.8 43930.8 44057.6 44121.8 44130.0 3261.7 3450.7 3534.7 3842.4 4039.0 27367.9 28649.3 29250.9 29363.4 30219.2 2803.9 2819.8 2824.8 2902.1 2915.5 505660.0 509896.0 511382.4 512139.0 513839.0 49050.8 75147.0 76519.0 76576.6 76714.0 51019.2 51179.5 51193.0 51208.0 51244.0 17450.5 17678.7 17729.7 17745.5 17810.6 14032.8 14118.9 14120.4 14127.9 14140.4 15757.8 15758.4 15777.4 15786.8 15849.0 6717.5 6742.2 6781.2 6808.9 6811.0 896.4 995.8 1066.8 1077.5 1085.5 30619.4 30634.5 30786.0 31083.0 31623.4 1111.4 1121.2 1146.8 1156.6 1165.1 15196.6 15561.5 15728.0 15771.0 15827.2 532680.0 532837.0 535793.0 538680.0 538847.0 63707.0 64152.0 64209.4 64242.0 64352.0 1487.2 1516.4 1545.7 1552.8 1558.9 29673.3 30774.2 31069.5 31269.4 31577.1 50458.0 50805.0 50928.0 51006.5 51138.7 384564.0 387074.0 388015.0 390445.0 483505.0 34273.8 34887.0 35707.8 35745.8 35822.5 44573.1 44748.0 45358.1 45792.6 45897.5 34384.1 35362.8 36452.3 36828.6 37067.6 29424.7 35093.6 35790.5 36543.5 37322.6 37538.0 37810.0 37860.6 37913.5 38103.2 27681.0 32244.9 32430.8 33329.3 33581.3 20313.4 21037.8 25095.5 25762.7 25858.6 16:31:07 INFO - PROCESS | 1956 | 16:31:07 INFO - PROCESS | 1956 | [#2] jquery.html Cycles:180 Average:35668.78 Median:21922.57 stddev:107585.86 (490.8%) stddev-sans-first:107855.02 16:31:07 INFO - PROCESS | 1956 | Values: 376.6 381.0 382.2 386.9 387.3 20371.3 21190.2 21306.1 21779.5 21855.6 21197.3 21585.6 21721.5 21946.9 22357.4 5747.3 5785.8 5856.7 5931.1 5947.8 4267.8 4490.9 6255.4 6495.4 6507.2 6367.0 6432.5 6444.1 6450.0 6453.9 6309.8 6436.2 6458.0 6477.1 6481.3 5554.6 5602.5 5642.2 5644.4 5646.4 26942.9 26946.9 27191.9 27242.6 27341.6 2073.8 2503.5 2600.3 2678.5 2938.5 14540.8 15229.5 15357.1 15479.8 15778.8 1689.5 1775.5 1782.6 1789.3 1803.5 101685.5 108772.5 110669.0 113446.0 114778.4 10797.4 11112.7 11278.8 11335.4 11425.9 13570.6 13645.5 13647.0 13702.8 13711.9 8932.9 9107.2 9136.4 9191.9 9210.3 6864.6 8776.5 8860.7 9461.8 9582.4 5378.9 6413.7 6489.9 6497.5 6525.7 1719.6 1731.2 1825.9 1852.8 1898.4 870.4 1082.1 1108.5 1109.6 1115.7 20357.4 21898.2 22145.8 22493.3 22560.0 1040.6 1040.9 1059.8 1081.3 1137.1 11628.4 12100.3 12137.9 12153.5 12165.3 515517.0 674128.0 679167.0 681194.0 692381.0 93662.1 110453.0 113955.0 114829.9 115991.3 1070.7 1086.8 1104.3 1104.4 1105.4 19175.3 19714.8 19921.4 19954.6 20296.3 46869.0 47144.6 47785.8 47882.0 48258.5 56159.7 62704.7 67554.7 68474.7 70588.3 8139.7 8194.3 8203.6 8363.8 8522.4 8454.8 9521.4 10874.9 12761.3 12971.0 11719.3 11878.8 11898.5 11926.5 12100.6 9840.4 11348.1 11878.5 11885.5 12050.5 12173.1 12223.4 12259.8 12371.0 12506.6 8452.1 8453.3 8665.9 8797.1 8936.9 11713.7 11887.4 11915.1 12137.5 12197.8 16:31:07 INFO - PROCESS | 1956 | 16:31:07 INFO - PROCESS | 1956 | [#3] mootools.html Cycles:180 Average:6167.24 Median:5664.45 stddev:3245.67 (57.3%) stddev-sans-first:3235.71 16:31:07 INFO - PROCESS | 1956 | Values: 1487.8 1613.4 1642.4 1948.8 2061.7 8282.8 8826.2 8957.6 8968.9 8970.1 8617.7 8904.0 8927.1 8927.8 8942.7 2235.5 2456.4 2516.5 2559.9 2569.7 2550.0 2556.2 2558.8 2560.8 2568.9 2444.9 2483.1 2558.6 2559.3 2562.6 2493.5 2531.6 2552.1 2562.0 2563.5 2512.1 2539.6 2549.2 2565.6 2566.1 8934.6 8990.3 9003.2 9017.5 9032.1 5607.7 5729.0 5766.7 5767.2 5768.7 3655.2 3702.5 3787.7 3805.4 3808.8 922.6 1061.8 1084.4 1086.2 1117.4 12113.4 12315.7 12331.0 12339.3 12353.6 4600.6 4974.7 5044.4 5123.9 5138.2 10613.3 10649.9 10652.5 10661.5 10734.3 5721.2 5727.9 5728.7 5740.7 5747.3 4545.7 4706.1 4924.9 5094.0 5122.9 4133.7 4162.1 4164.7 4197.7 4205.3 1288.6 1337.8 1356.9 1369.3 1389.0 1344.3 1384.9 1405.4 1429.3 1433.4 7144.2 8264.5 8435.6 8453.5 8458.7 539.3 540.1 549.0 551.8 552.4 6303.6 6323.2 6378.4 6381.5 6383.8 9288.7 10591.5 10949.7 10957.2 11065.6 10550.7 10776.4 10836.1 10895.0 10921.7 8440.2 8527.7 8595.5 8601.6 8604.7 8105.8 8113.7 8119.6 8291.0 8350.4 7681.3 9735.7 9851.5 9899.6 9969.4 8433.5 9760.0 9957.0 10084.5 10207.3 6440.3 6819.2 7610.1 7671.8 7758.8 8354.2 8383.0 8427.5 8440.8 8442.0 7351.3 7379.3 7389.6 7529.3 7623.3 6334.6 7337.2 7381.4 7457.3 7485.1 7720.8 7847.3 7900.7 7936.2 7956.6 7150.5 7163.6 7211.9 7221.4 7223.8 7181.2 7319.6 7335.6 7336.4 7346.1 16:31:07 INFO - PROCESS | 1956 | 16:31:07 INFO - PROCESS | 1956 | [#4] prototype.html Cycles:180 Average:5655.09 Median:6456.56 stddev:1810.69 (28.0%) stddev-sans-first:1771.10 16:31:07 INFO - PROCESS | 1956 | Values: 329.8 335.2 338.9 340.5 346.2 5887.4 5979.3 6451.7 6481.9 6517.6 6455.4 6459.2 6473.1 6480.3 6485.9 4635.2 4666.5 4755.1 4776.7 4847.2 4837.1 4838.9 4842.2 4856.6 4880.9 4795.5 4815.2 4826.6 4834.4 4846.4 4585.1 4686.5 4777.0 4809.0 4841.3 4112.5 4133.0 4135.5 4148.2 4167.0 6168.4 6171.6 6190.3 6211.1 6221.2 5616.2 5640.2 5642.5 5646.4 5653.8 5591.2 6827.0 6838.1 6864.4 6894.2 4265.6 4405.1 4431.9 4443.1 4615.2 7266.5 7286.4 7308.3 7317.5 7324.0 4553.7 4556.7 4561.5 4563.7 4568.0 4625.1 4626.5 4640.4 4645.9 4654.2 5455.5 5455.8 5470.9 5471.5 5472.2 6629.3 6828.3 6909.7 6915.0 6932.9 1358.9 1589.3 1603.9 1610.7 1615.1 962.5 1030.5 1033.7 1040.0 1057.4 6342.7 6482.8 6495.2 6497.0 6508.8 7052.2 7061.8 7063.0 7133.0 7153.2 6436.8 6438.6 6440.0 6445.2 6457.8 3212.4 3748.5 3777.8 3782.7 3784.5 7097.6 7315.3 7574.0 7600.3 7609.2 5664.4 7468.0 7484.6 7504.1 7511.7 7537.2 7557.4 7562.3 7563.2 7584.9 7198.0 7201.4 7204.9 7208.1 7215.9 6791.8 7017.9 7047.2 7119.3 7143.2 7574.9 7597.5 7639.2 7646.1 7651.8 3972.4 3995.4 4721.5 4809.4 4810.4 7122.0 7127.4 7129.6 7133.8 7137.4 6643.3 6888.2 6907.3 6916.6 6922.6 5792.4 6737.0 6839.7 6873.5 6890.3 6713.1 6724.6 6726.6 6731.7 6733.5 6847.0 6884.0 6888.3 6888.4 6888.7 6558.6 6571.8 6650.3 6717.8 6725.0 16:31:07 INFO - PROCESS | 1956 | 16:31:07 INFO - PROCESS | 1956 | [#5] yui.html Cycles:180 Average:19000.32 Median:53890.82 stddev:26758.05 (49.7%) stddev-sans-first:26797.94 16:31:07 INFO - PROCESS | 1956 | Values: 727.8 744.5 789.8 792.4 800.3 15351.4 15442.1 16108.9 16153.6 16162.0 14754.9 14831.9 14921.6 14928.0 14998.4 821.3 823.3 993.8 1016.2 1017.7 966.7 976.5 978.5 978.7 1015.2 1036.2 1036.7 1037.4 1038.2 1072.1 843.8 846.3 846.8 1036.1 1064.8 718.3 742.3 798.7 802.6 804.8 15384.5 15470.6 15476.5 15490.0 15496.7 13303.5 13318.3 13347.1 13538.5 13702.0 10161.4 10262.5 10269.1 10523.6 10762.3 4122.7 4127.0 4136.6 4189.9 4453.2 80854.0 81702.0 81980.0 82752.6 83298.0 9223.9 9621.0 9854.3 9958.9 10216.8 22067.0 22177.0 22267.3 22270.2 22342.2 6297.7 7730.2 7781.1 7848.1 7887.4 4139.7 4189.4 4201.6 4250.3 4284.0 3727.1 3767.0 3774.7 3775.8 3798.8 670.1 676.1 677.0 678.3 687.1 507.1 545.3 584.6 590.4 594.0 7839.5 8283.4 8335.3 8353.2 8445.4 591.6 606.5 609.7 613.3 615.0 3688.0 3749.6 3796.5 3859.6 3928.1 87628.0 92552.5 94056.6 94990.6 96211.0 84952.2 85100.0 85970.0 86129.0 86815.0 68636.3 69217.0 69469.0 73784.3 74815.6 8436.3 8486.7 8591.7 8656.9 8752.2 51315.0 51969.5 52595.7 53649.7 54131.9 69716.0 72414.6 72447.0 73408.6 75424.0 10779.6 11103.1 11203.1 11211.8 11320.9 11718.5 11859.5 11930.2 11964.8 12531.6 11008.6 11295.7 11480.7 11530.1 11641.2 11330.6 12002.7 12019.7 12032.3 12053.5 10226.7 11508.7 11533.9 11621.4 11670.5 9136.7 9453.1 9521.2 9625.3 9643.4 8911.8 9639.1 9691.3 9801.9 9812.8 16:31:07 INFO - PROCESS | 1956 | -------- Summary: end -------- 16:31:07 INFO - PROCESS | 1956 | 16:31:08 INFO - TEST-INFO | 1956: exit 0 16:31:08 INFO - TEST-OK | dromaeo_css | took 1113185ms 16:31:08 INFO - TEST-START | kraken 16:31:08 INFO - operating with platform_type : mac_ 16:31:08 INFO - Initialising browser for kraken test... 16:31:08 INFO - TEST-INFO | started process 1961 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpb5E1Nz/profile http://localhost:57310/getInfo.html) 16:31:10 INFO - PROCESS | 1961 | __metrics Screen width/height:1600/1200 16:31:10 INFO - PROCESS | 1961 | colorDepth:24 16:31:10 INFO - PROCESS | 1961 | Browser inner width/height: 1024/689 16:31:10 INFO - PROCESS | 1961 | __metrics 16:31:10 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" 16:31:10 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] 16:31:11 INFO - TEST-INFO | 1961: exit 0 16:31:11 INFO - Browser initialized. 16:31:11 INFO - Running cycle 1/1 for kraken test... 16:31:11 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/T/tmpb5E1Nz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:31:23 INFO - PROCESS | 1963 | RSS: Main: 210792448 16:31:23 INFO - PROCESS | 1963 | 16:31:25 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57310/tests/kraken/driver.html?testName=audio-beat-detection) 16:31:26 INFO - PROCESS | 1963 | RSS: Main: 266272768 16:31:26 INFO - PROCESS | 1963 | 16:31:28 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57310/tests/kraken/driver.html?testName=audio-dft) 16:31:29 INFO - PROCESS | 1963 | RSS: Main: 275599360 16:31:29 INFO - PROCESS | 1963 | 16:31:32 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57310/tests/kraken/driver.html?testName=audio-fft) 16:31:33 INFO - PROCESS | 1963 | RSS: Main: 265277440 16:31:33 INFO - PROCESS | 1963 | 16:31:34 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57310/tests/kraken/driver.html?testName=audio-oscillator) 16:31:35 INFO - PROCESS | 1963 | RSS: Main: 267554816 16:31:35 INFO - PROCESS | 1963 | 16:31:37 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57310/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:31:38 INFO - PROCESS | 1963 | RSS: Main: 266850304 16:31:38 INFO - PROCESS | 1963 | 16:31:41 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57310/tests/kraken/driver.html?testName=imaging-darkroom) 16:31:41 INFO - PROCESS | 1963 | RSS: Main: 268234752 16:31:41 INFO - PROCESS | 1963 | 16:31:44 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57310/tests/kraken/driver.html?testName=imaging-desaturate) 16:31:45 INFO - PROCESS | 1963 | RSS: Main: 267497472 16:31:45 INFO - PROCESS | 1963 | 16:31:47 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57310/tests/kraken/driver.html?testName=json-parse-financial) 16:31:48 INFO - PROCESS | 1963 | RSS: Main: 267366400 16:31:48 INFO - PROCESS | 1963 | 16:31:49 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57310/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:31:50 INFO - PROCESS | 1963 | RSS: Main: 300752896 16:31:50 INFO - PROCESS | 1963 | 16:31:52 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:31:52 INFO - PROCESS | 1963 | RSS: Main: 301711360 16:31:52 INFO - PROCESS | 1963 | 16:31:54 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:31:55 INFO - PROCESS | 1963 | RSS: Main: 307892224 16:31:55 INFO - PROCESS | 1963 | 16:31:58 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:31:58 INFO - PROCESS | 1963 | RSS: Main: 310685696 16:31:58 INFO - PROCESS | 1963 | 16:32:01 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:32:01 INFO - PROCESS | 1963 | RSS: Main: 310689792 16:32:01 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57310/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57310/tests/kraken/driver.html?testName=ai-astar) 16:32:03 INFO - PROCESS | 1963 | RSS: Main: 370638848 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | __start_tp_report 16:32:03 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 16:32:03 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 16:32:03 INFO - PROCESS | 1963 | |i|pagename|runs| 16:32:03 INFO - PROCESS | 1963 | |0;ai-astar;113;108;110;111;111;112;118;110;109;110 16:32:03 INFO - PROCESS | 1963 | |1;audio-beat-detection;153;118;154;147;116;141;140;146;145;114 16:32:03 INFO - PROCESS | 1963 | |2;audio-dft;186;186;184;184;186;183;184;183;186;185 16:32:03 INFO - PROCESS | 1963 | |3;audio-fft;74;72;74;115;54;56;57;57;118;56 16:32:03 INFO - PROCESS | 1963 | |4;audio-oscillator;92;96;129;80;78;86;116;77;78;115 16:32:03 INFO - PROCESS | 1963 | |5;imaging-gaussian-blur;90;85;133;83;89;129;131;84;86;84 16:32:03 INFO - PROCESS | 1963 | |6;imaging-darkroom;92;92;92;92;91;92;92;91;91;92 16:32:03 INFO - PROCESS | 1963 | |7;imaging-desaturate;85;84;86;84;86;86;86;88;84;85 16:32:03 INFO - PROCESS | 1963 | |8;json-parse-financial;56;59;58;57;58;58;56;68;54;52 16:32:03 INFO - PROCESS | 1963 | |9;json-stringify-tinderbox;62;62;77;73;69;66;65;67;68;69 16:32:03 INFO - PROCESS | 1963 | |10;stanford-crypto-aes;78;82;80;80;79;79;88;86;81;84 16:32:03 INFO - PROCESS | 1963 | |11;stanford-crypto-ccm;125;125;132;124;116;130;118;99;128;132 16:32:03 INFO - PROCESS | 1963 | |12;stanford-crypto-pbkdf2;135;120;129;133;131;121;130;132;130;134 16:32:03 INFO - PROCESS | 1963 | |13;stanford-crypto-sha256-iterative;65;65;65;67;67;65;66;66;66;64 16:32:03 INFO - PROCESS | 1963 | __end_tp_report 16:32:03 INFO - PROCESS | 1963 | __start_cc_report 16:32:03 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,1206 16:32:03 INFO - PROCESS | 1963 | __end_cc_report 16:32:03 INFO - PROCESS | 1963 | __startTimestamp1458862323697__endTimestamp 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | ------- Summary: start ------- 16:32:03 INFO - PROCESS | 1963 | Number of tests: 14 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:2.78 (2.5%) stddev-sans-first:2.87 16:32:03 INFO - PROCESS | 1963 | Values: 113.0 108.0 110.0 111.0 111.0 112.0 118.0 110.0 109.0 110.0 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:145.50 stddev:15.44 (10.6%) stddev-sans-first:15.31 16:32:03 INFO - PROCESS | 1963 | Values: 153.0 118.0 154.0 147.0 116.0 141.0 140.0 146.0 145.0 114.0 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.50 stddev:1.25 (0.7%) stddev-sans-first:1.24 16:32:03 INFO - PROCESS | 1963 | Values: 186.0 186.0 184.0 184.0 186.0 183.0 184.0 183.0 186.0 185.0 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#3] audio-fft Cycles:10 Average:73.30 Median:57.00 stddev:24.13 (42.3%) stddev-sans-first:25.60 16:32:03 INFO - PROCESS | 1963 | Values: 74.0 72.0 74.0 115.0 54.0 56.0 57.0 57.0 118.0 56.0 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:79.00 stddev:18.90 (23.9%) stddev-sans-first:20.02 16:32:03 INFO - PROCESS | 1963 | Values: 92.0 96.0 129.0 80.0 78.0 86.0 116.0 77.0 78.0 115.0 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#5] imaging-gaussian-blur Cycles:10 Average:99.40 Median:84.50 stddev:21.94 (26.0%) stddev-sans-first:23.00 16:32:03 INFO - PROCESS | 1963 | Values: 90.0 85.0 133.0 83.0 89.0 129.0 131.0 84.0 86.0 84.0 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#6] imaging-darkroom Cycles:10 Average:91.70 Median:92.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 16:32:03 INFO - PROCESS | 1963 | Values: 92.0 92.0 92.0 92.0 91.0 92.0 92.0 91.0 91.0 92.0 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:1.26 (1.5%) stddev-sans-first:1.33 16:32:03 INFO - PROCESS | 1963 | Values: 85.0 84.0 86.0 84.0 86.0 86.0 86.0 88.0 84.0 85.0 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:4.22 (7.3%) stddev-sans-first:4.44 16:32:03 INFO - PROCESS | 1963 | Values: 56.0 59.0 58.0 57.0 58.0 58.0 56.0 68.0 54.0 52.0 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.50 stddev:4.64 (6.8%) stddev-sans-first:4.42 16:32:03 INFO - PROCESS | 1963 | Values: 62.0 62.0 77.0 73.0 69.0 66.0 65.0 67.0 68.0 69.0 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.50 stddev:3.30 (4.1%) stddev-sans-first:3.22 16:32:03 INFO - PROCESS | 1963 | Values: 78.0 82.0 80.0 80.0 79.0 79.0 88.0 86.0 81.0 84.0 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:129.00 stddev:9.97 (7.7%) stddev-sans-first:10.55 16:32:03 INFO - PROCESS | 1963 | Values: 125.0 125.0 132.0 124.0 116.0 130.0 118.0 99.0 128.0 132.0 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:129.50 Median:131.50 stddev:5.10 (3.9%) stddev-sans-first:5.01 16:32:03 INFO - PROCESS | 1963 | Values: 135.0 120.0 129.0 133.0 131.0 121.0 130.0 132.0 130.0 134.0 16:32:03 INFO - PROCESS | 1963 | 16:32:03 INFO - PROCESS | 1963 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.00 16:32:03 INFO - PROCESS | 1963 | Values: 65.0 65.0 65.0 67.0 67.0 65.0 66.0 66.0 66.0 64.0 16:32:03 INFO - PROCESS | 1963 | -------- Summary: end -------- 16:32:03 INFO - PROCESS | 1963 | 16:32:04 INFO - TEST-INFO | 1963: exit 0 16:32:04 INFO - TEST-OK | kraken | took 56302ms 16:32:04 INFO - SUITE-END | took 1169s 16:32:04 INFO - Completed test suite (00:19:29) 16:32:04 INFO - javascript benchmark 16:32:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3405.761596688232, 3454.740894432917, 3487.1107867493783, 3495.0912762681696, 3531.3820081485733, 5701.600887937846, 5703.885922281552, 5708.457696518829, 5711.457411545902, 5733.48398644122, 5706.857328566788, 5717.456841600052, 5734.483896449318, 5746.597738158331, 5752.884942301152, 5193.610479214055, 5205.063088644042, 5249.763760630781, 5250.7112108834, 5256.737163141846, 5345.572354211654, 5348.518633323, 5355.946440535603, 5370.409254981949, 5375.220593014011, 5318.521333080022, 5334.199870019509, 5358.91961620576, 5377.731113444332, 5383.596230282725, 5367.114426119705, 5393.668042890359, 5399.1091469907415, 5417.674939503642, 5465.371482279549, 5136.948630513684, 5296.841094767163, 5328.973355133238, 5343.091674415358, 5345.957538280037, 4773.594244489223, 5704.971475142639, 5773.971130144364, 5777.306723193244, 5799.82600521985, 6190.226221722285, 6338.904916426257, 6351.682415879188, 6364.0, 6367.554271201017, 6252.624842509464, 6324.367563243639, 6327.5570710050315, 6327.810165695037, 6371.458426033792, 5895.823125306248, 5904.291485021825, 5910.054391297372, 5916.852078698067, 5924.555658325643, 6254.937450625526, 6289.276733175652, 6358.904616430757, 6367.52243581724, 6375.23497180332, 6237.4698150657705, 6240.31356550779, 6242.812715618538, 6268.843278917972, 6270.0, 6284.994400895835, 6297.842553936097, 6311.463525600284, 6315.400036996478, 6324.620522768649, 6117.84705382369, 6216.720247588779, 6222.502199824004, 6311.684415779285, 6326.9683651581445, 6284.528660350492, 6288.779892703825, 6321.747130114836, 6338.714757835908, 6364.395382438661, 4915.631327650441, 4921.87695307613, 4939.555440010345, 4944.381952255968, 4960.0, 4333.371661109185, 4367.388565600819, 4473.217186992263, 4483.103379324149, 4500.909981800346, 5848.795292164754, 5857.472827445466, 5860.941390586125, 5888.5289176865745, 5914.763409463573, 6278.372162783685, 6317.6209427434505, 6320.399562041599, 6324.019776934582, 6346.2067241594805, 5604.159376093618, 5837.795677151279, 5857.853553661193, 5887.381824908409, 5896.764129434775, 5407.432219616962, 5455.18172274162, 5455.5908306876345, 5459.153831156177, 5462.289902312674, 6389.9680501597195, 6403.455706264926, 6421.614703117828, 6422.678866056772, 6424.678766061678, 6224.9377506224355, 6253.843653908689, 6264.21697287839, 6276.184096067482, 6314.273858506331, 4853.781579828846, 5421.620486565903, 6371.299157092623, 6371.776987805404, 6417.326180751141, 6307.306196318493, 6312.810615681537, 6313.842153946188, 6317.431431171217, 6325.082862984934, 6209.844753881009, 6214.067889816563, 6248.718807653758, 6249.000159974382, 6267.498600111889, 6033.276006879202, 6195.81412557624, 6205.720742566505, 6212.254529456494, 6216.968915155576, 6074.058520929263, 6165.0, 6234.563580549499, 6241.188645476059, 6241.719122639583, 6046.969765151146, 6089.421504957022, 6106.7862624809695, 6118.040554665315, 6137.447629713347, 6229.3770622939155, 6230.408111229426, 6248.312685604489, 6249.875002500015, 6259.561830671809, 5944.019236825875, 6062.545309101747, 6124.479419249235, 6130.448259656652, 6130.938690613037], "unit": "score", "name": "dojo.html", "value": 5773.436717357247}, {"lowerIsBetter": false, "replicates": [463.4508107892146, 592.796622855603, 627.9466245369143, 661.6625520984296, 669.9464042876571, 31319.68680313196, 32686.836565817168, 32794.8521801737, 32936.83531582339, 41145.58854411455, 35658.2868342633, 44034.89912752175, 44284.114317713625, 44338.113237735226, 44392.778036109856, 9737.805243895118, 9910.405375677447, 9937.801243975116, 9957.30298879075, 9957.551910164024, 9750.36622619531, 9889.851652225223, 9893.0, 9898.257630677728, 9908.058734420218, 9834.311598188095, 10053.899461005369, 10069.345492542961, 10081.747956301115, 10101.797964040716, 9978.900210997906, 10053.547590358416, 10064.698059058166, 10069.144122749574, 10079.49602519871, 9827.0, 9955.950220248926, 9956.601735930626, 9960.0, 9969.601215951354, 43567.78216108931, 43930.780346098385, 44057.55942440566, 44121.77939110316, 44130.0, 3261.657525959764, 3450.6549345065546, 3534.6642069003406, 3842.366009608439, 4038.9700626340095, 27367.86316068427, 28649.28376790576, 29250.853745731347, 29363.41273174546, 30219.244518887204, 2803.8598070096414, 2819.7954226950133, 2824.7740180785486, 2902.0568315297614, 2915.4752144613963, 505660.0, 509895.9999999963, 511382.4430877859, 512139.0, 513839.0, 49050.75474622604, 75147.0, 76519.0, 76576.61711691518, 76714.0, 51019.23471147936, 51179.488205118214, 51192.976140477724, 51208.0, 51244.0, 17450.47648570545, 17678.734818977726, 17729.7340539892, 17745.46763597094, 17810.554736131442, 14032.789508157386, 14118.858811411754, 14120.43518259258, 14127.85872141286, 14140.363683634261, 15757.763633545506, 15758.448454304043, 15777.368905243662, 15786.842131578536, 15849.049057056614, 6717.5297729159465, 6742.157230346207, 6781.220159681699, 6808.944613584902, 6811.046453496514, 896.4442045931564, 995.7809281957958, 1066.7599790047177, 1077.5097330714507, 1085.5115198160859, 30619.387612248076, 30634.54048189279, 30786.0, 31083.0, 31623.36753264922, 1111.4220605285207, 1121.1647322744607, 1146.8337091121907, 1156.6298784389082, 1165.1028707895043, 15196.620084497756, 15561.455349062728, 15728.0, 15770.97488663256, 15827.208639568205, 532680.0, 532837.0, 535793.0, 538680.0, 538847.0, 63707.04439433412, 64152.03771943424, 64209.357906421275, 64242.0, 64352.0, 1487.21177775779, 1516.4237589716058, 1545.7217700813962, 1552.767084937246, 1558.9220538973007, 29673.25816854596, 30774.22966947268, 31069.53395699021, 31269.374612508076, 31577.052688419386, 50458.0, 50805.0, 50927.98144037025, 51006.48993510017, 51138.74430627823, 384564.0, 387074.0, 388015.0, 390445.0, 483505.0, 34273.82863085669, 34887.0, 35707.82146089253, 35745.82127089348, 35822.46266305955, 44573.10853782841, 44748.0, 45358.09283814371, 45792.62622121342, 45897.54102458933, 34384.14039648929, 35362.76230331926, 36452.27095458129, 36828.631713682524, 37067.62932370642, 29424.705752942198, 35093.64906350904, 35790.4631430534, 36543.45184822177, 37322.626773733, 37537.97581461841, 37810.0, 37860.62139378681, 37913.483460661264, 38103.2379352417, 27681.0, 32244.871429499854, 32430.815854533063, 33329.33341333208, 33581.32837343288, 20313.390598282076, 21037.84291863962, 25095.49809003773, 25762.742372576035, 25858.612120817827], "unit": "score", "name": "ext.html", "value": 19930.69847348983}, {"lowerIsBetter": false, "replicates": [376.6459528043639, 380.9866654667087, 382.1840370808325, 386.9380899056152, 387.3067209694645, 20371.28700495481, 21190.152393904245, 21306.147754089838, 21779.455513612167, 21855.562888742217, 21197.258095966645, 21585.596936199137, 21721.456963575918, 21946.902654867274, 22357.44106397341, 5747.310322761275, 5785.82642520725, 5856.707164641773, 5931.08068249422, 5947.821565353025, 4267.8079486423185, 4490.887727806815, 6255.405736455053, 6495.415412612864, 6507.154069970898, 6366.968165159168, 6432.5497215194955, 6444.130042444281, 6449.967750161242, 6453.903191452132, 6309.810705678837, 6436.227652681661, 6458.031295305695, 6477.0608261802245, 6481.254655714582, 5554.583406244547, 5602.495775380195, 5642.153676948449, 5644.407337229614, 5646.40712725162, 26942.86528567364, 26946.865265673743, 27191.86404067987, 27242.5913611296, 27341.589876151873, 2073.8133567978803, 2503.5493611149986, 2600.3499125218696, 2678.464307138561, 2938.5151450010935, 14540.781888271684, 15229.466968656154, 15357.078575285406, 15479.845201548065, 15778.763318550116, 1689.5353777711105, 1775.5472354549636, 1782.5900042990056, 1789.3021721528614, 1803.5220666523383, 101685.49157254166, 108772.4561377196, 110669.0, 113446.0, 114778.42610786976, 10797.352158870493, 11112.666620001413, 11278.774424511465, 11335.43322833855, 11425.885741142481, 13570.59288221355, 13645.522406715718, 13647.0, 13702.794458082937, 13711.931440342734, 8932.910670893338, 9107.22588579965, 9136.406133601295, 9191.908080919105, 9210.309226808016, 6864.5881247124335, 8776.464118779315, 8860.734177974671, 9461.817272840895, 9582.425054496613, 5378.946210537844, 6413.6793160341795, 6489.935100648933, 6497.480201583862, 6525.738970441224, 1719.6044909670595, 1731.1909055037265, 1825.863060270485, 1852.7684039495064, 1898.364048043893, 870.3733312015339, 1082.0802318029769, 1108.4568561405015, 1109.6171820721838, 1115.7433790228292, 20357.389278321672, 21898.23356182526, 22145.778542214695, 22493.325200243693, 22559.984800684007, 1040.599369242847, 1040.9375437473775, 1059.8039362717923, 1081.302559848893, 1137.141458199071, 11628.418579071013, 12100.33448160342, 12137.939310303569, 12153.5138594457, 12165.33090680021, 515517.0, 674128.0, 679167.0, 681194.0, 692381.0, 93662.06337936534, 110453.0, 113955.0, 114829.85170148358, 115991.2601310981, 1070.710908054821, 1086.7772106718262, 1104.276698762312, 1104.436737264001, 1105.4196546812987, 19175.32886348971, 19714.802851971297, 19921.402357929284, 19954.60090798147, 20296.289629862884, 46869.0, 47144.58566243018, 47785.80535486501, 47882.0, 48258.5174148254, 56159.71920140373, 62704.68647656915, 67554.66222668855, 68474.65762671155, 70588.29411706023, 8139.674413023413, 8194.262516373556, 8203.630836612247, 8363.790905227417, 8522.360822938428, 8454.813398653772, 9521.381110227812, 10874.858139895197, 12761.298128602644, 12971.0, 11719.296842189497, 11878.762424751629, 11898.464569094238, 11926.522939082686, 12100.576479823163, 9840.409575425498, 11348.092152627605, 11878.524859005543, 11885.465154067915, 12050.457729402022, 12173.087018473472, 12223.44994475233, 12259.816102758288, 12371.010319174624, 12506.562270320495, 8452.112528184452, 8453.281471075028, 8665.870011949952, 8797.120287971407, 8936.927568691799, 11713.707157321136, 11887.405629718653, 11915.106367022334, 12137.514499420278, 12197.817032744339], "unit": "score", "name": "jquery.html", "value": 9958.06302269689}, {"lowerIsBetter": false, "replicates": [1487.843776403477, 1613.4352976458238, 1642.4415698662453, 1948.756405449319, 2061.6804395318723, 8282.83434331313, 8826.161514656105, 8957.596908139132, 8968.910310896888, 8970.147835955582, 8617.698380556682, 8904.02055773866, 8927.107289271069, 8927.776805579848, 8942.73171804847, 2235.5417139486367, 2456.385903524119, 2516.484120755241, 2559.923202303934, 2569.730178331267, 2550.0, 2556.156468365444, 2558.756918092778, 2560.7695307422327, 2568.884400201986, 2444.9022039118413, 2483.056438553347, 2558.5906254999204, 2559.308986573624, 2562.6284188792615, 2493.463905260369, 2531.6455696202547, 2552.068494999321, 2561.974380256192, 2563.512932542811, 2512.133314006665, 2539.5809691400896, 2549.247971848309, 2565.615157726337, 2566.0762125634756, 8934.553272336358, 8990.325725570543, 9003.234725048378, 9017.458952462874, 9032.096790320915, 5607.719614019324, 5729.0, 5766.682832444214, 5767.192593036978, 5768.711564421762, 3655.1958569114754, 3702.500162478058, 3787.6780473659774, 3805.3721136012523, 3808.809559522013, 922.5710044829186, 1061.8088744026072, 1084.3981590217427, 1086.2450596835204, 1117.4245263689206, 12113.39433028345, 12315.69210769729, 12330.99999999991, 12339.259644421363, 12353.62939111828, 4600.631949444037, 4974.726390048582, 5044.394672639233, 5123.897522049539, 5138.203578445347, 10613.310134841211, 10649.893501065046, 10652.520636571373, 10661.466926653637, 10734.302270352402, 5721.170430287585, 5727.856803579861, 5728.742206600713, 5740.68426236561, 5747.281589801275, 4545.749983750859, 4706.129366067288, 4924.876878078005, 5094.0, 5122.92315615266, 4133.729494893974, 4162.084341444877, 4164.675428116252, 4197.727147735387, 4205.285101532747, 1288.6018669743246, 1337.7926421404698, 1356.905016648825, 1369.2879702554815, 1389.0276806235674, 1344.267374281019, 1384.9376778045012, 1405.374608299297, 1429.328215738601, 1433.4481224728347, 7144.214136444987, 8264.545450000307, 8435.620397082146, 8453.492790432594, 8458.74623761288, 539.2854467830063, 540.100732280756, 548.9725513724378, 551.7792882846813, 552.3730565807757, 6303.558750887394, 6323.20959880015, 6378.425941665272, 6381.4575761059905, 6383.808485745435, 9288.674896378729, 10591.523381447852, 10949.671509854717, 10957.17821163416, 11065.612703555498, 10550.683479495627, 10776.407297598551, 10836.133109351233, 10895.0, 10921.672349829518, 8440.198181172778, 8527.744167674855, 8595.52724600153, 8601.5699215039, 8604.698835540727, 8105.756827294955, 8113.675452982051, 8119.634616442156, 8291.0, 8350.373721970755, 7681.308682218627, 9735.70792876215, 9851.507424628884, 9899.554520046471, 9969.40183588987, 8433.451825631315, 9760.0, 9957.0, 10084.546195421077, 10207.285490015627, 6440.32376600469, 6819.18169819605, 7610.086789585285, 7671.846563068819, 7758.844823103619, 8354.206350396702, 8383.0, 8427.536485493356, 8440.788980275542, 8442.0, 7351.264873512606, 7379.335859772432, 7389.556626602421, 7529.322360987538, 7623.313901748869, 6334.556581039283, 7337.229590893093, 7381.4094872409005, 7457.32884040439, 7485.1017877855, 7720.806979825549, 7847.293743562878, 7900.68397264103, 7936.206379362017, 7956.562389068657, 7150.463715221484, 7163.641817909188, 7211.891821622575, 7221.4222862171955, 7223.819404514929, 7181.174164971095, 7319.560826350436, 7335.559866408033, 7336.413086953137, 7346.11846578414], "unit": "score", "name": "mootools.html", "value": 4968.43510624442}, {"lowerIsBetter": false, "replicates": [329.7823436531889, 335.17045312850695, 338.8968906210285, 340.5198669875473, 346.23482104548964, 5887.4406931341455, 5979.3123790764075, 6451.709673064712, 6481.935180648192, 6517.576357536756, 6455.354464553542, 6459.192600924885, 6473.061406096113, 6480.254770701371, 6485.870282594346, 4635.172544747701, 4666.510016448275, 4755.096531658991, 4776.665633405663, 4847.248676455146, 4837.105135549917, 4838.927416088762, 4842.232585106429, 4856.587190088847, 4880.902381952359, 4795.5444232798, 4815.181419158734, 4826.61387089032, 4834.395700537433, 4846.39420072491, 4585.128825523157, 4686.53134686532, 4777.020710754287, 4809.0, 4841.298011788289, 4112.527059388179, 4133.0, 4135.483064616923, 4148.170365926797, 4166.979165104185, 6168.352323006065, 6171.6297022178815, 6190.257169139687, 6211.09939058834, 6221.222347206599, 5616.213730077792, 5640.238567793336, 5642.520385767174, 5646.378898321182, 5653.830385088454, 5591.161325801122, 6827.044213810071, 6838.111045564095, 6864.4165245954155, 6894.207166175904, 4265.552117027699, 4405.118976204772, 4431.889202769924, 4443.066955939256, 4615.192341340252, 7266.527675701115, 7286.380657644054, 7308.342249197598, 7317.524360916524, 7323.963380183065, 4553.658475614342, 4556.658250631216, 4561.521040290721, 4563.703359281702, 4567.977160114245, 4625.074985003012, 4626.514216007338, 4640.373549570765, 4645.860624181212, 4654.162250794821, 5455.509004189642, 5455.781768729206, 5470.91793623096, 5471.480209380103, 5472.2338872557875, 6629.270780214172, 6828.317168283132, 6909.723611055501, 6915.0, 6932.861342773116, 1358.9456421743216, 1589.2927647197118, 1603.9117848518445, 1610.7261765499659, 1615.127830971286, 962.5235508423235, 1030.525958059301, 1033.6692258477365, 1039.9896001040045, 1057.3550134417999, 6342.682865856688, 6482.773102941374, 6495.1556297681, 6497.0, 6508.772192973223, 7052.188998265266, 7061.82345441368, 7063.0, 7133.037039999534, 7153.213146553875, 6436.8390790230615, 6438.613683178931, 6439.967800160969, 6445.16212892321, 6457.773977910751, 3212.437823380899, 3748.5126933498473, 3777.7544459610035, 3782.71629627779, 3784.4512545681273, 7097.57414555118, 7315.30504602062, 7573.962130189314, 7600.315971562586, 7609.239076092346, 5664.405237450091, 7467.954486371912, 7484.625768711651, 7504.137024242173, 7511.699532018767, 7537.2462753724185, 7557.395408367317, 7562.281583249583, 7563.243675632392, 7584.886226706604, 7197.964010179916, 7201.423886089205, 7204.89192662121, 7208.098987626547, 7215.8556828864175, 6791.830204244933, 7017.894731578928, 7047.189573199148, 7119.323664251888, 7143.2499587544635, 7574.924250757643, 7597.506162099446, 7639.159692433939, 7646.082470103401, 7651.808704782425, 3972.3644216925154, 3995.4006898965386, 4721.480637129845, 4809.44691360498, 4810.374651295449, 7122.038524799086, 7127.358537731629, 7129.572225666477, 7133.82165445868, 7137.357637812414, 6643.302453242533, 6888.173419189729, 6907.274736152632, 6916.550424222611, 6922.550034247959, 5792.4497172768515, 6737.0, 6839.69221385029, 6873.518853680194, 6890.276520965226, 6713.12729345182, 6724.562903411263, 6726.630035347907, 6731.697073631601, 6733.494987876027, 6846.965765171142, 6884.0, 6888.311168883071, 6888.380045795702, 6888.690008949709, 6558.573692709959, 6571.835704107244, 6650.268470468148, 6717.832054198684, 6724.966375168093], "unit": "score", "name": "prototype.html", "value": 5050.590903976}, {"lowerIsBetter": false, "replicates": [727.8193109449786, 744.5495475237482, 789.7828097273251, 792.4096548071686, 800.2517646000994, 15351.385944562218, 15442.073475591458, 16108.919455402707, 16153.596160095974, 16162.0, 14754.852451475483, 14831.851681483182, 14921.626959326022, 14928.0, 14998.400063997455, 821.2977903892175, 823.3495538524559, 993.7714325705074, 1016.187050359713, 1017.7201269650831, 966.6906589891238, 976.4531862157179, 978.4667356290838, 978.6623614852864, 1015.2436434856043, 1036.2487196782347, 1036.6838114375112, 1037.3568387599698, 1038.231708535682, 1072.0619457974271, 843.8312337532518, 846.2552953400999, 846.7713717296326, 1036.0623635609786, 1064.834950582657, 718.3140101203338, 742.2651574940824, 798.700487317256, 802.5987006496752, 804.8108694456798, 15384.538463846102, 15470.61323466911, 15476.458323958608, 15490.0, 15496.690066198613, 13303.467861285537, 13318.334083295797, 13347.132436391603, 13538.526151584745, 13702.0, 10161.441120738356, 10262.538185781657, 10269.075783179474, 10523.631672891488, 10762.300450470773, 4122.670186385082, 4126.979365103155, 4136.565660605623, 4189.853355132586, 4453.176162409932, 80854.0, 81702.0, 81980.0, 82752.58623706903, 83298.0, 9223.907760922439, 9620.95189524048, 9854.260930430246, 9958.850617240747, 10216.795664086825, 22067.0, 22177.0, 22267.331980040624, 22270.220542280942, 22342.21802236914, 6297.685115744194, 7730.188330225358, 7781.144074151839, 7848.0974687910475, 7887.369010479148, 4139.689523285766, 4189.392538081961, 4201.642860356904, 4250.3199488081755, 4284.0, 3727.086863718406, 3767.020574650611, 3774.735768496179, 3775.8300876460626, 3798.772073675588, 670.0518765946229, 676.1176664452936, 677.0386051806447, 678.2539206872401, 687.1342108942769, 507.0847120946727, 545.3237984898697, 584.5615788158881, 590.3801008940595, 593.9940600594025, 7839.529628222325, 8283.37874659403, 8335.291265290602, 8353.248207661218, 8445.366597505212, 591.5651995783096, 606.523878755175, 609.679918043031, 613.2885852411182, 615.0, 3687.9858039039477, 3749.6250374962287, 3796.468494410785, 3859.614038596174, 3928.1161738609158, 87628.0, 92552.53723731473, 94056.58915116279, 94990.57514137293, 96211.03788962161, 84952.15047849443, 85100.0, 85970.0, 86129.0, 86815.0, 68636.313636864, 69217.0, 69469.0, 73784.2621573788, 74815.62592187004, 8436.32509399259, 8486.702965396182, 8591.742247732578, 8656.870146947675, 8752.21230089295, 51315.0, 51969.48030519646, 52595.73702131465, 53649.731751340994, 54131.91736165334, 69715.95426068714, 72414.63792681003, 72447.0, 73408.63295683487, 75424.0, 10779.568817247537, 11103.056240219672, 11203.103751700008, 11211.775764484502, 11320.943395282971, 11718.472668729757, 11859.466324015613, 11930.22453540517, 11964.820527692265, 12531.624051278477, 11008.614698485515, 11295.661130166109, 11480.712982175512, 11530.135239856876, 11641.185117041725, 11330.60342887995, 12002.699932501757, 12019.699507512032, 12032.278063315878, 12053.457594408097, 10226.693199204035, 11508.654740357802, 11533.884661153617, 11621.418929053683, 11670.474828632561, 9136.725898223063, 9453.101955314234, 9521.19069879068, 9625.32622716403, 9643.439595901713, 8911.821763564822, 9639.132478077006, 9691.321607487409, 9801.852972205565, 9812.754681133028], "unit": "score", "name": "yui.html", "value": 7166.226281104728}], "name": "dromaeo_css", "value": 7685.4614718342955}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 110.0, 111.0, 111.0, 112.0, 118.0, 110.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [153.0, 118.0, 154.0, 147.0, 116.0, 141.0, 140.0, 146.0, 145.0, 114.0], "unit": "score", "name": "audio-beat-detection", "value": 137.4}, {"lowerIsBetter": true, "replicates": [186.0, 186.0, 184.0, 184.0, 186.0, 183.0, 184.0, 183.0, 186.0, 185.0], "unit": "score", "name": "audio-dft", "value": 184.7}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 74.0, 115.0, 54.0, 56.0, 57.0, 57.0, 118.0, 56.0], "unit": "score", "name": "audio-fft", "value": 73.3}, {"lowerIsBetter": true, "replicates": [92.0, 96.0, 129.0, 80.0, 78.0, 86.0, 116.0, 77.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 94.7}, {"lowerIsBetter": true, "replicates": [90.0, 85.0, 133.0, 83.0, 89.0, 129.0, 131.0, 84.0, 86.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 99.4}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 92.0, 92.0, 91.0, 92.0, 92.0, 91.0, 91.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 91.7}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 86.0, 84.0, 86.0, 86.0, 86.0, 88.0, 84.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.4}, {"lowerIsBetter": true, "replicates": [56.0, 59.0, 58.0, 57.0, 58.0, 58.0, 56.0, 68.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [62.0, 62.0, 77.0, 73.0, 69.0, 66.0, 65.0, 67.0, 68.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [78.0, 82.0, 80.0, 80.0, 79.0, 79.0, 88.0, 86.0, 81.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.7}, {"lowerIsBetter": true, "replicates": [125.0, 125.0, 132.0, 124.0, 116.0, 130.0, 118.0, 99.0, 128.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [135.0, 120.0, 129.0, 133.0, 131.0, 121.0, 130.0, 132.0, 130.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 129.5}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 67.0, 67.0, 65.0, 66.0, 66.0, 66.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1402.9}]} 16:32:04 INFO - Return code: 0 16:32:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:32:04 INFO - # TBPL SUCCESS # 16:32:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:32:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:32:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:32:05 INFO - 2016-03-24 16:32:04.999 screenresolution[1967:20821] starting screenresolution argv=screenresolution get 16:32:05 INFO - 2016-03-24 16:32:05.001 screenresolution[1967:20821] Display 0: 1600x1200x32@60 16:32:05 INFO - 2016-03-24 16:32:05.007 screenresolution[1968:20824] starting screenresolution argv=screenresolution list 16:32:05 INFO - Available Modes on Display 0 16:32:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:32:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:32:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:32:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:32:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:32:05 INFO - Intel Iris: 16:32:05 INFO - Chipset Model: Intel Iris 16:32:05 INFO - Type: GPU 16:32:05 INFO - Bus: Built-In 16:32:05 INFO - VRAM (Dynamic, Max): 1536 MB 16:32:05 INFO - Vendor: Intel (0x8086) 16:32:05 INFO - Device ID: 0x0a2e 16:32:05 INFO - Revision ID: 0x0009 16:32:05 INFO - Displays: 16:32:05 INFO - Display: 16:32:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:32:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:32:05 INFO - Display Serial Number: 1600x1200 60 16:32:05 INFO - Main Display: Yes 16:32:05 INFO - Mirror: Off 16:32:05 INFO - Online: Yes 16:32:05 INFO - Rotation: Supported 16:32:05 INFO - Return code: 0 16:32:05 INFO - Running post-action listener: _resource_record_post_action 16:32:05 INFO - Running post-run listener: _resource_record_post_run 16:32:06 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 270336; Write bytes: 663953408; Read time: 7; Write time: 1869 16:32:06 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 351894016; Write bytes: 352667136; Read time: 27025; Write time: 664 16:32:06 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 270336; Write bytes: 300947968; Read time: 7; Write time: 1170 16:32:06 INFO - Running post-run listener: _upload_blobber_files 16:32:06 INFO - Blob upload gear active. 16:32:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:32:06 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 16:32:06 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'] 16:32:06 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 16:32:06 INFO - (blobuploader) - INFO - Open directory for files ... 16:32:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:32:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:32:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:07 INFO - (blobuploader) - INFO - Done attempting. 16:32:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:32:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:32:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:32:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:32:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:32:08 INFO - (blobuploader) - INFO - Done attempting. 16:32:08 INFO - (blobuploader) - INFO - Iteration through files over. 16:32:08 INFO - Return code: 0 16:32:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:32:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:32:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75ec5cf2dfb31ba27f550dd1b16a1ea561b47fc82b714c99b8fe149bcd398ea6ac87150f7604434c90a4310bf5431a3ca1e0e4ea3f5042b35ad37ff5c1b40852", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39945f84737c72736f77e7483c024ef047c00f53c473ea595eff4cb0fa30ee5efb5035caed6052dd46cc5222d91ff58f160b3057789b7eff0b99bbe55ca3f453"} 16:32:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:32:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:32:08 INFO - Contents: 16:32:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/75ec5cf2dfb31ba27f550dd1b16a1ea561b47fc82b714c99b8fe149bcd398ea6ac87150f7604434c90a4310bf5431a3ca1e0e4ea3f5042b35ad37ff5c1b40852", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39945f84737c72736f77e7483c024ef047c00f53c473ea595eff4cb0fa30ee5efb5035caed6052dd46cc5222d91ff58f160b3057789b7eff0b99bbe55ca3f453"} 16:32:08 INFO - Running post-run listener: copy_logs_to_upload_dir 16:32:08 INFO - Copying logs to upload dir... 16:32:08 INFO - mkdir: /builds/slave/test/build/upload/logs 16:32:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.287997 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2016-03-24 16:32:08.747066) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 16:32:08.754817) ========= 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.BSAqMFOKi2/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.SdSv848icr/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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/75ec5cf2dfb31ba27f550dd1b16a1ea561b47fc82b714c99b8fe149bcd398ea6ac87150f7604434c90a4310bf5431a3ca1e0e4ea3f5042b35ad37ff5c1b40852", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39945f84737c72736f77e7483c024ef047c00f53c473ea595eff4cb0fa30ee5efb5035caed6052dd46cc5222d91ff58f160b3057789b7eff0b99bbe55ca3f453"} build_url:https://queue.taskcluster.net/v1/task/DTkWQjA9Rhy59Z207fL7GQ/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/DTkWQjA9Rhy59Z207fL7GQ/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/75ec5cf2dfb31ba27f550dd1b16a1ea561b47fc82b714c99b8fe149bcd398ea6ac87150f7604434c90a4310bf5431a3ca1e0e4ea3f5042b35ad37ff5c1b40852", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/39945f84737c72736f77e7483c024ef047c00f53c473ea595eff4cb0fa30ee5efb5035caed6052dd46cc5222d91ff58f160b3057789b7eff0b99bbe55ca3f453"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-24 16:32:08.785848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 16:32:08.786227) ========= 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.BSAqMFOKi2/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.SdSv848icr/Listeners TMPDIR=/var/folders/2n/nlxy_zj109l8ldbz191kgyg800000w/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.005155 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-24 16:32:08.839718) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 16:32:08.840210) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-24 16:32:08.840771) ========= ========= Total master_lag: 11.79 =========