builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0180 starttime: 1456398714.27 results: success (0) buildid: 20160225014330 builduid: 08e9eb0f21224ef9a7e9b68acd84bd9c revision: 4f64ec5486f4694082a189d9b93730c444e0594a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.270114) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.270622) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.270968) ========= 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.VvMgWihc6t/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.GYMmDLmENO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005566 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.295112) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.295439) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.312144) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.312473) ========= 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.VvMgWihc6t/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.GYMmDLmENO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005370 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.360775) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.361137) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.361549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.361874) ========= 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.VvMgWihc6t/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.GYMmDLmENO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-25 03:11:54-- 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% 15.7M=0.001s 2016-02-25 03:11:54 (15.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112461 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.489963) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.490324) ========= 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.VvMgWihc6t/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.GYMmDLmENO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.026161 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:54.538751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 03:11:54.539161) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4f64ec5486f4694082a189d9b93730c444e0594a --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 4f64ec5486f4694082a189d9b93730c444e0594a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VvMgWihc6t/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.GYMmDLmENO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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-25 03:11:54,612 truncating revision to first 12 chars 2016-02-25 03:11:54,613 Setting DEBUG logging. 2016-02-25 03:11:54,613 attempt 1/10 2016-02-25 03:11:54,613 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4f64ec5486f4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-25 03:11:55,478 unpacking tar archive at: mozilla-central-4f64ec5486f4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.115727 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-25 03:11:55.671578) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:55.671939) ========= echo 4f64ec5486f4694082a189d9b93730c444e0594a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'4f64ec5486f4694082a189d9b93730c444e0594a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VvMgWihc6t/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.GYMmDLmENO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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 4f64ec5486f4694082a189d9b93730c444e0594a program finished with exit code 0 elapsedTime=0.005802 script_repo_revision: '4f64ec5486f4694082a189d9b93730c444e0594a' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:55.723176) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:55.723707) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-25 03:11:55.738316) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-25 03:11:55.738829) ========= /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.VvMgWihc6t/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.GYMmDLmENO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 03:11:55 INFO - MultiFileLogger online at 20160225 03:11:55 in /builds/slave/test 03:11:55 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 03:11:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:11:55 INFO - {'append_to_log': False, 03:11:55 INFO - 'base_work_dir': '/builds/slave/test', 03:11:55 INFO - 'blob_upload_branch': 'Firefox', 03:11:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:11:55 INFO - 'branch': 'Firefox', 03:11:55 INFO - 'buildbot_json_path': 'buildprops.json', 03:11:55 INFO - 'config_files': ('talos/mac_config.py',), 03:11:55 INFO - 'default_actions': ('clobber', 03:11:55 INFO - 'read-buildbot-config', 03:11:55 INFO - 'download-and-extract', 03:11:55 INFO - 'populate-webroot', 03:11:55 INFO - 'create-virtualenv', 03:11:55 INFO - 'install', 03:11:55 INFO - 'run-tests'), 03:11:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:11:55 INFO - 'download_minidump_stackwalk': True, 03:11:55 INFO - 'download_symbols': 'ondemand', 03:11:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:11:55 INFO - 'tooltool.py': '/tools/tooltool.py', 03:11:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:11:55 INFO - '/tools/misc-python/virtualenv.py')}, 03:11:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:11:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:11:55 INFO - 'installer_path': 'installer.exe', 03:11:55 INFO - 'log_level': 'info', 03:11:55 INFO - 'log_name': 'talos', 03:11:55 INFO - 'log_to_console': True, 03:11:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:11:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:11:55 INFO - 'opt_config_files': (), 03:11:55 INFO - 'pip_index': False, 03:11:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:11:55 INFO - 'cmd': ('bash', 03:11:55 INFO - '-c', 03:11:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:11:55 INFO - 'enabled': True, 03:11:55 INFO - 'halt_on_failure': False, 03:11:55 INFO - 'name': 'check_screen_resolution'},), 03:11:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:11:55 INFO - 'cmd': ('bash', 03:11:55 INFO - '-c', 03:11:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:11:55 INFO - 'enabled': True, 03:11:55 INFO - 'halt_on_failure': False, 03:11:55 INFO - 'name': 'check_screen_resolution'},), 03:11:55 INFO - 'run_cmd_checks_enabled': True, 03:11:55 INFO - 'sps_profile': False, 03:11:55 INFO - 'sps_profile_interval': 0, 03:11:55 INFO - 'suite': 'dromaeojs', 03:11:55 INFO - 'system_bits': '32', 03:11:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:11:55 INFO - 'title': 't-yosemite-r7-0180', 03:11:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:11:55 INFO - 'use_talos_json': True, 03:11:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:11:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:11:55 INFO - 'work_dir': 'build'} 03:11:55 INFO - ##### 03:11:55 INFO - ##### Running clobber step. 03:11:55 INFO - ##### 03:11:55 INFO - Running pre-action listener: _resource_record_pre_action 03:11:55 INFO - Running main action method: clobber 03:11:55 INFO - rmtree: /builds/slave/test/build 03:11:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:11:57 INFO - Running post-action listener: _resource_record_post_action 03:11:57 INFO - ##### 03:11:57 INFO - ##### Running read-buildbot-config step. 03:11:57 INFO - ##### 03:11:57 INFO - Running pre-action listener: _resource_record_pre_action 03:11:57 INFO - Running main action method: read_buildbot_config 03:11:57 INFO - Using buildbot properties: 03:11:57 INFO - { 03:11:57 INFO - "project": "", 03:11:57 INFO - "product": "firefox", 03:11:57 INFO - "script_repo_revision": "production", 03:11:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:11:57 INFO - "repository": "", 03:11:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:11:57 INFO - "buildid": "20160225014330", 03:11:57 INFO - "pgo_build": "False", 03:11:57 INFO - "basedir": "/builds/slave/test", 03:11:57 INFO - "buildnumber": 135, 03:11:57 INFO - "slavename": "t-yosemite-r7-0180", 03:11:57 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 03:11:57 INFO - "platform": "yosemite_r7", 03:11:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:11:57 INFO - "branch": "mozilla-central", 03:11:57 INFO - "repo_path": "mozilla-central", 03:11:57 INFO - "revision": "4f64ec5486f4694082a189d9b93730c444e0594a", 03:11:57 INFO - "stage_platform": "macosx64", 03:11:57 INFO - "builduid": "08e9eb0f21224ef9a7e9b68acd84bd9c", 03:11:57 INFO - "slavebuilddir": "test" 03:11:57 INFO - } 03:11:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 03:11:57 INFO - Running post-action listener: _resource_record_post_action 03:11:57 INFO - ##### 03:11:57 INFO - ##### Running download-and-extract step. 03:11:57 INFO - ##### 03:11:57 INFO - Running pre-action listener: _resource_record_pre_action 03:11:57 INFO - Running main action method: download_and_extract 03:11:57 INFO - mkdir: /builds/slave/test/build/tests 03:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:57 INFO - https://queue.taskcluster.net/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:11:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/test_packages.json 03:11:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/test_packages.json 03:11:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:11:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:11:58 INFO - Downloaded 1277 bytes. 03:11:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:11:58 INFO - Using the following test package requirements: 03:11:58 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:11:58 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:11:58 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 03:11:58 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:11:58 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 03:11:58 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:11:58 INFO - u'jsshell-mac.zip'], 03:11:58 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:11:58 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 03:11:58 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:11:58 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:11:58 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 03:11:58 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:11:58 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 03:11:58 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:11:58 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 03:11:58 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 03:11:58 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 03:11:58 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 03:11:58 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:11:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:11:59 INFO - https://queue.taskcluster.net/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:11:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:11:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:11:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/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 03:11:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/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 03:12:00 INFO - Downloaded 17827663 bytes. 03:12:00 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'] 03:12:00 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 03:12:03 INFO - Return code: 0 03:12:03 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 03:12:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:03 INFO - https://queue.taskcluster.net/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 03:12:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:12:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 03:12:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/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 03:12:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/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 03:12:04 INFO - Downloaded 17827663 bytes. 03:12:04 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'] 03:12:04 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 03:12:07 INFO - Return code: 0 03:12:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:07 INFO - https://queue.taskcluster.net/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 03:12:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:12:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 03:12:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/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 03:12:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/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 03:12:08 INFO - Downloaded 10707015 bytes. 03:12:08 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'] 03:12:08 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 03:12:09 INFO - Return code: 0 03:12:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:09 INFO - https://queue.taskcluster.net/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 03:12:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:12:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:12:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 03:12:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B4cxvgx5TR6bFzBIPVBFzw/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 03:12:12 INFO - Downloaded 111451894 bytes. 03:12:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:12:12 INFO - mkdir: /builds/slave/test/properties 03:12:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:12:12 INFO - Writing to file /builds/slave/test/properties/build_url 03:12:12 INFO - Contents: 03:12:12 INFO - build_url:https://queue.taskcluster.net/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 03:12:13 INFO - Running post-action listener: _resource_record_post_action 03:12:13 INFO - Running post-action listener: set_extra_try_arguments 03:12:13 INFO - ##### 03:12:13 INFO - ##### Running populate-webroot step. 03:12:13 INFO - ##### 03:12:13 INFO - Running pre-action listener: _resource_record_pre_action 03:12:13 INFO - Running main action method: populate_webroot 03:12:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:12:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:12:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:12:13 INFO - '--tppagecycles', 03:12:13 INFO - '7'], 03:12:13 INFO - 'tests': ['tsvgm']}}, 03:12:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:12:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:12:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:12:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 03:12:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:12:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:12:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:12:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:13 INFO - 'talos_options': ['--e10s'], 03:12:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:12:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:13 INFO - 'tests': ['damp', 'tps']}, 03:12:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:13 INFO - 'talos_options': ['--e10s'], 03:12:13 INFO - 'tests': ['damp', 'tps']}, 03:12:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:12:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:12:13 INFO - 'other': {'tests': ['a11yr', 03:12:13 INFO - 'ts_paint', 03:12:13 INFO - 'tpaint', 03:12:13 INFO - 'sessionrestore', 03:12:13 INFO - 'sessionrestore_no_auto_restore']}, 03:12:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:12:13 INFO - 'tests': ['a11yr', 03:12:13 INFO - 'ts_paint', 03:12:13 INFO - 'tpaint', 03:12:13 INFO - 'sessionrestore', 03:12:13 INFO - 'sessionrestore_no_auto_restore']}, 03:12:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:12:13 INFO - 'tests': ['a11yr', 03:12:13 INFO - 'ts_paint', 03:12:13 INFO - 'tpaint', 03:12:13 INFO - 'sessionrestore', 03:12:13 INFO - 'sessionrestore_no_auto_restore']}, 03:12:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:12:13 INFO - 'tests': ['a11yr', 03:12:13 INFO - 'ts_paint', 03:12:13 INFO - 'tpaint', 03:12:13 INFO - 'sessionrestore', 03:12:13 INFO - 'sessionrestore_no_auto_restore']}, 03:12:13 INFO - 'other_l64': {'tests': ['a11yr', 03:12:13 INFO - 'ts_paint', 03:12:13 INFO - 'tpaint', 03:12:13 INFO - 'sessionrestore', 03:12:13 INFO - 'sessionrestore_no_auto_restore']}, 03:12:13 INFO - 'other_nol64': {'tests': ['a11yr', 03:12:13 INFO - 'ts_paint', 03:12:13 INFO - 'tpaint', 03:12:13 INFO - 'sessionrestore', 03:12:13 INFO - 'sessionrestore_no_auto_restore']}, 03:12:13 INFO - 'svgr': {'tests': ['tsvgx', 03:12:13 INFO - 'tsvgr_opacity', 03:12:13 INFO - 'tart', 03:12:13 INFO - 'tscrollx', 03:12:13 INFO - 'cart']}, 03:12:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:12:13 INFO - 'tests': ['tsvgx', 03:12:13 INFO - 'tsvgr_opacity', 03:12:13 INFO - 'tart', 03:12:13 INFO - 'tscrollx', 03:12:13 INFO - 'cart']}, 03:12:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:13 INFO - 'tests': ['tp5o']}, 03:12:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:13 INFO - 'talos_options': ['--e10s'], 03:12:13 INFO - 'tests': ['tp5o']}, 03:12:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:13 INFO - 'talos_options': ['--xperf_path', 03:12:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:12:13 INFO - 'tests': ['tp5n']}, 03:12:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:12:13 INFO - 'talos_options': ['--e10s', 03:12:13 INFO - '--xperf_path', 03:12:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:12:13 INFO - 'tests': ['tp5n']}}, 03:12:13 INFO - 'talos.zip': {'path': '', 03:12:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:12:13 INFO - Running post-action listener: _resource_record_post_action 03:12:13 INFO - ##### 03:12:13 INFO - ##### Running create-virtualenv step. 03:12:13 INFO - ##### 03:12:13 INFO - Running pre-action listener: _resource_record_pre_action 03:12:13 INFO - Running main action method: create_virtualenv 03:12:13 INFO - Creating virtualenv /builds/slave/test/build/venv 03:12:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:12:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:12:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:12:13 INFO - Using real prefix '/tools/python27' 03:12:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:12:14 INFO - Installing distribute.............................................................................................................................................................................................done. 03:12:17 INFO - Installing pip.................done. 03:12:17 INFO - Return code: 0 03:12:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:17 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 0x10450aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a114bc500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043aed30>, '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 0x1041d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043a5b20>, '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.VvMgWihc6t/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.GYMmDLmENO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:12:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvMgWihc6t/Render', 03:12:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:17 INFO - 'HOME': '/Users/cltbld', 03:12:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:17 INFO - 'LOGNAME': 'cltbld', 03:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:17 INFO - 'MOZ_NO_REMOTE': '1', 03:12:17 INFO - 'NO_EM_RESTART': '1', 03:12:17 INFO - 'PAGER': '/bin/cat', 03:12:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:17 INFO - 'PWD': '/builds/slave/test', 03:12:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:17 INFO - 'SHELL': '/bin/bash', 03:12:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYMmDLmENO/Listeners', 03:12:17 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:12:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:17 INFO - 'USER': 'cltbld', 03:12:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:17 INFO - 'XPC_FLAGS': '0x0', 03:12:17 INFO - 'XPC_SERVICE_NAME': '0', 03:12:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:12:17 INFO - Cleaning up... 03:12:17 INFO - Return code: 0 03:12:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:17 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 0x10450aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a114bc500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043aed30>, '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 0x1041d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043a5b20>, '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.VvMgWihc6t/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.GYMmDLmENO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:12:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvMgWihc6t/Render', 03:12:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:17 INFO - 'HOME': '/Users/cltbld', 03:12:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:17 INFO - 'LOGNAME': 'cltbld', 03:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:17 INFO - 'MOZ_NO_REMOTE': '1', 03:12:17 INFO - 'NO_EM_RESTART': '1', 03:12:17 INFO - 'PAGER': '/bin/cat', 03:12:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:17 INFO - 'PWD': '/builds/slave/test', 03:12:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:17 INFO - 'SHELL': '/bin/bash', 03:12:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYMmDLmENO/Listeners', 03:12:17 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:12:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:17 INFO - 'USER': 'cltbld', 03:12:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:17 INFO - 'XPC_FLAGS': '0x0', 03:12:17 INFO - 'XPC_SERVICE_NAME': '0', 03:12:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:17 INFO - Downloading/unpacking psutil>=0.7.1 03:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:12:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:12:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:12:20 INFO - Installing collected packages: psutil 03:12:20 INFO - Running setup.py install for psutil 03:12:20 INFO - building 'psutil._psutil_osx' extension 03:12:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:12:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:12:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:12:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:12:21 INFO - building 'psutil._psutil_posix' extension 03:12:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:12:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:12:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:12:21 INFO - ^ 03:12:21 INFO - 1 warning generated. 03:12:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:12:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:12:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:12:21 INFO - Successfully installed psutil 03:12:21 INFO - Cleaning up... 03:12:21 INFO - Return code: 0 03:12:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:21 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 0x10450aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a114bc500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043aed30>, '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 0x1041d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043a5b20>, '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.VvMgWihc6t/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.GYMmDLmENO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 03:12:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:12:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvMgWihc6t/Render', 03:12:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:21 INFO - 'HOME': '/Users/cltbld', 03:12:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:21 INFO - 'LOGNAME': 'cltbld', 03:12:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:21 INFO - 'MOZ_NO_REMOTE': '1', 03:12:21 INFO - 'NO_EM_RESTART': '1', 03:12:21 INFO - 'PAGER': '/bin/cat', 03:12:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:21 INFO - 'PWD': '/builds/slave/test', 03:12:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:21 INFO - 'SHELL': '/bin/bash', 03:12:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYMmDLmENO/Listeners', 03:12:21 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:12:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:21 INFO - 'USER': 'cltbld', 03:12:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:21 INFO - 'XPC_FLAGS': '0x0', 03:12:21 INFO - 'XPC_SERVICE_NAME': '0', 03:12:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:12:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:12:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:12:24 INFO - Installing collected packages: mozsystemmonitor 03:12:24 INFO - Running setup.py install for mozsystemmonitor 03:12:24 INFO - Successfully installed mozsystemmonitor 03:12:24 INFO - Cleaning up... 03:12:24 INFO - Return code: 0 03:12:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:24 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 0x10450aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a114bc500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043aed30>, '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 0x1041d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043a5b20>, '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.VvMgWihc6t/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.GYMmDLmENO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:12:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:12:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvMgWihc6t/Render', 03:12:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:24 INFO - 'HOME': '/Users/cltbld', 03:12:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:24 INFO - 'LOGNAME': 'cltbld', 03:12:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:24 INFO - 'MOZ_NO_REMOTE': '1', 03:12:24 INFO - 'NO_EM_RESTART': '1', 03:12:24 INFO - 'PAGER': '/bin/cat', 03:12:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:24 INFO - 'PWD': '/builds/slave/test', 03:12:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:24 INFO - 'SHELL': '/bin/bash', 03:12:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYMmDLmENO/Listeners', 03:12:24 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:12:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:24 INFO - 'USER': 'cltbld', 03:12:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:24 INFO - 'XPC_FLAGS': '0x0', 03:12:24 INFO - 'XPC_SERVICE_NAME': '0', 03:12:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:24 INFO - Downloading/unpacking blobuploader==1.2.4 03:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:26 INFO - Downloading blobuploader-1.2.4.tar.gz 03:12:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:12:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:12:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:28 INFO - Downloading docopt-0.6.1.tar.gz 03:12:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:12:28 INFO - Installing collected packages: blobuploader, requests, docopt 03:12:28 INFO - Running setup.py install for blobuploader 03:12:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:12:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:12:28 INFO - Running setup.py install for requests 03:12:28 INFO - Running setup.py install for docopt 03:12:29 INFO - Successfully installed blobuploader requests docopt 03:12:29 INFO - Cleaning up... 03:12:29 INFO - Return code: 0 03:12:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12: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')]} 03:12:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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')]} 03:12:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:29 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 0x10450aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a114bc500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043aed30>, '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 0x1041d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043a5b20>, '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.VvMgWihc6t/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.GYMmDLmENO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:12:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:12:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvMgWihc6t/Render', 03:12:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:29 INFO - 'HOME': '/Users/cltbld', 03:12:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:29 INFO - 'LOGNAME': 'cltbld', 03:12:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:29 INFO - 'MOZ_NO_REMOTE': '1', 03:12:29 INFO - 'NO_EM_RESTART': '1', 03:12:29 INFO - 'PAGER': '/bin/cat', 03:12:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:29 INFO - 'PWD': '/builds/slave/test', 03:12:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:29 INFO - 'SHELL': '/bin/bash', 03:12:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYMmDLmENO/Listeners', 03:12:29 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:12:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:29 INFO - 'USER': 'cltbld', 03:12:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:29 INFO - 'XPC_FLAGS': '0x0', 03:12:29 INFO - 'XPC_SERVICE_NAME': '0', 03:12:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:12:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Lasy0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:12:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Avxssd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:12:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-gBQV1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:12:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-cX9thm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:12:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-FhGVn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:12:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:12:29 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Hy6TBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:12:30 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-1BQMQ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:12:30 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-moSUm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:12:30 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-AqDh2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:12:30 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-XMUcsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:12:30 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-tzqjBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:12:30 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-vo0M7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:12:30 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-9BFSlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:12:30 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-lvy3Mm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:30 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-MmJIAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:12:30 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-HRjbrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:12:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:12:31 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-BtRpQs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:12:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:12:31 INFO - Running setup.py install for manifestparser 03:12:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:12:31 INFO - Running setup.py install for mozcrash 03:12:31 INFO - Running setup.py install for mozdebug 03:12:31 INFO - Running setup.py install for mozdevice 03:12:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:12:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:12:31 INFO - Running setup.py install for mozfile 03:12:31 INFO - Running setup.py install for mozhttpd 03:12:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:12:32 INFO - Running setup.py install for mozinfo 03:12:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:12:32 INFO - Running setup.py install for mozInstall 03:12:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:12:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:12:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:12:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:12:32 INFO - Running setup.py install for mozleak 03:12:32 INFO - Running setup.py install for mozlog 03:12:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:12:32 INFO - Running setup.py install for moznetwork 03:12:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:12:32 INFO - Running setup.py install for mozprocess 03:12:33 INFO - Running setup.py install for mozprofile 03:12:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:12:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:12:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:12:33 INFO - Running setup.py install for mozrunner 03:12:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:12:33 INFO - Running setup.py install for mozscreenshot 03:12:33 INFO - Running setup.py install for moztest 03:12:33 INFO - Running setup.py install for mozversion 03:12:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:12:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:12:33 INFO - Cleaning up... 03:12:33 INFO - Return code: 0 03:12:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:33 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 0x10450aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a114bc500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043aed30>, '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 0x1041d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043a5b20>, '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.VvMgWihc6t/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.GYMmDLmENO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:12:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvMgWihc6t/Render', 03:12:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:33 INFO - 'HOME': '/Users/cltbld', 03:12:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:33 INFO - 'LOGNAME': 'cltbld', 03:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:33 INFO - 'MOZ_NO_REMOTE': '1', 03:12:33 INFO - 'NO_EM_RESTART': '1', 03:12:33 INFO - 'PAGER': '/bin/cat', 03:12:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:33 INFO - 'PWD': '/builds/slave/test', 03:12:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:33 INFO - 'SHELL': '/bin/bash', 03:12:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYMmDLmENO/Listeners', 03:12:33 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:12:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:33 INFO - 'USER': 'cltbld', 03:12:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:33 INFO - 'XPC_FLAGS': '0x0', 03:12:33 INFO - 'XPC_SERVICE_NAME': '0', 03:12:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:12:34 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-aDbwZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:12:34 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-vXtDek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:12:34 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)) 03:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:12:34 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-XChe2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:12:34 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-wZb63I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:12:34 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-pQHc3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 03:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:12:34 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-NyMJPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:12:34 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-VdJ0km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:12:34 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-gujfp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:12:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:12:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:12:34 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-X6fhDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:12:35 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-PS2fO_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:12:35 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-0yCxrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:12:35 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-hKRLss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:12:35 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-Dygx9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:12:35 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-UW2D3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:35 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-nh8AQt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:12:35 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-BE0FBa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:12:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:12:35 INFO - Running setup.py (path:/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/pip-CkfOVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:12:35 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)) 03:12:35 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)) 03:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:12:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:38 INFO - Downloading blessings-1.6.tar.gz 03:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:12:38 INFO - Installing collected packages: blessings 03:12:38 INFO - Running setup.py install for blessings 03:12:38 INFO - Successfully installed blessings 03:12:38 INFO - Cleaning up... 03:12:38 INFO - Return code: 0 03:12:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:12:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:12:38 INFO - Reading from file tmpfile_stdout 03:12:38 INFO - Current package versions: 03:12:38 INFO - blessings == 1.6 03:12:38 INFO - blobuploader == 1.2.4 03:12:38 INFO - docopt == 0.6.1 03:12:38 INFO - manifestparser == 1.1 03:12:38 INFO - mozInstall == 1.12 03:12:38 INFO - mozcrash == 0.16 03:12:38 INFO - mozdebug == 0.1 03:12:38 INFO - mozdevice == 0.48 03:12:38 INFO - mozfile == 1.2 03:12:38 INFO - mozhttpd == 0.7 03:12:38 INFO - mozinfo == 0.9 03:12:38 INFO - mozleak == 0.1 03:12:38 INFO - mozlog == 3.1 03:12:38 INFO - moznetwork == 0.27 03:12:38 INFO - mozprocess == 0.22 03:12:38 INFO - mozprofile == 0.28 03:12:38 INFO - mozrunner == 6.11 03:12:38 INFO - mozscreenshot == 0.1 03:12:38 INFO - mozsystemmonitor == 0.0 03:12:38 INFO - moztest == 0.7 03:12:38 INFO - mozversion == 1.4 03:12:38 INFO - psutil == 3.1.1 03:12:38 INFO - requests == 1.2.3 03:12:38 INFO - wsgiref == 0.1.2 03:12:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:38 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 0x10450aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a114bc500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043aed30>, '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 0x1041d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043a5b20>, '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.VvMgWihc6t/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.GYMmDLmENO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:12:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvMgWihc6t/Render', 03:12:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:38 INFO - 'HOME': '/Users/cltbld', 03:12:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:38 INFO - 'LOGNAME': 'cltbld', 03:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:38 INFO - 'MOZ_NO_REMOTE': '1', 03:12:38 INFO - 'NO_EM_RESTART': '1', 03:12:38 INFO - 'PAGER': '/bin/cat', 03:12:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:38 INFO - 'PWD': '/builds/slave/test', 03:12:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:38 INFO - 'SHELL': '/bin/bash', 03:12:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYMmDLmENO/Listeners', 03:12:38 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:12:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:38 INFO - 'USER': 'cltbld', 03:12:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:38 INFO - 'XPC_FLAGS': '0x0', 03:12:38 INFO - 'XPC_SERVICE_NAME': '0', 03:12:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:12:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:12:39 INFO - Cleaning up... 03:12:39 INFO - Return code: 0 03:12:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:12:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12:39 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 0x10450aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a114bc500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043aed30>, '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 0x1041d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043a5b20>, '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.VvMgWihc6t/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.GYMmDLmENO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:12:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:12:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvMgWihc6t/Render', 03:12:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:39 INFO - 'HOME': '/Users/cltbld', 03:12:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:39 INFO - 'LOGNAME': 'cltbld', 03:12:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:39 INFO - 'MOZ_NO_REMOTE': '1', 03:12:39 INFO - 'NO_EM_RESTART': '1', 03:12:39 INFO - 'PAGER': '/bin/cat', 03:12:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:39 INFO - 'PWD': '/builds/slave/test', 03:12:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:39 INFO - 'SHELL': '/bin/bash', 03:12:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYMmDLmENO/Listeners', 03:12:39 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:12:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:39 INFO - 'USER': 'cltbld', 03:12:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:39 INFO - 'XPC_FLAGS': '0x0', 03:12:39 INFO - 'XPC_SERVICE_NAME': '0', 03:12:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:39 INFO - Downloading/unpacking jsonschema 03:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:12:41 INFO - Downloading/unpacking functools32 (from jsonschema) 03:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:42 INFO - Downloading functools32-3.2.3-2.tar.gz 03:12:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:12:42 INFO - warning: no files found matching '*.txt' 03:12:42 INFO - no previously-included directories found matching 'build' 03:12:42 INFO - no previously-included directories found matching 'dist' 03:12:42 INFO - no previously-included directories found matching '.git*' 03:12:42 INFO - Installing collected packages: jsonschema, functools32 03:12:42 INFO - Running setup.py install for functools32 03:12:42 INFO - warning: no files found matching '*.txt' 03:12:42 INFO - no previously-included directories found matching 'build' 03:12:42 INFO - no previously-included directories found matching 'dist' 03:12:42 INFO - no previously-included directories found matching '.git*' 03:12:42 INFO - Successfully installed jsonschema functools32 03:12:42 INFO - Cleaning up... 03:12:42 INFO - Return code: 0 03:12:42 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:12: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')]} 03:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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')]} 03:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:12: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10450aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1045124c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a114bc500>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1043aed30>, '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 0x1041d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043a5b20>, '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.VvMgWihc6t/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.GYMmDLmENO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:12: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', 'flake8'] in /builds/slave/test/build 03:12: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 flake8 03:12:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvMgWihc6t/Render', 03:12:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:12:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:12:42 INFO - 'HOME': '/Users/cltbld', 03:12:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:12:42 INFO - 'LOGNAME': 'cltbld', 03:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:12:42 INFO - 'MOZ_NO_REMOTE': '1', 03:12:42 INFO - 'NO_EM_RESTART': '1', 03:12:42 INFO - 'PAGER': '/bin/cat', 03:12:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:12:42 INFO - 'PWD': '/builds/slave/test', 03:12:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:12:42 INFO - 'SHELL': '/bin/bash', 03:12:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYMmDLmENO/Listeners', 03:12:42 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:12:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:12:42 INFO - 'USER': 'cltbld', 03:12:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:12:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:12:42 INFO - 'XPC_FLAGS': '0x0', 03:12:42 INFO - 'XPC_SERVICE_NAME': '0', 03:12:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:12:42 INFO - Downloading/unpacking flake8 03:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:45 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:12:45 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:45 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:12:45 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:45 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:12:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:12:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:12:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:12:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:12:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:12:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:12:46 INFO - no previously-included directories found matching 'docs/_build' 03:12:46 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:12:46 INFO - Running setup.py install for pep8 03:12:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:12:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:12:46 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:12:46 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:12:46 INFO - no previously-included directories found matching 'docs/_build' 03:12:46 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:12:46 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:12:46 INFO - Cleaning up... 03:12:46 INFO - Return code: 0 03:12:46 INFO - Running post-action listener: _resource_record_post_action 03:12:46 INFO - Running post-action listener: _start_resource_monitoring 03:12:46 INFO - Starting resource monitoring. 03:12:46 INFO - ##### 03:12:46 INFO - ##### Running install step. 03:12:46 INFO - ##### 03:12:46 INFO - Running pre-action listener: _resource_record_pre_action 03:12:46 INFO - Running main action method: install 03:12:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:12:46 INFO - Reading from file tmpfile_stdout 03:12:46 INFO - Detecting whether we're running mozinstall >=1.0... 03:12:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:12:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:12:47 INFO - Reading from file tmpfile_stdout 03:12:47 INFO - Output received: 03:12:47 INFO - Usage: mozinstall [options] installer 03:12:47 INFO - Options: 03:12:47 INFO - -h, --help show this help message and exit 03:12:47 INFO - -d DEST, --destination=DEST 03:12:47 INFO - Directory to install application into. [default: 03:12:47 INFO - "/builds/slave/test"] 03:12:47 INFO - --app=APP Application being installed. [default: firefox] 03:12:47 INFO - mkdir: /builds/slave/test/build/application 03:12:47 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'] 03:12:47 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 03:13:20 INFO - Reading from file tmpfile_stdout 03:13:20 INFO - Output received: 03:13:20 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:13:20 INFO - Running post-action listener: _resource_record_post_action 03:13:20 INFO - ##### 03:13:20 INFO - ##### Running run-tests step. 03:13:20 INFO - ##### 03:13:20 INFO - Running pre-action listener: _resource_record_pre_action 03:13:20 INFO - Running main action method: run_tests 03:13:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:13:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:13:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:13:20 INFO - 2016-02-25 03:13:20.878 screenresolution[1661:7451] starting screenresolution argv=screenresolution get 03:13:20 INFO - 2016-02-25 03:13:20.881 screenresolution[1661:7451] Display 0: 1600x1200x32@60 03:13:20 INFO - 2016-02-25 03:13:20.887 screenresolution[1662:7453] starting screenresolution argv=screenresolution list 03:13:20 INFO - Available Modes on Display 0 03:13:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:13:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:13:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:13:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:13:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:13:21 INFO - Intel Iris: 03:13:21 INFO - Chipset Model: Intel Iris 03:13:21 INFO - Type: GPU 03:13:21 INFO - Bus: Built-In 03:13:21 INFO - VRAM (Dynamic, Max): 1536 MB 03:13:21 INFO - Vendor: Intel (0x8086) 03:13:21 INFO - Device ID: 0x0a2e 03:13:21 INFO - Revision ID: 0x0009 03:13:21 INFO - Displays: 03:13:21 INFO - Display: 03:13:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:13:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:13:21 INFO - Display Serial Number: 1600x1200 60 03:13:21 INFO - Main Display: Yes 03:13:21 INFO - Mirror: Off 03:13:21 INFO - Online: Yes 03:13:21 INFO - Rotation: Supported 03:13:21 INFO - Return code: 0 03:13:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:13:21 INFO - Python 2.7.3 03:13:21 INFO - Return code: 0 03:13:21 INFO - grabbing minidump binary from tooltool 03:13:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:13:21 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 0x1043aed30>, '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 0x1041d2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1043a5b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:13:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:13:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 03:13:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:13:21 INFO - Return code: 0 03:13:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:13:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:13:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:13:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:13:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:13:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:13:22 INFO - Return code: 0 03:13:22 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:13:22 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0180 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:13:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VvMgWihc6t/Render', 03:13:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:13:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:13:22 INFO - 'HOME': '/Users/cltbld', 03:13:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:13:22 INFO - 'LOGNAME': 'cltbld', 03:13:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:13:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:13:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:13:22 INFO - 'MOZ_NO_REMOTE': '1', 03:13:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:13:22 INFO - 'NO_EM_RESTART': '1', 03:13:22 INFO - 'PAGER': '/bin/cat', 03:13:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:13:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:13:22 INFO - 'PWD': '/builds/slave/test', 03:13:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:13:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:13:22 INFO - 'SHELL': '/bin/bash', 03:13:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GYMmDLmENO/Listeners', 03:13:22 INFO - 'TMPDIR': '/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/', 03:13:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:13:22 INFO - 'USER': 'cltbld', 03:13:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:13:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:13:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:13:22 INFO - 'XPC_FLAGS': '0x0', 03:13:22 INFO - 'XPC_SERVICE_NAME': '0', 03:13:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:13:22 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0180', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:13:22 INFO - mozversion application_buildid: 20160225014330 03:13:22 INFO - mozversion application_changeset: 4f64ec5486f4694082a189d9b93730c444e0594a 03:13:22 INFO - mozversion application_display_name: Nightly 03:13:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:13:22 INFO - mozversion application_name: Firefox 03:13:22 INFO - mozversion application_remotingname: firefox 03:13:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:13:22 INFO - mozversion application_vendor: Mozilla 03:13:22 INFO - mozversion application_version: 47.0a1 03:13:22 INFO - mozversion platform_buildid: 20160225014330 03:13:22 INFO - mozversion platform_changeset: 4f64ec5486f4694082a189d9b93730c444e0594a 03:13:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:13:22 INFO - mozversion platform_version: 47.0a1 03:13:22 INFO - using testdate: 1456398802 03:13:22 INFO - actual date: 1456398802 03:13:23 INFO - starting webserver on 'localhost:49278' 03:13:23 INFO - SUITE-START | Running 2 tests 03:13:23 INFO - TEST-START | dromaeo_css 03:13:23 INFO - operating with platform_type : mac_ 03:13:23 INFO - Initialising browser for dromaeo_css test... 03:13:23 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpPUwVOc/profile http://localhost:49278/getInfo.html) 03:13:25 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 03:13:25 INFO - PROCESS | 1680 | colorDepth:24 03:13:25 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 03:13:25 INFO - PROCESS | 1680 | __metrics 03:13:25 INFO - PROCESS | 1680 | 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" 03:13:25 INFO - PROCESS | 1680 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:13:26 INFO - TEST-INFO | 1680: exit 0 03:13:26 INFO - Browser initialized. 03:13:26 INFO - Running cycle 1/1 for dromaeo_css test... 03:13:26 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpPUwVOc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:13:38 INFO - PROCESS | 1683 | RSS: Main: 244334592 03:13:38 INFO - PROCESS | 1683 | 03:14:29 INFO - PROCESS | 1683 | 1456398869693 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:16:39 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 03:16:40 INFO - PROCESS | 1683 | RSS: Main: 374575104 03:16:40 INFO - PROCESS | 1683 | 03:19:43 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 03:19:43 INFO - PROCESS | 1683 | RSS: Main: 374984704 03:19:43 INFO - PROCESS | 1683 | 03:22:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 03:22:46 INFO - PROCESS | 1683 | RSS: Main: 376496128 03:22:46 INFO - PROCESS | 1683 | 03:25:48 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 03:25:49 INFO - PROCESS | 1683 | RSS: Main: 338972672 03:25:49 INFO - PROCESS | 1683 | 03:28:52 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 03:28:53 INFO - PROCESS | 1683 | RSS: Main: 339320832 03:28:53 INFO - PROCESS | 1683 | 03:31:55 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 03:31:55 INFO - PROCESS | 1683 | RSS: Main: 380133376 03:31:55 INFO - PROCESS | 1683 | 03:31:55 INFO - PROCESS | 1683 | __start_tp_report 03:31:55 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 03:31:55 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 03:31:55 INFO - PROCESS | 1683 | |i|pagename|runs| 03:31:55 INFO - PROCESS | 1683 | |0;dojo.html;2520.8109391795615;2936.8531573421324;3498.895033149005;3540.1149712571855;3596.568411790584;5585.944140558593;5665.150227465882;5696.515796157327;5697.116946873241;5749.108888122342;5765.567582431314;5807.593468457209;5812.0410132328225;5970.223870896788;5981.16263723078;4705.882352941169;5070.264811602316;5090.134677104883;5140.922886156711;5217.2695822584865;4383.9342409863875;5247.973760131194;5283.682979021251;5303.257543943851;5304.17785243286;5107.233914912774;5123.795048198068;5210.2445145453885;5227.947720522784;5256.185291279858;5191.558717508979;5199.506046925536;5204.297419848348;5208.765605547759;5211.583073354161;5159.432462429129;5165.354330708661;5175.844724658266;5200.479952004807;5231.8168864089575;5555.638883472561;5621.7751289948355;5669.659820410789;5700;5754.827355179351;6242.188515492957;6279.905801412982;6316.62100273985;6324.367563243685;6325.683715814191;5181.248718935733;5339.359276886759;6320.74717011319;6348.904766428507;6352.047192921053;5724.914126288109;5805.767769289181;5809.796657116981;5817.476427121537;5830.7084645767545;6215.906761398583;6239.095331176954;6319.55763096588;6324.367563243731;6329.398707122816;6158.815235542941;6189.6286222826775;6196.535259855439;6204.844878877974;6218;6239.095331176954;6275.843103922439;6282.528810339243;6289.119523266746;6322.367763223733;6081.665508396992;6153.630782153085;6160.322364539897;6239.376062393724;6273.843153921097;6289.8742025159245;6295.96852015737;6314;6314.936850631527;6324;4869.853904382803;4870.756462176877;4903;4926.211806111077;4956.479569645207;4411.801468933906;4422.778861056934;4449.087936972913;4503.707259028152;4505.819767209275;5722.885542289131;5730.770769169187;5733.799317023884;5751.13732940054;5786.971065144731;6185.907211391833;6223.782167624111;6333.113364129025;6334.5565810393755;6342.682865856688;5715.228444160069;5720.227769251098;5721.370649228582;5740.655560666373;5744.741486633112;5390.164524498709;5403.351597808288;5406.756695948692;5413.079776438015;5413.593980451482;6217.502599792006;6275;6324.462420694201;6328.335524769833;6348.809535713936;6305.747770089145;6322.083297921868;6333.081703153109;6335.809925702236;6336.017917222838;6323.873522529431;6327.557071004985;6329.082283069021;6343.270523889812;6345.904811427925;5843.2403787507355;5964.807038592386;6063.848403789941;6263.937360626518;6280.591761535486;6244.250689917058;6269.404406581368;6291.402316779899;6291.528135389773;6312.084747711648;4711.128441238382;5959.374265702038;6129.325774164749;6131.601445906002;6169.383061693795;5993.520518358608;6057.57596968208;6099.370313949917;6127.769884593299;6130.111133885651;6044.637321760709;6063.909041364295;6064.302605200459;6069.089636554552;6072.332043475126;5957.553183511167;6132.41742034506;6142.687538036454;6184.81445556634;6193.535484838565;5863.296404431496;5974.790882319098;5997.970010149921;6053.576249662481;6086.239220097488 03:31:55 INFO - PROCESS | 1683 | |1;ext.html;522.5584381197887;553.5820455556058;566.2893069198154;569.3367227180335;624.6626821516381;37702.81148594257;38066.61933380665;38087.23825523488;38131.618683813154;38435.80782096092;43699.34450983238;44558.777206114006;44600.553994460046;44645.77677111618;44661;9570.856437153448;9788.461634610094;9788.951055244714;9805.705828825112;9817.214622830192;9650.372725772837;9792.657256996006;9792.951035244849;9802.264830137732;9806.264530160232;9748.26887983404;9831.852522212173;9835.557399916985;9874.9506252469;9879.506024698772;9723.22214222864;9805.31362804604;9822.263330250189;9826;9840.557174927146;9614.134727874454;9745.707628771148;9750.853737193947;9750.90249097507;9751.561179746928;32161.517577236362;40448;40448.98877528056;40489;40489.39265911013;1635.0608203915574;3264.820434876081;3276.7870088444174;3281.9343613127844;3286.753493487974;21996;22238.555228895493;27014.189574312604;28312.858435707894;28412.147635570967;2744.19046381318;2749.6425464689664;2767.9446411071667;2831.178958102148;2891.7323424530146;354709;355394;357449;357788;359230;64335;64461.03308450377;64621.67689161524;64692.70614587682;64870;67138.66430667913;67295.66352168207;67329.32670673328;67397.66301168462;67480;16386.508404747878;16579.419720309732;16596.83403165977;16604.003759774452;16616.83383166177;12662.556810511587;12718.554850580185;12724.300163491096;12725;12728.872711272768;20003.899980500297;20789.480262993548;20790.480237994172;20811.855347955705;20863.582728345653;8503.61733721984;8722.69159626061;8765.167309105625;8778.517181555077;8850.380473366802;952.64752041745;962.552413127899;966.1642679082543;990.8018396320765;1077.8975997280245;23370.883145584165;27691;28153.15540533787;28518.287042823682;28562.285942851595;935.9143393663454;953.2469349214182;980.7106903463496;1088.5373716170595;1153.8846115388394;14463.92768036153;15150.242487875563;15259.771103433457;15364.308606112752;15612.843871561367;499206.5039674851;637824;652818.7359063175;653228;655959;60374.396256036875;61067.69466152641;61068;61216.081758772765;61244.69377653083;1422.50923431416;1431.3487363249697;1448.2541491132286;1454.2292584929792;1454.331007736432;30050.699493005664;30182;30231;30753.846230768704;30898.69101308958;51072;51470.742646286526;51549.71125721887;51594;51676.22485662643;502062;504485;505119;505431;507475;33312;43730.562694372646;43773.562264376946;44813.77593112014;44822.551774483145;44623.66129016135;44692;44732.55267447284;44763.32855007242;45786.85532861572;35557.466638000966;36793.08017299589;37390.62609373871;37576.62423375731;37750.811245943594;34803.12992175216;36584.90245292646;37087.443688345236;37679.811600942914;38569.6143038566;31989.840050799598;36212.456813148354;37261;37472.688455905;37541.624583753815;27010.459790804467;27703.58444623292;33946.66053339435;34011.31977360488;34169.48745768766;25037;25467.617985730598;25550.616740749276;25684.743152568237;25894 03:31:55 INFO - PROCESS | 1683 | |2;jquery.html;354.89175801380577;363.4475597092418;363.5782492308922;369.58975537153754;371.3519907760954;15890.682186356265;16407.605353544932;19067.618647627038;19732;20554.69167962482;19513.70729439056;19846.702299465484;20169.294074707388;20782.89608551955;20801.063952122153;5551.1673249012565;5612.859678508029;5750.079987202049;5776;5836.970815145918;4082.142750022499;4286.87139385819;5725.255716756837;6069.696515174246;6320.399562041599;6242.687865606724;6252.406021427957;6256.155419018442;6263.561550691454;6265.592736472137;5333.2000199970125;6069.271687397496;6160.414760597736;6262.091996660504;6272.8118156455375;5386.515213630752;5413.188021796723;5425.131978883399;5428.538574221196;5438;23827.642585361235;24698.382540436454;24748.628770568277;25050.624240636404;25248.621270680953;2315.4327189838427;2429.6962879640046;2719.619253304539;2800.215939536933;2858.399736055431;14238.644033899132;14552.927235363755;14733.778993315109;14941.402343906231;15067.4726384576;1768.6285879965224;1773.796013458456;1783.8572914166834;1797.1014492753623;1800.9459716208403;105309.47345263224;106280.4685976573;107160;108135;109939.35090973641;10048.748781280381;10604.204684648528;10620.468976551296;10686.305390149615;10710.785784284271;12579.433925473375;12676.492940282285;12711.30087845159;12711.872881271254;12716;8330.166983301622;8432.283255923192;8436.45163064399;8482.279006284534;8490.108538603357;8632.654693812303;8643.09247529013;8660.566971651393;8741.519216443157;8742.912570874338;6102.511799056065;6199.597026193283;6205.6586887720705;6207.565470417027;6257.968710156511;1579.1867188397985;1588.816331832792;1711.5977745229861;1733.3153404405189;1733.9219735111951;398.26520070470514;406.3843277434689;407.0942153708035;976.5556671714353;1020.1991436722137;11271.154663400277;11962.450152329562;12018.75962480763;12027;12031;447.72017489069333;448.2156226603444;450.90981803639403;457.32316172064867;464.6933024204009;6128.479079278222;6133.539984501181;6152.107944348045;6193.318734939153;6213.720382582795;586066.5326814047;634626;647515;652593;652810.7359463172;100272;124888;131805;132409.67590323972;132556.3372183133;459.68281885498897;465.73220398271127;466.7409587678803;468.0451878168498;469.1133757198897;9294.932294823217;11177.441127943734;11238.494267757807;11245.662630121109;11276.492557835081;46412.53587464217;49330.766730832016;49331.02675892924;49373;49755;62992.11023669297;68160.31839681539;69261.65369173324;72232.63883680548;79250.6037469809;7887.763367098996;8047.275745182962;8220;8302.667893284442;8352.665893364441;10884.455777211266;12074.39628018613;13108.344582771015;13571.79642305386;13743.518976835763;7505.568450915407;8400.117987611213;8982.955085224532;11127.944360278147;11817.881821182022;6634.772567075107;8007.879881801661;8107.1892810718455;8337.499750015018;8370.916290837014;8585.270252028648;8599.613017414356;8657.350698697497;8737.91262087371;8794;8861.468311901306;9468.857967130636;10204.642837500653;12286.324252166216;12373.443195056425;10742.194335424718;11297.26567773092;12052.819207712068;12100.152989290666;12136.939315303367 03:31:55 INFO - PROCESS | 1683 | |3;mootools.html;1391;1484.9183294918778;1536.431520337475;1750.9737353939693;1925.8170473804992;7658.578778167205;8247.381446391522;8438.746837594867;8455.873161902577;8483.745487635366;6893.4140598049225;7896.210378962115;8165.183481651832;8178.427510074297;8198.303144232732;2123.649597816366;2361.8346715729904;2389.9880500597474;2422.9030838766516;2426.5874801283735;2025.8885761283123;2452.5217582571404;2454.006127518358;2454.6808914841135;2461.3477428481465;2363.409147713072;2411.987940060306;2421.4672771990136;2421.878906054699;2431.550163219801;2374.655674927126;2422.515496900627;2422.5760491913934;2427.053449154831;2433.8904749286326;2387.271882075966;2416.4442178298914;2439.7194322652945;2440.6827112475444;2447.204658485999;8520.531370774605;8591.914080859236;8593.527355995418;8601.870971935426;8601.95699021507;5232.189010703347;5341.1187154119525;5345.251664766935;5362.839114826562;5375.462453754632;3535.9646403535894;3628.6734193922675;3669.027707657473;3675.7978311192874;3675.981620091909;1031.3296357367697;1052.5631862776938;1057.9471026448646;1081.691717860414;1085.3813326403954;11436.142289328334;11481.253718508271;11482.48328825205;11491.080713542897;11502.907223813641;4157.64660003897;4718.2214934536105;4797.592204662643;4857.319975203474;4857.659963802571;9920.950395247977;9948.850767238497;9952.15406690425;9952.751181220527;9961.850572241423;5329.360476742816;5346.010987967238;5350.38470575881;5371.113766228606;5389.757460914268;4303.225419424533;4431.268840641258;4722.433308003062;4871.244957031666;4871.269309603517;3863.787491687984;3922.156736301709;3964.365701487748;3976.1252524444576;3978.462907507507;1107.8449017137607;1266.8669789672135;1274.4265080713717;1277.8658240884758;1296.3647812571771;1081.734974931147;1099.4612639806437;1103.3490240757992;1152.1128730877344;1235.6231349438328;7957.482763620346;7963.243491868263;7971.880421793678;8018.679252829821;8078.8788168177525;507.34805774580224;518.9974050129725;522.5662699959025;524.5777149394697;524.5777149394773;6087.57386982907;6100.3899610039525;6138.478229350555;6142.447179753844;6148.477379422709;10174;10274.897251027394;10278.537465813906;10421.9478902605;10438.37369757817;10066.496675166212;10268.691939241835;10305.742356440998;10306.587736490457;10330.225233107547;8051.436399451982;8100.311473524816;8100.473469224482;8115.229053239933;8173.305269052078;7943.4836735612;7960.920390796018;7969.6015199238645;8039.5176289422825;8075.798105047421;9240;9399.953000234955;9505.857412138685;9584.808303834025;9605.519724013911;9607.711768646952;9811.509424528887;9831.655892043744;9941.403515789076;9964.202863770735;6718.428933540704;6906.930930690629;7187.9640601796655;7414.592197428978;7543.170251272246;8064.8790268147195;8124.309433698202;8141;8147.348212142896;8148.918510815053;7071.540349877241;7162.820929476805;7174.1032370953635;7292.380147687294;7299.160596531255;7081.362677359062;7088.539244949268;7132.821679458055;7226.277372262732;7237.457190710613;7347.191808901123;7621.618919054136;7624.961875190588;7638;7640.694372225049;6880.208775990625;6943.652817359213;6957.652117394211;6960;6961.37347638715;6913.3777959983845;7027.578345299298;7028.6485675714985;7033.050538177281;7045.154581450259 03:31:55 INFO - PROCESS | 1683 | |4;prototype.html;263.9023561282325;322.97254733347665;327.9590051243595;328.75014988608666;334.6770366596234;6436.259830119532;6604.900926486101;6608.603483790964;6631.204255489336;6662.200535935683;6473.54685172037;6554.803355899318;6559.212894452672;6562.146920900276;6564.835879103025;4579.816807327703;4703.811847526094;4840.104580652573;4855.9028819423675;4860.222364421693;4694.90610187796;4784.182010835878;4784.521547845205;4800.4719480857075;4815.422149342084;4731.692439991407;4737.952620473803;4747.287906813971;4762.738049407281;4818.988012517376;4569.862904112882;4608.446986361658;4732.43210814701;4797.544233297831;4801.399825021855;4073.551909289976;4079.2861249281555;4084.019835239551;4090.3046482098116;4094.28350038745;6186.690665466754;6224.62652240867;6225.221847269091;6226.87546249077;6234.719437625317;5605.859853503654;5615.9157612635845;5618.522425593788;5619.269494965628;5627.831165065014;6932.6533673316635;6945.47908906834;6947.340002699735;6958.47811414146;6967.233604303523;4444.555544445562;4615.307703844416;4631.745254011028;4655.534446555352;4660.790264438075;6887.276835932205;7250.093738282715;7286.1256649201905;7303.160136584308;7315.341619254239;3827.2919509890758;4705.60002399793;4707.082118986833;4709.670323077352;4719.882002949885;4778.641601879873;4782.760861956888;4787.976060119677;4790.233562630032;4795.904081918342;5599.1321345190745;5612.943870561324;5616.297962754656;5616.747246373923;5626.324841019104;6682.899756503656;6951.721931122698;6954.3393377629045;6987.790366289019;6995.79012629622;1377.889768818492;1393.2754967416886;1659.5933996170775;1681.529171831889;1685.2163743859164;1014.4521958142668;1082.7509672775307;1082.9566817327218;1097.160672085855;1111.1333160134946;5271.920921186185;6297.433231009231;6382.425581697669;6531.542792004514;6548.8035358939305;7338.559686418832;7341.77974660761;7348.963255183797;7352.0442342495135;7354.742584009534;6522.5760325578685;6535.0850880876715;6536.281009088996;6541.182352205974;6542.7710030149665;3818.9045273868373;3855.9421608675893;3871.4773505576386;3872.845086196577;3878.1274213302345;7212.050058701488;7602.961985190039;7636.656350464243;7637.083549973928;7642.847143057108;7461.962690186514;7557.093148822177;7562.546247225074;7565.319121279112;7568.470207085561;7589.203133670995;7592.658330375036;7599.848003039909;7601.809954751176;7609.239076092457;7012.088428504262;7328.890066648898;7336.395579569176;7344.853102938018;7350.669219885225;7043.436525078084;7106.6446677666945;7116.039334689751;7127.501074924706;7127.82180445493;7556.168821429528;7577.014988051518;7591.544507329578;7592.316691497792;7603.505772124794;4587.954120458753;4626.311396340244;4645.233536466445;4646.953530464787;4656.115338085753;7017.894731579133;7277.745278915212;7286.6720997556295;7304.890426643711;7306.634668266459;6983.930160698531;6998.580085194904;7025.297470253138;7036.542624729376;7046.1192350956135;6137.925862974051;6416.550841441054;6922.996165555865;6940.271271516418;6943.861122777415;6876.553024053421;6883.8967415487805;6885.037764237169;6895.620740859301;6904.033435318959;6750.763723269858;7039.084918960707;7050.647467626495;7060.71757129709;7081.291870812877;6632.701528431328;6780.423663988616;6841.281665425058;6900.137482814648;6912.619805910723 03:31:55 INFO - PROCESS | 1683 | |5;yui.html;662.4270006444425;729.9051123353963;738.6897503048717;741.1439787045964;762.2263402646315;12093;14943;15046.699066018673;15131.773023404658;15154.848451515481;11172.776544469105;13494.527691530773;13543.864561354383;13569.982251331141;13577.45690172392;833.6498670558381;859.3726579596898;865.091653763549;869.0570730757136;874.3922973533397;858.5406807358065;865.8354912566624;866.2766589897411;870.2168048756139;871.4205053639322;906.12106256931;906.2659246010719;906.7642412972608;909.6088681866795;914.5518695839057;902.6118768929325;902.6795487601872;903.1510380242551;903.5708038681639;907.7866701325183;645.4932877691037;675.3010633993792;676.2527407215055;679.9558028728117;680.2449281297755;15039.323230454656;15079;15093.622659433493;15128.848711512854;15158.848411515854;12343.259404435672;12429.875701242961;12478.563250286286;12642.115051946368;12901.870981290162;8178.631961561744;10207.387556746544;10217.897821021843;10331.121854642364;10639.893601064045;3419.333230020147;3488.1105318143964;3519.964800351989;3560.038789526839;3651.1419816343137;58635.413645863424;70369;71338.2866171342;73885.63057184733;81164;9171.950373891934;9333.719988400358;9415.482148481899;9422.62309507612;9879.160271377013;19750.209991600463;19750.81495110298;19759.802401976085;19783.505412364808;20667.58664826695;7316.707331706779;7436.851262974818;7551.848963020709;7658.923410765932;7696.846063078707;4030.8186131624147;4087.7138600297694;4087.816048277835;4096.754194748325;4098.6516146127315;3549.769264997767;3558.7508874378545;3571.2143328467696;3572.821358932043;3574.249407624376;531.9946800532023;641.20490591666;650.1353200243665;675.3786516404821;678.1387637700093;553.9086050801653;583.9488919944083;598.4255115089563;627.0187157099125;628.522323034488;8413.747587572383;8591;8622.827543449095;8716.825663486821;8761.420765569706;537.2693137333224;545.5635491606698;612.8682333298362;621.0249907645044;632.4971647540217;3615.186583018852;3939.8227079780904;4315.762633055149;4430.511602067399;4445.355423463644;96729;97782;98415.50792245993;99684;99692;66512.66743666251;71326.64336678284;71709;72555.27444725485;77050;54276;68199.3180068203;68244.6587767068;68378.65810670915;69238.30761692318;8535.146485351415;8560.785980350292;8725.432846864933;8803.471791692518;8933.553322333728;40152.79923600363;46197;47924.760376199294;52272;53115.4688453126;53389;66119.00821487777;67149.66425167843;69448.30551694418;69611;10850.240483166419;11031.558737650405;11046.668599941693;11116.055135313589;11522.308661480338;10827.51276192589;10958.12335013213;10979.341239525655;11027.724306892393;11211.831822522505;11411.828822567833;11414.771704565695;11418.543258269576;11430.1998860079;11446.313221206754;11456.3698996556;11473.13951453661;11481.36852473122;11496.137789665976;11499.08007359426;11222.438878056228;11243.887561124284;11248.493817778057;11257.718557035812;11261.774764504828;9481.905180948102;9949.452780097165;9989.800203995734;10011.199104071802;10041;7243.384312333511;9716.271279653913;9903.207743380657;9910.454924979196;9919.702408927744 03:31:55 INFO - PROCESS | 1683 | __end_tp_report 03:31:55 INFO - PROCESS | 1683 | __start_cc_report 03:31:55 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1178 03:31:55 INFO - PROCESS | 1683 | __end_cc_report 03:31:55 INFO - PROCESS | 1683 | __startTimestamp1456399915851__endTimestamp 03:31:55 INFO - PROCESS | 1683 | 03:31:55 INFO - PROCESS | 1683 | ------- Summary: start ------- 03:31:55 INFO - PROCESS | 1683 | Number of tests: 6 03:31:55 INFO - PROCESS | 1683 | 03:31:55 INFO - PROCESS | 1683 | [#0] dojo.html Cycles:165 Average:5737.49 Median:5974.79 stddev:686.47 (11.5%) stddev-sans-first:640.52 03:31:55 INFO - PROCESS | 1683 | Values: 2520.8 2936.9 3498.9 3540.1 3596.6 5585.9 5665.2 5696.5 5697.1 5749.1 5765.6 5807.6 5812.0 5970.2 5981.2 4705.9 5070.3 5090.1 5140.9 5217.3 4383.9 5248.0 5283.7 5303.3 5304.2 5107.2 5123.8 5210.2 5227.9 5256.2 5191.6 5199.5 5204.3 5208.8 5211.6 5159.4 5165.4 5175.8 5200.5 5231.8 5555.6 5621.8 5669.7 5700.0 5754.8 6242.2 6279.9 6316.6 6324.4 6325.7 5181.2 5339.4 6320.7 6348.9 6352.0 5724.9 5805.8 5809.8 5817.5 5830.7 6215.9 6239.1 6319.6 6324.4 6329.4 6158.8 6189.6 6196.5 6204.8 6218.0 6239.1 6275.8 6282.5 6289.1 6322.4 6081.7 6153.6 6160.3 6239.4 6273.8 6289.9 6296.0 6314.0 6314.9 6324.0 4869.9 4870.8 4903.0 4926.2 4956.5 4411.8 4422.8 4449.1 4503.7 4505.8 5722.9 5730.8 5733.8 5751.1 5787.0 6185.9 6223.8 6333.1 6334.6 6342.7 5715.2 5720.2 5721.4 5740.7 5744.7 5390.2 5403.4 5406.8 5413.1 5413.6 6217.5 6275.0 6324.5 6328.3 6348.8 6305.7 6322.1 6333.1 6335.8 6336.0 6323.9 6327.6 6329.1 6343.3 6345.9 5843.2 5964.8 6063.8 6263.9 6280.6 6244.3 6269.4 6291.4 6291.5 6312.1 4711.1 5959.4 6129.3 6131.6 6169.4 5993.5 6057.6 6099.4 6127.8 6130.1 6044.6 6063.9 6064.3 6069.1 6072.3 5957.6 6132.4 6142.7 6184.8 6193.5 5863.3 5974.8 5998.0 6053.6 6086.2 03:31:55 INFO - PROCESS | 1683 | 03:31:55 INFO - PROCESS | 1683 | [#1] ext.html Cycles:180 Average:64362.63 Median:40448.49 stddev:135217.55 (334.3%) stddev-sans-first:135511.92 03:31:55 INFO - PROCESS | 1683 | Values: 522.6 553.6 566.3 569.3 624.7 37702.8 38066.6 38087.2 38131.6 38435.8 43699.3 44558.8 44600.6 44645.8 44661.0 9570.9 9788.5 9789.0 9805.7 9817.2 9650.4 9792.7 9793.0 9802.3 9806.3 9748.3 9831.9 9835.6 9875.0 9879.5 9723.2 9805.3 9822.3 9826.0 9840.6 9614.1 9745.7 9750.9 9750.9 9751.6 32161.5 40448.0 40449.0 40489.0 40489.4 1635.1 3264.8 3276.8 3281.9 3286.8 21996.0 22238.6 27014.2 28312.9 28412.1 2744.2 2749.6 2767.9 2831.2 2891.7 354709.0 355394.0 357449.0 357788.0 359230.0 64335.0 64461.0 64621.7 64692.7 64870.0 67138.7 67295.7 67329.3 67397.7 67480.0 16386.5 16579.4 16596.8 16604.0 16616.8 12662.6 12718.6 12724.3 12725.0 12728.9 20003.9 20789.5 20790.5 20811.9 20863.6 8503.6 8722.7 8765.2 8778.5 8850.4 952.6 962.6 966.2 990.8 1077.9 23370.9 27691.0 28153.2 28518.3 28562.3 935.9 953.2 980.7 1088.5 1153.9 14463.9 15150.2 15259.8 15364.3 15612.8 499206.5 637824.0 652818.7 653228.0 655959.0 60374.4 61067.7 61068.0 61216.1 61244.7 1422.5 1431.3 1448.3 1454.2 1454.3 30050.7 30182.0 30231.0 30753.8 30898.7 51072.0 51470.7 51549.7 51594.0 51676.2 502062.0 504485.0 505119.0 505431.0 507475.0 33312.0 43730.6 43773.6 44813.8 44822.6 44623.7 44692.0 44732.6 44763.3 45786.9 35557.5 36793.1 37390.6 37576.6 37750.8 34803.1 36584.9 37087.4 37679.8 38569.6 31989.8 36212.5 37261.0 37472.7 37541.6 27010.5 27703.6 33946.7 34011.3 34169.5 25037.0 25467.6 25550.6 25684.7 25894.0 03:31:55 INFO - PROCESS | 1683 | 03:31:55 INFO - PROCESS | 1683 | [#2] jquery.html Cycles:180 Average:34584.58 Median:447.97 stddev:105464.52 (23542.9%) stddev-sans-first:105729.05 03:31:55 INFO - PROCESS | 1683 | Values: 354.9 363.4 363.6 369.6 371.4 15890.7 16407.6 19067.6 19732.0 20554.7 19513.7 19846.7 20169.3 20782.9 20801.1 5551.2 5612.9 5750.1 5776.0 5837.0 4082.1 4286.9 5725.3 6069.7 6320.4 6242.7 6252.4 6256.2 6263.6 6265.6 5333.2 6069.3 6160.4 6262.1 6272.8 5386.5 5413.2 5425.1 5428.5 5438.0 23827.6 24698.4 24748.6 25050.6 25248.6 2315.4 2429.7 2719.6 2800.2 2858.4 14238.6 14552.9 14733.8 14941.4 15067.5 1768.6 1773.8 1783.9 1797.1 1800.9 105309.5 106280.5 107160.0 108135.0 109939.4 10048.7 10604.2 10620.5 10686.3 10710.8 12579.4 12676.5 12711.3 12711.9 12716.0 8330.2 8432.3 8436.5 8482.3 8490.1 8632.7 8643.1 8660.6 8741.5 8742.9 6102.5 6199.6 6205.7 6207.6 6258.0 1579.2 1588.8 1711.6 1733.3 1733.9 398.3 406.4 407.1 976.6 1020.2 11271.2 11962.5 12018.8 12027.0 12031.0 447.7 448.2 450.9 457.3 464.7 6128.5 6133.5 6152.1 6193.3 6213.7 586066.5 634626.0 647515.0 652593.0 652810.7 100272.0 124888.0 131805.0 132409.7 132556.3 459.7 465.7 466.7 468.0 469.1 9294.9 11177.4 11238.5 11245.7 11276.5 46412.5 49330.8 49331.0 49373.0 49755.0 62992.1 68160.3 69261.7 72232.6 79250.6 7887.8 8047.3 8220.0 8302.7 8352.7 10884.5 12074.4 13108.3 13571.8 13743.5 7505.6 8400.1 8983.0 11127.9 11817.9 6634.8 8007.9 8107.2 8337.5 8370.9 8585.3 8599.6 8657.4 8737.9 8794.0 8861.5 9468.9 10204.6 12286.3 12373.4 10742.2 11297.3 12052.8 12100.2 12136.9 03:31:55 INFO - PROCESS | 1683 | 03:31:55 INFO - PROCESS | 1683 | [#3] mootools.html Cycles:180 Average:5903.27 Median:5356.61 stddev:3124.01 (58.3%) stddev-sans-first:3114.36 03:31:55 INFO - PROCESS | 1683 | Values: 1391.0 1484.9 1536.4 1751.0 1925.8 7658.6 8247.4 8438.7 8455.9 8483.7 6893.4 7896.2 8165.2 8178.4 8198.3 2123.6 2361.8 2390.0 2422.9 2426.6 2025.9 2452.5 2454.0 2454.7 2461.3 2363.4 2412.0 2421.5 2421.9 2431.6 2374.7 2422.5 2422.6 2427.1 2433.9 2387.3 2416.4 2439.7 2440.7 2447.2 8520.5 8591.9 8593.5 8601.9 8602.0 5232.2 5341.1 5345.3 5362.8 5375.5 3536.0 3628.7 3669.0 3675.8 3676.0 1031.3 1052.6 1057.9 1081.7 1085.4 11436.1 11481.3 11482.5 11491.1 11502.9 4157.6 4718.2 4797.6 4857.3 4857.7 9921.0 9948.9 9952.2 9952.8 9961.9 5329.4 5346.0 5350.4 5371.1 5389.8 4303.2 4431.3 4722.4 4871.2 4871.3 3863.8 3922.2 3964.4 3976.1 3978.5 1107.8 1266.9 1274.4 1277.9 1296.4 1081.7 1099.5 1103.3 1152.1 1235.6 7957.5 7963.2 7971.9 8018.7 8078.9 507.3 519.0 522.6 524.6 524.6 6087.6 6100.4 6138.5 6142.4 6148.5 10174.0 10274.9 10278.5 10421.9 10438.4 10066.5 10268.7 10305.7 10306.6 10330.2 8051.4 8100.3 8100.5 8115.2 8173.3 7943.5 7960.9 7969.6 8039.5 8075.8 9240.0 9400.0 9505.9 9584.8 9605.5 9607.7 9811.5 9831.7 9941.4 9964.2 6718.4 6906.9 7188.0 7414.6 7543.2 8064.9 8124.3 8141.0 8147.3 8148.9 7071.5 7162.8 7174.1 7292.4 7299.2 7081.4 7088.5 7132.8 7226.3 7237.5 7347.2 7621.6 7625.0 7638.0 7640.7 6880.2 6943.7 6957.7 6960.0 6961.4 6913.4 7027.6 7028.6 7033.1 7045.2 03:31:55 INFO - PROCESS | 1683 | 03:31:55 INFO - PROCESS | 1683 | [#4] prototype.html Cycles:180 Average:5735.60 Median:6538.73 stddev:1837.00 (28.1%) stddev-sans-first:1795.66 03:31:55 INFO - PROCESS | 1683 | Values: 263.9 323.0 328.0 328.8 334.7 6436.3 6604.9 6608.6 6631.2 6662.2 6473.5 6554.8 6559.2 6562.1 6564.8 4579.8 4703.8 4840.1 4855.9 4860.2 4694.9 4784.2 4784.5 4800.5 4815.4 4731.7 4738.0 4747.3 4762.7 4819.0 4569.9 4608.4 4732.4 4797.5 4801.4 4073.6 4079.3 4084.0 4090.3 4094.3 6186.7 6224.6 6225.2 6226.9 6234.7 5605.9 5615.9 5618.5 5619.3 5627.8 6932.7 6945.5 6947.3 6958.5 6967.2 4444.6 4615.3 4631.7 4655.5 4660.8 6887.3 7250.1 7286.1 7303.2 7315.3 3827.3 4705.6 4707.1 4709.7 4719.9 4778.6 4782.8 4788.0 4790.2 4795.9 5599.1 5612.9 5616.3 5616.7 5626.3 6682.9 6951.7 6954.3 6987.8 6995.8 1377.9 1393.3 1659.6 1681.5 1685.2 1014.5 1082.8 1083.0 1097.2 1111.1 5271.9 6297.4 6382.4 6531.5 6548.8 7338.6 7341.8 7349.0 7352.0 7354.7 6522.6 6535.1 6536.3 6541.2 6542.8 3818.9 3855.9 3871.5 3872.8 3878.1 7212.1 7603.0 7636.7 7637.1 7642.8 7462.0 7557.1 7562.5 7565.3 7568.5 7589.2 7592.7 7599.8 7601.8 7609.2 7012.1 7328.9 7336.4 7344.9 7350.7 7043.4 7106.6 7116.0 7127.5 7127.8 7556.2 7577.0 7591.5 7592.3 7603.5 4588.0 4626.3 4645.2 4647.0 4656.1 7017.9 7277.7 7286.7 7304.9 7306.6 6983.9 6998.6 7025.3 7036.5 7046.1 6137.9 6416.6 6923.0 6940.3 6943.9 6876.6 6883.9 6885.0 6895.6 6904.0 6750.8 7039.1 7050.6 7060.7 7081.3 6632.7 6780.4 6841.3 6900.1 6912.6 03:31:55 INFO - PROCESS | 1683 | 03:31:55 INFO - PROCESS | 1683 | [#5] yui.html Cycles:180 Average:17696.35 Median:616.95 stddev:24839.07 (4026.1%) stddev-sans-first:24875.82 03:31:55 INFO - PROCESS | 1683 | Values: 662.4 729.9 738.7 741.1 762.2 12093.0 14943.0 15046.7 15131.8 15154.8 11172.8 13494.5 13543.9 13570.0 13577.5 833.6 859.4 865.1 869.1 874.4 858.5 865.8 866.3 870.2 871.4 906.1 906.3 906.8 909.6 914.6 902.6 902.7 903.2 903.6 907.8 645.5 675.3 676.3 680.0 680.2 15039.3 15079.0 15093.6 15128.8 15158.8 12343.3 12429.9 12478.6 12642.1 12901.9 8178.6 10207.4 10217.9 10331.1 10639.9 3419.3 3488.1 3520.0 3560.0 3651.1 58635.4 70369.0 71338.3 73885.6 81164.0 9172.0 9333.7 9415.5 9422.6 9879.2 19750.2 19750.8 19759.8 19783.5 20667.6 7316.7 7436.9 7551.8 7658.9 7696.8 4030.8 4087.7 4087.8 4096.8 4098.7 3549.8 3558.8 3571.2 3572.8 3574.2 532.0 641.2 650.1 675.4 678.1 553.9 583.9 598.4 627.0 628.5 8413.7 8591.0 8622.8 8716.8 8761.4 537.3 545.6 612.9 621.0 632.5 3615.2 3939.8 4315.8 4430.5 4445.4 96729.0 97782.0 98415.5 99684.0 99692.0 66512.7 71326.6 71709.0 72555.3 77050.0 54276.0 68199.3 68244.7 68378.7 69238.3 8535.1 8560.8 8725.4 8803.5 8933.6 40152.8 46197.0 47924.8 52272.0 53115.5 53389.0 66119.0 67149.7 69448.3 69611.0 10850.2 11031.6 11046.7 11116.1 11522.3 10827.5 10958.1 10979.3 11027.7 11211.8 11411.8 11414.8 11418.5 11430.2 11446.3 11456.4 11473.1 11481.4 11496.1 11499.1 11222.4 11243.9 11248.5 11257.7 11261.8 9481.9 9949.5 9989.8 10011.2 10041.0 7243.4 9716.3 9903.2 9910.5 9919.7 03:31:55 INFO - PROCESS | 1683 | -------- Summary: end -------- 03:31:55 INFO - PROCESS | 1683 | 03:31:56 INFO - TEST-INFO | 1683: exit 0 03:31:56 INFO - TEST-OK | dromaeo_css | took 1113344ms 03:31:56 INFO - TEST-START | kraken 03:31:56 INFO - operating with platform_type : mac_ 03:31:56 INFO - Initialising browser for kraken test... 03:31:56 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpJcVZTd/profile http://localhost:49278/getInfo.html) 03:31:58 INFO - PROCESS | 1694 | __metrics Screen width/height:1600/1200 03:31:58 INFO - PROCESS | 1694 | colorDepth:24 03:31:58 INFO - PROCESS | 1694 | Browser inner width/height: 1024/689 03:31:58 INFO - PROCESS | 1694 | __metrics 03:31:58 INFO - PROCESS | 1694 | 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" 03:31:58 INFO - PROCESS | 1694 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:31:59 INFO - TEST-INFO | 1694: exit 0 03:31:59 INFO - Browser initialized. 03:31:59 INFO - Running cycle 1/1 for kraken test... 03:31:59 INFO - TEST-INFO | started process 1696 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/T/tmpJcVZTd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:32:11 INFO - PROCESS | 1696 | RSS: Main: 243802112 03:32:11 INFO - PROCESS | 1696 | 03:32:14 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 03:32:14 INFO - PROCESS | 1696 | RSS: Main: 290873344 03:32:14 INFO - PROCESS | 1696 | 03:32:17 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 03:32:17 INFO - PROCESS | 1696 | RSS: Main: 300552192 03:32:17 INFO - PROCESS | 1696 | 03:32:21 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 03:32:21 INFO - PROCESS | 1696 | RSS: Main: 288468992 03:32:21 INFO - PROCESS | 1696 | 03:32:23 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 03:32:24 INFO - PROCESS | 1696 | RSS: Main: 288272384 03:32:24 INFO - PROCESS | 1696 | 03:32:26 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:32:27 INFO - PROCESS | 1696 | RSS: Main: 289378304 03:32:27 INFO - PROCESS | 1696 | 03:32:29 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 03:32:30 INFO - PROCESS | 1696 | RSS: Main: 288706560 03:32:30 INFO - PROCESS | 1696 | 03:32:33 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 03:32:33 INFO - PROCESS | 1696 | RSS: Main: 290328576 03:32:33 INFO - PROCESS | 1696 | 03:32:36 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 03:32:37 INFO - PROCESS | 1696 | RSS: Main: 291192832 03:32:37 INFO - PROCESS | 1696 | 03:32:38 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:32:39 INFO - PROCESS | 1696 | RSS: Main: 322854912 03:32:39 INFO - PROCESS | 1696 | 03:32:41 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:32:41 INFO - PROCESS | 1696 | RSS: Main: 323100672 03:32:41 INFO - PROCESS | 1696 | 03:32:43 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:32:44 INFO - PROCESS | 1696 | RSS: Main: 331448320 03:32:44 INFO - PROCESS | 1696 | 03:32:47 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:32:47 INFO - PROCESS | 1696 | RSS: Main: 333189120 03:32:47 INFO - PROCESS | 1696 | 03:32:50 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:32:50 INFO - PROCESS | 1696 | RSS: Main: 334364672 03:32:50 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 03:32:52 INFO - PROCESS | 1696 | RSS: Main: 394313728 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | __start_tp_report 03:32:52 INFO - PROCESS | 1696 | _x_x_mozilla_page_load 03:32:52 INFO - PROCESS | 1696 | _x_x_mozilla_page_load_details 03:32:52 INFO - PROCESS | 1696 | |i|pagename|runs| 03:32:52 INFO - PROCESS | 1696 | |0;ai-astar;110;107;111;108;111;110;117;110;110;110 03:32:52 INFO - PROCESS | 1696 | |1;audio-beat-detection;157;122;146;150;116;147;158;116;159;121 03:32:52 INFO - PROCESS | 1696 | |2;audio-dft;184;185;189;186;199;268;183;185;181;183 03:32:52 INFO - PROCESS | 1696 | |3;audio-fft;77;77;88;78;56;57;58;84;76;55 03:32:52 INFO - PROCESS | 1696 | |4;audio-oscillator;96;99;138;64;79;111;111;71;108;145 03:32:52 INFO - PROCESS | 1696 | |5;imaging-gaussian-blur;86;91;87;92;87;91;85;91;85;91 03:32:52 INFO - PROCESS | 1696 | |6;imaging-darkroom;95;95;98;95;95;103;143;113;95;95 03:32:52 INFO - PROCESS | 1696 | |7;imaging-desaturate;87;86;84;87;87;85;87;88;86;87 03:32:52 INFO - PROCESS | 1696 | |8;json-parse-financial;55;55;54;53;53;53;54;63;53;52 03:32:52 INFO - PROCESS | 1696 | |9;json-stringify-tinderbox;69;68;65;73;71;66;65;66;67;68 03:32:52 INFO - PROCESS | 1696 | |10;stanford-crypto-aes;83;81;82;82;84;83;82;83;83;85 03:32:52 INFO - PROCESS | 1696 | |11;stanford-crypto-ccm;125;136;128;130;119;121;119;134;127;136 03:32:52 INFO - PROCESS | 1696 | |12;stanford-crypto-pbkdf2;139;128;138;142;172;171;139;135;135;121 03:32:52 INFO - PROCESS | 1696 | |13;stanford-crypto-sha256-iterative;67;67;65;67;71;78;96;92;95;67 03:32:52 INFO - PROCESS | 1696 | __end_tp_report 03:32:52 INFO - PROCESS | 1696 | __start_cc_report 03:32:52 INFO - PROCESS | 1696 | _x_x_mozilla_cycle_collect,1263 03:32:52 INFO - PROCESS | 1696 | __end_cc_report 03:32:52 INFO - PROCESS | 1696 | __startTimestamp1456399972970__endTimestamp 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | ------- Summary: start ------- 03:32:52 INFO - PROCESS | 1696 | Number of tests: 14 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#0] ai-astar Cycles:10 Average:110.40 Median:110.00 stddev:2.63 (2.4%) stddev-sans-first:2.79 03:32:52 INFO - PROCESS | 1696 | Values: 110.0 107.0 111.0 108.0 111.0 110.0 117.0 110.0 110.0 110.0 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:148.50 stddev:18.23 (12.3%) stddev-sans-first:18.16 03:32:52 INFO - PROCESS | 1696 | Values: 157.0 122.0 146.0 150.0 116.0 147.0 158.0 116.0 159.0 121.0 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#2] audio-dft Cycles:10 Average:194.30 Median:185.50 stddev:26.38 (14.2%) stddev-sans-first:27.71 03:32:52 INFO - PROCESS | 1696 | Values: 184.0 185.0 189.0 186.0 199.0 268.0 183.0 185.0 181.0 183.0 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#3] audio-fft Cycles:10 Average:70.60 Median:77.00 stddev:12.69 (16.5%) stddev-sans-first:13.24 03:32:52 INFO - PROCESS | 1696 | Values: 77.0 77.0 88.0 78.0 56.0 57.0 58.0 84.0 76.0 55.0 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#4] audio-oscillator Cycles:10 Average:102.20 Median:67.50 stddev:26.50 (39.3%) stddev-sans-first:28.02 03:32:52 INFO - PROCESS | 1696 | Values: 96.0 99.0 138.0 64.0 79.0 111.0 111.0 71.0 108.0 145.0 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:91.00 stddev:2.84 (3.1%) stddev-sans-first:2.85 03:32:52 INFO - PROCESS | 1696 | Values: 86.0 91.0 87.0 92.0 87.0 91.0 85.0 91.0 85.0 91.0 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#6] imaging-darkroom Cycles:10 Average:102.70 Median:95.00 stddev:15.30 (16.1%) stddev-sans-first:15.98 03:32:52 INFO - PROCESS | 1696 | Values: 95.0 95.0 98.0 95.0 95.0 103.0 143.0 113.0 95.0 95.0 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#7] imaging-desaturate Cycles:10 Average:86.40 Median:87.00 stddev:1.17 (1.3%) stddev-sans-first:1.22 03:32:52 INFO - PROCESS | 1696 | Values: 87.0 86.0 84.0 87.0 87.0 85.0 87.0 88.0 86.0 87.0 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:54.00 stddev:3.14 (5.8%) stddev-sans-first:3.32 03:32:52 INFO - PROCESS | 1696 | Values: 55.0 55.0 54.0 53.0 53.0 53.0 54.0 63.0 53.0 52.0 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:2.62 (3.8%) stddev-sans-first:2.74 03:32:52 INFO - PROCESS | 1696 | Values: 69.0 68.0 65.0 73.0 71.0 66.0 65.0 66.0 67.0 68.0 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:1.14 (1.4%) stddev-sans-first:1.20 03:32:52 INFO - PROCESS | 1696 | Values: 83.0 81.0 82.0 82.0 84.0 83.0 82.0 83.0 83.0 85.0 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#11] stanford-crypto-ccm Cycles:10 Average:127.50 Median:129.00 stddev:6.55 (5.1%) stddev-sans-first:6.89 03:32:52 INFO - PROCESS | 1696 | Values: 125.0 136.0 128.0 130.0 119.0 121.0 119.0 134.0 127.0 136.0 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.00 Median:139.00 stddev:16.70 (12.0%) stddev-sans-first:17.68 03:32:52 INFO - PROCESS | 1696 | Values: 139.0 128.0 138.0 142.0 172.0 171.0 139.0 135.0 135.0 121.0 03:32:52 INFO - PROCESS | 1696 | 03:32:52 INFO - PROCESS | 1696 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.50 Median:74.50 stddev:12.86 (17.3%) stddev-sans-first:13.17 03:32:52 INFO - PROCESS | 1696 | Values: 67.0 67.0 65.0 67.0 71.0 78.0 96.0 92.0 95.0 67.0 03:32:52 INFO - PROCESS | 1696 | -------- Summary: end -------- 03:32:52 INFO - PROCESS | 1696 | 03:32:53 INFO - TEST-INFO | 1696: exit 0 03:32:53 INFO - TEST-OK | kraken | took 57281ms 03:32:53 INFO - SUITE-END | took 1170s 03:32:54 INFO - Completed test suite (00:19:31) 03:32:54 INFO - Working with test: dromaeo_css 03:32:54 INFO - Generating results file: dromaeo_css 03:32:54 INFO - Working with test: kraken 03:32:54 INFO - Generating results file: kraken 03:32:54 INFO - javascript benchmark 03:32:54 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:32:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 03:32:54 INFO - process_Request line: dromaeo_css 7363.64 graph.html#tests=[[72,1,59]] 03:32:54 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:32:54 INFO - process_Request line: kraken 1445.50 graph.html#tests=[[232,1,59]] 03:32:54 INFO - RETURN: dromaeo_css: 7363.64 03:32:54 INFO - RETURN: kraken: 1445.50 03:32:54 INFO - javascript benchmark 03:32:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2520.8109391795615, 2936.8531573421324, 3498.895033149005, 3540.1149712571855, 3596.568411790584, 5585.944140558593, 5665.150227465882, 5696.515796157327, 5697.116946873241, 5749.108888122342, 5765.567582431314, 5807.593468457209, 5812.0410132328225, 5970.223870896788, 5981.16263723078, 4705.882352941169, 5070.264811602316, 5090.134677104883, 5140.922886156711, 5217.2695822584865, 4383.9342409863875, 5247.973760131194, 5283.682979021251, 5303.257543943851, 5304.17785243286, 5107.233914912774, 5123.795048198068, 5210.2445145453885, 5227.947720522784, 5256.185291279858, 5191.558717508979, 5199.506046925536, 5204.297419848348, 5208.765605547759, 5211.583073354161, 5159.432462429129, 5165.354330708661, 5175.844724658266, 5200.479952004807, 5231.8168864089575, 5555.638883472561, 5621.7751289948355, 5669.659820410789, 5700.0, 5754.827355179351, 6242.188515492957, 6279.905801412982, 6316.62100273985, 6324.367563243685, 6325.683715814191, 5181.248718935733, 5339.359276886759, 6320.74717011319, 6348.904766428507, 6352.047192921053, 5724.914126288109, 5805.767769289181, 5809.796657116981, 5817.476427121537, 5830.7084645767545, 6215.906761398583, 6239.095331176954, 6319.55763096588, 6324.367563243731, 6329.398707122816, 6158.815235542941, 6189.6286222826775, 6196.535259855439, 6204.844878877974, 6218.0, 6239.095331176954, 6275.843103922439, 6282.528810339243, 6289.119523266746, 6322.367763223733, 6081.665508396992, 6153.630782153085, 6160.322364539897, 6239.376062393724, 6273.843153921097, 6289.8742025159245, 6295.96852015737, 6314.0, 6314.936850631527, 6324.0, 4869.853904382803, 4870.756462176877, 4903.0, 4926.211806111077, 4956.479569645207, 4411.801468933906, 4422.778861056934, 4449.087936972913, 4503.707259028152, 4505.819767209275, 5722.885542289131, 5730.770769169187, 5733.799317023884, 5751.13732940054, 5786.971065144731, 6185.907211391833, 6223.782167624111, 6333.113364129025, 6334.5565810393755, 6342.682865856688, 5715.228444160069, 5720.227769251098, 5721.370649228582, 5740.655560666373, 5744.741486633112, 5390.164524498709, 5403.351597808288, 5406.756695948692, 5413.079776438015, 5413.593980451482, 6217.502599792006, 6275.0, 6324.462420694201, 6328.335524769833, 6348.809535713936, 6305.747770089145, 6322.083297921868, 6333.081703153109, 6335.809925702236, 6336.017917222838, 6323.873522529431, 6327.557071004985, 6329.082283069021, 6343.270523889812, 6345.904811427925, 5843.2403787507355, 5964.807038592386, 6063.848403789941, 6263.937360626518, 6280.591761535486, 6244.250689917058, 6269.404406581368, 6291.402316779899, 6291.528135389773, 6312.084747711648, 4711.128441238382, 5959.374265702038, 6129.325774164749, 6131.601445906002, 6169.383061693795, 5993.520518358608, 6057.57596968208, 6099.370313949917, 6127.769884593299, 6130.111133885651, 6044.637321760709, 6063.909041364295, 6064.302605200459, 6069.089636554552, 6072.332043475126, 5957.553183511167, 6132.41742034506, 6142.687538036454, 6184.81445556634, 6193.535484838565, 5863.296404431496, 5974.790882319098, 5997.970010149921, 6053.576249662481, 6086.239220097488], "unit": "score", "name": "dojo.html", "value": 5691.372822338667}, {"lowerIsBetter": false, "replicates": [522.5584381197887, 553.5820455556058, 566.2893069198154, 569.3367227180335, 624.6626821516381, 37702.81148594257, 38066.61933380665, 38087.23825523488, 38131.618683813154, 38435.80782096092, 43699.34450983238, 44558.777206114006, 44600.553994460046, 44645.77677111618, 44661.0, 9570.856437153448, 9788.461634610094, 9788.951055244714, 9805.705828825112, 9817.214622830192, 9650.372725772837, 9792.657256996006, 9792.951035244849, 9802.264830137732, 9806.264530160232, 9748.26887983404, 9831.852522212173, 9835.557399916985, 9874.9506252469, 9879.506024698772, 9723.22214222864, 9805.31362804604, 9822.263330250189, 9826.0, 9840.557174927146, 9614.134727874454, 9745.707628771148, 9750.853737193947, 9750.90249097507, 9751.561179746928, 32161.517577236362, 40448.0, 40448.98877528056, 40489.0, 40489.39265911013, 1635.0608203915574, 3264.820434876081, 3276.7870088444174, 3281.9343613127844, 3286.753493487974, 21996.0, 22238.555228895493, 27014.189574312604, 28312.858435707894, 28412.147635570967, 2744.19046381318, 2749.6425464689664, 2767.9446411071667, 2831.178958102148, 2891.7323424530146, 354709.0, 355394.0, 357449.0, 357788.0, 359230.0, 64335.0, 64461.03308450377, 64621.67689161524, 64692.70614587682, 64870.0, 67138.66430667913, 67295.66352168207, 67329.32670673328, 67397.66301168462, 67480.0, 16386.508404747878, 16579.419720309732, 16596.83403165977, 16604.003759774452, 16616.83383166177, 12662.556810511587, 12718.554850580185, 12724.300163491096, 12725.0, 12728.872711272768, 20003.899980500297, 20789.480262993548, 20790.480237994172, 20811.855347955705, 20863.582728345653, 8503.61733721984, 8722.69159626061, 8765.167309105625, 8778.517181555077, 8850.380473366802, 952.64752041745, 962.552413127899, 966.1642679082543, 990.8018396320765, 1077.8975997280245, 23370.883145584165, 27691.0, 28153.15540533787, 28518.287042823682, 28562.285942851595, 935.9143393663454, 953.2469349214182, 980.7106903463496, 1088.5373716170595, 1153.8846115388394, 14463.92768036153, 15150.242487875563, 15259.771103433457, 15364.308606112752, 15612.843871561367, 499206.5039674851, 637824.0, 652818.7359063175, 653228.0, 655959.0, 60374.396256036875, 61067.69466152641, 61068.0, 61216.081758772765, 61244.69377653083, 1422.50923431416, 1431.3487363249697, 1448.2541491132286, 1454.2292584929792, 1454.331007736432, 30050.699493005664, 30182.0, 30231.0, 30753.846230768704, 30898.69101308958, 51072.0, 51470.742646286526, 51549.71125721887, 51594.0, 51676.22485662643, 502062.0, 504485.0, 505119.0, 505431.0, 507475.0, 33312.0, 43730.562694372646, 43773.562264376946, 44813.77593112014, 44822.551774483145, 44623.66129016135, 44692.0, 44732.55267447284, 44763.32855007242, 45786.85532861572, 35557.466638000966, 36793.08017299589, 37390.62609373871, 37576.62423375731, 37750.811245943594, 34803.12992175216, 36584.90245292646, 37087.443688345236, 37679.811600942914, 38569.6143038566, 31989.840050799598, 36212.456813148354, 37261.0, 37472.688455905, 37541.624583753815, 27010.459790804467, 27703.58444623292, 33946.66053339435, 34011.31977360488, 34169.48745768766, 25037.0, 25467.617985730598, 25550.616740749276, 25684.743152568237, 25894.0], "unit": "score", "name": "ext.html", "value": 19886.75460169152}, {"lowerIsBetter": false, "replicates": [354.89175801380577, 363.4475597092418, 363.5782492308922, 369.58975537153754, 371.3519907760954, 15890.682186356265, 16407.605353544932, 19067.618647627038, 19732.0, 20554.69167962482, 19513.70729439056, 19846.702299465484, 20169.294074707388, 20782.89608551955, 20801.063952122153, 5551.1673249012565, 5612.859678508029, 5750.079987202049, 5776.0, 5836.970815145918, 4082.142750022499, 4286.87139385819, 5725.255716756837, 6069.696515174246, 6320.399562041599, 6242.687865606724, 6252.406021427957, 6256.155419018442, 6263.561550691454, 6265.592736472137, 5333.2000199970125, 6069.271687397496, 6160.414760597736, 6262.091996660504, 6272.8118156455375, 5386.515213630752, 5413.188021796723, 5425.131978883399, 5428.538574221196, 5438.0, 23827.642585361235, 24698.382540436454, 24748.628770568277, 25050.624240636404, 25248.621270680953, 2315.4327189838427, 2429.6962879640046, 2719.619253304539, 2800.215939536933, 2858.399736055431, 14238.644033899132, 14552.927235363755, 14733.778993315109, 14941.402343906231, 15067.4726384576, 1768.6285879965224, 1773.796013458456, 1783.8572914166834, 1797.1014492753623, 1800.9459716208403, 105309.47345263224, 106280.4685976573, 107160.0, 108135.0, 109939.35090973641, 10048.748781280381, 10604.204684648528, 10620.468976551296, 10686.305390149615, 10710.785784284271, 12579.433925473375, 12676.492940282285, 12711.30087845159, 12711.872881271254, 12716.0, 8330.166983301622, 8432.283255923192, 8436.45163064399, 8482.279006284534, 8490.108538603357, 8632.654693812303, 8643.09247529013, 8660.566971651393, 8741.519216443157, 8742.912570874338, 6102.511799056065, 6199.597026193283, 6205.6586887720705, 6207.565470417027, 6257.968710156511, 1579.1867188397985, 1588.816331832792, 1711.5977745229861, 1733.3153404405189, 1733.9219735111951, 398.26520070470514, 406.3843277434689, 407.0942153708035, 976.5556671714353, 1020.1991436722137, 11271.154663400277, 11962.450152329562, 12018.75962480763, 12027.0, 12031.0, 447.72017489069333, 448.2156226603444, 450.90981803639403, 457.32316172064867, 464.6933024204009, 6128.479079278222, 6133.539984501181, 6152.107944348045, 6193.318734939153, 6213.720382582795, 586066.5326814047, 634626.0, 647515.0, 652593.0, 652810.7359463172, 100272.0, 124888.0, 131805.0, 132409.67590323972, 132556.3372183133, 459.68281885498897, 465.73220398271127, 466.7409587678803, 468.0451878168498, 469.1133757198897, 9294.932294823217, 11177.441127943734, 11238.494267757807, 11245.662630121109, 11276.492557835081, 46412.53587464217, 49330.766730832016, 49331.02675892924, 49373.0, 49755.0, 62992.11023669297, 68160.31839681539, 69261.65369173324, 72232.63883680548, 79250.6037469809, 7887.763367098996, 8047.275745182962, 8220.0, 8302.667893284442, 8352.665893364441, 10884.455777211266, 12074.39628018613, 13108.344582771015, 13571.79642305386, 13743.518976835763, 7505.568450915407, 8400.117987611213, 8982.955085224532, 11127.944360278147, 11817.881821182022, 6634.772567075107, 8007.879881801661, 8107.1892810718455, 8337.499750015018, 8370.916290837014, 8585.270252028648, 8599.613017414356, 8657.350698697497, 8737.91262087371, 8794.0, 8861.468311901306, 9468.857967130636, 10204.642837500653, 12286.324252166216, 12373.443195056425, 10742.194335424718, 11297.26567773092, 12052.819207712068, 12100.152989290666, 12136.939315303367], "unit": "score", "name": "jquery.html", "value": 8567.002484344075}, {"lowerIsBetter": false, "replicates": [1391.0, 1484.9183294918778, 1536.431520337475, 1750.9737353939693, 1925.8170473804992, 7658.578778167205, 8247.381446391522, 8438.746837594867, 8455.873161902577, 8483.745487635366, 6893.4140598049225, 7896.210378962115, 8165.183481651832, 8178.427510074297, 8198.303144232732, 2123.649597816366, 2361.8346715729904, 2389.9880500597474, 2422.9030838766516, 2426.5874801283735, 2025.8885761283123, 2452.5217582571404, 2454.006127518358, 2454.6808914841135, 2461.3477428481465, 2363.409147713072, 2411.987940060306, 2421.4672771990136, 2421.878906054699, 2431.550163219801, 2374.655674927126, 2422.515496900627, 2422.5760491913934, 2427.053449154831, 2433.8904749286326, 2387.271882075966, 2416.4442178298914, 2439.7194322652945, 2440.6827112475444, 2447.204658485999, 8520.531370774605, 8591.914080859236, 8593.527355995418, 8601.870971935426, 8601.95699021507, 5232.189010703347, 5341.1187154119525, 5345.251664766935, 5362.839114826562, 5375.462453754632, 3535.9646403535894, 3628.6734193922675, 3669.027707657473, 3675.7978311192874, 3675.981620091909, 1031.3296357367697, 1052.5631862776938, 1057.9471026448646, 1081.691717860414, 1085.3813326403954, 11436.142289328334, 11481.253718508271, 11482.48328825205, 11491.080713542897, 11502.907223813641, 4157.64660003897, 4718.2214934536105, 4797.592204662643, 4857.319975203474, 4857.659963802571, 9920.950395247977, 9948.850767238497, 9952.15406690425, 9952.751181220527, 9961.850572241423, 5329.360476742816, 5346.010987967238, 5350.38470575881, 5371.113766228606, 5389.757460914268, 4303.225419424533, 4431.268840641258, 4722.433308003062, 4871.244957031666, 4871.269309603517, 3863.787491687984, 3922.156736301709, 3964.365701487748, 3976.1252524444576, 3978.462907507507, 1107.8449017137607, 1266.8669789672135, 1274.4265080713717, 1277.8658240884758, 1296.3647812571771, 1081.734974931147, 1099.4612639806437, 1103.3490240757992, 1152.1128730877344, 1235.6231349438328, 7957.482763620346, 7963.243491868263, 7971.880421793678, 8018.679252829821, 8078.8788168177525, 507.34805774580224, 518.9974050129725, 522.5662699959025, 524.5777149394697, 524.5777149394773, 6087.57386982907, 6100.3899610039525, 6138.478229350555, 6142.447179753844, 6148.477379422709, 10174.0, 10274.897251027394, 10278.537465813906, 10421.9478902605, 10438.37369757817, 10066.496675166212, 10268.691939241835, 10305.742356440998, 10306.587736490457, 10330.225233107547, 8051.436399451982, 8100.311473524816, 8100.473469224482, 8115.229053239933, 8173.305269052078, 7943.4836735612, 7960.920390796018, 7969.6015199238645, 8039.5176289422825, 8075.798105047421, 9240.0, 9399.953000234955, 9505.857412138685, 9584.808303834025, 9605.519724013911, 9607.711768646952, 9811.509424528887, 9831.655892043744, 9941.403515789076, 9964.202863770735, 6718.428933540704, 6906.930930690629, 7187.9640601796655, 7414.592197428978, 7543.170251272246, 8064.8790268147195, 8124.309433698202, 8141.0, 8147.348212142896, 8148.918510815053, 7071.540349877241, 7162.820929476805, 7174.1032370953635, 7292.380147687294, 7299.160596531255, 7081.362677359062, 7088.539244949268, 7132.821679458055, 7226.277372262732, 7237.457190710613, 7347.191808901123, 7621.618919054136, 7624.961875190588, 7638.0, 7640.694372225049, 6880.208775990625, 6943.652817359213, 6957.652117394211, 6960.0, 6961.37347638715, 6913.3777959983845, 7027.578345299298, 7028.6485675714985, 7033.050538177281, 7045.154581450259], "unit": "score", "name": "mootools.html", "value": 4727.665476438812}, {"lowerIsBetter": false, "replicates": [263.9023561282325, 322.97254733347665, 327.9590051243595, 328.75014988608666, 334.6770366596234, 6436.259830119532, 6604.900926486101, 6608.603483790964, 6631.204255489336, 6662.200535935683, 6473.54685172037, 6554.803355899318, 6559.212894452672, 6562.146920900276, 6564.835879103025, 4579.816807327703, 4703.811847526094, 4840.104580652573, 4855.9028819423675, 4860.222364421693, 4694.90610187796, 4784.182010835878, 4784.521547845205, 4800.4719480857075, 4815.422149342084, 4731.692439991407, 4737.952620473803, 4747.287906813971, 4762.738049407281, 4818.988012517376, 4569.862904112882, 4608.446986361658, 4732.43210814701, 4797.544233297831, 4801.399825021855, 4073.551909289976, 4079.2861249281555, 4084.019835239551, 4090.3046482098116, 4094.28350038745, 6186.690665466754, 6224.62652240867, 6225.221847269091, 6226.87546249077, 6234.719437625317, 5605.859853503654, 5615.9157612635845, 5618.522425593788, 5619.269494965628, 5627.831165065014, 6932.6533673316635, 6945.47908906834, 6947.340002699735, 6958.47811414146, 6967.233604303523, 4444.555544445562, 4615.307703844416, 4631.745254011028, 4655.534446555352, 4660.790264438075, 6887.276835932205, 7250.093738282715, 7286.1256649201905, 7303.160136584308, 7315.341619254239, 3827.2919509890758, 4705.60002399793, 4707.082118986833, 4709.670323077352, 4719.882002949885, 4778.641601879873, 4782.760861956888, 4787.976060119677, 4790.233562630032, 4795.904081918342, 5599.1321345190745, 5612.943870561324, 5616.297962754656, 5616.747246373923, 5626.324841019104, 6682.899756503656, 6951.721931122698, 6954.3393377629045, 6987.790366289019, 6995.79012629622, 1377.889768818492, 1393.2754967416886, 1659.5933996170775, 1681.529171831889, 1685.2163743859164, 1014.4521958142668, 1082.7509672775307, 1082.9566817327218, 1097.160672085855, 1111.1333160134946, 5271.920921186185, 6297.433231009231, 6382.425581697669, 6531.542792004514, 6548.8035358939305, 7338.559686418832, 7341.77974660761, 7348.963255183797, 7352.0442342495135, 7354.742584009534, 6522.5760325578685, 6535.0850880876715, 6536.281009088996, 6541.182352205974, 6542.7710030149665, 3818.9045273868373, 3855.9421608675893, 3871.4773505576386, 3872.845086196577, 3878.1274213302345, 7212.050058701488, 7602.961985190039, 7636.656350464243, 7637.083549973928, 7642.847143057108, 7461.962690186514, 7557.093148822177, 7562.546247225074, 7565.319121279112, 7568.470207085561, 7589.203133670995, 7592.658330375036, 7599.848003039909, 7601.809954751176, 7609.239076092457, 7012.088428504262, 7328.890066648898, 7336.395579569176, 7344.853102938018, 7350.669219885225, 7043.436525078084, 7106.6446677666945, 7116.039334689751, 7127.501074924706, 7127.82180445493, 7556.168821429528, 7577.014988051518, 7591.544507329578, 7592.316691497792, 7603.505772124794, 4587.954120458753, 4626.311396340244, 4645.233536466445, 4646.953530464787, 4656.115338085753, 7017.894731579133, 7277.745278915212, 7286.6720997556295, 7304.890426643711, 7306.634668266459, 6983.930160698531, 6998.580085194904, 7025.297470253138, 7036.542624729376, 7046.1192350956135, 6137.925862974051, 6416.550841441054, 6922.996165555865, 6940.271271516418, 6943.861122777415, 6876.553024053421, 6883.8967415487805, 6885.037764237169, 6895.620740859301, 6904.033435318959, 6750.763723269858, 7039.084918960707, 7050.647467626495, 7060.71757129709, 7081.291870812877, 6632.701528431328, 6780.423663988616, 6841.281665425058, 6900.137482814648, 6912.619805910723], "unit": "score", "name": "prototype.html", "value": 5113.2517738367915}, {"lowerIsBetter": false, "replicates": [662.4270006444425, 729.9051123353963, 738.6897503048717, 741.1439787045964, 762.2263402646315, 12093.0, 14943.0, 15046.699066018673, 15131.773023404658, 15154.848451515481, 11172.776544469105, 13494.527691530773, 13543.864561354383, 13569.982251331141, 13577.45690172392, 833.6498670558381, 859.3726579596898, 865.091653763549, 869.0570730757136, 874.3922973533397, 858.5406807358065, 865.8354912566624, 866.2766589897411, 870.2168048756139, 871.4205053639322, 906.12106256931, 906.2659246010719, 906.7642412972608, 909.6088681866795, 914.5518695839057, 902.6118768929325, 902.6795487601872, 903.1510380242551, 903.5708038681639, 907.7866701325183, 645.4932877691037, 675.3010633993792, 676.2527407215055, 679.9558028728117, 680.2449281297755, 15039.323230454656, 15079.0, 15093.622659433493, 15128.848711512854, 15158.848411515854, 12343.259404435672, 12429.875701242961, 12478.563250286286, 12642.115051946368, 12901.870981290162, 8178.631961561744, 10207.387556746544, 10217.897821021843, 10331.121854642364, 10639.893601064045, 3419.333230020147, 3488.1105318143964, 3519.964800351989, 3560.038789526839, 3651.1419816343137, 58635.413645863424, 70369.0, 71338.2866171342, 73885.63057184733, 81164.0, 9171.950373891934, 9333.719988400358, 9415.482148481899, 9422.62309507612, 9879.160271377013, 19750.209991600463, 19750.81495110298, 19759.802401976085, 19783.505412364808, 20667.58664826695, 7316.707331706779, 7436.851262974818, 7551.848963020709, 7658.923410765932, 7696.846063078707, 4030.8186131624147, 4087.7138600297694, 4087.816048277835, 4096.754194748325, 4098.6516146127315, 3549.769264997767, 3558.7508874378545, 3571.2143328467696, 3572.821358932043, 3574.249407624376, 531.9946800532023, 641.20490591666, 650.1353200243665, 675.3786516404821, 678.1387637700093, 553.9086050801653, 583.9488919944083, 598.4255115089563, 627.0187157099125, 628.522323034488, 8413.747587572383, 8591.0, 8622.827543449095, 8716.825663486821, 8761.420765569706, 537.2693137333224, 545.5635491606698, 612.8682333298362, 621.0249907645044, 632.4971647540217, 3615.186583018852, 3939.8227079780904, 4315.762633055149, 4430.511602067399, 4445.355423463644, 96729.0, 97782.0, 98415.50792245993, 99684.0, 99692.0, 66512.66743666251, 71326.64336678284, 71709.0, 72555.27444725485, 77050.0, 54276.0, 68199.3180068203, 68244.6587767068, 68378.65810670915, 69238.30761692318, 8535.146485351415, 8560.785980350292, 8725.432846864933, 8803.471791692518, 8933.553322333728, 40152.79923600363, 46197.0, 47924.760376199294, 52272.0, 53115.4688453126, 53389.0, 66119.00821487777, 67149.66425167843, 69448.30551694418, 69611.0, 10850.240483166419, 11031.558737650405, 11046.668599941693, 11116.055135313589, 11522.308661480338, 10827.51276192589, 10958.12335013213, 10979.341239525655, 11027.724306892393, 11211.831822522505, 11411.828822567833, 11414.771704565695, 11418.543258269576, 11430.1998860079, 11446.313221206754, 11456.3698996556, 11473.13951453661, 11481.36852473122, 11496.137789665976, 11499.08007359426, 11222.438878056228, 11243.887561124284, 11248.493817778057, 11257.718557035812, 11261.774764504828, 9481.905180948102, 9949.452780097165, 9989.800203995734, 10011.199104071802, 10041.0, 7243.384312333511, 9716.271279653913, 9903.207743380657, 9910.454924979196, 9919.702408927744], "unit": "score", "name": "yui.html", "value": 6800.870981147184}], "name": "dromaeo_css", "value": 7363.6361113248995}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 107.0, 111.0, 108.0, 111.0, 110.0, 117.0, 110.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [157.0, 122.0, 146.0, 150.0, 116.0, 147.0, 158.0, 116.0, 159.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 139.2}, {"lowerIsBetter": true, "replicates": [184.0, 185.0, 189.0, 186.0, 199.0, 268.0, 183.0, 185.0, 181.0, 183.0], "unit": "score", "name": "audio-dft", "value": 194.3}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 88.0, 78.0, 56.0, 57.0, 58.0, 84.0, 76.0, 55.0], "unit": "score", "name": "audio-fft", "value": 70.6}, {"lowerIsBetter": true, "replicates": [96.0, 99.0, 138.0, 64.0, 79.0, 111.0, 111.0, 71.0, 108.0, 145.0], "unit": "score", "name": "audio-oscillator", "value": 102.2}, {"lowerIsBetter": true, "replicates": [86.0, 91.0, 87.0, 92.0, 87.0, 91.0, 85.0, 91.0, 85.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 98.0, 95.0, 95.0, 103.0, 143.0, 113.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 102.7}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 84.0, 87.0, 87.0, 85.0, 87.0, 88.0, 86.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 86.4}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 54.0, 53.0, 53.0, 53.0, 54.0, 63.0, 53.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.5}, {"lowerIsBetter": true, "replicates": [69.0, 68.0, 65.0, 73.0, 71.0, 66.0, 65.0, 66.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 82.0, 82.0, 84.0, 83.0, 82.0, 83.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [125.0, 136.0, 128.0, 130.0, 119.0, 121.0, 119.0, 134.0, 127.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.5}, {"lowerIsBetter": true, "replicates": [139.0, 128.0, 138.0, 142.0, 172.0, 171.0, 139.0, 135.0, 135.0, 121.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.0}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 65.0, 67.0, 71.0, 78.0, 96.0, 92.0, 95.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 76.5}], "name": "kraken", "value": 1445.5}]} 03:32:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1445.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7363.64"}}} 03:32:54 INFO - Return code: 0 03:32:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:32:54 INFO - # TBPL SUCCESS # 03:32:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:32:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:32:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:32:54 INFO - 2016-02-25 03:32:54.751 screenresolution[1700:9688] starting screenresolution argv=screenresolution get 03:32:54 INFO - 2016-02-25 03:32:54.753 screenresolution[1700:9688] Display 0: 1600x1200x32@60 03:32:54 INFO - 2016-02-25 03:32:54.759 screenresolution[1701:9691] starting screenresolution argv=screenresolution list 03:32:54 INFO - Available Modes on Display 0 03:32:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:32:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:32:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:32:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:32:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:32:54 INFO - Intel Iris: 03:32:54 INFO - Chipset Model: Intel Iris 03:32:54 INFO - Type: GPU 03:32:54 INFO - Bus: Built-In 03:32:54 INFO - VRAM (Dynamic, Max): 1536 MB 03:32:54 INFO - Vendor: Intel (0x8086) 03:32:54 INFO - Device ID: 0x0a2e 03:32:54 INFO - Revision ID: 0x0009 03:32:54 INFO - Displays: 03:32:54 INFO - Display: 03:32:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:32:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:32:54 INFO - Display Serial Number: 1600x1200 60 03:32:54 INFO - Main Display: Yes 03:32:54 INFO - Mirror: Off 03:32:54 INFO - Online: Yes 03:32:54 INFO - Rotation: Supported 03:32:54 INFO - Return code: 0 03:32:54 INFO - Running post-action listener: _resource_record_post_action 03:32:54 INFO - Running post-run listener: _resource_record_post_run 03:32:56 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39253504; Write bytes: 707799552; Read time: 424; Write time: 2351 03:32:56 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 404851200; Write bytes: 405899264; Read time: 30216; Write time: 725 03:32:56 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 37418496; Write bytes: 300605952; Read time: 404; Write time: 1623 03:32:56 INFO - Running post-run listener: _upload_blobber_files 03:32:56 INFO - Blob upload gear active. 03:32:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:32:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:32:56 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'] 03:32:56 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 03:32:56 INFO - (blobuploader) - INFO - Open directory for files ... 03:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:32:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:57 INFO - (blobuploader) - INFO - Done attempting. 03:32:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:32:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:32:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:32:58 INFO - (blobuploader) - INFO - Done attempting. 03:32:58 INFO - (blobuploader) - INFO - Iteration through files over. 03:32:58 INFO - Return code: 0 03:32:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:32:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:32:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af150e934f2368a890f78bf67549a11cecd16f207f502f5a4421b962f883c3565a3e70b98598e0db8f1e4ca886e687468dc5b8254234958f0724ef4b62c08720", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45cf60f6f7d2bc5c63da35f716183d69242e49a0478bff4dcc91359532a5a3552ef3f439577e021f193f8370db2533a35dba96b1e2695a879534da20b9639ce0"} 03:32:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:32:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:32:58 INFO - Contents: 03:32:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af150e934f2368a890f78bf67549a11cecd16f207f502f5a4421b962f883c3565a3e70b98598e0db8f1e4ca886e687468dc5b8254234958f0724ef4b62c08720", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45cf60f6f7d2bc5c63da35f716183d69242e49a0478bff4dcc91359532a5a3552ef3f439577e021f193f8370db2533a35dba96b1e2695a879534da20b9639ce0"} 03:32:58 INFO - Running post-run listener: copy_logs_to_upload_dir 03:32:58 INFO - Copying logs to upload dir... 03:32:58 INFO - mkdir: /builds/slave/test/build/upload/logs 03:32:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.827792 ========= master_lag: 1.76 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-02-25 03:33:00.330722) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 03:33:00.338422) ========= 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.VvMgWihc6t/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.GYMmDLmENO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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/af150e934f2368a890f78bf67549a11cecd16f207f502f5a4421b962f883c3565a3e70b98598e0db8f1e4ca886e687468dc5b8254234958f0724ef4b62c08720", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45cf60f6f7d2bc5c63da35f716183d69242e49a0478bff4dcc91359532a5a3552ef3f439577e021f193f8370db2533a35dba96b1e2695a879534da20b9639ce0"} build_url:https://queue.taskcluster.net/v1/task/B4cxvgx5TR6bFzBIPVBFzw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011023 build_url: 'https://queue.taskcluster.net/v1/task/B4cxvgx5TR6bFzBIPVBFzw/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/af150e934f2368a890f78bf67549a11cecd16f207f502f5a4421b962f883c3565a3e70b98598e0db8f1e4ca886e687468dc5b8254234958f0724ef4b62c08720", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45cf60f6f7d2bc5c63da35f716183d69242e49a0478bff4dcc91359532a5a3552ef3f439577e021f193f8370db2533a35dba96b1e2695a879534da20b9639ce0"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-25 03:33:00.397482) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:33:00.397812) ========= 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.VvMgWihc6t/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.GYMmDLmENO/Listeners TMPDIR=/var/folders/ls/6dq3sb3j12l2f5_326_ys_8c00000w/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.005313 ========= master_lag: 0.24 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-25 03:33:00.641548) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 03:33:00.641868) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-25 03:33:00.643311) ========= ========= Total master_lag: 2.21 =========