builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0001 starttime: 1456151182.35 results: success (0) buildid: 20160222030212 builduid: c4c5afe0268442618a2d2c650e205c99 revision: e1cf617a1f2813b6cd66f460313a61c223406c9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.350712) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.351208) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.351555) ========= 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.yTVefNyplz/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.L0kZSmx2zt/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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.005750 basedir: '/builds/slave/test' ========= master_lag: 0.16 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.519905) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.520258) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.816817) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.817123) ========= 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.yTVefNyplz/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.L0kZSmx2zt/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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.005447 ========= master_lag: 0.17 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.996108) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.996478) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.996890) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:22.997196) ========= 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.yTVefNyplz/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.L0kZSmx2zt/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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-02-22 06:26:23-- 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% 38.1M=0s 2016-02-22 06:26:23 (38.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190651 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.323804) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.324133) ========= 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.yTVefNyplz/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.L0kZSmx2zt/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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.020059 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:23.472449) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-22 06:26:23.472939) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e1cf617a1f2813b6cd66f460313a61c223406c9b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e1cf617a1f2813b6cd66f460313a61c223406c9b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yTVefNyplz/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.L0kZSmx2zt/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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-02-22 06:26:23,603 truncating revision to first 12 chars 2016-02-22 06:26:23,603 Setting DEBUG logging. 2016-02-22 06:26:23,603 attempt 1/10 2016-02-22 06:26:23,603 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e1cf617a1f28?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 06:26:25,310 unpacking tar archive at: mozilla-central-e1cf617a1f28/testing/mozharness/ program finished with exit code 0 elapsedTime=1.956237 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-22 06:26:25.496694) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:25.497053) ========= echo e1cf617a1f2813b6cd66f460313a61c223406c9b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'e1cf617a1f2813b6cd66f460313a61c223406c9b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yTVefNyplz/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.L0kZSmx2zt/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 e1cf617a1f2813b6cd66f460313a61c223406c9b program finished with exit code 0 elapsedTime=0.005515 script_repo_revision: 'e1cf617a1f2813b6cd66f460313a61c223406c9b' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:25.548176) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:25.548500) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-22 06:26:25.563163) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2016-02-22 06:26:25.563657) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yTVefNyplz/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.L0kZSmx2zt/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 06:26:25 INFO - MultiFileLogger online at 20160222 06:26:25 in /builds/slave/test 06:26:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:26:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:26:25 INFO - {'append_to_log': False, 06:26:25 INFO - 'base_work_dir': '/builds/slave/test', 06:26:25 INFO - 'blob_upload_branch': 'Firefox', 06:26:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:26:25 INFO - 'branch': 'Firefox', 06:26:25 INFO - 'buildbot_json_path': 'buildprops.json', 06:26:25 INFO - 'config_files': ('talos/mac_config.py',), 06:26:25 INFO - 'default_actions': ('clobber', 06:26:25 INFO - 'read-buildbot-config', 06:26:25 INFO - 'download-and-extract', 06:26:25 INFO - 'populate-webroot', 06:26:25 INFO - 'create-virtualenv', 06:26:25 INFO - 'install', 06:26:25 INFO - 'run-tests'), 06:26:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:26:25 INFO - 'download_minidump_stackwalk': True, 06:26:25 INFO - 'download_symbols': 'ondemand', 06:26:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:26:25 INFO - 'tooltool.py': '/tools/tooltool.py', 06:26:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:26:25 INFO - '/tools/misc-python/virtualenv.py')}, 06:26:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:26:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:26:25 INFO - 'installer_path': 'installer.exe', 06:26:25 INFO - 'log_level': 'info', 06:26:25 INFO - 'log_name': 'talos', 06:26:25 INFO - 'log_to_console': True, 06:26:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:26:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:26:25 INFO - 'opt_config_files': (), 06:26:25 INFO - 'pip_index': False, 06:26:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:26:25 INFO - 'cmd': ('bash', 06:26:25 INFO - '-c', 06:26:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:26:25 INFO - 'enabled': True, 06:26:25 INFO - 'halt_on_failure': False, 06:26:25 INFO - 'name': 'check_screen_resolution'},), 06:26:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:26:25 INFO - 'cmd': ('bash', 06:26:25 INFO - '-c', 06:26:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:26:25 INFO - 'enabled': True, 06:26:25 INFO - 'halt_on_failure': False, 06:26:25 INFO - 'name': 'check_screen_resolution'},), 06:26:25 INFO - 'run_cmd_checks_enabled': True, 06:26:25 INFO - 'sps_profile': False, 06:26:25 INFO - 'sps_profile_interval': 0, 06:26:25 INFO - 'suite': 'dromaeojs', 06:26:25 INFO - 'system_bits': '32', 06:26:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:26:25 INFO - 'title': 't-yosemite-r7-0001', 06:26:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:26:25 INFO - 'use_talos_json': True, 06:26:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:26:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:26:25 INFO - 'work_dir': 'build'} 06:26:25 INFO - ##### 06:26:25 INFO - ##### Running clobber step. 06:26:25 INFO - ##### 06:26:25 INFO - Running pre-action listener: _resource_record_pre_action 06:26:25 INFO - Running main action method: clobber 06:26:25 INFO - rmtree: /builds/slave/test/build 06:26:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:26:27 INFO - Running post-action listener: _resource_record_post_action 06:26:27 INFO - ##### 06:26:27 INFO - ##### Running read-buildbot-config step. 06:26:27 INFO - ##### 06:26:27 INFO - Running pre-action listener: _resource_record_pre_action 06:26:27 INFO - Running main action method: read_buildbot_config 06:26:27 INFO - Using buildbot properties: 06:26:27 INFO - { 06:26:27 INFO - "project": "", 06:26:27 INFO - "product": "firefox", 06:26:27 INFO - "script_repo_revision": "production", 06:26:27 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:26:27 INFO - "repository": "", 06:26:27 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:26:27 INFO - "buildid": "20160222030212", 06:26:27 INFO - "stage_platform": "macosx64", 06:26:27 INFO - "basedir": "/builds/slave/test", 06:26:27 INFO - "nightly_build": "True", 06:26:27 INFO - "buildnumber": 146, 06:26:27 INFO - "slavename": "t-yosemite-r7-0001", 06:26:27 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:26:27 INFO - "platform": "yosemite_r7", 06:26:27 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:26:27 INFO - "branch": "mozilla-central", 06:26:27 INFO - "repo_path": "mozilla-central", 06:26:27 INFO - "revision": "e1cf617a1f2813b6cd66f460313a61c223406c9b", 06:26:27 INFO - "pgo_build": "False", 06:26:27 INFO - "builduid": "c4c5afe0268442618a2d2c650e205c99", 06:26:27 INFO - "slavebuilddir": "test" 06:26:27 INFO - } 06:26:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 06:26:27 INFO - Running post-action listener: _resource_record_post_action 06:26:27 INFO - ##### 06:26:27 INFO - ##### Running download-and-extract step. 06:26:27 INFO - ##### 06:26:27 INFO - Running pre-action listener: _resource_record_pre_action 06:26:27 INFO - Running main action method: download_and_extract 06:26:27 INFO - mkdir: /builds/slave/test/build/tests 06:26: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')]} 06:26:27 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:26:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json 06:26:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json 06:26:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:26:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:26:56 INFO - Downloaded 1277 bytes. 06:26:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:26:56 INFO - Using the following test package requirements: 06:26:56 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:26:56 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:56 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 06:26:56 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:56 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 06:26:56 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:56 INFO - u'jsshell-mac.zip'], 06:26:56 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:56 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 06:26:56 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:26:56 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:56 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 06:26:56 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:56 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 06:26:56 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:56 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 06:26:56 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 06:26:56 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 06:26:56 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 06:26:56 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:26: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')]} 06:26:56 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:26:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:26:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:26:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:26:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:27:15 INFO - Downloaded 17825439 bytes. 06:27:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:27:18 INFO - Return code: 0 06:27:18 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:27:18 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')]} 06:27:18 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:27:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:27:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:27:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 06:27:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:27:25 INFO - Downloaded 17825439 bytes. 06:27:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:27:29 INFO - Return code: 0 06:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:29 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:27:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:27:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:27:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 06:27:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:27:31 INFO - Downloaded 10707015 bytes. 06:27:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:27:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:27:31 INFO - Return code: 0 06:27:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:31 INFO - https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:27:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:27:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:27:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 06:27:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 06:27:37 INFO - Downloaded 111382499 bytes. 06:27:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:27:37 INFO - mkdir: /builds/slave/test/properties 06:27:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:27:37 INFO - Writing to file /builds/slave/test/properties/build_url 06:27:37 INFO - Contents: 06:27:37 INFO - build_url:https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 06:27:39 INFO - Running post-action listener: _resource_record_post_action 06:27:39 INFO - Running post-action listener: set_extra_try_arguments 06:27:39 INFO - ##### 06:27:39 INFO - ##### Running populate-webroot step. 06:27:39 INFO - ##### 06:27:39 INFO - Running pre-action listener: _resource_record_pre_action 06:27:39 INFO - Running main action method: populate_webroot 06:27:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:27:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:27:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:27:39 INFO - '--tppagecycles', 06:27:39 INFO - '7'], 06:27:39 INFO - 'tests': ['tsvgm']}}, 06:27:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:27:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:27:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:27:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:27:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:27:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:27:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:27:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:39 INFO - 'talos_options': ['--e10s'], 06:27:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:27:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:39 INFO - 'tests': ['damp', 'tps']}, 06:27:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:39 INFO - 'talos_options': ['--e10s'], 06:27:39 INFO - 'tests': ['damp', 'tps']}, 06:27:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:27:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:27:39 INFO - 'other': {'tests': ['a11yr', 06:27:39 INFO - 'ts_paint', 06:27:39 INFO - 'tpaint', 06:27:39 INFO - 'sessionrestore', 06:27:39 INFO - 'sessionrestore_no_auto_restore']}, 06:27:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:27:39 INFO - 'tests': ['a11yr', 06:27:39 INFO - 'ts_paint', 06:27:39 INFO - 'tpaint', 06:27:39 INFO - 'sessionrestore', 06:27:39 INFO - 'sessionrestore_no_auto_restore']}, 06:27:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:27:39 INFO - 'tests': ['a11yr', 06:27:39 INFO - 'ts_paint', 06:27:39 INFO - 'tpaint', 06:27:39 INFO - 'sessionrestore', 06:27:39 INFO - 'sessionrestore_no_auto_restore']}, 06:27:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:27:39 INFO - 'tests': ['a11yr', 06:27:39 INFO - 'ts_paint', 06:27:39 INFO - 'tpaint', 06:27:39 INFO - 'sessionrestore', 06:27:39 INFO - 'sessionrestore_no_auto_restore']}, 06:27:39 INFO - 'other_l64': {'tests': ['a11yr', 06:27:39 INFO - 'ts_paint', 06:27:39 INFO - 'tpaint', 06:27:39 INFO - 'sessionrestore', 06:27:39 INFO - 'sessionrestore_no_auto_restore']}, 06:27:39 INFO - 'other_nol64': {'tests': ['a11yr', 06:27:39 INFO - 'ts_paint', 06:27:39 INFO - 'tpaint', 06:27:39 INFO - 'sessionrestore', 06:27:39 INFO - 'sessionrestore_no_auto_restore']}, 06:27:39 INFO - 'svgr': {'tests': ['tsvgx', 06:27:39 INFO - 'tsvgr_opacity', 06:27:39 INFO - 'tart', 06:27:39 INFO - 'tscrollx', 06:27:39 INFO - 'cart']}, 06:27:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:27:39 INFO - 'tests': ['tsvgx', 06:27:39 INFO - 'tsvgr_opacity', 06:27:39 INFO - 'tart', 06:27:39 INFO - 'tscrollx', 06:27:39 INFO - 'cart']}, 06:27:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:39 INFO - 'tests': ['tp5o']}, 06:27:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:39 INFO - 'talos_options': ['--e10s'], 06:27:39 INFO - 'tests': ['tp5o']}, 06:27:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:39 INFO - 'talos_options': ['--xperf_path', 06:27:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:27:39 INFO - 'tests': ['tp5n']}, 06:27:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:27:39 INFO - 'talos_options': ['--e10s', 06:27:39 INFO - '--xperf_path', 06:27:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:27:39 INFO - 'tests': ['tp5n']}}, 06:27:39 INFO - 'talos.zip': {'path': '', 06:27:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:27:39 INFO - Running post-action listener: _resource_record_post_action 06:27:39 INFO - ##### 06:27:39 INFO - ##### Running create-virtualenv step. 06:27:39 INFO - ##### 06:27:39 INFO - Running pre-action listener: _resource_record_pre_action 06:27:39 INFO - Running main action method: create_virtualenv 06:27:39 INFO - Creating virtualenv /builds/slave/test/build/venv 06:27:39 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 06:27:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:27:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:27:39 INFO - Using real prefix '/tools/python27' 06:27:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:27:39 INFO - Installing distribute.............................................................................................................................................................................................done. 06:27:42 INFO - Installing pip.................done. 06:27:42 INFO - Return code: 0 06:27:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:27:42 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')]} 06:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:42 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')]} 06:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:42 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 0x108e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c8f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d32d30>, '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 0x108b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d29b20>, '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.yTVefNyplz/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.L0kZSmx2zt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 06:27:42 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 06:27:42 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 06:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTVefNyplz/Render', 06:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:42 INFO - 'HOME': '/Users/cltbld', 06:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:42 INFO - 'LOGNAME': 'cltbld', 06:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:42 INFO - 'MOZ_NO_REMOTE': '1', 06:27:42 INFO - 'NO_EM_RESTART': '1', 06:27:42 INFO - 'PAGER': '/bin/cat', 06:27:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:42 INFO - 'PWD': '/builds/slave/test', 06:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:42 INFO - 'SHELL': '/bin/bash', 06:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L0kZSmx2zt/Listeners', 06:27:42 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 06:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:42 INFO - 'USER': 'cltbld', 06:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:42 INFO - 'XPC_FLAGS': '0x0', 06:27:42 INFO - 'XPC_SERVICE_NAME': '0', 06:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:42 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 06:27:42 INFO - Cleaning up... 06:27:43 INFO - Return code: 0 06:27:43 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:27: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')]} 06:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27: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')]} 06:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c8f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d32d30>, '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 0x108b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d29b20>, '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.yTVefNyplz/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.L0kZSmx2zt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 06:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:27:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTVefNyplz/Render', 06:27:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:43 INFO - 'HOME': '/Users/cltbld', 06:27:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:43 INFO - 'LOGNAME': 'cltbld', 06:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:43 INFO - 'MOZ_NO_REMOTE': '1', 06:27:43 INFO - 'NO_EM_RESTART': '1', 06:27:43 INFO - 'PAGER': '/bin/cat', 06:27:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:43 INFO - 'PWD': '/builds/slave/test', 06:27:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:43 INFO - 'SHELL': '/bin/bash', 06:27:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L0kZSmx2zt/Listeners', 06:27:43 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 06:27:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:43 INFO - 'USER': 'cltbld', 06:27:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:43 INFO - 'XPC_FLAGS': '0x0', 06:27:43 INFO - 'XPC_SERVICE_NAME': '0', 06:27:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:43 INFO - Downloading/unpacking psutil>=0.7.1 06:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:27:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:46 INFO - Installing collected packages: psutil 06:27:46 INFO - Running setup.py install for psutil 06:27:46 INFO - building 'psutil._psutil_osx' extension 06:27:46 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 06:27:46 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 06:27:46 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 06:27:47 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 06:27:47 INFO - building 'psutil._psutil_posix' extension 06:27:47 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 06:27:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:27:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:27:47 INFO - ^ 06:27:47 INFO - 1 warning generated. 06:27:47 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 06:27:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:47 INFO - Successfully installed psutil 06:27:47 INFO - Cleaning up... 06:27:47 INFO - Return code: 0 06:27:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c8f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d32d30>, '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 0x108b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d29b20>, '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.yTVefNyplz/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.L0kZSmx2zt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 06:27:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:27:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:27:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTVefNyplz/Render', 06:27:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:47 INFO - 'HOME': '/Users/cltbld', 06:27:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:47 INFO - 'LOGNAME': 'cltbld', 06:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:47 INFO - 'MOZ_NO_REMOTE': '1', 06:27:47 INFO - 'NO_EM_RESTART': '1', 06:27:47 INFO - 'PAGER': '/bin/cat', 06:27:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:47 INFO - 'PWD': '/builds/slave/test', 06:27:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:47 INFO - 'SHELL': '/bin/bash', 06:27:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L0kZSmx2zt/Listeners', 06:27:47 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 06:27:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:47 INFO - 'USER': 'cltbld', 06:27:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:47 INFO - 'XPC_FLAGS': '0x0', 06:27:47 INFO - 'XPC_SERVICE_NAME': '0', 06:27:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:27:50 INFO - Installing collected packages: mozsystemmonitor 06:27:50 INFO - Running setup.py install for mozsystemmonitor 06:27:50 INFO - Successfully installed mozsystemmonitor 06:27:50 INFO - Cleaning up... 06:27:50 INFO - Return code: 0 06:27:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x108e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c8f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d32d30>, '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 0x108b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d29b20>, '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.yTVefNyplz/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.L0kZSmx2zt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 06:27:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:27:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:27:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTVefNyplz/Render', 06:27:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:50 INFO - 'HOME': '/Users/cltbld', 06:27:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:50 INFO - 'LOGNAME': 'cltbld', 06:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:50 INFO - 'MOZ_NO_REMOTE': '1', 06:27:50 INFO - 'NO_EM_RESTART': '1', 06:27:50 INFO - 'PAGER': '/bin/cat', 06:27:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:50 INFO - 'PWD': '/builds/slave/test', 06:27:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:50 INFO - 'SHELL': '/bin/bash', 06:27:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L0kZSmx2zt/Listeners', 06:27:50 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 06:27:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:50 INFO - 'USER': 'cltbld', 06:27:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:50 INFO - 'XPC_FLAGS': '0x0', 06:27:50 INFO - 'XPC_SERVICE_NAME': '0', 06:27:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:50 INFO - Downloading/unpacking blobuploader==1.2.4 06:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:52 INFO - Downloading blobuploader-1.2.4.tar.gz 06:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:27:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:27: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 06:27: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 06:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:27:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:54 INFO - Downloading docopt-0.6.1.tar.gz 06:27:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:27:54 INFO - Installing collected packages: blobuploader, requests, docopt 06:27:54 INFO - Running setup.py install for blobuploader 06:27:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:27:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:27:54 INFO - Running setup.py install for requests 06:27:54 INFO - Running setup.py install for docopt 06:27:54 INFO - Successfully installed blobuploader requests docopt 06:27:54 INFO - Cleaning up... 06:27:55 INFO - Return code: 0 06:27:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:55 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')]} 06:27:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:55 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')]} 06:27:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:55 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 0x108e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c8f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d32d30>, '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 0x108b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d29b20>, '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.yTVefNyplz/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.L0kZSmx2zt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 06:27:55 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 06:27:55 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 06:27:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTVefNyplz/Render', 06:27:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:55 INFO - 'HOME': '/Users/cltbld', 06:27:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:55 INFO - 'LOGNAME': 'cltbld', 06:27:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:55 INFO - 'MOZ_NO_REMOTE': '1', 06:27:55 INFO - 'NO_EM_RESTART': '1', 06:27:55 INFO - 'PAGER': '/bin/cat', 06:27:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:55 INFO - 'PWD': '/builds/slave/test', 06:27:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:55 INFO - 'SHELL': '/bin/bash', 06:27:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L0kZSmx2zt/Listeners', 06:27:55 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 06:27:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:55 INFO - 'USER': 'cltbld', 06:27:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:55 INFO - 'XPC_FLAGS': '0x0', 06:27:55 INFO - 'XPC_SERVICE_NAME': '0', 06:27:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:55 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-7ZY10V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:55 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-2eW13t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:55 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-Ax0gMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:55 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-XbTp4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:55 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-cLAHkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:55 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-PCv2tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:55 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-2SnZ8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:55 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-pEUDzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:56 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-MwYI4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:56 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-Y3vRSW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:56 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-gPfWEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:56 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-23EjKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:56 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-mmPT6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:56 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-pHrIky-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:56 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-Z6sUCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:56 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-6oVydk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:56 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-_GYXcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:27:57 INFO - Running setup.py install for manifestparser 06:27:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:27:57 INFO - Running setup.py install for mozcrash 06:27:57 INFO - Running setup.py install for mozdebug 06:27:57 INFO - Running setup.py install for mozdevice 06:27:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:27:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:27:57 INFO - Running setup.py install for mozfile 06:27:57 INFO - Running setup.py install for mozhttpd 06:27:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:27:57 INFO - Running setup.py install for mozinfo 06:27:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Running setup.py install for mozInstall 06:27:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Running setup.py install for mozleak 06:27:58 INFO - Running setup.py install for mozlog 06:27:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Running setup.py install for moznetwork 06:27:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Running setup.py install for mozprocess 06:27:58 INFO - Running setup.py install for mozprofile 06:27:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:27:58 INFO - Running setup.py install for mozrunner 06:27:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:27:59 INFO - Running setup.py install for mozscreenshot 06:27:59 INFO - Running setup.py install for moztest 06:27:59 INFO - Running setup.py install for mozversion 06:27:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:27:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:27:59 INFO - Cleaning up... 06:27:59 INFO - Return code: 0 06:27:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:59 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')]} 06:27:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:59 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')]} 06:27:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:27:59 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 0x108e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c8f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d32d30>, '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 0x108b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d29b20>, '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.yTVefNyplz/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.L0kZSmx2zt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 06:27:59 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 06:27:59 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 06:27:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTVefNyplz/Render', 06:27:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:27:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:27:59 INFO - 'HOME': '/Users/cltbld', 06:27:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:27:59 INFO - 'LOGNAME': 'cltbld', 06:27:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:59 INFO - 'MOZ_NO_REMOTE': '1', 06:27:59 INFO - 'NO_EM_RESTART': '1', 06:27:59 INFO - 'PAGER': '/bin/cat', 06:27:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:27:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:59 INFO - 'PWD': '/builds/slave/test', 06:27:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:27:59 INFO - 'SHELL': '/bin/bash', 06:27:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L0kZSmx2zt/Listeners', 06:27:59 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 06:27:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:27:59 INFO - 'USER': 'cltbld', 06:27:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:27:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:27:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:59 INFO - 'XPC_FLAGS': '0x0', 06:27:59 INFO - 'XPC_SERVICE_NAME': '0', 06:27:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:27:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:59 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-YosK1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:59 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)) 06:27:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:59 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-zw6Di5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:00 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-rI7hJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:00 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-GNaZLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:00 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-ovQqZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:00 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-bfR1ph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:00 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-OfHbz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:00 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-TQXSDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:00 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-mPZSxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:00 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-mXR6LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:00 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)) 06:28:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:00 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-_uubPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:01 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)) 06:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:01 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-thztrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:01 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)) 06:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:01 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-TAW7LP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:01 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)) 06:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:01 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-9Lm4jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:01 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)) 06:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:01 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-OymQPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:01 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)) 06:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:01 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-kPYt99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:01 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)) 06:28:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:01 INFO - Running setup.py (path:/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/pip-I9geM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:01 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)) 06:28:01 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:28:01 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:28:01 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)) 06:28:01 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)) 06:28:01 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)) 06:28:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:28:01 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 06:28:01 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 06:28:01 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 06:28:01 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 06:28:01 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 06:28:01 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 06:28:03 INFO - Downloading blessings-1.6.tar.gz 06:28:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:28:04 INFO - Installing collected packages: blessings 06:28:04 INFO - Running setup.py install for blessings 06:28:04 INFO - Successfully installed blessings 06:28:04 INFO - Cleaning up... 06:28:04 INFO - Return code: 0 06:28:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:28:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:04 INFO - Reading from file tmpfile_stdout 06:28:04 INFO - Current package versions: 06:28:04 INFO - blessings == 1.6 06:28:04 INFO - blobuploader == 1.2.4 06:28:04 INFO - docopt == 0.6.1 06:28:04 INFO - manifestparser == 1.1 06:28:04 INFO - mozInstall == 1.12 06:28:04 INFO - mozcrash == 0.16 06:28:04 INFO - mozdebug == 0.1 06:28:04 INFO - mozdevice == 0.48 06:28:04 INFO - mozfile == 1.2 06:28:04 INFO - mozhttpd == 0.7 06:28:04 INFO - mozinfo == 0.9 06:28:04 INFO - mozleak == 0.1 06:28:04 INFO - mozlog == 3.1 06:28:04 INFO - moznetwork == 0.27 06:28:04 INFO - mozprocess == 0.22 06:28:04 INFO - mozprofile == 0.28 06:28:04 INFO - mozrunner == 6.11 06:28:04 INFO - mozscreenshot == 0.1 06:28:04 INFO - mozsystemmonitor == 0.0 06:28:04 INFO - moztest == 0.7 06:28:04 INFO - mozversion == 1.4 06:28:04 INFO - psutil == 3.1.1 06:28:04 INFO - requests == 1.2.3 06:28:04 INFO - wsgiref == 0.1.2 06:28:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:04 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 0x108e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c8f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d32d30>, '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 0x108b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d29b20>, '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.yTVefNyplz/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.L0kZSmx2zt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 06:28:04 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 06:28:04 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 06:28:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTVefNyplz/Render', 06:28:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:04 INFO - 'HOME': '/Users/cltbld', 06:28:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:04 INFO - 'LOGNAME': 'cltbld', 06:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:04 INFO - 'MOZ_NO_REMOTE': '1', 06:28:04 INFO - 'NO_EM_RESTART': '1', 06:28:04 INFO - 'PAGER': '/bin/cat', 06:28:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:04 INFO - 'PWD': '/builds/slave/test', 06:28:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:04 INFO - 'SHELL': '/bin/bash', 06:28:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L0kZSmx2zt/Listeners', 06:28:04 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 06:28:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:04 INFO - 'USER': 'cltbld', 06:28:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:04 INFO - 'XPC_FLAGS': '0x0', 06:28:04 INFO - 'XPC_SERVICE_NAME': '0', 06:28:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 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)) 06:28:04 INFO - Cleaning up... 06:28:04 INFO - Return code: 0 06:28:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:04 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 0x108e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c8f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d32d30>, '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 0x108b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d29b20>, '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.yTVefNyplz/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.L0kZSmx2zt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 06:28:04 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 06:28:04 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 06:28:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTVefNyplz/Render', 06:28:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:04 INFO - 'HOME': '/Users/cltbld', 06:28:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:04 INFO - 'LOGNAME': 'cltbld', 06:28:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:04 INFO - 'MOZ_NO_REMOTE': '1', 06:28:04 INFO - 'NO_EM_RESTART': '1', 06:28:04 INFO - 'PAGER': '/bin/cat', 06:28:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:04 INFO - 'PWD': '/builds/slave/test', 06:28:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:04 INFO - 'SHELL': '/bin/bash', 06:28:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L0kZSmx2zt/Listeners', 06:28:04 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 06:28:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:04 INFO - 'USER': 'cltbld', 06:28:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:04 INFO - 'XPC_FLAGS': '0x0', 06:28:04 INFO - 'XPC_SERVICE_NAME': '0', 06:28:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:05 INFO - Downloading/unpacking jsonschema 06:28:05 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 06:28:05 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 06:28:05 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 06:28:05 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 06:28:05 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 06:28:05 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 06:28:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:28:07 INFO - Downloading/unpacking functools32 (from jsonschema) 06:28:07 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 06:28:07 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 06:28:07 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 06:28:07 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 06:28:07 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 06:28:07 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 06:28:07 INFO - Downloading functools32-3.2.3-2.tar.gz 06:28:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:28:07 INFO - warning: no files found matching '*.txt' 06:28:07 INFO - no previously-included directories found matching 'build' 06:28:07 INFO - no previously-included directories found matching 'dist' 06:28:07 INFO - no previously-included directories found matching '.git*' 06:28:07 INFO - Installing collected packages: jsonschema, functools32 06:28:07 INFO - Running setup.py install for functools32 06:28:07 INFO - warning: no files found matching '*.txt' 06:28:07 INFO - no previously-included directories found matching 'build' 06:28:07 INFO - no previously-included directories found matching 'dist' 06:28:07 INFO - no previously-included directories found matching '.git*' 06:28:08 INFO - Successfully installed jsonschema functools32 06:28:08 INFO - Cleaning up... 06:28:08 INFO - Return code: 0 06:28:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x108e8ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108e964c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98b9c8f850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108d32d30>, '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 0x108b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d29b20>, '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.yTVefNyplz/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.L0kZSmx2zt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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 06:28:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:28:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:28:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTVefNyplz/Render', 06:28:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:08 INFO - 'HOME': '/Users/cltbld', 06:28:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:08 INFO - 'LOGNAME': 'cltbld', 06:28:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:08 INFO - 'MOZ_NO_REMOTE': '1', 06:28:08 INFO - 'NO_EM_RESTART': '1', 06:28:08 INFO - 'PAGER': '/bin/cat', 06:28:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:08 INFO - 'PWD': '/builds/slave/test', 06:28:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:08 INFO - 'SHELL': '/bin/bash', 06:28:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L0kZSmx2zt/Listeners', 06:28:08 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 06:28:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:08 INFO - 'USER': 'cltbld', 06:28:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:08 INFO - 'XPC_FLAGS': '0x0', 06:28:08 INFO - 'XPC_SERVICE_NAME': '0', 06:28:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:08 INFO - Downloading/unpacking flake8 06:28:08 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 06:28:08 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 06:28:08 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 06:28:08 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 06:28:08 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 06:28:08 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 06:28:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:28:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:28:10 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 06:28:10 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 06:28:10 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 06:28:10 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 06:28:10 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 06:28:10 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 06:28:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:28:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:28:11 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 06:28:11 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 06:28:11 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 06:28:11 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 06:28:11 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 06:28:11 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 06:28:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:28:11 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 06:28:11 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 06:28:11 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 06:28:11 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 06:28:11 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 06:28:11 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 06:28:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:28:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:11 INFO - no previously-included directories found matching 'docs/_build' 06:28:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:28:12 INFO - Running setup.py install for pep8 06:28:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:12 INFO - no previously-included directories found matching 'docs/_build' 06:28:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:28:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:28:12 INFO - Cleaning up... 06:28:12 INFO - Return code: 0 06:28:12 INFO - Running post-action listener: _resource_record_post_action 06:28:12 INFO - Running post-action listener: _start_resource_monitoring 06:28:12 INFO - Starting resource monitoring. 06:28:12 INFO - ##### 06:28:12 INFO - ##### Running install step. 06:28:12 INFO - ##### 06:28:12 INFO - Running pre-action listener: _resource_record_pre_action 06:28:12 INFO - Running main action method: install 06:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:12 INFO - Reading from file tmpfile_stdout 06:28:12 INFO - Detecting whether we're running mozinstall >=1.0... 06:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:28:12 INFO - Reading from file tmpfile_stdout 06:28:12 INFO - Output received: 06:28:12 INFO - Usage: mozinstall [options] installer 06:28:12 INFO - Options: 06:28:12 INFO - -h, --help show this help message and exit 06:28:12 INFO - -d DEST, --destination=DEST 06:28:12 INFO - Directory to install application into. [default: 06:28:12 INFO - "/builds/slave/test"] 06:28:12 INFO - --app=APP Application being installed. [default: firefox] 06:28:12 INFO - mkdir: /builds/slave/test/build/application 06:28:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:28:46 INFO - Reading from file tmpfile_stdout 06:28:46 INFO - Output received: 06:28:46 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 06:28:46 INFO - Running post-action listener: _resource_record_post_action 06:28:46 INFO - ##### 06:28:46 INFO - ##### Running run-tests step. 06:28:46 INFO - ##### 06:28:46 INFO - Running pre-action listener: _resource_record_pre_action 06:28:46 INFO - Running main action method: run_tests 06:28:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:28:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:28:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:28:46 INFO - 2016-02-22 06:28:46.452 screenresolution[2270:23748] starting screenresolution argv=screenresolution get 06:28:46 INFO - 2016-02-22 06:28:46.455 screenresolution[2270:23748] Display 0: 1600x1200x32@60 06:28:46 INFO - 2016-02-22 06:28:46.461 screenresolution[2271:23750] starting screenresolution argv=screenresolution list 06:28:46 INFO - Available Modes on Display 0 06:28:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:28:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:28:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:28:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:28:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:28:46 INFO - Intel Iris: 06:28:46 INFO - Chipset Model: Intel Iris 06:28:46 INFO - Type: GPU 06:28:46 INFO - Bus: Built-In 06:28:46 INFO - VRAM (Dynamic, Max): 1536 MB 06:28:46 INFO - Vendor: Intel (0x8086) 06:28:46 INFO - Device ID: 0x0a2e 06:28:46 INFO - Revision ID: 0x0009 06:28:46 INFO - Displays: 06:28:46 INFO - Display: 06:28:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:28:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:28:46 INFO - Display Serial Number: 1600x1200 60 06:28:46 INFO - Main Display: Yes 06:28:46 INFO - Mirror: Off 06:28:46 INFO - Online: Yes 06:28:46 INFO - Rotation: Supported 06:28:46 INFO - Return code: 0 06:28:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:28:46 INFO - Python 2.7.3 06:28:46 INFO - Return code: 0 06:28:46 INFO - grabbing minidump binary from tooltool 06:28: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')]} 06:28:46 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 0x108d32d30>, '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 0x108b56db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108d29b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:28:46 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 06:28:46 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 06:28:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:28:46 INFO - Return code: 0 06:28:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:28:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:28:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:28:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:28:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:28:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:28:48 INFO - Return code: 0 06:28:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--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 06:28:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0001 --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 06:28:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yTVefNyplz/Render', 06:28:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:48 INFO - 'HOME': '/Users/cltbld', 06:28:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:48 INFO - 'LOGNAME': 'cltbld', 06:28:48 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:28:48 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:48 INFO - 'MOZ_NO_REMOTE': '1', 06:28:48 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:28:48 INFO - 'NO_EM_RESTART': '1', 06:28:48 INFO - 'PAGER': '/bin/cat', 06:28:48 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:48 INFO - 'PWD': '/builds/slave/test', 06:28:48 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:28:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:48 INFO - 'SHELL': '/bin/bash', 06:28:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.L0kZSmx2zt/Listeners', 06:28:48 INFO - 'TMPDIR': '/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/', 06:28:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:48 INFO - 'USER': 'cltbld', 06:28:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:48 INFO - 'XPC_FLAGS': '0x0', 06:28:48 INFO - 'XPC_SERVICE_NAME': '0', 06:28:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:48 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--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 06:28:48 INFO - mozversion application_buildid: 20160222030212 06:28:48 INFO - mozversion application_changeset: e1cf617a1f2813b6cd66f460313a61c223406c9b 06:28:48 INFO - mozversion application_display_name: Nightly 06:28:48 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:28:48 INFO - mozversion application_name: Firefox 06:28:48 INFO - mozversion application_remotingname: firefox 06:28:48 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:28:48 INFO - mozversion application_vendor: Mozilla 06:28:48 INFO - mozversion application_version: 47.0a1 06:28:48 INFO - mozversion platform_buildid: 20160222030212 06:28:48 INFO - mozversion platform_changeset: e1cf617a1f2813b6cd66f460313a61c223406c9b 06:28:48 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:28:48 INFO - mozversion platform_version: 47.0a1 06:28:48 INFO - using testdate: 1456151328 06:28:48 INFO - actual date: 1456151328 06:28:48 INFO - starting webserver on 'localhost:56599' 06:28:48 INFO - SUITE-START | Running 2 tests 06:28:48 INFO - TEST-START | dromaeo_css 06:28:48 INFO - operating with platform_type : mac_ 06:28:48 INFO - Initialising browser for dromaeo_css test... 06:28:48 INFO - TEST-INFO | started process 2289 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/tmpPakz7u/profile http://localhost:56599/getInfo.html) 06:28:51 INFO - PROCESS | 2289 | __metrics Screen width/height:1600/1200 06:28:51 INFO - PROCESS | 2289 | colorDepth:24 06:28:51 INFO - PROCESS | 2289 | Browser inner width/height: 1024/689 06:28:51 INFO - PROCESS | 2289 | __metrics 06:28:51 INFO - PROCESS | 2289 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:28:51 INFO - PROCESS | 2289 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:28:51 INFO - TEST-INFO | 2289: exit 0 06:28:51 INFO - Browser initialized. 06:28:51 INFO - Running cycle 1/1 for dromaeo_css test... 06:28:51 INFO - TEST-INFO | started process 2293 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/tmpPakz7u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:29:03 INFO - PROCESS | 2293 | RSS: Main: 244584448 06:29:03 INFO - PROCESS | 2293 | 06:29:55 INFO - PROCESS | 2293 | 1456151395267 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] 06:32:05 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:56599/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56599/tests/dromaeo/cssquery-ext.html) 06:32:07 INFO - PROCESS | 2293 | RSS: Main: 334417920 06:32:07 INFO - PROCESS | 2293 | 06:35:09 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:56599/tests/dromaeo/cssquery-ext.html (next: http://localhost:56599/tests/dromaeo/cssquery-jquery.html) 06:35:10 INFO - PROCESS | 2293 | RSS: Main: 382066688 06:35:10 INFO - PROCESS | 2293 | 06:38:12 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:56599/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56599/tests/dromaeo/cssquery-mootools.html) 06:38:13 INFO - PROCESS | 2293 | RSS: Main: 377253888 06:38:13 INFO - PROCESS | 2293 | 06:41:15 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:56599/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56599/tests/dromaeo/cssquery-prototype.html) 06:41:16 INFO - PROCESS | 2293 | RSS: Main: 335364096 06:41:16 INFO - PROCESS | 2293 | 06:44:19 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:56599/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56599/tests/dromaeo/cssquery-yui.html) 06:44:19 INFO - PROCESS | 2293 | RSS: Main: 337465344 06:44:19 INFO - PROCESS | 2293 | 06:47:22 INFO - PROCESS | 2293 | Cycle 1(1): loaded http://localhost:56599/tests/dromaeo/cssquery-yui.html (next: http://localhost:56599/tests/dromaeo/cssquery-dojo.html) 06:47:22 INFO - PROCESS | 2293 | RSS: Main: 385994752 06:47:22 INFO - PROCESS | 2293 | 06:47:22 INFO - PROCESS | 2293 | __start_tp_report 06:47:22 INFO - PROCESS | 2293 | _x_x_mozilla_page_load 06:47:22 INFO - PROCESS | 2293 | _x_x_mozilla_page_load_details 06:47:22 INFO - PROCESS | 2293 | |i|pagename|runs| 06:47:22 INFO - PROCESS | 2293 | |0;dojo.html;3416.2313479467116;3447.08652207165;3479.42589472737;3490.249596336787;3501.842417091231;5587.525060369863;5649;5663.8584035399135;5673.914891276629;5702.600817942745;5670.68811215383;5688.488036076752;5698.487136157745;5793.217915581406;5822.359540450547;5082.822101226458;5115.872103197422;5153.969206158765;5159.535641792238;5262.552683021929;5214.452482489341;5228.137357336035;5266.315379000744;5281.313429254192;5327.866803329909;5107.540321371057;5133.768980395873;5201.609879259071;5207.270982062514;5217.113090774558;5152.845414637567;5158.819441319573;5188.040212560651;5193.37679478465;5193.987172501364;4547.408836851188;5116.923246151311;5119.56483698886;5124.692518448905;5171.22431635254;5476.616636835423;5491.780328786844;5529.087700529408;5572.86067848303;5605.32736071674;6169.598976066542;6174.96912515439;6181.258249010102;6181.907271390933;6197.411245931629;6126.571140020201;6183.319834818167;6246.781362652331;6248.562600617958;6256.624602523863;5721.313442386941;5748.885022299614;5756.539476841843;5757.942420575782;5837.211976383176;6223.222097237845;6234.096056071844;6237.220347456568;6244.906326405107;6257.499400047986;5982.551308651781;6007.340541612901;6017.037274036134;6087.756489740361;6089.63462192261;6101.82280290701;6108.297545782292;6131.877362452726;6249.718762655601;6257.217847769029;6174.38256174388;6177.81466555995;6180.289266734383;6190.876182476325;6220.284667263232;6194.442500175006;6199.318075011745;6216.7824126155365;6222.097795819581;6230.532710046765;4798.2082956311815;4830.975845120822;4865.7323847188745;4881.096997055556;4894.804207831647;4255.148970205909;4413.735175889393;4434.13534360803;4453.799579018887;4454.888627784331;5745.68398738065;5767.567432442584;5778.88442231153;5779.306483222041;5805.7387417566315;6252.280987686383;6257.499400047986;6260.123582698426;6277.874442511215;6298.1812364392335;5609.551235901118;5767.22142510764;5773.538116950634;5785.88428231433;5830.979578573732;5325.121354976463;5326.893462130735;5331.760070796746;5333.253344531769;5340.2256672783005;6192.287886892975;6194.938050619436;6243.531735119885;6282.963311053625;6293.370662933761;6151.753929842756;6231.501479881689;6239.251289845248;6259.092431597302;6278.6546739929745;6158.907616385668;6246.125542424155;6246.750129994749;6262.029385445263;6270.7491700331475;6131.662758548323;6168.537359697951;6173.722182501709;6176.28972668131;6184.505239580732;6216.968915155395;6232.906506402498;6241.906371404341;6242.219722534684;6260.123582698335;5889.587728858939;5997.280326360865;6030.7286172121485;6033.215681961317;6066.939330606638;5959.28488581373;6040.335563088145;6046.183765191819;6071.939280607137;6092.786752463642;5852.590318677651;5863.501602363847;5868.23712917318;5884.9705751470965;5910.408959104056;5948.910766338422;6007.098935159761;6040.728167232397;6057.636541807506;6127.662978536223;5855.121731740273;5919.171316015847;5921.6743079131065;5926.7925622603;5931.169636250842 06:47:22 INFO - PROCESS | 2293 | |1;ext.html;465.573999790192;472.3906161052243;520.9296744939434;537.4598528478878;570.9143628455731;29090.127296181123;29652.258693532673;29654.110376688735;29705;29805.105846824576;31146.532802007987;37867.24265514688;38230;38781;38797.612023879825;9355.391899526527;9532.237421006303;9555.94884562701;9574.760630984247;9591.040895910388;9427.717168484956;9555.426674399558;9566.760830979212;9574.90425095747;9597.760055998586;9533.713988580319;9600.615975360977;9601.087896649842;9603.18372938301;9620.71137865865;9489.098535639103;9546.904530954671;9549.665761698378;9550.90449095507;9582.520873956275;9402.62389504419;9540.618375264981;9546.809063818684;9551.188149007343;9575.09036641518;38383.808080959694;38699.806500967316;38726.8381948542;38844.805775971225;38907;2891.1326602019312;3185.2992341684794;3330.81680507572;3560.1455650643916;3762.360398732222;26319.605205921926;27067.917283308645;27290.04484843021;27866.16401507958;27975.440491190064;2759.351552385188;2801.6778070521946;2818.5772134179833;2826.858657067159;2836.4610723962383;331296;399243;405293;405813;405817;43498.91252718707;43899.78050109729;43966.56033439688;43974.560254397045;43992.3401148983;43148.35277470841;43582.78208608937;43655.563444365784;43691.56308436939;43820.3426948596;14826.33281502335;15000.324985375684;15008.924955375373;15011.849881501264;15016.924915375354;11869;11956.103292253116;11958.40207989597;12027.639170824888;12030;14053.859461405254;14074.577762667137;14115.85884141166;14140;14215.36030878613;5208.265660528177;5464.9180262296095;5958.285005799332;6221.129041934133;6275.748970041147;892.830362231174;893.3166127912152;1030.685640879539;1059.8606498014665;1075.4837677914645;28845.71154288472;29323;29410.970616028335;30042.84978575137;30501.847490762848;948.6632245552729;1041.760395109114;1043.5408420295046;1069.2301542889106;1139.566964553481;13895.374708138159;14167.64580885486;14182.305496465326;14347.641308967359;14514.274286285643;659120;663355;667616;667885;668011;49537.25694114591;50214.74892625513;50279;56510.717446412506;57452.13821792677;1411.181514721459;1430.4850253908585;1438.3743071763815;1455.7234125516118;1458.744719674074;28186.631072183845;28394.574081389208;28535.85856565797;28677.85661071681;29299.85350073236;45511;52190.43428697145;53197.734011329696;53368;53376.19935701045;375030;380909;381975;382511;383616.0819195998;30688.079357619306;30782.692173077983;30929.536056958714;30961.845190773904;30965.225869353446;40227.3965890506;40746.59253407428;41090.79454602708;41782.95542611459;41854.581454186286;35987;36331.81834090919;36433.453498198076;37159.6284037167;38069;35354.46968295426;35828;35969.04926375249;36412.90761277166;36421.907342779756;35130.82434587811;35775.82112089423;36160.27679446344;36223.63776362203;36232.81883590565;30258.394832103673;32659.673403266614;32689.509657354683;32786.0164195065;32867.83566082154;24529.0047633471;24608.261752147464;24655.013799448538;24758.38104047413;24947.376315592257 06:47:22 INFO - PROCESS | 2293 | |2;jquery.html;342.8697095103861;369.2062066556903;369.6599128801504;375.6131184879573;375.9473673685683;15362.539123826275;15797.684046319067;19204.99999999998;19479.513012174702;19927.601447971032;18781.812181878176;19081.713774293396;19279.903600482012;19936.800631993676;19950.900245498753;5677.687727175014;5869.85325366865;5924.259467566554;6011.458968692817;6584.374484423972;4208.726432781875;4408.382826404306;6280.528960327993;6389.5846769960035;6548.5088618353575;6473.902891456632;6484.319146489622;6489.4483968862705;6492.2858485566785;6493.253275873264;5732;6289.7169627366875;6292.87414251717;6346.746130154788;6494.253160886511;5571.247881535981;5604.935062338142;5638.74625641843;5639.436056394369;5639.492445679908;23852.403689907893;24678.25965221046;24828.875855620605;25221.62167567488;25442.491150177077;2026.1591439552567;2143.506993391513;2199.549092436047;2409.987950060256;2628.0670362021397;8472.025717042558;9517.714468565953;9726.659566915194;10101.723229289944;10170.08469237772;1550.7363748162838;1709.1368858726264;1778.4220128458173;1787.6245988342464;1805.4583624912605;95675;101121;105637;107469.46265268701;108613.45693271562;11217.102631789601;11346.659600211842;11360.091192704564;11449.141314401453;11583.6524904253;13567.66080847967;13682.452701892013;13698;13719.794203086962;13720.45118195261;8227.095019547845;8333.708320208763;8346.958265208636;8432.873506897402;8446.873296900429;8382.538960357238;8410.32717382608;8420.200080992296;8491.320694344562;8517.531535765593;4383.057642606791;4493.955060449353;4505.977470112629;4527.298268768346;4553.3397657340165;1500.6323450754635;1707.6499317639855;1769.6814573376917;1793.5516120969758;1832.9564374642619;905.2983937448398;923.8383282925461;935.209747763139;1009.1623952119724;1018.3940555369543;18152.546186345447;20409.48976275605;20522.79477205209;20787.584248315252;20900.581988360147;850.4769566716425;892.7098692924695;910.4582773249906;916.5279880861361;984.9704508864745;6179.62922224668;6243.656598887014;6294.527910406646;10690.24404773732;11145.888541114648;437870;459316;484870.1512984825;532252;613194;81771.96586836263;112554;116021.4198929;127050;130960;466.3215022142842;474.5349557433734;474.86941091199503;476.2903274121534;476.6520440078762;9793.237217300953;11424.632490671835;11802.114841387101;11868;11955.760884782081;44027.559724402345;55730;55773.316653759786;56343.43656563546;56532;77779;78420.60789696015;81060.78408823755;81619;81671;8151.470154439942;8199.385046121446;8247.95876020616;8344.165583441607;8432.789180270542;12632.873671263169;13329.800052999019;13541.526046588322;13627.591172264847;13660;11665.533378664759;11690.649280521598;11754.76490470203;11757.647270581896;11820.40897955116;9475.194608458358;11646.825297620711;11722.238054526428;11729.178957473236;11730.530778768754;11819.763604728028;12025.677175510511;12028.63914082579;12060.939695301468;12077.51689932428;6990.440764738707;7168.103987001625;7513.812154696177;7805.414593905366;8284.917150828414;9459.479728614717;10633.361998280128;10652.360858348524;11677.889676817198;11833.763324733285 06:47:22 INFO - PROCESS | 2293 | |3;mootools.html;1404.424186083706;1521.262187838898;1574.2994367506458;1799.3432397175027;1946.192330182975;7940.880886786696;8503.277221436178;8691.39160258782;8695.347848911326;8707.477551346916;8369.414141010131;8645.827083458327;8656.826863462727;8657.95671021644;8667.826643467128;2176.706144670473;2412.7828495435406;2472.7650873167067;2498.100683753856;2504.5742223821994;2488.328151399121;2496.0764517128687;2498.6252062190633;2499.0628514307136;2499.187763976706;2408.8675122868235;2486.3038349262147;2503.311589312935;2504.912328068518;2507.6865391826022;2422.9273121806286;2459.692538432696;2503.436726736488;2504.561701702195;2506.9373265668323;2445.193086281523;2466.666999955019;2483.0936708101412;2502.987485062581;2504.599264117751;8729.869051964226;8803.735887923373;8805.911940880573;8807.427517211361;8826.470411775314;5353.812616558441;5495.340559132929;5495.505404513613;5512.558995280408;5513.696746678931;3642.2169233614636;3687.446882967576;3759.7368184227116;3769.321522126016;3773.3208022555928;1058.8200005999;1076.429492369038;1084.7071290751453;1108.2519299472824;1116.2353787655481;11699.005584525241;11699.18105732599;11941.582044628483;12082.879171208351;12101.334426606532;4243.554426785205;4929.75351232437;4991.5258050485145;5006.998600279959;5032.874178145503;10105.696829094992;10119.544620492095;10127.037931396506;10130.949345253226;10139.847902281472;5451.672899626035;5514.862128446821;5519.089350257163;5537.889242215214;5549.916751248735;4167.729097608706;4403.669724770591;4577.702449340783;4755.833545825949;4952.860842006358;3282.2286762610765;3902.941455878164;3913.5695073541888;3961.7028722845903;3971.980140099281;1293.7671219180638;1304.2956803326288;1312.6324629103676;1313.5599574142577;1315.9868401316055;1318.5516924245803;1329.8803107720353;1332.367125615325;1356.7083077138464;1363.9931800340935;8145.266925976572;8180.631871565674;8313.875291870627;8324.70863519774;8336;1166.719987203065;1167.9532818687328;1190.047961630692;1191.4519321112386;1212.9454174562165;6251.624902505864;6266.279377871512;6329.050642403677;6335.208098987627;6340.4293613575;10450.947745261225;10675.519601617945;10748.408837513856;10763.515641796137;10773.730656733644;10614.522346494427;10741.19441041925;10816.026557609854;10825.07986821129;10827.404492752818;6939.618320992394;8197;8310.667573297122;8419.621117049748;8419.705310314232;7857;7897.605119743875;7932.325752311118;7932.524048557105;7939.920600794149;7817.843643127219;9525.61897524119;9699.030096990244;9749.415035097916;9793.706188814347;9887.626969527406;10061.39631622105;10071.84892226632;10190.43952582615;10207.59169633236;6386.552941294065;6471.288158302677;6990.790276291719;7001.754938577125;7118.60847653384;8193.959030204811;8215.137410571804;8243.464174828618;8255.711050113217;8256.091829898587;6138.631682099089;7262.055932728711;7345.081864766904;7419.554826710415;7466.813329666802;7198.388137008413;7238.457115716447;7239.384652304613;7265.346118849117;7387.704491820267;7689.692412303445;7700.922990770245;7739.651715672696;7748.728794492391;7759;5981.222441082631;6981.79054628362;7025.262347453444;7029.5430796998035;7046.048783414173;7021.1574611047;7168.354848063699;7169.605671688108;7174.67713952863;7199.028131202221 06:47:22 INFO - PROCESS | 2293 | |4;prototype.html;266.44446329403195;327.86393646636645;329.9026787097806;332.6473937626118;338.8644542183125;6406.519511036673;6679.766208182715;6724.02501637263;6782.28785977472;6806.489513286499;5364.973175134129;6537.477001839853;6673.566218195814;6688.097106890568;6716.6305853178055;4601.930971035437;4775.761211939406;4785.564330700793;4914.606831453484;4941.332920055783;4848.054629347279;4857.174280372327;4859.514048595148;4875.024995000997;4888.462269150391;4792.544708252728;4818.10864989978;4818.566329030386;4827.44484384295;4836.951630483685;4616.838410655628;4737.099951009332;4818.204996175627;4821.493743156953;4836.903261934777;3352.3127758809387;4076.266272071026;4079.9184016319805;4082.081531655354;4090.713650044498;6280.685965701697;6364.427201551883;6375.8406039848915;6379.266384365811;6382.457491113261;5618.747156377932;5620.5503559715535;5621.943780562183;5624.3250809902665;5639.577031722637;6771.661416929183;6989.615571143585;7007.369336759716;7030.086088808423;7039.824004399879;3841.9231615367817;4281.871543853658;4500.09998000398;4535;4540.364348991144;7402.518836275625;7468.365188958945;7476.401887848959;7481.476296659236;7501.66242519088;4610.446746390455;4630.976845115752;4643.605293550018;4643.931895664016;4645.744484053342;4696.084263568571;4700.412448443944;4702.012577358724;4706.858794236178;4712.575868171881;5576.358718747315;5599.496045355938;5606.915896261559;5609.523190528769;5612.635178713371;5774.422557744276;6852.7820336288;7113.7154513819905;7116.146062472433;7126.073610430714;1596.6088308364292;1626.3169468823123;1633.207894171326;1635.2641311409914;1639.5819066138297;978.2369751593768;1009.5305682857506;1015.7155996321042;1030.1192480429274;1057.043375744952;6553.574017688835;6569.178852643419;6617.7683781067435;6834.179898412222;6864.176298844171;7459.142198647117;7466.925330746732;7475.962620186973;7480.9625951870985;7492.850142997218;5577.749001294951;6796.762113326109;6800.727970881109;6801.149856267966;6808.148981377328;3744.0452684565807;3895.824687889052;3929.017745563609;3930.6069393060466;3934.449177115206;6560.704768285439;7614.162442131361;7715.498492598075;7737.574433406104;7821.687132514636;6215.378462153749;7658.808529786688;7675.53946763196;7680.385569154454;7691.615419229016;7788.649510772028;7797.103333116765;7806.765797025984;7816.413768967236;7818.530888146729;7196.35232829027;7355.190928997699;7422.554646721214;7461;7465.141508726349;6822.488313376417;7327.963360183165;7328;7331.816704582428;7344.889826652711;6304.3380445054445;6566.737330506726;7513.549187048795;7787.649555770117;7847.332976697045;3872.574016858087;4622.791974361229;4673.906521869611;4677.625789936865;4681.859544213679;7076.71693132269;7349.081364829396;7360.558366497813;7367.3369396752405;7367.77896663101;7083.929160708327;7118.60847653384;7122.928770712227;7123.572585644878;7142.464315176487;7103.538270012433;7107.076080109553;7107.0760801097595;7128.144622645108;7145.4998150128995;6926.619035953071;6932.549384290005;6935.479839012195;6935.965320173367;6940.583564986117;5713.143028545585;6810.080639113657;7078.646067696697;7087.078679771596;7104.431645468247;6742.224644165984;6783.559068660521;6898.103246577913;6902.24075351721;6905.482088843256 06:47:22 INFO - PROCESS | 2293 | |5;yui.html;676.6718141701275;715.7781087862767;728.8214387475066;745.1542499263338;766.4864540757695;15074.698506029872;15276.847231527681;15294.617634559141;15301.464448744297;15305.923470382646;13846.238456884867;13895.444182232699;13929.164250144973;15490.922545387286;16004.119773412458;864.7924498120453;877.2806298834957;877.846376884046;877.846376884046;878.3280790195505;709.0640354731756;713.9286071392845;868.8175483148547;885.4687187687368;886.8182022685334;919.0901008002063;923.6259314977444;926.2821313482071;927.0358826820133;927.2211342472322;734.8824188129873;916.8991410944791;919.7516670498994;920.700772249015;920.7283851263893;676.0636518422021;676.4858707382375;676.8781619308522;678.9524733268673;679.7960611816485;15279;15400.07599544031;15407.306671199824;15441.150736709476;15482.922585387114;12629;12739.299338536377;12887.93556032214;13100.86899131006;13181;10112.140468060225;10139.391636501834;10335.22485813567;10354.585816567329;10992.230543861933;3544.805035723034;3571.8392672329805;3573.4639804029603;3576.0702217423395;3576.9642303576893;79467.6026619869;80578.59710701468;80639.790403144;81722;88445.11554884497;9793.412395256308;9872.901270987199;9874.111329980336;10128.949355253177;10435.37387756737;22288.55422891533;22557;22598.774012259997;22604.208852690077;22649.82902393666;7580.9620951894885;7701.845963080819;7921.920780792234;7975.082865470429;7982.68069277234;4018.3313303180103;4086.40747091676;4130.339145736728;4135.545090040093;4160.375943608483;3590.5691317042124;3600.891973240807;3611.8013509256716;3612.4039533477207;3617.0595645132457;630.895902176145;638.9648569328732;644.6816260746784;662.3939095727355;668.7057694614355;547.8739889825363;575.171752676145;590.4479311843354;608.8173547935602;619.7180282971237;8354.498730076215;8470.195331443503;8602.18279263469;8624.78438039054;8706.12938706137;555.5999680230228;562.9465200805917;590.5069267161967;621.2606997672755;627.0468887291382;3141.748660107186;3890.3386424307937;4008.2785098681934;4039.4546736190828;4120.25835349634;70490.09696360001;96626.55060174104;97475;97541;97791.02208977961;82597;85042;85331.02682812144;86002.56998715091;86140.56929715311;73173.63413183007;74275.62862185763;74524;74724.62637686885;74791.62604186944;6827.686692227003;7623.313901748869;8095.5142691438705;8198.795030124056;8204.917950820416;51547.74226128995;52411.73794131005;52723.73638131938;52871.41385758433;53629.65925851885;69334.9599755994;72701;74039;74153.88769168359;74318.62840685979;10141.949290253502;10241.283110182514;10440.425776582057;10545.31455455393;10945.83581246266;10983.670489885317;11255;11352.772944541228;11388.316700997966;11406.429678516208;10205.59177632916;10210.642627508001;10548.630797922342;10601.522931468257;10621.734456638645;10291.639792607222;10593.417362045162;10621.787564248827;10652.201084918817;10695.5187016586;10262.640807571699;10284.125849302893;10316.329438586468;10441.68674939753;10553.155747540332;8696.78258043554;8905.821883562163;8928.955355223183;9251.722448326562;9267.212286955684;6821.045053692388;6897;8737.388382813142;8785.341099417441;9136.588853501475 06:47:22 INFO - PROCESS | 2293 | __end_tp_report 06:47:22 INFO - PROCESS | 2293 | __start_cc_report 06:47:22 INFO - PROCESS | 2293 | _x_x_mozilla_cycle_collect,1137 06:47:22 INFO - PROCESS | 2293 | __end_cc_report 06:47:22 INFO - PROCESS | 2293 | __startTimestamp1456152442768__endTimestamp 06:47:22 INFO - PROCESS | 2293 | 06:47:22 INFO - PROCESS | 2293 | ------- Summary: start ------- 06:47:22 INFO - PROCESS | 2293 | Number of tests: 6 06:47:22 INFO - PROCESS | 2293 | 06:47:22 INFO - PROCESS | 2293 | [#0] dojo.html Cycles:165 Average:5713.75 Median:5919.17 stddev:626.93 (10.6%) stddev-sans-first:602.39 06:47:22 INFO - PROCESS | 2293 | Values: 3416.2 3447.1 3479.4 3490.2 3501.8 5587.5 5649.0 5663.9 5673.9 5702.6 5670.7 5688.5 5698.5 5793.2 5822.4 5082.8 5115.9 5154.0 5159.5 5262.6 5214.5 5228.1 5266.3 5281.3 5327.9 5107.5 5133.8 5201.6 5207.3 5217.1 5152.8 5158.8 5188.0 5193.4 5194.0 4547.4 5116.9 5119.6 5124.7 5171.2 5476.6 5491.8 5529.1 5572.9 5605.3 6169.6 6175.0 6181.3 6181.9 6197.4 6126.6 6183.3 6246.8 6248.6 6256.6 5721.3 5748.9 5756.5 5757.9 5837.2 6223.2 6234.1 6237.2 6244.9 6257.5 5982.6 6007.3 6017.0 6087.8 6089.6 6101.8 6108.3 6131.9 6249.7 6257.2 6174.4 6177.8 6180.3 6190.9 6220.3 6194.4 6199.3 6216.8 6222.1 6230.5 4798.2 4831.0 4865.7 4881.1 4894.8 4255.1 4413.7 4434.1 4453.8 4454.9 5745.7 5767.6 5778.9 5779.3 5805.7 6252.3 6257.5 6260.1 6277.9 6298.2 5609.6 5767.2 5773.5 5785.9 5831.0 5325.1 5326.9 5331.8 5333.3 5340.2 6192.3 6194.9 6243.5 6283.0 6293.4 6151.8 6231.5 6239.3 6259.1 6278.7 6158.9 6246.1 6246.8 6262.0 6270.7 6131.7 6168.5 6173.7 6176.3 6184.5 6217.0 6232.9 6241.9 6242.2 6260.1 5889.6 5997.3 6030.7 6033.2 6066.9 5959.3 6040.3 6046.2 6071.9 6092.8 5852.6 5863.5 5868.2 5885.0 5910.4 5948.9 6007.1 6040.7 6057.6 6127.7 5855.1 5919.2 5921.7 5926.8 5931.2 06:47:22 INFO - PROCESS | 2293 | 06:47:22 INFO - PROCESS | 2293 | [#1] ext.html Cycles:180 Average:60408.69 Median:36796.54 stddev:133046.37 (361.6%) stddev-sans-first:133343.48 06:47:22 INFO - PROCESS | 2293 | Values: 465.6 472.4 520.9 537.5 570.9 29090.1 29652.3 29654.1 29705.0 29805.1 31146.5 37867.2 38230.0 38781.0 38797.6 9355.4 9532.2 9555.9 9574.8 9591.0 9427.7 9555.4 9566.8 9574.9 9597.8 9533.7 9600.6 9601.1 9603.2 9620.7 9489.1 9546.9 9549.7 9550.9 9582.5 9402.6 9540.6 9546.8 9551.2 9575.1 38383.8 38699.8 38726.8 38844.8 38907.0 2891.1 3185.3 3330.8 3560.1 3762.4 26319.6 27067.9 27290.0 27866.2 27975.4 2759.4 2801.7 2818.6 2826.9 2836.5 331296.0 399243.0 405293.0 405813.0 405817.0 43498.9 43899.8 43966.6 43974.6 43992.3 43148.4 43582.8 43655.6 43691.6 43820.3 14826.3 15000.3 15008.9 15011.8 15016.9 11869.0 11956.1 11958.4 12027.6 12030.0 14053.9 14074.6 14115.9 14140.0 14215.4 5208.3 5464.9 5958.3 6221.1 6275.7 892.8 893.3 1030.7 1059.9 1075.5 28845.7 29323.0 29411.0 30042.8 30501.8 948.7 1041.8 1043.5 1069.2 1139.6 13895.4 14167.6 14182.3 14347.6 14514.3 659120.0 663355.0 667616.0 667885.0 668011.0 49537.3 50214.7 50279.0 56510.7 57452.1 1411.2 1430.5 1438.4 1455.7 1458.7 28186.6 28394.6 28535.9 28677.9 29299.9 45511.0 52190.4 53197.7 53368.0 53376.2 375030.0 380909.0 381975.0 382511.0 383616.1 30688.1 30782.7 30929.5 30961.8 30965.2 40227.4 40746.6 41090.8 41783.0 41854.6 35987.0 36331.8 36433.5 37159.6 38069.0 35354.5 35828.0 35969.0 36412.9 36421.9 35130.8 35775.8 36160.3 36223.6 36232.8 30258.4 32659.7 32689.5 32786.0 32867.8 24529.0 24608.3 24655.0 24758.4 24947.4 06:47:22 INFO - PROCESS | 2293 | 06:47:22 INFO - PROCESS | 2293 | [#2] jquery.html Cycles:180 Average:31328.37 Median:2292.34 stddev:85373.83 (3724.3%) stddev-sans-first:85581.63 06:47:22 INFO - PROCESS | 2293 | Values: 342.9 369.2 369.7 375.6 375.9 15362.5 15797.7 19205.0 19479.5 19927.6 18781.8 19081.7 19279.9 19936.8 19950.9 5677.7 5869.9 5924.3 6011.5 6584.4 4208.7 4408.4 6280.5 6389.6 6548.5 6473.9 6484.3 6489.4 6492.3 6493.3 5732.0 6289.7 6292.9 6346.7 6494.3 5571.2 5604.9 5638.7 5639.4 5639.5 23852.4 24678.3 24828.9 25221.6 25442.5 2026.2 2143.5 2199.5 2410.0 2628.1 8472.0 9517.7 9726.7 10101.7 10170.1 1550.7 1709.1 1778.4 1787.6 1805.5 95675.0 101121.0 105637.0 107469.5 108613.5 11217.1 11346.7 11360.1 11449.1 11583.7 13567.7 13682.5 13698.0 13719.8 13720.5 8227.1 8333.7 8347.0 8432.9 8446.9 8382.5 8410.3 8420.2 8491.3 8517.5 4383.1 4494.0 4506.0 4527.3 4553.3 1500.6 1707.6 1769.7 1793.6 1833.0 905.3 923.8 935.2 1009.2 1018.4 18152.5 20409.5 20522.8 20787.6 20900.6 850.5 892.7 910.5 916.5 985.0 6179.6 6243.7 6294.5 10690.2 11145.9 437870.0 459316.0 484870.2 532252.0 613194.0 81772.0 112554.0 116021.4 127050.0 130960.0 466.3 474.5 474.9 476.3 476.7 9793.2 11424.6 11802.1 11868.0 11955.8 44027.6 55730.0 55773.3 56343.4 56532.0 77779.0 78420.6 81060.8 81619.0 81671.0 8151.5 8199.4 8248.0 8344.2 8432.8 12632.9 13329.8 13541.5 13627.6 13660.0 11665.5 11690.6 11754.8 11757.6 11820.4 9475.2 11646.8 11722.2 11729.2 11730.5 11819.8 12025.7 12028.6 12060.9 12077.5 6990.4 7168.1 7513.8 7805.4 8284.9 9459.5 10633.4 10652.4 11677.9 11833.8 06:47:22 INFO - PROCESS | 2293 | 06:47:22 INFO - PROCESS | 2293 | [#3] mootools.html Cycles:180 Average:6035.48 Median:4972.19 stddev:3169.11 (63.7%) stddev-sans-first:3158.88 06:47:22 INFO - PROCESS | 2293 | Values: 1404.4 1521.3 1574.3 1799.3 1946.2 7940.9 8503.3 8691.4 8695.3 8707.5 8369.4 8645.8 8656.8 8658.0 8667.8 2176.7 2412.8 2472.8 2498.1 2504.6 2488.3 2496.1 2498.6 2499.1 2499.2 2408.9 2486.3 2503.3 2504.9 2507.7 2422.9 2459.7 2503.4 2504.6 2506.9 2445.2 2466.7 2483.1 2503.0 2504.6 8729.9 8803.7 8805.9 8807.4 8826.5 5353.8 5495.3 5495.5 5512.6 5513.7 3642.2 3687.4 3759.7 3769.3 3773.3 1058.8 1076.4 1084.7 1108.3 1116.2 11699.0 11699.2 11941.6 12082.9 12101.3 4243.6 4929.8 4991.5 5007.0 5032.9 10105.7 10119.5 10127.0 10130.9 10139.8 5451.7 5514.9 5519.1 5537.9 5549.9 4167.7 4403.7 4577.7 4755.8 4952.9 3282.2 3902.9 3913.6 3961.7 3972.0 1293.8 1304.3 1312.6 1313.6 1316.0 1318.6 1329.9 1332.4 1356.7 1364.0 8145.3 8180.6 8313.9 8324.7 8336.0 1166.7 1168.0 1190.0 1191.5 1212.9 6251.6 6266.3 6329.1 6335.2 6340.4 10450.9 10675.5 10748.4 10763.5 10773.7 10614.5 10741.2 10816.0 10825.1 10827.4 6939.6 8197.0 8310.7 8419.6 8419.7 7857.0 7897.6 7932.3 7932.5 7939.9 7817.8 9525.6 9699.0 9749.4 9793.7 9887.6 10061.4 10071.8 10190.4 10207.6 6386.6 6471.3 6990.8 7001.8 7118.6 8194.0 8215.1 8243.5 8255.7 8256.1 6138.6 7262.1 7345.1 7419.6 7466.8 7198.4 7238.5 7239.4 7265.3 7387.7 7689.7 7700.9 7739.7 7748.7 7759.0 5981.2 6981.8 7025.3 7029.5 7046.0 7021.2 7168.4 7169.6 7174.7 7199.0 06:47:22 INFO - PROCESS | 2293 | 06:47:22 INFO - PROCESS | 2293 | [#4] prototype.html Cycles:180 Average:5761.35 Median:6593.47 stddev:1875.09 (28.4%) stddev-sans-first:1834.43 06:47:22 INFO - PROCESS | 2293 | Values: 266.4 327.9 329.9 332.6 338.9 6406.5 6679.8 6724.0 6782.3 6806.5 5365.0 6537.5 6673.6 6688.1 6716.6 4601.9 4775.8 4785.6 4914.6 4941.3 4848.1 4857.2 4859.5 4875.0 4888.5 4792.5 4818.1 4818.6 4827.4 4837.0 4616.8 4737.1 4818.2 4821.5 4836.9 3352.3 4076.3 4079.9 4082.1 4090.7 6280.7 6364.4 6375.8 6379.3 6382.5 5618.7 5620.6 5621.9 5624.3 5639.6 6771.7 6989.6 7007.4 7030.1 7039.8 3841.9 4281.9 4500.1 4535.0 4540.4 7402.5 7468.4 7476.4 7481.5 7501.7 4610.4 4631.0 4643.6 4643.9 4645.7 4696.1 4700.4 4702.0 4706.9 4712.6 5576.4 5599.5 5606.9 5609.5 5612.6 5774.4 6852.8 7113.7 7116.1 7126.1 1596.6 1626.3 1633.2 1635.3 1639.6 978.2 1009.5 1015.7 1030.1 1057.0 6553.6 6569.2 6617.8 6834.2 6864.2 7459.1 7466.9 7476.0 7481.0 7492.9 5577.7 6796.8 6800.7 6801.1 6808.1 3744.0 3895.8 3929.0 3930.6 3934.4 6560.7 7614.2 7715.5 7737.6 7821.7 6215.4 7658.8 7675.5 7680.4 7691.6 7788.6 7797.1 7806.8 7816.4 7818.5 7196.4 7355.2 7422.6 7461.0 7465.1 6822.5 7328.0 7328.0 7331.8 7344.9 6304.3 6566.7 7513.5 7787.6 7847.3 3872.6 4622.8 4673.9 4677.6 4681.9 7076.7 7349.1 7360.6 7367.3 7367.8 7083.9 7118.6 7122.9 7123.6 7142.5 7103.5 7107.1 7107.1 7128.1 7145.5 6926.6 6932.5 6935.5 6936.0 6940.6 5713.1 6810.1 7078.6 7087.1 7104.4 6742.2 6783.6 6898.1 6902.2 6905.5 06:47:22 INFO - PROCESS | 2293 | 06:47:22 INFO - PROCESS | 2293 | [#5] yui.html Cycles:180 Average:18788.70 Median:624.15 stddev:26954.72 (4318.6%) stddev-sans-first:26996.03 06:47:22 INFO - PROCESS | 2293 | Values: 676.7 715.8 728.8 745.2 766.5 15074.7 15276.8 15294.6 15301.5 15305.9 13846.2 13895.4 13929.2 15490.9 16004.1 864.8 877.3 877.8 877.8 878.3 709.1 713.9 868.8 885.5 886.8 919.1 923.6 926.3 927.0 927.2 734.9 916.9 919.8 920.7 920.7 676.1 676.5 676.9 679.0 679.8 15279.0 15400.1 15407.3 15441.2 15482.9 12629.0 12739.3 12887.9 13100.9 13181.0 10112.1 10139.4 10335.2 10354.6 10992.2 3544.8 3571.8 3573.5 3576.1 3577.0 79467.6 80578.6 80639.8 81722.0 88445.1 9793.4 9872.9 9874.1 10128.9 10435.4 22288.6 22557.0 22598.8 22604.2 22649.8 7581.0 7701.8 7921.9 7975.1 7982.7 4018.3 4086.4 4130.3 4135.5 4160.4 3590.6 3600.9 3611.8 3612.4 3617.1 630.9 639.0 644.7 662.4 668.7 547.9 575.2 590.4 608.8 619.7 8354.5 8470.2 8602.2 8624.8 8706.1 555.6 562.9 590.5 621.3 627.0 3141.7 3890.3 4008.3 4039.5 4120.3 70490.1 96626.6 97475.0 97541.0 97791.0 82597.0 85042.0 85331.0 86002.6 86140.6 73173.6 74275.6 74524.0 74724.6 74791.6 6827.7 7623.3 8095.5 8198.8 8204.9 51547.7 52411.7 52723.7 52871.4 53629.7 69335.0 72701.0 74039.0 74153.9 74318.6 10141.9 10241.3 10440.4 10545.3 10945.8 10983.7 11255.0 11352.8 11388.3 11406.4 10205.6 10210.6 10548.6 10601.5 10621.7 10291.6 10593.4 10621.8 10652.2 10695.5 10262.6 10284.1 10316.3 10441.7 10553.2 8696.8 8905.8 8929.0 9251.7 9267.2 6821.0 6897.0 8737.4 8785.3 9136.6 06:47:22 INFO - PROCESS | 2293 | -------- Summary: end -------- 06:47:22 INFO - PROCESS | 2293 | 06:47:23 INFO - TEST-INFO | 2293: exit 0 06:47:23 INFO - TEST-OK | dromaeo_css | took 1114516ms 06:47:23 INFO - TEST-START | kraken 06:47:23 INFO - operating with platform_type : mac_ 06:47:23 INFO - Initialising browser for kraken test... 06:47:23 INFO - TEST-INFO | started process 2298 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/tmpV6c8MZ/profile http://localhost:56599/getInfo.html) 06:47:25 INFO - PROCESS | 2298 | __metrics Screen width/height:1600/1200 06:47:25 INFO - PROCESS | 2298 | colorDepth:24 06:47:25 INFO - PROCESS | 2298 | Browser inner width/height: 1024/689 06:47:25 INFO - PROCESS | 2298 | __metrics 06:47:25 INFO - PROCESS | 2298 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:47:25 INFO - PROCESS | 2298 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:47:26 INFO - TEST-INFO | 2298: exit 0 06:47:26 INFO - Browser initialized. 06:47:26 INFO - Running cycle 1/1 for kraken test... 06:47:26 INFO - TEST-INFO | started process 2301 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/T/tmpV6c8MZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:47:38 INFO - PROCESS | 2301 | RSS: Main: 242655232 06:47:38 INFO - PROCESS | 2301 | 06:47:40 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56599/tests/kraken/driver.html?testName=audio-beat-detection) 06:47:41 INFO - PROCESS | 2301 | RSS: Main: 289886208 06:47:41 INFO - PROCESS | 2301 | 06:47:44 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56599/tests/kraken/driver.html?testName=audio-dft) 06:47:44 INFO - PROCESS | 2301 | RSS: Main: 300285952 06:47:44 INFO - PROCESS | 2301 | 06:47:48 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56599/tests/kraken/driver.html?testName=audio-fft) 06:47:48 INFO - PROCESS | 2301 | RSS: Main: 284020736 06:47:48 INFO - PROCESS | 2301 | 06:47:50 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56599/tests/kraken/driver.html?testName=audio-oscillator) 06:47:51 INFO - PROCESS | 2301 | RSS: Main: 286253056 06:47:51 INFO - PROCESS | 2301 | 06:47:53 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56599/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:47:53 INFO - PROCESS | 2301 | RSS: Main: 286879744 06:47:53 INFO - PROCESS | 2301 | 06:47:56 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56599/tests/kraken/driver.html?testName=imaging-darkroom) 06:47:57 INFO - PROCESS | 2301 | RSS: Main: 285954048 06:47:57 INFO - PROCESS | 2301 | 06:48:00 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56599/tests/kraken/driver.html?testName=imaging-desaturate) 06:48:00 INFO - PROCESS | 2301 | RSS: Main: 288067584 06:48:00 INFO - PROCESS | 2301 | 06:48:03 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56599/tests/kraken/driver.html?testName=json-parse-financial) 06:48:04 INFO - PROCESS | 2301 | RSS: Main: 289742848 06:48:04 INFO - PROCESS | 2301 | 06:48:06 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56599/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:48:06 INFO - PROCESS | 2301 | RSS: Main: 322392064 06:48:06 INFO - PROCESS | 2301 | 06:48:08 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56599/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:48:09 INFO - PROCESS | 2301 | RSS: Main: 321916928 06:48:09 INFO - PROCESS | 2301 | 06:48:11 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56599/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:48:11 INFO - PROCESS | 2301 | RSS: Main: 331997184 06:48:11 INFO - PROCESS | 2301 | 06:48:14 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56599/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:48:14 INFO - PROCESS | 2301 | RSS: Main: 332931072 06:48:14 INFO - PROCESS | 2301 | 06:48:17 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56599/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:48:18 INFO - PROCESS | 2301 | RSS: Main: 334249984 06:48:18 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | Cycle 1(1): loaded http://localhost:56599/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56599/tests/kraken/driver.html?testName=ai-astar) 06:48:19 INFO - PROCESS | 2301 | RSS: Main: 393879552 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | __start_tp_report 06:48:19 INFO - PROCESS | 2301 | _x_x_mozilla_page_load 06:48:19 INFO - PROCESS | 2301 | _x_x_mozilla_page_load_details 06:48:19 INFO - PROCESS | 2301 | |i|pagename|runs| 06:48:19 INFO - PROCESS | 2301 | |0;ai-astar;111;109;110;111;111;112;115;111;111;110 06:48:19 INFO - PROCESS | 2301 | |1;audio-beat-detection;164;126;147;157;120;146;141;119;159;121 06:48:19 INFO - PROCESS | 2301 | |2;audio-dft;187;187;185;184;184;184;185;183;185;258 06:48:19 INFO - PROCESS | 2301 | |3;audio-fft;72;74;75;115;45;58;85;84;141;80 06:48:19 INFO - PROCESS | 2301 | |4;audio-oscillator;91;93;126;79;77;83;116;78;79;121 06:48:19 INFO - PROCESS | 2301 | |5;imaging-gaussian-blur;87;92;87;91;84;90;85;91;85;91 06:48:19 INFO - PROCESS | 2301 | |6;imaging-darkroom;96;94;102;143;95;94;109;149;110;102 06:48:19 INFO - PROCESS | 2301 | |7;imaging-desaturate;87;95;134;74;141;142;92;71;126;142 06:48:19 INFO - PROCESS | 2301 | |8;json-parse-financial;56;56;54;53;55;53;55;64;53;52 06:48:19 INFO - PROCESS | 2301 | |9;json-stringify-tinderbox;66;65;74;74;71;71;66;68;69;67 06:48:19 INFO - PROCESS | 2301 | |10;stanford-crypto-aes;85;81;84;83;84;88;110;109;83;82 06:48:19 INFO - PROCESS | 2301 | |11;stanford-crypto-ccm;124;126;134;114;132;123;125;118;119;126 06:48:19 INFO - PROCESS | 2301 | |12;stanford-crypto-pbkdf2;137;129;139;136;135;125;136;164;125;159 06:48:19 INFO - PROCESS | 2301 | |13;stanford-crypto-sha256-iterative;67;68;66;66;68;67;66;67;67;65 06:48:19 INFO - PROCESS | 2301 | __end_tp_report 06:48:19 INFO - PROCESS | 2301 | __start_cc_report 06:48:19 INFO - PROCESS | 2301 | _x_x_mozilla_cycle_collect,1147 06:48:19 INFO - PROCESS | 2301 | __end_cc_report 06:48:19 INFO - PROCESS | 2301 | __startTimestamp1456152499952__endTimestamp 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | ------- Summary: start ------- 06:48:19 INFO - PROCESS | 2301 | Number of tests: 14 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:1.60 (1.4%) stddev-sans-first:1.69 06:48:19 INFO - PROCESS | 2301 | Values: 111.0 109.0 110.0 111.0 111.0 112.0 115.0 111.0 111.0 110.0 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#1] audio-beat-detection Cycles:10 Average:140.00 Median:146.50 stddev:17.35 (11.8%) stddev-sans-first:16.09 06:48:19 INFO - PROCESS | 2301 | Values: 164.0 126.0 147.0 157.0 120.0 146.0 141.0 119.0 159.0 121.0 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#2] audio-dft Cycles:10 Average:192.20 Median:185.00 stddev:23.16 (12.5%) stddev-sans-first:24.48 06:48:19 INFO - PROCESS | 2301 | Values: 187.0 187.0 185.0 184.0 184.0 184.0 185.0 183.0 185.0 258.0 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#3] audio-fft Cycles:10 Average:82.90 Median:74.50 stddev:27.36 (36.7%) stddev-sans-first:28.73 06:48:19 INFO - PROCESS | 2301 | Values: 72.0 74.0 75.0 115.0 45.0 58.0 85.0 84.0 141.0 80.0 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:79.00 stddev:19.33 (24.5%) stddev-sans-first:20.46 06:48:19 INFO - PROCESS | 2301 | Values: 91.0 93.0 126.0 79.0 77.0 83.0 116.0 78.0 79.0 121.0 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:90.50 stddev:3.02 (3.3%) stddev-sans-first:3.17 06:48:19 INFO - PROCESS | 2301 | Values: 87.0 92.0 87.0 91.0 84.0 90.0 85.0 91.0 85.0 91.0 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#6] imaging-darkroom Cycles:10 Average:109.40 Median:121.50 stddev:20.19 (16.6%) stddev-sans-first:20.82 06:48:19 INFO - PROCESS | 2301 | Values: 96.0 94.0 102.0 143.0 95.0 94.0 109.0 149.0 110.0 102.0 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#7] imaging-desaturate Cycles:10 Average:110.40 Median:72.50 stddev:29.32 (40.4%) stddev-sans-first:29.85 06:48:19 INFO - PROCESS | 2301 | Values: 87.0 95.0 134.0 74.0 141.0 142.0 92.0 71.0 126.0 142.0 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.00 stddev:3.41 (6.2%) stddev-sans-first:3.61 06:48:19 INFO - PROCESS | 2301 | Values: 56.0 56.0 54.0 53.0 55.0 53.0 55.0 64.0 53.0 52.0 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:70.00 stddev:3.28 (4.7%) stddev-sans-first:3.28 06:48:19 INFO - PROCESS | 2301 | Values: 66.0 65.0 74.0 74.0 71.0 71.0 66.0 68.0 69.0 67.0 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:83.50 stddev:11.02 (13.2%) stddev-sans-first:11.60 06:48:19 INFO - PROCESS | 2301 | Values: 85.0 81.0 84.0 83.0 84.0 88.0 110.0 109.0 83.0 82.0 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:125.50 stddev:6.10 (4.9%) stddev-sans-first:6.47 06:48:19 INFO - PROCESS | 2301 | Values: 124.0 126.0 134.0 114.0 132.0 123.0 125.0 118.0 119.0 126.0 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.50 Median:136.50 stddev:13.13 (9.6%) stddev-sans-first:13.92 06:48:19 INFO - PROCESS | 2301 | Values: 137.0 129.0 139.0 136.0 135.0 125.0 136.0 164.0 125.0 159.0 06:48:19 INFO - PROCESS | 2301 | 06:48:19 INFO - PROCESS | 2301 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.95 (1.4%) stddev-sans-first:1.00 06:48:19 INFO - PROCESS | 2301 | Values: 67.0 68.0 66.0 66.0 68.0 67.0 66.0 67.0 67.0 65.0 06:48:19 INFO - PROCESS | 2301 | -------- Summary: end -------- 06:48:19 INFO - PROCESS | 2301 | 06:48:20 INFO - TEST-INFO | 2301: exit 0 06:48:20 INFO - TEST-OK | kraken | took 57361ms 06:48:20 INFO - SUITE-END | took 1171s 06:48:21 INFO - Completed test suite (00:19:32) 06:48:21 INFO - Working with test: dromaeo_css 06:48:21 INFO - Generating results file: dromaeo_css 06:48:21 INFO - Working with test: kraken 06:48:21 INFO - Generating results file: kraken 06:48:21 INFO - javascript benchmark 06:48:21 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:48:21 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 06:48:21 INFO - process_Request line: dromaeo_css 7389.11 graph.html#tests=[[72,1,59]] 06:48:21 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:48:21 INFO - process_Request line: kraken 1471.00 graph.html#tests=[[232,1,59]] 06:48:21 INFO - RETURN: dromaeo_css: 7389.11 06:48:21 INFO - RETURN: kraken: 1471.00 06:48:21 INFO - javascript benchmark 06:48:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3416.2313479467116, 3447.08652207165, 3479.42589472737, 3490.249596336787, 3501.842417091231, 5587.525060369863, 5649.0, 5663.8584035399135, 5673.914891276629, 5702.600817942745, 5670.68811215383, 5688.488036076752, 5698.487136157745, 5793.217915581406, 5822.359540450547, 5082.822101226458, 5115.872103197422, 5153.969206158765, 5159.535641792238, 5262.552683021929, 5214.452482489341, 5228.137357336035, 5266.315379000744, 5281.313429254192, 5327.866803329909, 5107.540321371057, 5133.768980395873, 5201.609879259071, 5207.270982062514, 5217.113090774558, 5152.845414637567, 5158.819441319573, 5188.040212560651, 5193.37679478465, 5193.987172501364, 4547.408836851188, 5116.923246151311, 5119.56483698886, 5124.692518448905, 5171.22431635254, 5476.616636835423, 5491.780328786844, 5529.087700529408, 5572.86067848303, 5605.32736071674, 6169.598976066542, 6174.96912515439, 6181.258249010102, 6181.907271390933, 6197.411245931629, 6126.571140020201, 6183.319834818167, 6246.781362652331, 6248.562600617958, 6256.624602523863, 5721.313442386941, 5748.885022299614, 5756.539476841843, 5757.942420575782, 5837.211976383176, 6223.222097237845, 6234.096056071844, 6237.220347456568, 6244.906326405107, 6257.499400047986, 5982.551308651781, 6007.340541612901, 6017.037274036134, 6087.756489740361, 6089.63462192261, 6101.82280290701, 6108.297545782292, 6131.877362452726, 6249.718762655601, 6257.217847769029, 6174.38256174388, 6177.81466555995, 6180.289266734383, 6190.876182476325, 6220.284667263232, 6194.442500175006, 6199.318075011745, 6216.7824126155365, 6222.097795819581, 6230.532710046765, 4798.2082956311815, 4830.975845120822, 4865.7323847188745, 4881.096997055556, 4894.804207831647, 4255.148970205909, 4413.735175889393, 4434.13534360803, 4453.799579018887, 4454.888627784331, 5745.68398738065, 5767.567432442584, 5778.88442231153, 5779.306483222041, 5805.7387417566315, 6252.280987686383, 6257.499400047986, 6260.123582698426, 6277.874442511215, 6298.1812364392335, 5609.551235901118, 5767.22142510764, 5773.538116950634, 5785.88428231433, 5830.979578573732, 5325.121354976463, 5326.893462130735, 5331.760070796746, 5333.253344531769, 5340.2256672783005, 6192.287886892975, 6194.938050619436, 6243.531735119885, 6282.963311053625, 6293.370662933761, 6151.753929842756, 6231.501479881689, 6239.251289845248, 6259.092431597302, 6278.6546739929745, 6158.907616385668, 6246.125542424155, 6246.750129994749, 6262.029385445263, 6270.7491700331475, 6131.662758548323, 6168.537359697951, 6173.722182501709, 6176.28972668131, 6184.505239580732, 6216.968915155395, 6232.906506402498, 6241.906371404341, 6242.219722534684, 6260.123582698335, 5889.587728858939, 5997.280326360865, 6030.7286172121485, 6033.215681961317, 6066.939330606638, 5959.28488581373, 6040.335563088145, 6046.183765191819, 6071.939280607137, 6092.786752463642, 5852.590318677651, 5863.501602363847, 5868.23712917318, 5884.9705751470965, 5910.408959104056, 5948.910766338422, 6007.098935159761, 6040.728167232397, 6057.636541807506, 6127.662978536223, 5855.121731740273, 5919.171316015847, 5921.6743079131065, 5926.7925622603, 5931.169636250842], "unit": "score", "name": "dojo.html", "value": 5674.06728575771}, {"lowerIsBetter": false, "replicates": [465.573999790192, 472.3906161052243, 520.9296744939434, 537.4598528478878, 570.9143628455731, 29090.127296181123, 29652.258693532673, 29654.110376688735, 29705.0, 29805.105846824576, 31146.532802007987, 37867.24265514688, 38230.0, 38781.0, 38797.612023879825, 9355.391899526527, 9532.237421006303, 9555.94884562701, 9574.760630984247, 9591.040895910388, 9427.717168484956, 9555.426674399558, 9566.760830979212, 9574.90425095747, 9597.760055998586, 9533.713988580319, 9600.615975360977, 9601.087896649842, 9603.18372938301, 9620.71137865865, 9489.098535639103, 9546.904530954671, 9549.665761698378, 9550.90449095507, 9582.520873956275, 9402.62389504419, 9540.618375264981, 9546.809063818684, 9551.188149007343, 9575.09036641518, 38383.808080959694, 38699.806500967316, 38726.8381948542, 38844.805775971225, 38907.0, 2891.1326602019312, 3185.2992341684794, 3330.81680507572, 3560.1455650643916, 3762.360398732222, 26319.605205921926, 27067.917283308645, 27290.04484843021, 27866.16401507958, 27975.440491190064, 2759.351552385188, 2801.6778070521946, 2818.5772134179833, 2826.858657067159, 2836.4610723962383, 331296.0, 399243.0, 405293.0, 405813.0, 405817.0, 43498.91252718707, 43899.78050109729, 43966.56033439688, 43974.560254397045, 43992.3401148983, 43148.35277470841, 43582.78208608937, 43655.563444365784, 43691.56308436939, 43820.3426948596, 14826.33281502335, 15000.324985375684, 15008.924955375373, 15011.849881501264, 15016.924915375354, 11869.0, 11956.103292253116, 11958.40207989597, 12027.639170824888, 12030.0, 14053.859461405254, 14074.577762667137, 14115.85884141166, 14140.0, 14215.36030878613, 5208.265660528177, 5464.9180262296095, 5958.285005799332, 6221.129041934133, 6275.748970041147, 892.830362231174, 893.3166127912152, 1030.685640879539, 1059.8606498014665, 1075.4837677914645, 28845.71154288472, 29323.0, 29410.970616028335, 30042.84978575137, 30501.847490762848, 948.6632245552729, 1041.760395109114, 1043.5408420295046, 1069.2301542889106, 1139.566964553481, 13895.374708138159, 14167.64580885486, 14182.305496465326, 14347.641308967359, 14514.274286285643, 659120.0, 663355.0, 667616.0, 667885.0, 668011.0, 49537.25694114591, 50214.74892625513, 50279.0, 56510.717446412506, 57452.13821792677, 1411.181514721459, 1430.4850253908585, 1438.3743071763815, 1455.7234125516118, 1458.744719674074, 28186.631072183845, 28394.574081389208, 28535.85856565797, 28677.85661071681, 29299.85350073236, 45511.0, 52190.43428697145, 53197.734011329696, 53368.0, 53376.19935701045, 375030.0, 380909.0, 381975.0, 382511.0, 383616.0819195998, 30688.079357619306, 30782.692173077983, 30929.536056958714, 30961.845190773904, 30965.225869353446, 40227.3965890506, 40746.59253407428, 41090.79454602708, 41782.95542611459, 41854.581454186286, 35987.0, 36331.81834090919, 36433.453498198076, 37159.6284037167, 38069.0, 35354.46968295426, 35828.0, 35969.04926375249, 36412.90761277166, 36421.907342779756, 35130.82434587811, 35775.82112089423, 36160.27679446344, 36223.63776362203, 36232.81883590565, 30258.394832103673, 32659.673403266614, 32689.509657354683, 32786.0164195065, 32867.83566082154, 24529.0047633471, 24608.261752147464, 24655.013799448538, 24758.38104047413, 24947.376315592257], "unit": "score", "name": "ext.html", "value": 18318.482243861767}, {"lowerIsBetter": false, "replicates": [342.8697095103861, 369.2062066556903, 369.6599128801504, 375.6131184879573, 375.9473673685683, 15362.539123826275, 15797.684046319067, 19204.99999999998, 19479.513012174702, 19927.601447971032, 18781.812181878176, 19081.713774293396, 19279.903600482012, 19936.800631993676, 19950.900245498753, 5677.687727175014, 5869.85325366865, 5924.259467566554, 6011.458968692817, 6584.374484423972, 4208.726432781875, 4408.382826404306, 6280.528960327993, 6389.5846769960035, 6548.5088618353575, 6473.902891456632, 6484.319146489622, 6489.4483968862705, 6492.2858485566785, 6493.253275873264, 5732.0, 6289.7169627366875, 6292.87414251717, 6346.746130154788, 6494.253160886511, 5571.247881535981, 5604.935062338142, 5638.74625641843, 5639.436056394369, 5639.492445679908, 23852.403689907893, 24678.25965221046, 24828.875855620605, 25221.62167567488, 25442.491150177077, 2026.1591439552567, 2143.506993391513, 2199.549092436047, 2409.987950060256, 2628.0670362021397, 8472.025717042558, 9517.714468565953, 9726.659566915194, 10101.723229289944, 10170.08469237772, 1550.7363748162838, 1709.1368858726264, 1778.4220128458173, 1787.6245988342464, 1805.4583624912605, 95675.0, 101121.0, 105637.0, 107469.46265268701, 108613.45693271562, 11217.102631789601, 11346.659600211842, 11360.091192704564, 11449.141314401453, 11583.6524904253, 13567.66080847967, 13682.452701892013, 13698.0, 13719.794203086962, 13720.45118195261, 8227.095019547845, 8333.708320208763, 8346.958265208636, 8432.873506897402, 8446.873296900429, 8382.538960357238, 8410.32717382608, 8420.200080992296, 8491.320694344562, 8517.531535765593, 4383.057642606791, 4493.955060449353, 4505.977470112629, 4527.298268768346, 4553.3397657340165, 1500.6323450754635, 1707.6499317639855, 1769.6814573376917, 1793.5516120969758, 1832.9564374642619, 905.2983937448398, 923.8383282925461, 935.209747763139, 1009.1623952119724, 1018.3940555369543, 18152.546186345447, 20409.48976275605, 20522.79477205209, 20787.584248315252, 20900.581988360147, 850.4769566716425, 892.7098692924695, 910.4582773249906, 916.5279880861361, 984.9704508864745, 6179.62922224668, 6243.656598887014, 6294.527910406646, 10690.24404773732, 11145.888541114648, 437870.0, 459316.0, 484870.1512984825, 532252.0, 613194.0, 81771.96586836263, 112554.0, 116021.4198929, 127050.0, 130960.0, 466.3215022142842, 474.5349557433734, 474.86941091199503, 476.2903274121534, 476.6520440078762, 9793.237217300953, 11424.632490671835, 11802.114841387101, 11868.0, 11955.760884782081, 44027.559724402345, 55730.0, 55773.316653759786, 56343.43656563546, 56532.0, 77779.0, 78420.60789696015, 81060.78408823755, 81619.0, 81671.0, 8151.470154439942, 8199.385046121446, 8247.95876020616, 8344.165583441607, 8432.789180270542, 12632.873671263169, 13329.800052999019, 13541.526046588322, 13627.591172264847, 13660.0, 11665.533378664759, 11690.649280521598, 11754.76490470203, 11757.647270581896, 11820.40897955116, 9475.194608458358, 11646.825297620711, 11722.238054526428, 11729.178957473236, 11730.530778768754, 11819.763604728028, 12025.677175510511, 12028.63914082579, 12060.939695301468, 12077.51689932428, 6990.440764738707, 7168.103987001625, 7513.812154696177, 7805.414593905366, 8284.917150828414, 9459.479728614717, 10633.361998280128, 10652.360858348524, 11677.889676817198, 11833.763324733285], "unit": "score", "name": "jquery.html", "value": 8994.97725535163}, {"lowerIsBetter": false, "replicates": [1404.424186083706, 1521.262187838898, 1574.2994367506458, 1799.3432397175027, 1946.192330182975, 7940.880886786696, 8503.277221436178, 8691.39160258782, 8695.347848911326, 8707.477551346916, 8369.414141010131, 8645.827083458327, 8656.826863462727, 8657.95671021644, 8667.826643467128, 2176.706144670473, 2412.7828495435406, 2472.7650873167067, 2498.100683753856, 2504.5742223821994, 2488.328151399121, 2496.0764517128687, 2498.6252062190633, 2499.0628514307136, 2499.187763976706, 2408.8675122868235, 2486.3038349262147, 2503.311589312935, 2504.912328068518, 2507.6865391826022, 2422.9273121806286, 2459.692538432696, 2503.436726736488, 2504.561701702195, 2506.9373265668323, 2445.193086281523, 2466.666999955019, 2483.0936708101412, 2502.987485062581, 2504.599264117751, 8729.869051964226, 8803.735887923373, 8805.911940880573, 8807.427517211361, 8826.470411775314, 5353.812616558441, 5495.340559132929, 5495.505404513613, 5512.558995280408, 5513.696746678931, 3642.2169233614636, 3687.446882967576, 3759.7368184227116, 3769.321522126016, 3773.3208022555928, 1058.8200005999, 1076.429492369038, 1084.7071290751453, 1108.2519299472824, 1116.2353787655481, 11699.005584525241, 11699.18105732599, 11941.582044628483, 12082.879171208351, 12101.334426606532, 4243.554426785205, 4929.75351232437, 4991.5258050485145, 5006.998600279959, 5032.874178145503, 10105.696829094992, 10119.544620492095, 10127.037931396506, 10130.949345253226, 10139.847902281472, 5451.672899626035, 5514.862128446821, 5519.089350257163, 5537.889242215214, 5549.916751248735, 4167.729097608706, 4403.669724770591, 4577.702449340783, 4755.833545825949, 4952.860842006358, 3282.2286762610765, 3902.941455878164, 3913.5695073541888, 3961.7028722845903, 3971.980140099281, 1293.7671219180638, 1304.2956803326288, 1312.6324629103676, 1313.5599574142577, 1315.9868401316055, 1318.5516924245803, 1329.8803107720353, 1332.367125615325, 1356.7083077138464, 1363.9931800340935, 8145.266925976572, 8180.631871565674, 8313.875291870627, 8324.70863519774, 8336.0, 1166.719987203065, 1167.9532818687328, 1190.047961630692, 1191.4519321112386, 1212.9454174562165, 6251.624902505864, 6266.279377871512, 6329.050642403677, 6335.208098987627, 6340.4293613575, 10450.947745261225, 10675.519601617945, 10748.408837513856, 10763.515641796137, 10773.730656733644, 10614.522346494427, 10741.19441041925, 10816.026557609854, 10825.07986821129, 10827.404492752818, 6939.618320992394, 8197.0, 8310.667573297122, 8419.621117049748, 8419.705310314232, 7857.0, 7897.605119743875, 7932.325752311118, 7932.524048557105, 7939.920600794149, 7817.843643127219, 9525.61897524119, 9699.030096990244, 9749.415035097916, 9793.706188814347, 9887.626969527406, 10061.39631622105, 10071.84892226632, 10190.43952582615, 10207.59169633236, 6386.552941294065, 6471.288158302677, 6990.790276291719, 7001.754938577125, 7118.60847653384, 8193.959030204811, 8215.137410571804, 8243.464174828618, 8255.711050113217, 8256.091829898587, 6138.631682099089, 7262.055932728711, 7345.081864766904, 7419.554826710415, 7466.813329666802, 7198.388137008413, 7238.457115716447, 7239.384652304613, 7265.346118849117, 7387.704491820267, 7689.692412303445, 7700.922990770245, 7739.651715672696, 7748.728794492391, 7759.0, 5981.222441082631, 6981.79054628362, 7025.262347453444, 7029.5430796998035, 7046.048783414173, 7021.1574611047, 7168.354848063699, 7169.605671688108, 7174.67713952863, 7199.028131202221], "unit": "score", "name": "mootools.html", "value": 4946.563369605228}, {"lowerIsBetter": false, "replicates": [266.44446329403195, 327.86393646636645, 329.9026787097806, 332.6473937626118, 338.8644542183125, 6406.519511036673, 6679.766208182715, 6724.02501637263, 6782.28785977472, 6806.489513286499, 5364.973175134129, 6537.477001839853, 6673.566218195814, 6688.097106890568, 6716.6305853178055, 4601.930971035437, 4775.761211939406, 4785.564330700793, 4914.606831453484, 4941.332920055783, 4848.054629347279, 4857.174280372327, 4859.514048595148, 4875.024995000997, 4888.462269150391, 4792.544708252728, 4818.10864989978, 4818.566329030386, 4827.44484384295, 4836.951630483685, 4616.838410655628, 4737.099951009332, 4818.204996175627, 4821.493743156953, 4836.903261934777, 3352.3127758809387, 4076.266272071026, 4079.9184016319805, 4082.081531655354, 4090.713650044498, 6280.685965701697, 6364.427201551883, 6375.8406039848915, 6379.266384365811, 6382.457491113261, 5618.747156377932, 5620.5503559715535, 5621.943780562183, 5624.3250809902665, 5639.577031722637, 6771.661416929183, 6989.615571143585, 7007.369336759716, 7030.086088808423, 7039.824004399879, 3841.9231615367817, 4281.871543853658, 4500.09998000398, 4535.0, 4540.364348991144, 7402.518836275625, 7468.365188958945, 7476.401887848959, 7481.476296659236, 7501.66242519088, 4610.446746390455, 4630.976845115752, 4643.605293550018, 4643.931895664016, 4645.744484053342, 4696.084263568571, 4700.412448443944, 4702.012577358724, 4706.858794236178, 4712.575868171881, 5576.358718747315, 5599.496045355938, 5606.915896261559, 5609.523190528769, 5612.635178713371, 5774.422557744276, 6852.7820336288, 7113.7154513819905, 7116.146062472433, 7126.073610430714, 1596.6088308364292, 1626.3169468823123, 1633.207894171326, 1635.2641311409914, 1639.5819066138297, 978.2369751593768, 1009.5305682857506, 1015.7155996321042, 1030.1192480429274, 1057.043375744952, 6553.574017688835, 6569.178852643419, 6617.7683781067435, 6834.179898412222, 6864.176298844171, 7459.142198647117, 7466.925330746732, 7475.962620186973, 7480.9625951870985, 7492.850142997218, 5577.749001294951, 6796.762113326109, 6800.727970881109, 6801.149856267966, 6808.148981377328, 3744.0452684565807, 3895.824687889052, 3929.017745563609, 3930.6069393060466, 3934.449177115206, 6560.704768285439, 7614.162442131361, 7715.498492598075, 7737.574433406104, 7821.687132514636, 6215.378462153749, 7658.808529786688, 7675.53946763196, 7680.385569154454, 7691.615419229016, 7788.649510772028, 7797.103333116765, 7806.765797025984, 7816.413768967236, 7818.530888146729, 7196.35232829027, 7355.190928997699, 7422.554646721214, 7461.0, 7465.141508726349, 6822.488313376417, 7327.963360183165, 7328.0, 7331.816704582428, 7344.889826652711, 6304.3380445054445, 6566.737330506726, 7513.549187048795, 7787.649555770117, 7847.332976697045, 3872.574016858087, 4622.791974361229, 4673.906521869611, 4677.625789936865, 4681.859544213679, 7076.71693132269, 7349.081364829396, 7360.558366497813, 7367.3369396752405, 7367.77896663101, 7083.929160708327, 7118.60847653384, 7122.928770712227, 7123.572585644878, 7142.464315176487, 7103.538270012433, 7107.076080109553, 7107.0760801097595, 7128.144622645108, 7145.4998150128995, 6926.619035953071, 6932.549384290005, 6935.479839012195, 6935.965320173367, 6940.583564986117, 5713.143028545585, 6810.080639113657, 7078.646067696697, 7087.078679771596, 7104.431645468247, 6742.224644165984, 6783.559068660521, 6898.103246577913, 6902.24075351721, 6905.482088843256], "unit": "score", "name": "prototype.html", "value": 5128.494588460159}, {"lowerIsBetter": false, "replicates": [676.6718141701275, 715.7781087862767, 728.8214387475066, 745.1542499263338, 766.4864540757695, 15074.698506029872, 15276.847231527681, 15294.617634559141, 15301.464448744297, 15305.923470382646, 13846.238456884867, 13895.444182232699, 13929.164250144973, 15490.922545387286, 16004.119773412458, 864.7924498120453, 877.2806298834957, 877.846376884046, 877.846376884046, 878.3280790195505, 709.0640354731756, 713.9286071392845, 868.8175483148547, 885.4687187687368, 886.8182022685334, 919.0901008002063, 923.6259314977444, 926.2821313482071, 927.0358826820133, 927.2211342472322, 734.8824188129873, 916.8991410944791, 919.7516670498994, 920.700772249015, 920.7283851263893, 676.0636518422021, 676.4858707382375, 676.8781619308522, 678.9524733268673, 679.7960611816485, 15279.0, 15400.07599544031, 15407.306671199824, 15441.150736709476, 15482.922585387114, 12629.0, 12739.299338536377, 12887.93556032214, 13100.86899131006, 13181.0, 10112.140468060225, 10139.391636501834, 10335.22485813567, 10354.585816567329, 10992.230543861933, 3544.805035723034, 3571.8392672329805, 3573.4639804029603, 3576.0702217423395, 3576.9642303576893, 79467.6026619869, 80578.59710701468, 80639.790403144, 81722.0, 88445.11554884497, 9793.412395256308, 9872.901270987199, 9874.111329980336, 10128.949355253177, 10435.37387756737, 22288.55422891533, 22557.0, 22598.774012259997, 22604.208852690077, 22649.82902393666, 7580.9620951894885, 7701.845963080819, 7921.920780792234, 7975.082865470429, 7982.68069277234, 4018.3313303180103, 4086.40747091676, 4130.339145736728, 4135.545090040093, 4160.375943608483, 3590.5691317042124, 3600.891973240807, 3611.8013509256716, 3612.4039533477207, 3617.0595645132457, 630.895902176145, 638.9648569328732, 644.6816260746784, 662.3939095727355, 668.7057694614355, 547.8739889825363, 575.171752676145, 590.4479311843354, 608.8173547935602, 619.7180282971237, 8354.498730076215, 8470.195331443503, 8602.18279263469, 8624.78438039054, 8706.12938706137, 555.5999680230228, 562.9465200805917, 590.5069267161967, 621.2606997672755, 627.0468887291382, 3141.748660107186, 3890.3386424307937, 4008.2785098681934, 4039.4546736190828, 4120.25835349634, 70490.09696360001, 96626.55060174104, 97475.0, 97541.0, 97791.02208977961, 82597.0, 85042.0, 85331.02682812144, 86002.56998715091, 86140.56929715311, 73173.63413183007, 74275.62862185763, 74524.0, 74724.62637686885, 74791.62604186944, 6827.686692227003, 7623.313901748869, 8095.5142691438705, 8198.795030124056, 8204.917950820416, 51547.74226128995, 52411.73794131005, 52723.73638131938, 52871.41385758433, 53629.65925851885, 69334.9599755994, 72701.0, 74039.0, 74153.88769168359, 74318.62840685979, 10141.949290253502, 10241.283110182514, 10440.425776582057, 10545.31455455393, 10945.83581246266, 10983.670489885317, 11255.0, 11352.772944541228, 11388.316700997966, 11406.429678516208, 10205.59177632916, 10210.642627508001, 10548.630797922342, 10601.522931468257, 10621.734456638645, 10291.639792607222, 10593.417362045162, 10621.787564248827, 10652.201084918817, 10695.5187016586, 10262.640807571699, 10284.125849302893, 10316.329438586468, 10441.68674939753, 10553.155747540332, 8696.78258043554, 8905.821883562163, 8928.955355223183, 9251.722448326562, 9267.212286955684, 6821.045053692388, 6897.0, 8737.388382813142, 8785.341099417441, 9136.588853501475], "unit": "score", "name": "yui.html", "value": 6861.867247459543}], "name": "dromaeo_css", "value": 7389.106261318718}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 110.0, 111.0, 111.0, 112.0, 115.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.1}, {"lowerIsBetter": true, "replicates": [164.0, 126.0, 147.0, 157.0, 120.0, 146.0, 141.0, 119.0, 159.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 140.0}, {"lowerIsBetter": true, "replicates": [187.0, 187.0, 185.0, 184.0, 184.0, 184.0, 185.0, 183.0, 185.0, 258.0], "unit": "score", "name": "audio-dft", "value": 192.2}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 75.0, 115.0, 45.0, 58.0, 85.0, 84.0, 141.0, 80.0], "unit": "score", "name": "audio-fft", "value": 82.9}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 126.0, 79.0, 77.0, 83.0, 116.0, 78.0, 79.0, 121.0], "unit": "score", "name": "audio-oscillator", "value": 94.3}, {"lowerIsBetter": true, "replicates": [87.0, 92.0, 87.0, 91.0, 84.0, 90.0, 85.0, 91.0, 85.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.3}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 102.0, 143.0, 95.0, 94.0, 109.0, 149.0, 110.0, 102.0], "unit": "score", "name": "imaging-darkroom", "value": 109.4}, {"lowerIsBetter": true, "replicates": [87.0, 95.0, 134.0, 74.0, 141.0, 142.0, 92.0, 71.0, 126.0, 142.0], "unit": "score", "name": "imaging-desaturate", "value": 110.4}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 54.0, 53.0, 55.0, 53.0, 55.0, 64.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [66.0, 65.0, 74.0, 74.0, 71.0, 71.0, 66.0, 68.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [85.0, 81.0, 84.0, 83.0, 84.0, 88.0, 110.0, 109.0, 83.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 88.9}, {"lowerIsBetter": true, "replicates": [124.0, 126.0, 134.0, 114.0, 132.0, 123.0, 125.0, 118.0, 119.0, 126.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [137.0, 129.0, 139.0, 136.0, 135.0, 125.0, 136.0, 164.0, 125.0, 159.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 66.0, 66.0, 68.0, 67.0, 66.0, 67.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1470.9999999999998}]} 06:48:21 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1471.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7389.11"}}} 06:48:21 INFO - Return code: 0 06:48:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:48:21 INFO - # TBPL SUCCESS # 06:48:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:48:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:48:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:48:21 INFO - 2016-02-22 06:48:21.664 screenresolution[2305:25730] starting screenresolution argv=screenresolution get 06:48:21 INFO - 2016-02-22 06:48:21.667 screenresolution[2305:25730] Display 0: 1600x1200x32@60 06:48:21 INFO - 2016-02-22 06:48:21.673 screenresolution[2306:25733] starting screenresolution argv=screenresolution list 06:48:21 INFO - Available Modes on Display 0 06:48:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:48:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:48:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:48:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:48:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:48:21 INFO - Intel Iris: 06:48:21 INFO - Chipset Model: Intel Iris 06:48:21 INFO - Type: GPU 06:48:21 INFO - Bus: Built-In 06:48:21 INFO - VRAM (Dynamic, Max): 1536 MB 06:48:21 INFO - Vendor: Intel (0x8086) 06:48:21 INFO - Device ID: 0x0a2e 06:48:21 INFO - Revision ID: 0x0009 06:48:21 INFO - Displays: 06:48:21 INFO - Display: 06:48:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:48:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:48:21 INFO - Display Serial Number: 1600x1200 60 06:48:21 INFO - Main Display: Yes 06:48:21 INFO - Mirror: Off 06:48:21 INFO - Online: Yes 06:48:21 INFO - Rotation: Supported 06:48:21 INFO - Return code: 0 06:48:21 INFO - Running post-action listener: _resource_record_post_action 06:48:21 INFO - Running post-run listener: _resource_record_post_run 06:48:22 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 61440; Write bytes: 709337600; Read time: 2; Write time: 2474 06:48:22 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 404554240; Write bytes: 407507968; Read time: 30171; Write time: 776 06:48:22 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 61440; Write bytes: 300981760; Read time: 2; Write time: 1695 06:48:22 INFO - Running post-run listener: _upload_blobber_files 06:48:22 INFO - Blob upload gear active. 06:48:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:48:22 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 06:48:22 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:48:22 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:48:23 INFO - (blobuploader) - INFO - Open directory for files ... 06:48:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:48:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:48:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:24 INFO - (blobuploader) - INFO - Done attempting. 06:48:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:48:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:48:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:25 INFO - (blobuploader) - INFO - Done attempting. 06:48:25 INFO - (blobuploader) - INFO - Iteration through files over. 06:48:25 INFO - Return code: 0 06:48:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:48:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:48:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af8f49780b212668a4d201fb0c493057d50fb9e2bfc8d9b5ad0101505934e1215bcbbb8281ff7f9ccac7adf361e1ee478f7251e5ba36bb9f16a1dd72fb29835c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d38085eaf5bd006575cc4979170f584b87edfb820e7d0b42d8bb58132146b34eefd04f814a16cbcf593392c7cc1673aeb1e5f14a4f637a42ce0c4ac929f222fa"} 06:48:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:48:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:48:25 INFO - Contents: 06:48:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af8f49780b212668a4d201fb0c493057d50fb9e2bfc8d9b5ad0101505934e1215bcbbb8281ff7f9ccac7adf361e1ee478f7251e5ba36bb9f16a1dd72fb29835c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d38085eaf5bd006575cc4979170f584b87edfb820e7d0b42d8bb58132146b34eefd04f814a16cbcf593392c7cc1673aeb1e5f14a4f637a42ce0c4ac929f222fa"} 06:48:25 INFO - Running post-run listener: copy_logs_to_upload_dir 06:48:25 INFO - Copying logs to upload dir... 06:48:25 INFO - mkdir: /builds/slave/test/build/upload/logs 06:48:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1319.569637 ========= master_lag: 2.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2016-02-22 06:48:27.304377) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 06:48:27.308066) ========= 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.yTVefNyplz/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.L0kZSmx2zt/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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/Firefox/sha512/af8f49780b212668a4d201fb0c493057d50fb9e2bfc8d9b5ad0101505934e1215bcbbb8281ff7f9ccac7adf361e1ee478f7251e5ba36bb9f16a1dd72fb29835c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d38085eaf5bd006575cc4979170f584b87edfb820e7d0b42d8bb58132146b34eefd04f814a16cbcf593392c7cc1673aeb1e5f14a4f637a42ce0c4ac929f222fa"} build_url:https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011510 build_url: 'https://queue.taskcluster.net/v1/task/GDxxNljnTKuR_fx-Sz8ghQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af8f49780b212668a4d201fb0c493057d50fb9e2bfc8d9b5ad0101505934e1215bcbbb8281ff7f9ccac7adf361e1ee478f7251e5ba36bb9f16a1dd72fb29835c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d38085eaf5bd006575cc4979170f584b87edfb820e7d0b42d8bb58132146b34eefd04f814a16cbcf593392c7cc1673aeb1e5f14a4f637a42ce0c4ac929f222fa"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 06:48:27.367111) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:48:27.367492) ========= 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.yTVefNyplz/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.L0kZSmx2zt/Listeners TMPDIR=/var/folders/hk/j900lgdx54q2y_gxk212q1hr00000w/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.005299 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 06:48:27.416926) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 06:48:27.417375) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 06:48:27.417881) ========= ========= Total master_lag: 2.98 =========