builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0105 starttime: 1456155476.28 results: success (0) buildid: 20160222053756 builduid: b32f9adb0e3643e5a91eec6145f55d59 revision: 789a12291942763bc1e3a89f97e0b82dc1c9d00b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 07:37:56.282110) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-22 07:37:56.282562) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 07:37:56.285903) ========= 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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.005234 basedir: '/builds/slave/test' ========= master_lag: 0.13 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-22 07:37:56.419821) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 07:37:56.420111) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-22 07:37:56.879190) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 07:37:56.879589) ========= 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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.005365 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 07:37:56.938818) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 07:37:56.939260) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-22 07:37:56.939686) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-22 07:37:56.939972) ========= 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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-22 07:37:57-- 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% 47.1M=0s 2016-02-22 07:37:57 (47.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.571854 ========= master_lag: 1.64 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-22 07:37:59.150077) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 07:37:59.150363) ========= 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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.025847 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 07:37:59.234828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-02-22 07:37:59.235133) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 789a12291942763bc1e3a89f97e0b82dc1c9d00b --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 789a12291942763bc1e3a89f97e0b82dc1c9d00b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vhnvTrMFqz/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.6ThNCx6kXn/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-22 07:37:59,583 truncating revision to first 12 chars 2016-02-22 07:37:59,583 Setting DEBUG logging. 2016-02-22 07:37:59,583 attempt 1/10 2016-02-22 07:37:59,583 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/789a12291942?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-22 07:38:00,229 unpacking tar archive at: mozilla-central-789a12291942/testing/mozharness/ program finished with exit code 0 elapsedTime=0.899097 ========= master_lag: 2.76 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-02-22 07:38:02.894308) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 07:38:02.894616) ========= echo 789a12291942763bc1e3a89f97e0b82dc1c9d00b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'789a12291942763bc1e3a89f97e0b82dc1c9d00b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vhnvTrMFqz/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.6ThNCx6kXn/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 789a12291942763bc1e3a89f97e0b82dc1c9d00b program finished with exit code 0 elapsedTime=0.005678 script_repo_revision: '789a12291942763bc1e3a89f97e0b82dc1c9d00b' ========= master_lag: 0.07 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-22 07:38:02.972004) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 6 secs) (at 2016-02-22 07:38:02.972286) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 6 secs) (at 2016-02-22 07:38:09.392237) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-02-22 07:38:09.392500) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 07:38:09 INFO - MultiFileLogger online at 20160222 07:38:09 in /builds/slave/test 07:38:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:38:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:38:09 INFO - {'append_to_log': False, 07:38:09 INFO - 'base_work_dir': '/builds/slave/test', 07:38:09 INFO - 'blob_upload_branch': 'Firefox', 07:38:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:38:09 INFO - 'branch': 'Firefox', 07:38:09 INFO - 'buildbot_json_path': 'buildprops.json', 07:38:09 INFO - 'config_files': ('talos/mac_config.py',), 07:38:09 INFO - 'default_actions': ('clobber', 07:38:09 INFO - 'read-buildbot-config', 07:38:09 INFO - 'download-and-extract', 07:38:09 INFO - 'populate-webroot', 07:38:09 INFO - 'create-virtualenv', 07:38:09 INFO - 'install', 07:38:09 INFO - 'run-tests'), 07:38:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:38:09 INFO - 'download_minidump_stackwalk': True, 07:38:09 INFO - 'download_symbols': 'ondemand', 07:38:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:38:09 INFO - 'tooltool.py': '/tools/tooltool.py', 07:38:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:38:09 INFO - '/tools/misc-python/virtualenv.py')}, 07:38:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:38:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:38:09 INFO - 'installer_path': 'installer.exe', 07:38:09 INFO - 'log_level': 'info', 07:38:09 INFO - 'log_name': 'talos', 07:38:09 INFO - 'log_to_console': True, 07:38:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:38:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:38:09 INFO - 'opt_config_files': (), 07:38:09 INFO - 'pip_index': False, 07:38:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:38:09 INFO - 'cmd': ('bash', 07:38:09 INFO - '-c', 07:38:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:38:09 INFO - 'enabled': True, 07:38:09 INFO - 'halt_on_failure': False, 07:38:09 INFO - 'name': 'check_screen_resolution'},), 07:38:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:38:09 INFO - 'cmd': ('bash', 07:38:09 INFO - '-c', 07:38:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:38:09 INFO - 'enabled': True, 07:38:09 INFO - 'halt_on_failure': False, 07:38:09 INFO - 'name': 'check_screen_resolution'},), 07:38:09 INFO - 'run_cmd_checks_enabled': True, 07:38:09 INFO - 'sps_profile': False, 07:38:09 INFO - 'sps_profile_interval': 0, 07:38:09 INFO - 'suite': 'dromaeojs-e10s', 07:38:09 INFO - 'system_bits': '32', 07:38:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:38:09 INFO - 'title': 't-yosemite-r7-0105', 07:38:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:38:09 INFO - 'use_talos_json': True, 07:38:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:38:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:38:09 INFO - 'work_dir': 'build'} 07:38:09 INFO - ##### 07:38:09 INFO - ##### Running clobber step. 07:38:09 INFO - ##### 07:38:09 INFO - Running pre-action listener: _resource_record_pre_action 07:38:09 INFO - Running main action method: clobber 07:38:09 INFO - rmtree: /builds/slave/test/build 07:38:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:38:11 INFO - Running post-action listener: _resource_record_post_action 07:38:11 INFO - ##### 07:38:11 INFO - ##### Running read-buildbot-config step. 07:38:11 INFO - ##### 07:38:11 INFO - Running pre-action listener: _resource_record_pre_action 07:38:11 INFO - Running main action method: read_buildbot_config 07:38:11 INFO - Using buildbot properties: 07:38:11 INFO - { 07:38:11 INFO - "project": "", 07:38:11 INFO - "product": "firefox", 07:38:11 INFO - "script_repo_revision": "production", 07:38:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 07:38:11 INFO - "repository": "", 07:38:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 07:38:11 INFO - "buildid": "20160222053756", 07:38:11 INFO - "pgo_build": "False", 07:38:11 INFO - "basedir": "/builds/slave/test", 07:38:11 INFO - "buildnumber": 117, 07:38:11 INFO - "slavename": "t-yosemite-r7-0105", 07:38:11 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:38:11 INFO - "platform": "yosemite_r7", 07:38:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:38:11 INFO - "branch": "mozilla-central", 07:38:11 INFO - "repo_path": "mozilla-central", 07:38:11 INFO - "revision": "789a12291942763bc1e3a89f97e0b82dc1c9d00b", 07:38:11 INFO - "stage_platform": "macosx64", 07:38:11 INFO - "builduid": "b32f9adb0e3643e5a91eec6145f55d59", 07:38:11 INFO - "slavebuilddir": "test" 07:38:11 INFO - } 07:38:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 07:38:11 INFO - Running post-action listener: _resource_record_post_action 07:38:11 INFO - ##### 07:38:11 INFO - ##### Running download-and-extract step. 07:38:11 INFO - ##### 07:38:11 INFO - Running pre-action listener: _resource_record_pre_action 07:38:11 INFO - Running main action method: download_and_extract 07:38:11 INFO - mkdir: /builds/slave/test/build/tests 07:38:11 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')]} 07:38:11 INFO - https://queue.taskcluster.net/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:38:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/test_packages.json 07:38:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/test_packages.json 07:38:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:38:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:38:13 INFO - Downloaded 1277 bytes. 07:38:13 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:38:13 INFO - Using the following test package requirements: 07:38:13 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:38:13 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:38:13 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 07:38:13 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:38:13 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 07:38:13 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:38:13 INFO - u'jsshell-mac.zip'], 07:38:13 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:38:13 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 07:38:13 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:38:13 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:38:13 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 07:38:13 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:38:13 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 07:38:13 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:38:13 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 07:38:13 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 07:38:13 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 07:38:13 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 07:38:13 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:38:13 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')]} 07:38:13 INFO - https://queue.taskcluster.net/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:38:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:38:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:38:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/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 07:38:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/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 07:38:17 INFO - Downloaded 17825446 bytes. 07:38:17 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'] 07:38:17 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 07:38:20 INFO - Return code: 0 07:38:20 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 07:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:20 INFO - https://queue.taskcluster.net/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:38:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:38:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 07:38:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/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 07:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/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 07:38:24 INFO - Downloaded 17825446 bytes. 07:38:24 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'] 07:38:24 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 07:38:27 INFO - Return code: 0 07:38:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:27 INFO - https://queue.taskcluster.net/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:38:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:38:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 07:38:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/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 07:38:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/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 07:38:28 INFO - Downloaded 10707015 bytes. 07:38:28 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'] 07:38:28 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 07:38:28 INFO - Return code: 0 07:38:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:28 INFO - https://queue.taskcluster.net/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:38:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:38:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:38:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 07:38:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DW_B6u_6RG60l5KQjrRIHQ/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 07:38:32 INFO - Downloaded 111263347 bytes. 07:38:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:38:32 INFO - mkdir: /builds/slave/test/properties 07:38:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:38:32 INFO - Writing to file /builds/slave/test/properties/build_url 07:38:32 INFO - Contents: 07:38:32 INFO - build_url:https://queue.taskcluster.net/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 07:38:33 INFO - Running post-action listener: _resource_record_post_action 07:38:33 INFO - Running post-action listener: set_extra_try_arguments 07:38:33 INFO - ##### 07:38:33 INFO - ##### Running populate-webroot step. 07:38:33 INFO - ##### 07:38:33 INFO - Running pre-action listener: _resource_record_pre_action 07:38:33 INFO - Running main action method: populate_webroot 07:38:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:38:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:38:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:38:33 INFO - '--tppagecycles', 07:38:33 INFO - '7'], 07:38:33 INFO - 'tests': ['tsvgm']}}, 07:38:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:38:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:38:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:38:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 07:38:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:38:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:38:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:33 INFO - 'talos_options': ['--e10s'], 07:38:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:38:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:33 INFO - 'tests': ['damp', 'tps']}, 07:38:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:33 INFO - 'talos_options': ['--e10s'], 07:38:33 INFO - 'tests': ['damp', 'tps']}, 07:38:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:38:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:38:33 INFO - 'other': {'tests': ['a11yr', 07:38:33 INFO - 'ts_paint', 07:38:33 INFO - 'tpaint', 07:38:33 INFO - 'sessionrestore', 07:38:33 INFO - 'sessionrestore_no_auto_restore']}, 07:38:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:38:33 INFO - 'tests': ['a11yr', 07:38:33 INFO - 'ts_paint', 07:38:33 INFO - 'tpaint', 07:38:33 INFO - 'sessionrestore', 07:38:33 INFO - 'sessionrestore_no_auto_restore']}, 07:38:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:38:33 INFO - 'tests': ['a11yr', 07:38:33 INFO - 'ts_paint', 07:38:33 INFO - 'tpaint', 07:38:33 INFO - 'sessionrestore', 07:38:33 INFO - 'sessionrestore_no_auto_restore']}, 07:38:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:38:33 INFO - 'tests': ['a11yr', 07:38:33 INFO - 'ts_paint', 07:38:33 INFO - 'tpaint', 07:38:33 INFO - 'sessionrestore', 07:38:33 INFO - 'sessionrestore_no_auto_restore']}, 07:38:33 INFO - 'other_l64': {'tests': ['a11yr', 07:38:33 INFO - 'ts_paint', 07:38:33 INFO - 'tpaint', 07:38:33 INFO - 'sessionrestore', 07:38:33 INFO - 'sessionrestore_no_auto_restore']}, 07:38:33 INFO - 'other_nol64': {'tests': ['a11yr', 07:38:33 INFO - 'ts_paint', 07:38:33 INFO - 'tpaint', 07:38:33 INFO - 'sessionrestore', 07:38:33 INFO - 'sessionrestore_no_auto_restore']}, 07:38:33 INFO - 'svgr': {'tests': ['tsvgx', 07:38:33 INFO - 'tsvgr_opacity', 07:38:33 INFO - 'tart', 07:38:33 INFO - 'tscrollx', 07:38:33 INFO - 'cart']}, 07:38:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:38:33 INFO - 'tests': ['tsvgx', 07:38:33 INFO - 'tsvgr_opacity', 07:38:33 INFO - 'tart', 07:38:33 INFO - 'tscrollx', 07:38:33 INFO - 'cart']}, 07:38:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:33 INFO - 'tests': ['tp5o']}, 07:38:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:33 INFO - 'talos_options': ['--e10s'], 07:38:33 INFO - 'tests': ['tp5o']}, 07:38:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:33 INFO - 'talos_options': ['--xperf_path', 07:38:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:33 INFO - 'tests': ['tp5n']}, 07:38:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:38:33 INFO - 'talos_options': ['--e10s', 07:38:33 INFO - '--xperf_path', 07:38:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:38:33 INFO - 'tests': ['tp5n']}}, 07:38:33 INFO - 'talos.zip': {'path': '', 07:38:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:38:33 INFO - Running post-action listener: _resource_record_post_action 07:38:33 INFO - ##### 07:38:33 INFO - ##### Running create-virtualenv step. 07:38:33 INFO - ##### 07:38:33 INFO - Running pre-action listener: _resource_record_pre_action 07:38:33 INFO - Running main action method: create_virtualenv 07:38:33 INFO - Creating virtualenv /builds/slave/test/build/venv 07:38:33 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 07:38:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:38:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:38:33 INFO - Using real prefix '/tools/python27' 07:38:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:38:34 INFO - Installing distribute.............................................................................................................................................................................................done. 07:38:37 INFO - Installing pip.................done. 07:38:37 INFO - Return code: 0 07:38:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:38:37 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')]} 07:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:37 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')]} 07:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:37 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 0x10cd53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b794b6e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf7d30>, '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 0x10ca1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeeb20>, '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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 07:38:37 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 07:38:37 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 07:38:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vhnvTrMFqz/Render', 07:38:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:37 INFO - 'HOME': '/Users/cltbld', 07:38:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:37 INFO - 'LOGNAME': 'cltbld', 07:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:37 INFO - 'MOZ_NO_REMOTE': '1', 07:38:37 INFO - 'NO_EM_RESTART': '1', 07:38:37 INFO - 'PAGER': '/bin/cat', 07:38:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:37 INFO - 'PWD': '/builds/slave/test', 07:38:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:37 INFO - 'SHELL': '/bin/bash', 07:38:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ThNCx6kXn/Listeners', 07:38:37 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 07:38:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:37 INFO - 'USER': 'cltbld', 07:38:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:37 INFO - 'XPC_FLAGS': '0x0', 07:38:37 INFO - 'XPC_SERVICE_NAME': '0', 07:38:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:37 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 07:38:37 INFO - Cleaning up... 07:38:37 INFO - Return code: 0 07:38:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:38:37 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')]} 07:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:37 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')]} 07:38:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:37 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 0x10cd53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b794b6e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf7d30>, '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 0x10ca1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeeb20>, '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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 07:38:37 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 07:38:37 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 07:38:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vhnvTrMFqz/Render', 07:38:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:37 INFO - 'HOME': '/Users/cltbld', 07:38:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:37 INFO - 'LOGNAME': 'cltbld', 07:38:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:37 INFO - 'MOZ_NO_REMOTE': '1', 07:38:37 INFO - 'NO_EM_RESTART': '1', 07:38:37 INFO - 'PAGER': '/bin/cat', 07:38:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:37 INFO - 'PWD': '/builds/slave/test', 07:38:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:37 INFO - 'SHELL': '/bin/bash', 07:38:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ThNCx6kXn/Listeners', 07:38:37 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 07:38:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:37 INFO - 'USER': 'cltbld', 07:38:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:37 INFO - 'XPC_FLAGS': '0x0', 07:38:37 INFO - 'XPC_SERVICE_NAME': '0', 07:38:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:37 INFO - Downloading/unpacking psutil>=0.7.1 07:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:38:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:40 INFO - Installing collected packages: psutil 07:38:40 INFO - Running setup.py install for psutil 07:38:40 INFO - building 'psutil._psutil_osx' extension 07:38:40 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 07:38:40 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 07:38:40 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 07:38:40 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 07:38:40 INFO - building 'psutil._psutil_posix' extension 07:38:40 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 07:38:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:38:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:38:41 INFO - ^ 07:38:41 INFO - 1 warning generated. 07:38:41 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 07:38:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:38:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:38:41 INFO - Successfully installed psutil 07:38:41 INFO - Cleaning up... 07:38:41 INFO - Return code: 0 07:38:41 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:38:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:41 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 0x10cd53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b794b6e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf7d30>, '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 0x10ca1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeeb20>, '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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 07:38:41 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 07:38:41 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 07:38:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vhnvTrMFqz/Render', 07:38:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:41 INFO - 'HOME': '/Users/cltbld', 07:38:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:41 INFO - 'LOGNAME': 'cltbld', 07:38:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:41 INFO - 'MOZ_NO_REMOTE': '1', 07:38:41 INFO - 'NO_EM_RESTART': '1', 07:38:41 INFO - 'PAGER': '/bin/cat', 07:38:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:41 INFO - 'PWD': '/builds/slave/test', 07:38:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:41 INFO - 'SHELL': '/bin/bash', 07:38:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ThNCx6kXn/Listeners', 07:38:41 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 07:38:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:41 INFO - 'USER': 'cltbld', 07:38:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:41 INFO - 'XPC_FLAGS': '0x0', 07:38:41 INFO - 'XPC_SERVICE_NAME': '0', 07:38:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:41 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38: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 07:38:43 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:38:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:38:43 INFO - Installing collected packages: mozsystemmonitor 07:38:43 INFO - Running setup.py install for mozsystemmonitor 07:38:44 INFO - Successfully installed mozsystemmonitor 07:38:44 INFO - Cleaning up... 07:38:44 INFO - Return code: 0 07:38:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:38:44 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')]} 07:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:44 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')]} 07:38:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:44 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 0x10cd53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b794b6e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf7d30>, '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 0x10ca1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeeb20>, '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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 07:38:44 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 07:38:44 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 07:38:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vhnvTrMFqz/Render', 07:38:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:44 INFO - 'HOME': '/Users/cltbld', 07:38:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:44 INFO - 'LOGNAME': 'cltbld', 07:38:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:44 INFO - 'MOZ_NO_REMOTE': '1', 07:38:44 INFO - 'NO_EM_RESTART': '1', 07:38:44 INFO - 'PAGER': '/bin/cat', 07:38:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:44 INFO - 'PWD': '/builds/slave/test', 07:38:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:44 INFO - 'SHELL': '/bin/bash', 07:38:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ThNCx6kXn/Listeners', 07:38:44 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 07:38:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:44 INFO - 'USER': 'cltbld', 07:38:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:44 INFO - 'XPC_FLAGS': '0x0', 07:38:44 INFO - 'XPC_SERVICE_NAME': '0', 07:38:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:44 INFO - Downloading/unpacking blobuploader==1.2.4 07:38:44 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 07:38:44 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 07:38:44 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 07:38:44 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 07:38:44 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 07:38:44 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 07:38:46 INFO - Downloading blobuploader-1.2.4.tar.gz 07:38:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:38:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:38:46 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 07:38:46 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 07:38:46 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 07:38:46 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 07:38:46 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 07:38:46 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 07:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:38:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:47 INFO - Downloading docopt-0.6.1.tar.gz 07:38:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:38:47 INFO - Installing collected packages: blobuploader, requests, docopt 07:38:47 INFO - Running setup.py install for blobuploader 07:38:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:38:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:38:48 INFO - Running setup.py install for requests 07:38:48 INFO - Running setup.py install for docopt 07:38:48 INFO - Successfully installed blobuploader requests docopt 07:38:48 INFO - Cleaning up... 07:38:48 INFO - Return code: 0 07:38:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:48 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')]} 07:38:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:48 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')]} 07:38:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:48 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 0x10cd53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b794b6e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf7d30>, '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 0x10ca1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeeb20>, '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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 07:38:48 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 07:38:48 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 07:38:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vhnvTrMFqz/Render', 07:38:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:48 INFO - 'HOME': '/Users/cltbld', 07:38:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:48 INFO - 'LOGNAME': 'cltbld', 07:38:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:48 INFO - 'MOZ_NO_REMOTE': '1', 07:38:48 INFO - 'NO_EM_RESTART': '1', 07:38:48 INFO - 'PAGER': '/bin/cat', 07:38:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:48 INFO - 'PWD': '/builds/slave/test', 07:38:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:48 INFO - 'SHELL': '/bin/bash', 07:38:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ThNCx6kXn/Listeners', 07:38:48 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 07:38:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:48 INFO - 'USER': 'cltbld', 07:38:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:48 INFO - 'XPC_FLAGS': '0x0', 07:38:48 INFO - 'XPC_SERVICE_NAME': '0', 07:38:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-TageMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-I1nok7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-tUY_3T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-tuZ8o_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-a8FGss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-VOaMAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-PS5Tx1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-InlYjW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:49 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-5oTCtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:50 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-h9e7B6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:50 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-eftIvP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:50 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-TQZwqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:50 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-DDSEYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:50 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-VPIKs_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:50 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-UpP1YU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:50 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-OzMfku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:50 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-cVWrXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:38:50 INFO - Running setup.py install for manifestparser 07:38:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:38:50 INFO - Running setup.py install for mozcrash 07:38:51 INFO - Running setup.py install for mozdebug 07:38:51 INFO - Running setup.py install for mozdevice 07:38:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:38:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:38:51 INFO - Running setup.py install for mozfile 07:38:51 INFO - Running setup.py install for mozhttpd 07:38:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:38:51 INFO - Running setup.py install for mozinfo 07:38:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:38:51 INFO - Running setup.py install for mozInstall 07:38:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:38:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:38:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:38:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Running setup.py install for mozleak 07:38:52 INFO - Running setup.py install for mozlog 07:38:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Running setup.py install for moznetwork 07:38:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Running setup.py install for mozprocess 07:38:52 INFO - Running setup.py install for mozprofile 07:38:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Running setup.py install for mozrunner 07:38:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:38:52 INFO - Running setup.py install for mozscreenshot 07:38:53 INFO - Running setup.py install for moztest 07:38:53 INFO - Running setup.py install for mozversion 07:38:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:38:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:38:53 INFO - Cleaning up... 07:38:53 INFO - Return code: 0 07:38:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38:53 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')]} 07:38:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:53 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')]} 07:38:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:53 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 0x10cd53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b794b6e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf7d30>, '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 0x10ca1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeeb20>, '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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 07:38:53 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 07:38:53 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 07:38:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vhnvTrMFqz/Render', 07:38:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:53 INFO - 'HOME': '/Users/cltbld', 07:38:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:53 INFO - 'LOGNAME': 'cltbld', 07:38:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:53 INFO - 'MOZ_NO_REMOTE': '1', 07:38:53 INFO - 'NO_EM_RESTART': '1', 07:38:53 INFO - 'PAGER': '/bin/cat', 07:38:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:53 INFO - 'PWD': '/builds/slave/test', 07:38:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:53 INFO - 'SHELL': '/bin/bash', 07:38:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ThNCx6kXn/Listeners', 07:38:53 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 07:38:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:53 INFO - 'USER': 'cltbld', 07:38:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:53 INFO - 'XPC_FLAGS': '0x0', 07:38:53 INFO - 'XPC_SERVICE_NAME': '0', 07:38:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:38:53 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-3YN5zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:38:53 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)) 07:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:38:53 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-eanNJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:38:53 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)) 07:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:38:53 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-gOQ_VM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:38:53 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)) 07:38:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:38:53 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-9zB28F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:38:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-9wAyfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:38:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-FZhlUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:38:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-MlXhy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:38:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-9uKZMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:38:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-UajDW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:38:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-5uRhvb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:38:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-iRcKWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:38:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-U5ZiNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:38:54 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)) 07:38:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:38:54 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-PdHXSE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:38:55 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)) 07:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:38:55 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-xDyVUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:38:55 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)) 07:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:55 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-xWEvzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:38:55 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)) 07:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:38:55 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-NxFH1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:38:55 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)) 07:38:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:38:55 INFO - Running setup.py (path:/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/pip-j1mkZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:38:55 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)) 07:38:55 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)) 07:38:55 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)) 07:38:55 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)) 07:38:55 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)) 07:38:55 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)) 07:38:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:38:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:38:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:38:57 INFO - Downloading blessings-1.6.tar.gz 07:38:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:38:57 INFO - Installing collected packages: blessings 07:38:57 INFO - Running setup.py install for blessings 07:38:58 INFO - Successfully installed blessings 07:38:58 INFO - Cleaning up... 07:38:58 INFO - Return code: 0 07:38:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:38:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:38:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:38:58 INFO - Reading from file tmpfile_stdout 07:38:58 INFO - Current package versions: 07:38:58 INFO - blessings == 1.6 07:38:58 INFO - blobuploader == 1.2.4 07:38:58 INFO - docopt == 0.6.1 07:38:58 INFO - manifestparser == 1.1 07:38:58 INFO - mozInstall == 1.12 07:38:58 INFO - mozcrash == 0.16 07:38:58 INFO - mozdebug == 0.1 07:38:58 INFO - mozdevice == 0.48 07:38:58 INFO - mozfile == 1.2 07:38:58 INFO - mozhttpd == 0.7 07:38:58 INFO - mozinfo == 0.9 07:38:58 INFO - mozleak == 0.1 07:38:58 INFO - mozlog == 3.1 07:38:58 INFO - moznetwork == 0.27 07:38:58 INFO - mozprocess == 0.22 07:38:58 INFO - mozprofile == 0.28 07:38:58 INFO - mozrunner == 6.11 07:38:58 INFO - mozscreenshot == 0.1 07:38:58 INFO - mozsystemmonitor == 0.0 07:38:58 INFO - moztest == 0.7 07:38:58 INFO - mozversion == 1.4 07:38:58 INFO - psutil == 3.1.1 07:38:58 INFO - requests == 1.2.3 07:38:58 INFO - wsgiref == 0.1.2 07:38:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:58 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 0x10cd53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b794b6e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf7d30>, '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 0x10ca1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeeb20>, '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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 07:38:58 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 07:38:58 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 07:38:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vhnvTrMFqz/Render', 07:38:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:58 INFO - 'HOME': '/Users/cltbld', 07:38:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:58 INFO - 'LOGNAME': 'cltbld', 07:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:58 INFO - 'MOZ_NO_REMOTE': '1', 07:38:58 INFO - 'NO_EM_RESTART': '1', 07:38:58 INFO - 'PAGER': '/bin/cat', 07:38:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:58 INFO - 'PWD': '/builds/slave/test', 07:38:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:58 INFO - 'SHELL': '/bin/bash', 07:38:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ThNCx6kXn/Listeners', 07:38:58 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 07:38:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:58 INFO - 'USER': 'cltbld', 07:38:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:58 INFO - 'XPC_FLAGS': '0x0', 07:38:58 INFO - 'XPC_SERVICE_NAME': '0', 07:38:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:58 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)) 07:38:58 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)) 07:38:58 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)) 07:38:58 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)) 07:38:58 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)) 07:38:58 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)) 07:38:58 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)) 07:38:58 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)) 07:38:58 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)) 07:38:58 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)) 07:38:58 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)) 07:38:58 INFO - Cleaning up... 07:38:58 INFO - Return code: 0 07:38:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:38: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')]} 07:38:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:38:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38: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')]} 07:38:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:38:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:38:58 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 0x10cd53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b794b6e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf7d30>, '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 0x10ca1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeeb20>, '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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 07:38:58 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 07:38:58 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 07:38:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vhnvTrMFqz/Render', 07:38:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:38:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:38:58 INFO - 'HOME': '/Users/cltbld', 07:38:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:38:58 INFO - 'LOGNAME': 'cltbld', 07:38:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:38:58 INFO - 'MOZ_NO_REMOTE': '1', 07:38:58 INFO - 'NO_EM_RESTART': '1', 07:38:58 INFO - 'PAGER': '/bin/cat', 07:38:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:38:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:38:58 INFO - 'PWD': '/builds/slave/test', 07:38:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:38:58 INFO - 'SHELL': '/bin/bash', 07:38:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ThNCx6kXn/Listeners', 07:38:58 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 07:38:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:38:58 INFO - 'USER': 'cltbld', 07:38:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:38:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:38:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:38:58 INFO - 'XPC_FLAGS': '0x0', 07:38:58 INFO - 'XPC_SERVICE_NAME': '0', 07:38:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:38:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:38:58 INFO - Downloading/unpacking jsonschema 07:38:58 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 07:38:58 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 07:38:58 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 07:38:58 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 07:38:58 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 07:38:58 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 07:39:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:39:01 INFO - Downloading/unpacking functools32 (from jsonschema) 07:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:01 INFO - Downloading functools32-3.2.3-2.tar.gz 07:39:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:39:01 INFO - warning: no files found matching '*.txt' 07:39:01 INFO - no previously-included directories found matching 'build' 07:39:01 INFO - no previously-included directories found matching 'dist' 07:39:01 INFO - no previously-included directories found matching '.git*' 07:39:01 INFO - Installing collected packages: jsonschema, functools32 07:39:01 INFO - Running setup.py install for functools32 07:39:01 INFO - warning: no files found matching '*.txt' 07:39:01 INFO - no previously-included directories found matching 'build' 07:39:01 INFO - no previously-included directories found matching 'dist' 07:39:01 INFO - no previously-included directories found matching '.git*' 07:39:01 INFO - Successfully installed jsonschema functools32 07:39:01 INFO - Cleaning up... 07:39:01 INFO - Return code: 0 07:39:01 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:39:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:01 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 0x10cd53a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd5a4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b794b6e00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cbf7d30>, '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 0x10ca1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeeb20>, '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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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 07:39:01 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 07:39:01 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 07:39:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vhnvTrMFqz/Render', 07:39:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:39:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:39:01 INFO - 'HOME': '/Users/cltbld', 07:39:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:39:01 INFO - 'LOGNAME': 'cltbld', 07:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:01 INFO - 'MOZ_NO_REMOTE': '1', 07:39:01 INFO - 'NO_EM_RESTART': '1', 07:39:01 INFO - 'PAGER': '/bin/cat', 07:39:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:01 INFO - 'PWD': '/builds/slave/test', 07:39:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:39:01 INFO - 'SHELL': '/bin/bash', 07:39:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ThNCx6kXn/Listeners', 07:39:01 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 07:39:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:39:01 INFO - 'USER': 'cltbld', 07:39:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:39:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:01 INFO - 'XPC_FLAGS': '0x0', 07:39:01 INFO - 'XPC_SERVICE_NAME': '0', 07:39:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:39:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:02 INFO - Downloading/unpacking flake8 07:39:02 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 07:39:02 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 07:39:02 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 07:39:02 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 07:39:02 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 07:39:02 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 07:39:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:39:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:39:04 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 07:39:04 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 07:39:04 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 07:39:04 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 07:39:04 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 07:39:04 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 07:39:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:39:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:39:04 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 07:39:04 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 07:39:04 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 07:39:04 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 07:39:04 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 07:39:04 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 07:39:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:39:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:39:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:39:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:39:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:39:05 INFO - no previously-included directories found matching 'docs/_build' 07:39:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:39:05 INFO - Running setup.py install for pep8 07:39:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:39:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:39:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:39:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:39:05 INFO - no previously-included directories found matching 'docs/_build' 07:39:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:39:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:39:05 INFO - Cleaning up... 07:39:06 INFO - Return code: 0 07:39:06 INFO - Running post-action listener: _resource_record_post_action 07:39:06 INFO - Running post-action listener: _start_resource_monitoring 07:39:06 INFO - Starting resource monitoring. 07:39:06 INFO - ##### 07:39:06 INFO - ##### Running install step. 07:39:06 INFO - ##### 07:39:06 INFO - Running pre-action listener: _resource_record_pre_action 07:39:06 INFO - Running main action method: install 07:39:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:39:06 INFO - Reading from file tmpfile_stdout 07:39:06 INFO - Detecting whether we're running mozinstall >=1.0... 07:39:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:39:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:39:06 INFO - Reading from file tmpfile_stdout 07:39:06 INFO - Output received: 07:39:06 INFO - Usage: mozinstall [options] installer 07:39:06 INFO - Options: 07:39:06 INFO - -h, --help show this help message and exit 07:39:06 INFO - -d DEST, --destination=DEST 07:39:06 INFO - Directory to install application into. [default: 07:39:06 INFO - "/builds/slave/test"] 07:39:06 INFO - --app=APP Application being installed. [default: firefox] 07:39:06 INFO - mkdir: /builds/slave/test/build/application 07:39:06 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'] 07:39:06 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 07:39:40 INFO - Reading from file tmpfile_stdout 07:39:40 INFO - Output received: 07:39:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:39:40 INFO - Running post-action listener: _resource_record_post_action 07:39:40 INFO - ##### 07:39:40 INFO - ##### Running run-tests step. 07:39:40 INFO - ##### 07:39:40 INFO - Running pre-action listener: _resource_record_pre_action 07:39:40 INFO - Running main action method: run_tests 07:39:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:39:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:39:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:39:40 INFO - 2016-02-22 07:39:40.227 screenresolution[1663:8264] starting screenresolution argv=screenresolution get 07:39:40 INFO - 2016-02-22 07:39:40.230 screenresolution[1663:8264] Display 0: 1600x1200x32@60 07:39:40 INFO - 2016-02-22 07:39:40.236 screenresolution[1664:8266] starting screenresolution argv=screenresolution list 07:39:40 INFO - Available Modes on Display 0 07:39:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:39:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:39:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:39:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:39:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:39:40 INFO - Intel Iris: 07:39:40 INFO - Chipset Model: Intel Iris 07:39:40 INFO - Type: GPU 07:39:40 INFO - Bus: Built-In 07:39:40 INFO - VRAM (Dynamic, Max): 1536 MB 07:39:40 INFO - Vendor: Intel (0x8086) 07:39:40 INFO - Device ID: 0x0a2e 07:39:40 INFO - Revision ID: 0x0009 07:39:40 INFO - Displays: 07:39:40 INFO - Display: 07:39:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:39:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:39:40 INFO - Display Serial Number: 1600x1200 60 07:39:40 INFO - Main Display: Yes 07:39:40 INFO - Mirror: Off 07:39:40 INFO - Online: Yes 07:39:40 INFO - Rotation: Supported 07:39:40 INFO - Return code: 0 07:39:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:39:40 INFO - Python 2.7.3 07:39:40 INFO - Return code: 0 07:39:40 INFO - grabbing minidump binary from tooltool 07:39:40 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')]} 07:39:40 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 0x10cbf7d30>, '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 0x10ca1bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cbeeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:39:40 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 07:39:40 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 07:39:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:39:40 INFO - Return code: 0 07:39:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:39:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:39:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:39:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:39:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:39:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:39:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:39:41 INFO - Return code: 0 07:39:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:39:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0105 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:39:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vhnvTrMFqz/Render', 07:39:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:39:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:39:41 INFO - 'HOME': '/Users/cltbld', 07:39:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:39:41 INFO - 'LOGNAME': 'cltbld', 07:39:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:39:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:39:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:41 INFO - 'MOZ_NO_REMOTE': '1', 07:39:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:39:41 INFO - 'NO_EM_RESTART': '1', 07:39:41 INFO - 'PAGER': '/bin/cat', 07:39:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:39:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:41 INFO - 'PWD': '/builds/slave/test', 07:39:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:39:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:39:41 INFO - 'SHELL': '/bin/bash', 07:39:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6ThNCx6kXn/Listeners', 07:39:41 INFO - 'TMPDIR': '/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/', 07:39:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:39:41 INFO - 'USER': 'cltbld', 07:39:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:39:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:39:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:41 INFO - 'XPC_FLAGS': '0x0', 07:39:41 INFO - 'XPC_SERVICE_NAME': '0', 07:39:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:39:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0105', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:39:42 INFO - mozversion application_buildid: 20160222053756 07:39:42 INFO - mozversion application_changeset: 789a12291942763bc1e3a89f97e0b82dc1c9d00b 07:39:42 INFO - mozversion application_display_name: Nightly 07:39:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:39:42 INFO - mozversion application_name: Firefox 07:39:42 INFO - mozversion application_remotingname: firefox 07:39:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:39:42 INFO - mozversion application_vendor: Mozilla 07:39:42 INFO - mozversion application_version: 47.0a1 07:39:42 INFO - mozversion platform_buildid: 20160222053756 07:39:42 INFO - mozversion platform_changeset: 789a12291942763bc1e3a89f97e0b82dc1c9d00b 07:39:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:39:42 INFO - mozversion platform_version: 47.0a1 07:39:42 INFO - using testdate: 1456155582 07:39:42 INFO - actual date: 1456155582 07:39:42 INFO - starting webserver on 'localhost:49283' 07:39:42 INFO - SUITE-START | Running 2 tests 07:39:42 INFO - TEST-START | dromaeo_css 07:39:42 INFO - operating with platform_type : mac_ 07:39:42 INFO - Initialising browser for dromaeo_css test... 07:39:42 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpwV5Ube/profile http://localhost:49283/getInfo.html) 07:39:44 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 07:39:44 INFO - PROCESS | 1682 | colorDepth:24 07:39:44 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 07:39:44 INFO - PROCESS | 1682 | __metrics 07:39:45 ERROR - PROCESS | 1682 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 07:39:45 INFO - TEST-INFO | 1682: exit 0 07:39:45 INFO - Browser initialized. 07:39:45 INFO - Running cycle 1/1 for dromaeo_css test... 07:39:45 INFO - TEST-INFO | started process 1687 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpwV5Ube/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:39:57 INFO - PROCESS | 1687 | RSS: Main: 255676416 07:39:57 INFO - PROCESS | 1687 | 07:40:47 INFO - PROCESS | 1687 | 1456155647234 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] 07:42:58 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49283/tests/dromaeo/cssquery-ext.html) 07:43:00 INFO - PROCESS | 1687 | RSS: Main: 270434304 07:43:00 INFO - PROCESS | 1687 | 07:46:02 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-ext.html (next: http://localhost:49283/tests/dromaeo/cssquery-jquery.html) 07:46:02 INFO - PROCESS | 1687 | RSS: Main: 280825856 07:46:02 INFO - PROCESS | 1687 | 07:49:04 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49283/tests/dromaeo/cssquery-mootools.html) 07:49:05 INFO - PROCESS | 1687 | RSS: Main: 281522176 07:49:05 INFO - PROCESS | 1687 | 07:52:06 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49283/tests/dromaeo/cssquery-prototype.html) 07:52:07 INFO - PROCESS | 1687 | RSS: Main: 283361280 07:52:07 INFO - PROCESS | 1687 | 07:55:10 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49283/tests/dromaeo/cssquery-yui.html) 07:55:10 INFO - PROCESS | 1687 | RSS: Main: 287281152 07:55:10 INFO - PROCESS | 1687 | 07:58:13 INFO - PROCESS | 1687 | Cycle 1(1): loaded http://localhost:49283/tests/dromaeo/cssquery-yui.html (next: http://localhost:49283/tests/dromaeo/cssquery-dojo.html) 07:58:13 INFO - PROCESS | 1687 | RSS: Main: 288636928 07:58:13 INFO - PROCESS | 1687 | 07:58:13 INFO - PROCESS | 1687 | __start_tp_report 07:58:13 INFO - PROCESS | 1687 | _x_x_mozilla_page_load 07:58:13 INFO - PROCESS | 1687 | _x_x_mozilla_page_load_details 07:58:13 INFO - PROCESS | 1687 | |i|pagename|runs| 07:58:13 INFO - PROCESS | 1687 | |0;dojo.html;3500.1074725944886;3511.1046683095806;3544.3620148373316;3572.5534308211472;3575.4636804479323;4276.550962148976;5660.915086273699;5689.431056894314;5712.1431785232235;5715.628484148533;5521.337439507255;5733.254676892008;5769.16347129666;5816.854578635525;5873.412658734135;5194.896102077956;5197.870053248661;5244.239585260135;5266.183741520052;5277.762500687459;5307.124324486455;5319.228711836781;5322.095243808542;5356.678599284055;5371.57027437804;5171.663841850268;5176.27532145498;5216.66091704038;5262.105442074818;5264.105102132608;5255.211718242256;5285.339332583427;5291;5295.417504074549;5330.600204984642;5181.093308671006;5219.478052194788;5225.529702326771;5242.18746094356;5316.3354580677415;5526.696031718254;5646.802361917355;5678.971605141989;5699.173619825144;5705.714714264312;6140.3552626974415;6144.941444616059;6216.533759967975;6227.408396202353;6272.937270627326;6151.7539298428455;6258.843528911768;6265.655388953605;6283.497320214417;6329.620222786648;4803.807847686088;5833.066709326487;5856.560757943129;5879.059350503899;5910.143029260733;6204.751809927552;6227.19046523949;6309.179806625109;6311.621302721851;6352.205974253218;6066.059760737005;6177.660228687376;6216.595921265103;6243.906341404882;6247.718852651551;6286.685665716695;6293.213348331458;6301.810945671546;6320.399562041599;6322.988321868479;5958.493528050078;6141.631502109888;6165.290991535941;6177.135201071854;6216.689165541795;6093.908591371133;6238.095476155932;6246.812595622138;6268.279147897959;6287.622742635456;4969.801207951641;4973.825916092919;4984.077945580079;4991.5258050485145;4999.52504512078;3645.2345007548183;3815.8855234343014;4330.7401555906745;4350.282203436397;4445.555444455528;5796.826095217066;5827.679477628772;5836.182934389189;5865.35481097079;5865.912011319833;6220.875582488416;6253.405926436982;6270.874582508324;6276.058591211264;6301.338359472189;5805.6806875621405;5825.242718446575;5841.153032810304;5852.4147585241135;5857.88284234313;5416.91874621881;5422.674639521641;5445.428230035868;5454.12733962572;5454.509094181463;6228.439440450381;6334.714937827716;6355.650439225887;6366.936330636634;6394.976803711384;6170.10533472653;6213.813585592439;6290.402411770874;6298.905516417349;6337.112804207322;6347.206599175103;6360.300366959538;6389.424951754364;6403.135576697273;6408.775692850728;6101.4290607115445;6173.506119510339;6271.216097987752;6272.278687950944;6284.654344011124;6241.438270555672;6288.874222515616;6289.433950944437;6298;6337.176167098248;5356.839464715837;5925.970370148121;6072.514198864169;6186.319504854552;6189.133521306931;6072.787452439144;6130.9577371846;6170.352113028068;6184.165137706532;6196.597221180609;5819.214406055128;6052.388473343912;6098.976888191913;6100.1459795629535;6106.786262480792;6026.337102918763;6098.099428985257;6098.40197260387;6193.071039344134;6194.81415557534;6017.518598512196;6035.39646035393;6048.274207095177;6059.787907423219;6083.69581520931 07:58:13 INFO - PROCESS | 1687 | |1;ext.html;437.9912401751965;444.3978409255459;450.85347262139794;492.7582492119859;560.3080195957989;31120;36228.2754344913;36779.81610091949;37031.259374812485;37067.25865482689;37883.62116378835;38439.61560384395;38448.423273650915;38550.61449385505;38593.42109868354;9204.631814727403;9375.718728438158;9406.905930940706;9472.005439428864;9475.763105922339;8407.24334809867;9428.481433521154;9634.518274086302;9668.854967175497;9723.659671911484;8313.919190505227;9536.189423898977;9697;9718.076782705632;9742.123208911196;9601.615935362577;9648.179904708108;9684.61261549537;9694.757631059209;9698.321117521777;9366.625334986593;9398.62405503779;9554.235661147091;9577.61689532418;9608.711738647851;36607.267854642756;37187.628123718685;37230.25539489222;37362.25275494475;37704.24591508182;3114.252579380955;3246.3020450603;3362.663733626642;3385.4752513360468;3420.9486857697157;26821.793019314176;27321.86339068292;27427.31431714223;27689;28649.85400583995;2753.0501976817964;2755.9724402755915;2820.506411378001;2830.3631682871396;2836.4327134572964;422141;472505;472965;477313.9999999965;484714;44348;62245.06632400517;62523.6873815628;62639.6868015657;62670;36134.81932590373;43950.7802460992;44007.119857602665;44082.33876491855;44311;14941.701165976838;15059.94580379363;15281.541553753405;15413.691726165414;15458.690826183414;11986.340751258764;11992.820107698391;12250.571230006906;12318.692032699075;12464.563740269046;14018.509352172625;14082.014259001771;14187.219702916438;14486.927565362106;14530.273486325641;6328.557001009977;6423.871522569522;6437.871242575122;6445.355464453517;6449.935500644933;980.5881529757519;995.721198064543;1009.8030883977701;1170.9824352634716;1182.2847177457686;23400.414989625056;27744.706352377227;29341;29480.262993425335;29717.55423668647;1053;1064.4039337970607;1065.8827528971806;1073.5759375046812;1128.114430172311;12187.93906030482;12936.482540698267;14161.716765664629;14322.140671559531;14359.923005774608;636993;647274;650406;650477;651220;52501;54342;56100.5974850632;56840.147397789064;57220;1434.5050957419674;1451.4629587052857;1471.9190444525655;1474.8820094392208;1481.3037872200264;27286.590701139103;27414.314642133308;27870.721292786813;27907.860460697568;28211;46155.53844461512;46447.53552464432;47058;47229.34697285716;47240.29139562978;497205;499019;502249;504569;505170;31025.68974310228;31327.53008704917;32469.51295730613;32690.673093268764;32709.345813083128;40332.79001629956;40872.79563602163;41281;41354;41835.372469412374;35098.82450587833;35793.82103089572;36491.817540912125;36526.452103219;36796.81601591975;27029.45941081128;30574;35059.824700876336;36098.48768903887;36233.45649815308;31190.128592284535;35174.824125879204;35496.645033549335;35723.64276357307;36177.45733814048;26254.949802007704;29913.85043074858;30890.691093088783;31964.360712786078;32061;19762.604747904676;25046.622435766207;25504.107356242443;25750.484990299716;25763.227103186935 07:58:13 INFO - PROCESS | 1687 | |2;jquery.html;324.2073131194231;330.83458270864566;367.4561648759835;369.6377550000999;374.02939372328814;15597.454089106855;19480.90259548702;19495.805041949578;19644.508887277825;20067;18783.154758035886;18878.43364699058;19505;19595.216191352363;20004.29984950527;5588.91616625752;5612.69130197841;5929.466348028676;5930.199423077873;5933.258342707161;5800.796972105977;5835.737391817357;5864.824055278348;5887.293524777033;5889.234399528055;2883.4089011752644;5539.972300138514;5669.773209071632;5828.0966450200285;5849.268841394825;5880.6765627890445;5895.263092113486;5917.970410147922;5922.022866227067;5930.911036334458;4236.872893813191;5445.101558242885;5582.078956972095;5607.355154157242;5644;13004.934975325157;13152.605421837361;13245.205287682673;13271.071025028252;18558.44324670262;2083.5207902182583;2150;2160.2439146298825;2180.7274090738656;2197.230969160797;9405.200557952583;9405.529723513866;9602.567884445216;10038.648647297383;10116.94941525295;1713.151989765062;1764.7176451767784;1911.0635788463692;1915.8275755181962;1918.3477617610079;73030;91406.62890056655;93513.53243233808;95029.52485237598;95343;10491.950804919446;10883.945580272048;11099.722506937229;11298.209125361145;11328.603498877499;11618.76762464746;13402;13486.797698034537;13498.865011349957;13504.729905402033;8221.876671849926;8307.210814972568;8357;8548.615312310962;8552.61513231906;6973.58158510491;8617.181367770052;8658.134186581417;8672.479651220947;8677.826443471095;4208.789560521962;4329.19909816685;4427.712198707074;4509.932351014738;4542.000759832831;1691.8900271482314;1786.722493417213;1856.1183437867176;1894.9242030318908;1904.2668572599648;796.5101462600459;891.4784850862318;922.800359532605;944.7449188719007;990.5740531571494;18774.1551630177;20435.897820511098;20563.764809039356;21151;21429.67855482169;897.6947837735202;963.9252233759308;972.1056627902346;996.7807082441851;1010.3281317923645;10664.360138391721;11132;11136;11149.609763658233;11192.160587955936;587778;591343;593181;619265;631209;69148;70504;109503;111042;111659;872.8079822439054;1047.251215380991;1047.9685609431729;1050.2123407444417;1056.7252514346171;16885.32458701638;18129.093545322416;18305.450836474927;18337.449876503728;18505.167267472727;46656.533434665216;47623;49250.75374623104;50192.49807501878;50244.477996980444;66623;66894.32764180934;67817;68425.3157468419;68733.96899046419;8061.113277539349;8077.394195435483;8203.42576019673;8211.630476628447;8272.83454330922;10593.788124237319;13292.26892520882;13583.728325433238;13616.251106189255;13658.385372658055;11097.056750176003;11520.366379849189;11612;11638.301701897575;11752.236104653512;9529.332946693665;10781.62264320745;11357.375344355809;11854.466549005143;11972.16194866386;11341.546338146381;11832.34922079294;11915.2255103418;12063.939680301894;12126.27242365461;8036.397270204875;8043.959780201296;8096.5546894921345;8253.050899146676;8324.83350333002;8488.193621605938;9860.753481163028;10616.681499555025;11815.113866459878;11865.169438139592 07:58:13 INFO - PROCESS | 1687 | |3;mootools.html;1545.1424459425018;1560.4850399368206;1668.5161303222067;1812.2388596789347;1890.8109189081094;7958.283754462097;8477.957610211955;8785.165409286115;8839.204471597555;8957.820843583124;7963.92036079639;8132.593370331475;8755.993060797995;8853.247473964704;8863.689770858005;2467.617519284514;2473.6907886514186;2482.429041320497;2493.5262300163004;2514.4719608882065;2049.9282525111626;2467.457159424933;2471.406862353031;2478.863662498562;2481.727010028895;2417.4319035026756;2483.515714435686;2500.4874000829877;2505.66173566568;2511.359603301156;2483.5777917753844;2493.4265119022634;2501.8874150663173;2520.9369765756005;2522.2937577478338;2518.1312447205682;2533.6579561759113;2544.5419824431597;2545.4527276635426;2562.743725627441;8763.992140903814;8810.471371717718;8816.206541411304;8833.55832208387;8834.955825220897;5360.624756267063;5526.668399896019;5553.527950124244;5574.804881829116;5575.080111781551;3588.2644057968055;3661.707063434919;3702.740808143431;3715.071232191952;3724.3110024645525;1053.873535175784;1055.203321492276;1056.1497994114734;1090.596479302655;1105.7898999190209;11873.465694043789;11884.702882427922;11945.163838531307;12033.217840840318;12059.57791477294;4673.602743766818;4751;4773.856784296477;4773.9761301193275;4792.664513484093;8990.325725570608;9270.443773373485;9272.258219342571;9277.118673725985;9302.627894884265;5269.077911365495;5392.622516423813;5397.514223719884;5425.864353391118;5485.232067510552;4462.928897064681;4857.514248575114;4943.72809495474;4997.85006449807;5023.120953833065;3811.142492939122;3816.332141875216;3828.1195325075387;3859.208862183246;3864.903377415531;880.3045593980684;1184.1237484261585;1188.7741329147607;1189.5063548627395;1191.065013964034;1114.654457118296;1119.121489630636;1127.4982632728356;1290.6579756364572;1383.3221721356665;7616.822896389278;7690.346320562703;7868;7888.48724832884;7973.72091976778;508.5905845794171;509.52868596548046;512.8487096306599;518.3106468397023;526.3736153976755;6063.787767428119;6182.969085154546;6219.346968568326;6247.219097612799;6249.6562689052535;10500.579976800995;10574.947125264478;10818.621348252773;10838.837417438745;10847.294925829954;10305.793884122426;10566.841497377545;10630.840537391945;10677.572897084185;10779.137668986463;6767;8314.708985185489;8322.417430779788;8387.496750194885;8508.872366914502;7345.632718363953;7451.509698060518;8027.678892844221;8129.227723366271;8171.673133074611;9451.527423628928;9551.42691438516;9615.663451779154;9698.127168554864;9723.02769723022;7817.921820781719;9688.9031109688;9842.60629574809;9924.305298629026;9959.153471954965;6203.983705295706;6897.965510172417;7389.187189409268;7452.06849143857;7552.169261381134;8241.052278987992;8279.379046571652;8284.917150828414;8306.418550701394;8331.625076871434;7315.085614298213;7405.379304165161;7521.435892307989;7577.696892124253;7701.845963080819;7370.742024029133;7394.926050739424;7438.73964411243;7498.250174982458;7506.3244308012545;6520.836979075561;7718.035245594301;7857.489263198103;7926.326262267541;7940.483868548526;6965.47758918073;7063.117110361205;7148.821279468055;7174.605396703231;7190.568565886064;7155.42756579462;7230.927690723025;7241.058662374068;7312;7328.890066648898 07:58:13 INFO - PROCESS | 1687 | |4;prototype.html;303.5371059134819;325.9771815972881;327.81806097615816;334.6419331315492;334.6636630186662;6683.930571108624;6755.189377274722;6811.591304521726;6821.727130914764;6823.863522729549;5364.651297665649;6688.1305430294115;6718;6742.595444273335;6767.830804229897;4973.502649735034;4980.153373926441;4984.626153038518;4994.67534610251;4998.3252260944855;4083.448734420845;4919.631027672921;4923.261510773377;4987.276844857512;4987.351644286256;4948.703077815325;4949.480304568023;4951;4959.6528243023;4963.900721985558;4664.300354946751;4888.120138375091;4937.2840938063955;4947.109520286347;4954.504549545035;4076.2051399977017;4110.486189226347;4115.8971025724595;4115.938260926088;4120.608542188487;5318.840434786963;5632.211490391349;6357.841053973688;6367.363263673642;6375.489960803171;5581.441855814386;5788.855278618026;5806.506446952014;5815.447532484407;5831.475167234927;7227;7231.710731570731;7238;7245.058142441501;7247.782566523013;4611.976940115312;4612.431773197096;4621.2837010263465;4622.2835460503675;4639.188142075123;7650.158482566913;7694.269044440769;7717.151113377524;7719.228077192292;7801.648925798353;4453.799579018952;4539.341795439709;4554.612857907049;4611.930821037688;4645.094206629675;4686.226772582554;4687.039156972813;4688.2733176357715;4699.647526435463;4707.599854012379;4659.673822832437;5583.553315734732;5612.466815652507;5620.85947851307;5638.915416268759;6169.9383006170265;7157.606331651809;7266.45501587383;7266.600336981411;7287.198408175096;1638.7623794549725;1657.8176400595926;1658.2454982982713;1659.6929568029711;1663.2016632016457;1027.635189507729;1058.7882423515327;1060.7136073260176;1070.1011150633506;1080.0873262093519;6748.358905903931;6766.492513061442;6790.7623233186605;6791.456683465311;6803.217629972616;6076;6495.090687303781;7165.925111233357;7514.887276690854;7550.735724249625;6735.259121496631;6773.356531129633;6778.084958530634;6779.186497620219;6789.864202716017;3826.9234615307537;3985.740926839746;4009.8797036088963;4033.576474470197;4034.1931613677384;7858.0963189232825;7891.960540197377;7909.604519774103;7912.84174316522;7934.166912474223;7791.844163116706;7794.6882124714375;7811.296983271533;7821.178776228528;7831.98184236057;7885.802854928673;7889.132195458495;7892.605369731606;7899.249571290718;7916.287534121841;6463.676816159267;7250.492465527363;7527.887081693889;7551.358134558624;7578.696852125853;7386.667599958122;7390.334869861738;7403.185649578434;7404.148522919718;7417.369523590555;6314.905276420949;7886.526808391515;7917.208279172267;7921.316587786707;7934.841303174019;4663.860084197479;4701.801040734591;4703.929441058455;4705.364775755229;4712.7643617818285;6549.443297319781;6729.730810767514;7422.517536360119;7498.925010749823;7538.133114691881;7325.377342925911;7333.413326933725;7349.448791340564;7367.77896663101;7383.261673832574;6598.60408375499;7006.843870761268;7328.1938986712485;7356.705731770669;7413.555186688816;6122.846928826637;7111.933210018332;7192.748253811092;7200.963995179991;7212.459065570209;7097.574145551283;7360.263973602597;7370.96314518424;7401.666924988496;7406.962965185139;7160.713571457291;7204.351608355273;7221.4222862169845;7246.746363877239;7248.057752492142 07:58:13 INFO - PROCESS | 1687 | |5;yui.html;682.7269092363056;734.6510407556411;736.4734215036254;736.5249414127887;777.2421888658558;14976.326065327059;15070.924645376785;15190.620234494128;15197.620059498518;15201.695966080686;13624.114432561877;13633.182009079437;13693.794593081111;13722.794158087612;13729.725405491885;698.7414656577048;859.1065292096213;861.2636196052379;867.9974629303165;880.7049638371121;854.8375808596378;868.3704314372061;879.0989236033085;886.8182022685334;887.0863011098579;930.1163894300441;933.5705575435308;934.5654270764094;935.8362286599852;940.8823897012874;891.9732408027704;896.8654701794718;913.3150137396952;923.1553128887094;927.0405130689771;679.5548915460332;690.6822861483723;697.6546609428315;697.9162500499973;702.4731451411442;14439;14445.49440769568;14482.34829432678;14521.709565808731;14545.854541454662;10868.6195983141;12670.683232919158;12879.549215777402;12983.480660773557;13014.739705205937;9650.517474126265;9726.513674316328;9771.462569558671;9795.804083918352;10456.895431045668;3107.958833790683;3344.3812894614575;3448.2241495663525;3477.4088404971217;3596.4605309203566;78219;78808.60595696984;79229.20770792276;83968.58015709883;85210.57394712987;9440.763980900396;9542.856857147148;9614;9962.108780618843;9972.850407243897;20987.685184722242;21069.367918962456;21219.46951326229;21263.8936805315;21284.680729789066;7210.206877243499;7380.889286660705;7572.432067594952;7672.232776722283;7953.363730901514;4010.498687664042;4074.30736774749;4106.979465102655;4107.835686572564;4127.855525056609;3569.7501174918025;3629.9637003630155;3648.543932008499;3650.1604630935035;3651.3610118229735;704.5983789240187;709.8828693265657;713.105053158283;719.2124623537219;731.4952682648956;592.7658574862991;594.8958932186937;598.6228675934134;620.1136380494543;630.2027934662656;8219.876701849476;8515.914840851636;8536.146385361415;8729.99605045428;8934.374593778373;490.4066080043188;551.2172714744992;559.7844829740579;569.8974184646803;572.5505478199593;3919.6864250859862;3960.128771670228;4021.4369988201674;4065.024394145443;4154;91286;91312.5434372824;91575.54212228896;92093;92804;79154;79707.20292797114;79819.20180798233;80709;81087.594562028;70664;71330;71915.64042179755;72435.2756472439;72478.27521724715;7983.84032319362;8122.75631731049;8163.551004694798;8270.669173233244;8363.665453381796;42228.31086756618;44841;46103;46293.305600416694;47367.52632473769;64307;65403.67298163479;66844;67167;67407.66296168488;9034.774130646787;9442.725232093579;10087.899121008695;10333.689989300334;10359.119474844723;11194.531767660013;11292.774144517229;11564.884351156381;11707.180497365103;11891.82162267584;10286.588536458758;10390.480475976019;10735.980081892209;10765.677029689123;11258.09935205198;10276.280660353703;10432.68701938943;10775.730606734895;10791.40647264408;11276.379799111128;8780.956095219482;9649.517524123907;9938.701838944844;10576.894231057591;11124.388158651029;7953.6818527258265;8667.349948753743;8792.736217913473;8853.981792093991;9183;8310.719131614838;8362.665493380196;8623.267022302924;8820.25027872638;9220.907790922005 07:58:13 INFO - PROCESS | 1687 | __end_tp_report 07:58:13 INFO - PROCESS | 1687 | __start_cc_report 07:58:13 INFO - PROCESS | 1687 | _x_x_mozilla_cycle_collect,340 07:58:13 INFO - PROCESS | 1687 | __end_cc_report 07:58:13 INFO - PROCESS | 1687 | __startTimestamp1456156693335__endTimestamp 07:58:13 INFO - PROCESS | 1687 | 07:58:13 INFO - PROCESS | 1687 | ------- Summary: start ------- 07:58:13 INFO - PROCESS | 1687 | Number of tests: 6 07:58:13 INFO - PROCESS | 1687 | 07:58:13 INFO - PROCESS | 1687 | [#0] dojo.html Cycles:165 Average:5763.30 Median:6048.27 stddev:659.53 (10.9%) stddev-sans-first:637.20 07:58:13 INFO - PROCESS | 1687 | Values: 3500.1 3511.1 3544.4 3572.6 3575.5 4276.6 5660.9 5689.4 5712.1 5715.6 5521.3 5733.3 5769.2 5816.9 5873.4 5194.9 5197.9 5244.2 5266.2 5277.8 5307.1 5319.2 5322.1 5356.7 5371.6 5171.7 5176.3 5216.7 5262.1 5264.1 5255.2 5285.3 5291.0 5295.4 5330.6 5181.1 5219.5 5225.5 5242.2 5316.3 5526.7 5646.8 5679.0 5699.2 5705.7 6140.4 6144.9 6216.5 6227.4 6272.9 6151.8 6258.8 6265.7 6283.5 6329.6 4803.8 5833.1 5856.6 5879.1 5910.1 6204.8 6227.2 6309.2 6311.6 6352.2 6066.1 6177.7 6216.6 6243.9 6247.7 6286.7 6293.2 6301.8 6320.4 6323.0 5958.5 6141.6 6165.3 6177.1 6216.7 6093.9 6238.1 6246.8 6268.3 6287.6 4969.8 4973.8 4984.1 4991.5 4999.5 3645.2 3815.9 4330.7 4350.3 4445.6 5796.8 5827.7 5836.2 5865.4 5865.9 6220.9 6253.4 6270.9 6276.1 6301.3 5805.7 5825.2 5841.2 5852.4 5857.9 5416.9 5422.7 5445.4 5454.1 5454.5 6228.4 6334.7 6355.7 6366.9 6395.0 6170.1 6213.8 6290.4 6298.9 6337.1 6347.2 6360.3 6389.4 6403.1 6408.8 6101.4 6173.5 6271.2 6272.3 6284.7 6241.4 6288.9 6289.4 6298.0 6337.2 5356.8 5926.0 6072.5 6186.3 6189.1 6072.8 6131.0 6170.4 6184.2 6196.6 5819.2 6052.4 6099.0 6100.1 6106.8 6026.3 6098.1 6098.4 6193.1 6194.8 6017.5 6035.4 6048.3 6059.8 6083.7 07:58:13 INFO - PROCESS | 1687 | 07:58:13 INFO - PROCESS | 1687 | [#1] ext.html Cycles:180 Average:65662.10 Median:36693.54 stddev:145626.33 (396.9%) stddev-sans-first:145952.51 07:58:13 INFO - PROCESS | 1687 | Values: 438.0 444.4 450.9 492.8 560.3 31120.0 36228.3 36779.8 37031.3 37067.3 37883.6 38439.6 38448.4 38550.6 38593.4 9204.6 9375.7 9406.9 9472.0 9475.8 8407.2 9428.5 9634.5 9668.9 9723.7 8313.9 9536.2 9697.0 9718.1 9742.1 9601.6 9648.2 9684.6 9694.8 9698.3 9366.6 9398.6 9554.2 9577.6 9608.7 36607.3 37187.6 37230.3 37362.3 37704.2 3114.3 3246.3 3362.7 3385.5 3420.9 26821.8 27321.9 27427.3 27689.0 28649.9 2753.1 2756.0 2820.5 2830.4 2836.4 422141.0 472505.0 472965.0 477314.0 484714.0 44348.0 62245.1 62523.7 62639.7 62670.0 36134.8 43950.8 44007.1 44082.3 44311.0 14941.7 15059.9 15281.5 15413.7 15458.7 11986.3 11992.8 12250.6 12318.7 12464.6 14018.5 14082.0 14187.2 14486.9 14530.3 6328.6 6423.9 6437.9 6445.4 6449.9 980.6 995.7 1009.8 1171.0 1182.3 23400.4 27744.7 29341.0 29480.3 29717.6 1053.0 1064.4 1065.9 1073.6 1128.1 12187.9 12936.5 14161.7 14322.1 14359.9 636993.0 647274.0 650406.0 650477.0 651220.0 52501.0 54342.0 56100.6 56840.1 57220.0 1434.5 1451.5 1471.9 1474.9 1481.3 27286.6 27414.3 27870.7 27907.9 28211.0 46155.5 46447.5 47058.0 47229.3 47240.3 497205.0 499019.0 502249.0 504569.0 505170.0 31025.7 31327.5 32469.5 32690.7 32709.3 40332.8 40872.8 41281.0 41354.0 41835.4 35098.8 35793.8 36491.8 36526.5 36796.8 27029.5 30574.0 35059.8 36098.5 36233.5 31190.1 35174.8 35496.6 35723.6 36177.5 26254.9 29913.9 30890.7 31964.4 32061.0 19762.6 25046.6 25504.1 25750.5 25763.2 07:58:13 INFO - PROCESS | 1687 | 07:58:13 INFO - PROCESS | 1687 | [#2] jquery.html Cycles:180 Average:32595.03 Median:368.55 stddev:99617.88 (27029.9%) stddev-sans-first:99867.87 07:58:13 INFO - PROCESS | 1687 | Values: 324.2 330.8 367.5 369.6 374.0 15597.5 19480.9 19495.8 19644.5 20067.0 18783.2 18878.4 19505.0 19595.2 20004.3 5588.9 5612.7 5929.5 5930.2 5933.3 5800.8 5835.7 5864.8 5887.3 5889.2 2883.4 5540.0 5669.8 5828.1 5849.3 5880.7 5895.3 5918.0 5922.0 5930.9 4236.9 5445.1 5582.1 5607.4 5644.0 13004.9 13152.6 13245.2 13271.1 18558.4 2083.5 2150.0 2160.2 2180.7 2197.2 9405.2 9405.5 9602.6 10038.6 10116.9 1713.2 1764.7 1911.1 1915.8 1918.3 73030.0 91406.6 93513.5 95029.5 95343.0 10492.0 10883.9 11099.7 11298.2 11328.6 11618.8 13402.0 13486.8 13498.9 13504.7 8221.9 8307.2 8357.0 8548.6 8552.6 6973.6 8617.2 8658.1 8672.5 8677.8 4208.8 4329.2 4427.7 4509.9 4542.0 1691.9 1786.7 1856.1 1894.9 1904.3 796.5 891.5 922.8 944.7 990.6 18774.2 20435.9 20563.8 21151.0 21429.7 897.7 963.9 972.1 996.8 1010.3 10664.4 11132.0 11136.0 11149.6 11192.2 587778.0 591343.0 593181.0 619265.0 631209.0 69148.0 70504.0 109503.0 111042.0 111659.0 872.8 1047.3 1048.0 1050.2 1056.7 16885.3 18129.1 18305.5 18337.4 18505.2 46656.5 47623.0 49250.8 50192.5 50244.5 66623.0 66894.3 67817.0 68425.3 68734.0 8061.1 8077.4 8203.4 8211.6 8272.8 10593.8 13292.3 13583.7 13616.3 13658.4 11097.1 11520.4 11612.0 11638.3 11752.2 9529.3 10781.6 11357.4 11854.5 11972.2 11341.5 11832.3 11915.2 12063.9 12126.3 8036.4 8044.0 8096.6 8253.1 8324.8 8488.2 9860.8 10616.7 11815.1 11865.2 07:58:13 INFO - PROCESS | 1687 | 07:58:13 INFO - PROCESS | 1687 | [#3] mootools.html Cycles:180 Average:5991.84 Median:5540.10 stddev:3168.96 (57.2%) stddev-sans-first:3160.23 07:58:13 INFO - PROCESS | 1687 | Values: 1545.1 1560.5 1668.5 1812.2 1890.8 7958.3 8478.0 8785.2 8839.2 8957.8 7963.9 8132.6 8756.0 8853.2 8863.7 2467.6 2473.7 2482.4 2493.5 2514.5 2049.9 2467.5 2471.4 2478.9 2481.7 2417.4 2483.5 2500.5 2505.7 2511.4 2483.6 2493.4 2501.9 2520.9 2522.3 2518.1 2533.7 2544.5 2545.5 2562.7 8764.0 8810.5 8816.2 8833.6 8835.0 5360.6 5526.7 5553.5 5574.8 5575.1 3588.3 3661.7 3702.7 3715.1 3724.3 1053.9 1055.2 1056.1 1090.6 1105.8 11873.5 11884.7 11945.2 12033.2 12059.6 4673.6 4751.0 4773.9 4774.0 4792.7 8990.3 9270.4 9272.3 9277.1 9302.6 5269.1 5392.6 5397.5 5425.9 5485.2 4462.9 4857.5 4943.7 4997.9 5023.1 3811.1 3816.3 3828.1 3859.2 3864.9 880.3 1184.1 1188.8 1189.5 1191.1 1114.7 1119.1 1127.5 1290.7 1383.3 7616.8 7690.3 7868.0 7888.5 7973.7 508.6 509.5 512.8 518.3 526.4 6063.8 6183.0 6219.3 6247.2 6249.7 10500.6 10574.9 10818.6 10838.8 10847.3 10305.8 10566.8 10630.8 10677.6 10779.1 6767.0 8314.7 8322.4 8387.5 8508.9 7345.6 7451.5 8027.7 8129.2 8171.7 9451.5 9551.4 9615.7 9698.1 9723.0 7817.9 9688.9 9842.6 9924.3 9959.2 6204.0 6898.0 7389.2 7452.1 7552.2 8241.1 8279.4 8284.9 8306.4 8331.6 7315.1 7405.4 7521.4 7577.7 7701.8 7370.7 7394.9 7438.7 7498.3 7506.3 6520.8 7718.0 7857.5 7926.3 7940.5 6965.5 7063.1 7148.8 7174.6 7190.6 7155.4 7230.9 7241.1 7312.0 7328.9 07:58:13 INFO - PROCESS | 1687 | 07:58:13 INFO - PROCESS | 1687 | [#4] prototype.html Cycles:180 Average:5868.30 Median:6703.07 stddev:1914.86 (28.6%) stddev-sans-first:1874.13 07:58:13 INFO - PROCESS | 1687 | Values: 303.5 326.0 327.8 334.6 334.7 6683.9 6755.2 6811.6 6821.7 6823.9 5364.7 6688.1 6718.0 6742.6 6767.8 4973.5 4980.2 4984.6 4994.7 4998.3 4083.4 4919.6 4923.3 4987.3 4987.4 4948.7 4949.5 4951.0 4959.7 4963.9 4664.3 4888.1 4937.3 4947.1 4954.5 4076.2 4110.5 4115.9 4115.9 4120.6 5318.8 5632.2 6357.8 6367.4 6375.5 5581.4 5788.9 5806.5 5815.4 5831.5 7227.0 7231.7 7238.0 7245.1 7247.8 4612.0 4612.4 4621.3 4622.3 4639.2 7650.2 7694.3 7717.2 7719.2 7801.6 4453.8 4539.3 4554.6 4611.9 4645.1 4686.2 4687.0 4688.3 4699.6 4707.6 4659.7 5583.6 5612.5 5620.9 5638.9 6169.9 7157.6 7266.5 7266.6 7287.2 1638.8 1657.8 1658.2 1659.7 1663.2 1027.6 1058.8 1060.7 1070.1 1080.1 6748.4 6766.5 6790.8 6791.5 6803.2 6076.0 6495.1 7165.9 7514.9 7550.7 6735.3 6773.4 6778.1 6779.2 6789.9 3826.9 3985.7 4009.9 4033.6 4034.2 7858.1 7892.0 7909.6 7912.8 7934.2 7791.8 7794.7 7811.3 7821.2 7832.0 7885.8 7889.1 7892.6 7899.2 7916.3 6463.7 7250.5 7527.9 7551.4 7578.7 7386.7 7390.3 7403.2 7404.1 7417.4 6314.9 7886.5 7917.2 7921.3 7934.8 4663.9 4701.8 4703.9 4705.4 4712.8 6549.4 6729.7 7422.5 7498.9 7538.1 7325.4 7333.4 7349.4 7367.8 7383.3 6598.6 7006.8 7328.2 7356.7 7413.6 6122.8 7111.9 7192.7 7201.0 7212.5 7097.6 7360.3 7371.0 7401.7 7407.0 7160.7 7204.4 7221.4 7246.7 7248.1 07:58:13 INFO - PROCESS | 1687 | 07:58:13 INFO - PROCESS | 1687 | [#5] yui.html Cycles:180 Average:18037.48 Median:698.33 stddev:25735.35 (3685.3%) stddev-sans-first:25774.56 07:58:13 INFO - PROCESS | 1687 | Values: 682.7 734.7 736.5 736.5 777.2 14976.3 15070.9 15190.6 15197.6 15201.7 13624.1 13633.2 13693.8 13722.8 13729.7 698.7 859.1 861.3 868.0 880.7 854.8 868.4 879.1 886.8 887.1 930.1 933.6 934.6 935.8 940.9 892.0 896.9 913.3 923.2 927.0 679.6 690.7 697.7 697.9 702.5 14439.0 14445.5 14482.3 14521.7 14545.9 10868.6 12670.7 12879.5 12983.5 13014.7 9650.5 9726.5 9771.5 9795.8 10456.9 3108.0 3344.4 3448.2 3477.4 3596.5 78219.0 78808.6 79229.2 83968.6 85210.6 9440.8 9542.9 9614.0 9962.1 9972.9 20987.7 21069.4 21219.5 21263.9 21284.7 7210.2 7380.9 7572.4 7672.2 7953.4 4010.5 4074.3 4107.0 4107.8 4127.9 3569.8 3630.0 3648.5 3650.2 3651.4 704.6 709.9 713.1 719.2 731.5 592.8 594.9 598.6 620.1 630.2 8219.9 8515.9 8536.1 8730.0 8934.4 490.4 551.2 559.8 569.9 572.6 3919.7 3960.1 4021.4 4065.0 4154.0 91286.0 91312.5 91575.5 92093.0 92804.0 79154.0 79707.2 79819.2 80709.0 81087.6 70664.0 71330.0 71915.6 72435.3 72478.3 7983.8 8122.8 8163.6 8270.7 8363.7 42228.3 44841.0 46103.0 46293.3 47367.5 64307.0 65403.7 66844.0 67167.0 67407.7 9034.8 9442.7 10087.9 10333.7 10359.1 11194.5 11292.8 11564.9 11707.2 11891.8 10286.6 10390.5 10736.0 10765.7 11258.1 10276.3 10432.7 10775.7 10791.4 11276.4 8781.0 9649.5 9938.7 10576.9 11124.4 7953.7 8667.3 8792.7 8854.0 9183.0 8310.7 8362.7 8623.3 8820.3 9220.9 07:58:13 INFO - PROCESS | 1687 | -------- Summary: end -------- 07:58:13 INFO - PROCESS | 1687 | 07:58:13 INFO - TEST-INFO | 1687: exit 0 07:58:13 INFO - TEST-OK | dromaeo_css | took 1111835ms 07:58:13 INFO - TEST-START | kraken 07:58:13 INFO - operating with platform_type : mac_ 07:58:13 INFO - Initialising browser for kraken test... 07:58:13 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpcUmJ0y/profile http://localhost:49283/getInfo.html) 07:58:16 INFO - PROCESS | 1694 | __metrics Screen width/height:1600/1200 07:58:16 INFO - PROCESS | 1694 | colorDepth:24 07:58:16 INFO - PROCESS | 1694 | Browser inner width/height: 1024/689 07:58:16 INFO - PROCESS | 1694 | __metrics 07:58:16 ERROR - PROCESS | 1694 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 07:58:17 INFO - TEST-INFO | 1694: exit 0 07:58:17 INFO - Browser initialized. 07:58:17 INFO - Running cycle 1/1 for kraken test... 07:58:17 INFO - TEST-INFO | started process 1697 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/T/tmpcUmJ0y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:58:29 INFO - PROCESS | 1697 | RSS: Main: 256552960 07:58:29 INFO - PROCESS | 1697 | 07:58:32 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection) 07:58:32 INFO - PROCESS | 1697 | RSS: Main: 269508608 07:58:32 INFO - PROCESS | 1697 | 07:58:35 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-dft) 07:58:36 INFO - PROCESS | 1697 | RSS: Main: 277159936 07:58:36 INFO - PROCESS | 1697 | 07:58:39 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-fft) 07:58:39 INFO - PROCESS | 1697 | RSS: Main: 279474176 07:58:39 INFO - PROCESS | 1697 | 07:58:42 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator) 07:58:42 INFO - PROCESS | 1697 | RSS: Main: 282353664 07:58:42 INFO - PROCESS | 1697 | 07:58:44 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:58:45 INFO - PROCESS | 1697 | RSS: Main: 283504640 07:58:45 INFO - PROCESS | 1697 | 07:58:48 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom) 07:58:48 INFO - PROCESS | 1697 | RSS: Main: 283099136 07:58:48 INFO - PROCESS | 1697 | 07:58:51 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate) 07:58:52 INFO - PROCESS | 1697 | RSS: Main: 283078656 07:58:52 INFO - PROCESS | 1697 | 07:58:55 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial) 07:58:55 INFO - PROCESS | 1697 | RSS: Main: 283578368 07:58:55 INFO - PROCESS | 1697 | 07:58:57 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:58:57 INFO - PROCESS | 1697 | RSS: Main: 283840512 07:58:57 INFO - PROCESS | 1697 | 07:58:59 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:59:00 INFO - PROCESS | 1697 | RSS: Main: 282398720 07:59:00 INFO - PROCESS | 1697 | 07:59:02 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:59:03 INFO - PROCESS | 1697 | RSS: Main: 283394048 07:59:03 INFO - PROCESS | 1697 | 07:59:05 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:59:06 INFO - PROCESS | 1697 | RSS: Main: 282734592 07:59:06 INFO - PROCESS | 1697 | 07:59:09 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:59:09 INFO - PROCESS | 1697 | RSS: Main: 284856320 07:59:09 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | Cycle 1(1): loaded http://localhost:49283/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49283/tests/kraken/driver.html?testName=ai-astar) 07:59:11 INFO - PROCESS | 1697 | RSS: Main: 285487104 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | __start_tp_report 07:59:11 INFO - PROCESS | 1697 | _x_x_mozilla_page_load 07:59:11 INFO - PROCESS | 1697 | _x_x_mozilla_page_load_details 07:59:11 INFO - PROCESS | 1697 | |i|pagename|runs| 07:59:11 INFO - PROCESS | 1697 | |0;ai-astar;114;108;115;114;113;126;114;115;115;114 07:59:11 INFO - PROCESS | 1697 | |1;audio-beat-detection;156;127;186;180;122;139;129;203;149;125 07:59:11 INFO - PROCESS | 1697 | |2;audio-dft;190;195;194;207;244;279;232;196;196;197 07:59:11 INFO - PROCESS | 1697 | |3;audio-fft;58;73;66;75;103;105;84;89;88;116 07:59:11 INFO - PROCESS | 1697 | |4;audio-oscillator;84;84;117;64;96;124;152;86;82;112 07:59:11 INFO - PROCESS | 1697 | |5;imaging-gaussian-blur;87;92;85;92;86;91;127;143;85;91 07:59:11 INFO - PROCESS | 1697 | |6;imaging-darkroom;94;95;95;95;95;93;95;95;94;95 07:59:11 INFO - PROCESS | 1697 | |7;imaging-desaturate;146;155;91;94;91;98;93;91;89;116 07:59:11 INFO - PROCESS | 1697 | |8;json-parse-financial;58;58;56;55;57;57;59;66;55;56 07:59:11 INFO - PROCESS | 1697 | |9;json-stringify-tinderbox;68;70;66;72;85;106;95;68;66;66 07:59:11 INFO - PROCESS | 1697 | |10;stanford-crypto-aes;86;81;88;100;81;99;117;114;113;88 07:59:11 INFO - PROCESS | 1697 | |11;stanford-crypto-ccm;134;125;135;126;124;143;135;151;142;123 07:59:11 INFO - PROCESS | 1697 | |12;stanford-crypto-pbkdf2;181;186;139;138;141;144;143;168;182;177 07:59:11 INFO - PROCESS | 1697 | |13;stanford-crypto-sha256-iterative;76;99;101;96;99;83;67;74;104;100 07:59:11 INFO - PROCESS | 1697 | __end_tp_report 07:59:11 INFO - PROCESS | 1697 | __start_cc_report 07:59:11 INFO - PROCESS | 1697 | _x_x_mozilla_cycle_collect,887 07:59:11 INFO - PROCESS | 1697 | __end_cc_report 07:59:11 INFO - PROCESS | 1697 | __startTimestamp1456156751812__endTimestamp 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | ------- Summary: start ------- 07:59:11 INFO - PROCESS | 1697 | Number of tests: 14 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#0] ai-astar Cycles:10 Average:114.80 Median:114.50 stddev:4.44 (3.9%) stddev-sans-first:4.70 07:59:11 INFO - PROCESS | 1697 | Values: 114.0 108.0 115.0 114.0 113.0 126.0 114.0 115.0 115.0 114.0 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#1] audio-beat-detection Cycles:10 Average:151.60 Median:152.50 stddev:28.90 (19.0%) stddev-sans-first:30.61 07:59:11 INFO - PROCESS | 1697 | Values: 156.0 127.0 186.0 180.0 122.0 139.0 129.0 203.0 149.0 125.0 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#2] audio-dft Cycles:10 Average:213.00 Median:202.00 stddev:29.37 (14.5%) stddev-sans-first:29.95 07:59:11 INFO - PROCESS | 1697 | Values: 190.0 195.0 194.0 207.0 244.0 279.0 232.0 196.0 196.0 197.0 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#3] audio-fft Cycles:10 Average:85.70 Median:74.00 stddev:18.38 (24.8%) stddev-sans-first:16.54 07:59:11 INFO - PROCESS | 1697 | Values: 58.0 73.0 66.0 75.0 103.0 105.0 84.0 89.0 88.0 116.0 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#4] audio-oscillator Cycles:10 Average:100.10 Median:83.00 stddev:25.94 (31.3%) stddev-sans-first:26.85 07:59:11 INFO - PROCESS | 1697 | Values: 84.0 84.0 117.0 64.0 96.0 124.0 152.0 86.0 82.0 112.0 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#5] imaging-gaussian-blur Cycles:10 Average:97.90 Median:89.00 stddev:20.11 (22.6%) stddev-sans-first:20.94 07:59:11 INFO - PROCESS | 1697 | Values: 87.0 92.0 85.0 92.0 86.0 91.0 127.0 143.0 85.0 91.0 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 07:59:11 INFO - PROCESS | 1697 | Values: 94.0 95.0 95.0 95.0 95.0 93.0 95.0 95.0 94.0 95.0 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#7] imaging-desaturate Cycles:10 Average:106.40 Median:91.00 stddev:24.59 (27.0%) stddev-sans-first:21.50 07:59:11 INFO - PROCESS | 1697 | Values: 146.0 155.0 91.0 94.0 91.0 98.0 93.0 91.0 89.0 116.0 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#8] json-parse-financial Cycles:10 Average:57.70 Median:57.50 stddev:3.20 (5.6%) stddev-sans-first:3.39 07:59:11 INFO - PROCESS | 1697 | Values: 58.0 58.0 56.0 55.0 57.0 57.0 59.0 66.0 55.0 56.0 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#9] json-stringify-tinderbox Cycles:10 Average:76.20 Median:69.00 stddev:14.23 (20.6%) stddev-sans-first:14.78 07:59:11 INFO - PROCESS | 1697 | Values: 68.0 70.0 66.0 72.0 85.0 106.0 95.0 68.0 66.0 66.0 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#10] stanford-crypto-aes Cycles:10 Average:96.70 Median:83.50 stddev:13.95 (16.7%) stddev-sans-first:14.25 07:59:11 INFO - PROCESS | 1697 | Values: 86.0 81.0 88.0 100.0 81.0 99.0 117.0 114.0 113.0 88.0 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:135.00 stddev:9.44 (7.0%) stddev-sans-first:10.01 07:59:11 INFO - PROCESS | 1697 | Values: 134.0 125.0 135.0 126.0 124.0 143.0 135.0 151.0 142.0 123.0 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.90 Median:172.50 stddev:20.51 (11.9%) stddev-sans-first:20.28 07:59:11 INFO - PROCESS | 1697 | Values: 181.0 186.0 139.0 138.0 141.0 144.0 143.0 168.0 182.0 177.0 07:59:11 INFO - PROCESS | 1697 | 07:59:11 INFO - PROCESS | 1697 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:89.90 Median:79.50 stddev:13.52 (17.0%) stddev-sans-first:13.37 07:59:11 INFO - PROCESS | 1697 | Values: 76.0 99.0 101.0 96.0 99.0 83.0 67.0 74.0 104.0 100.0 07:59:11 INFO - PROCESS | 1697 | -------- Summary: end -------- 07:59:11 INFO - PROCESS | 1697 | 07:59:12 INFO - TEST-INFO | 1697: exit 0 07:59:12 INFO - TEST-OK | kraken | took 58657ms 07:59:12 INFO - SUITE-END | took 1170s 07:59:12 INFO - Completed test suite (00:19:30) 07:59:12 INFO - Working with test: dromaeo_css 07:59:12 INFO - Generating results file: dromaeo_css 07:59:12 INFO - Working with test: kraken 07:59:12 INFO - Generating results file: kraken 07:59:12 INFO - javascript benchmark 07:59:12 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:59:13 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 07:59:13 INFO - process_Request line: dromaeo_css 7397.70 graph.html#tests=[[72,1,61]] 07:59:13 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 07:59:13 INFO - process_Request line: kraken 1578.30 graph.html#tests=[[232,1,61]] 07:59:13 INFO - RETURN: dromaeo_css: 7397.70 07:59:13 INFO - RETURN: kraken: 1578.30 07:59:13 INFO - javascript benchmark 07:59:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3500.1074725944886, 3511.1046683095806, 3544.3620148373316, 3572.5534308211472, 3575.4636804479323, 4276.550962148976, 5660.915086273699, 5689.431056894314, 5712.1431785232235, 5715.628484148533, 5521.337439507255, 5733.254676892008, 5769.16347129666, 5816.854578635525, 5873.412658734135, 5194.896102077956, 5197.870053248661, 5244.239585260135, 5266.183741520052, 5277.762500687459, 5307.124324486455, 5319.228711836781, 5322.095243808542, 5356.678599284055, 5371.57027437804, 5171.663841850268, 5176.27532145498, 5216.66091704038, 5262.105442074818, 5264.105102132608, 5255.211718242256, 5285.339332583427, 5291.0, 5295.417504074549, 5330.600204984642, 5181.093308671006, 5219.478052194788, 5225.529702326771, 5242.18746094356, 5316.3354580677415, 5526.696031718254, 5646.802361917355, 5678.971605141989, 5699.173619825144, 5705.714714264312, 6140.3552626974415, 6144.941444616059, 6216.533759967975, 6227.408396202353, 6272.937270627326, 6151.7539298428455, 6258.843528911768, 6265.655388953605, 6283.497320214417, 6329.620222786648, 4803.807847686088, 5833.066709326487, 5856.560757943129, 5879.059350503899, 5910.143029260733, 6204.751809927552, 6227.19046523949, 6309.179806625109, 6311.621302721851, 6352.205974253218, 6066.059760737005, 6177.660228687376, 6216.595921265103, 6243.906341404882, 6247.718852651551, 6286.685665716695, 6293.213348331458, 6301.810945671546, 6320.399562041599, 6322.988321868479, 5958.493528050078, 6141.631502109888, 6165.290991535941, 6177.135201071854, 6216.689165541795, 6093.908591371133, 6238.095476155932, 6246.812595622138, 6268.279147897959, 6287.622742635456, 4969.801207951641, 4973.825916092919, 4984.077945580079, 4991.5258050485145, 4999.52504512078, 3645.2345007548183, 3815.8855234343014, 4330.7401555906745, 4350.282203436397, 4445.555444455528, 5796.826095217066, 5827.679477628772, 5836.182934389189, 5865.35481097079, 5865.912011319833, 6220.875582488416, 6253.405926436982, 6270.874582508324, 6276.058591211264, 6301.338359472189, 5805.6806875621405, 5825.242718446575, 5841.153032810304, 5852.4147585241135, 5857.88284234313, 5416.91874621881, 5422.674639521641, 5445.428230035868, 5454.12733962572, 5454.509094181463, 6228.439440450381, 6334.714937827716, 6355.650439225887, 6366.936330636634, 6394.976803711384, 6170.10533472653, 6213.813585592439, 6290.402411770874, 6298.905516417349, 6337.112804207322, 6347.206599175103, 6360.300366959538, 6389.424951754364, 6403.135576697273, 6408.775692850728, 6101.4290607115445, 6173.506119510339, 6271.216097987752, 6272.278687950944, 6284.654344011124, 6241.438270555672, 6288.874222515616, 6289.433950944437, 6298.0, 6337.176167098248, 5356.839464715837, 5925.970370148121, 6072.514198864169, 6186.319504854552, 6189.133521306931, 6072.787452439144, 6130.9577371846, 6170.352113028068, 6184.165137706532, 6196.597221180609, 5819.214406055128, 6052.388473343912, 6098.976888191913, 6100.1459795629535, 6106.786262480792, 6026.337102918763, 6098.099428985257, 6098.40197260387, 6193.071039344134, 6194.81415557534, 6017.518598512196, 6035.39646035393, 6048.274207095177, 6059.787907423219, 6083.69581520931], "unit": "score", "name": "dojo.html", "value": 5721.67076020791}, {"lowerIsBetter": false, "replicates": [437.9912401751965, 444.3978409255459, 450.85347262139794, 492.7582492119859, 560.3080195957989, 31120.0, 36228.2754344913, 36779.81610091949, 37031.259374812485, 37067.25865482689, 37883.62116378835, 38439.61560384395, 38448.423273650915, 38550.61449385505, 38593.42109868354, 9204.631814727403, 9375.718728438158, 9406.905930940706, 9472.005439428864, 9475.763105922339, 8407.24334809867, 9428.481433521154, 9634.518274086302, 9668.854967175497, 9723.659671911484, 8313.919190505227, 9536.189423898977, 9697.0, 9718.076782705632, 9742.123208911196, 9601.615935362577, 9648.179904708108, 9684.61261549537, 9694.757631059209, 9698.321117521777, 9366.625334986593, 9398.62405503779, 9554.235661147091, 9577.61689532418, 9608.711738647851, 36607.267854642756, 37187.628123718685, 37230.25539489222, 37362.25275494475, 37704.24591508182, 3114.252579380955, 3246.3020450603, 3362.663733626642, 3385.4752513360468, 3420.9486857697157, 26821.793019314176, 27321.86339068292, 27427.31431714223, 27689.0, 28649.85400583995, 2753.0501976817964, 2755.9724402755915, 2820.506411378001, 2830.3631682871396, 2836.4327134572964, 422141.0, 472505.0, 472965.0, 477313.9999999965, 484714.0, 44348.0, 62245.06632400517, 62523.6873815628, 62639.6868015657, 62670.0, 36134.81932590373, 43950.7802460992, 44007.119857602665, 44082.33876491855, 44311.0, 14941.701165976838, 15059.94580379363, 15281.541553753405, 15413.691726165414, 15458.690826183414, 11986.340751258764, 11992.820107698391, 12250.571230006906, 12318.692032699075, 12464.563740269046, 14018.509352172625, 14082.014259001771, 14187.219702916438, 14486.927565362106, 14530.273486325641, 6328.557001009977, 6423.871522569522, 6437.871242575122, 6445.355464453517, 6449.935500644933, 980.5881529757519, 995.721198064543, 1009.8030883977701, 1170.9824352634716, 1182.2847177457686, 23400.414989625056, 27744.706352377227, 29341.0, 29480.262993425335, 29717.55423668647, 1053.0, 1064.4039337970607, 1065.8827528971806, 1073.5759375046812, 1128.114430172311, 12187.93906030482, 12936.482540698267, 14161.716765664629, 14322.140671559531, 14359.923005774608, 636993.0, 647274.0, 650406.0, 650477.0, 651220.0, 52501.0, 54342.0, 56100.5974850632, 56840.147397789064, 57220.0, 1434.5050957419674, 1451.4629587052857, 1471.9190444525655, 1474.8820094392208, 1481.3037872200264, 27286.590701139103, 27414.314642133308, 27870.721292786813, 27907.860460697568, 28211.0, 46155.53844461512, 46447.53552464432, 47058.0, 47229.34697285716, 47240.29139562978, 497205.0, 499019.0, 502249.0, 504569.0, 505170.0, 31025.68974310228, 31327.53008704917, 32469.51295730613, 32690.673093268764, 32709.345813083128, 40332.79001629956, 40872.79563602163, 41281.0, 41354.0, 41835.372469412374, 35098.82450587833, 35793.82103089572, 36491.817540912125, 36526.452103219, 36796.81601591975, 27029.45941081128, 30574.0, 35059.824700876336, 36098.48768903887, 36233.45649815308, 31190.128592284535, 35174.824125879204, 35496.645033549335, 35723.64276357307, 36177.45733814048, 26254.949802007704, 29913.85043074858, 30890.691093088783, 31964.360712786078, 32061.0, 19762.604747904676, 25046.622435766207, 25504.107356242443, 25750.484990299716, 25763.227103186935], "unit": "score", "name": "ext.html", "value": 18658.004519116246}, {"lowerIsBetter": false, "replicates": [324.2073131194231, 330.83458270864566, 367.4561648759835, 369.6377550000999, 374.02939372328814, 15597.454089106855, 19480.90259548702, 19495.805041949578, 19644.508887277825, 20067.0, 18783.154758035886, 18878.43364699058, 19505.0, 19595.216191352363, 20004.29984950527, 5588.91616625752, 5612.69130197841, 5929.466348028676, 5930.199423077873, 5933.258342707161, 5800.796972105977, 5835.737391817357, 5864.824055278348, 5887.293524777033, 5889.234399528055, 2883.4089011752644, 5539.972300138514, 5669.773209071632, 5828.0966450200285, 5849.268841394825, 5880.6765627890445, 5895.263092113486, 5917.970410147922, 5922.022866227067, 5930.911036334458, 4236.872893813191, 5445.101558242885, 5582.078956972095, 5607.355154157242, 5644.0, 13004.934975325157, 13152.605421837361, 13245.205287682673, 13271.071025028252, 18558.44324670262, 2083.5207902182583, 2150.0, 2160.2439146298825, 2180.7274090738656, 2197.230969160797, 9405.200557952583, 9405.529723513866, 9602.567884445216, 10038.648647297383, 10116.94941525295, 1713.151989765062, 1764.7176451767784, 1911.0635788463692, 1915.8275755181962, 1918.3477617610079, 73030.0, 91406.62890056655, 93513.53243233808, 95029.52485237598, 95343.0, 10491.950804919446, 10883.945580272048, 11099.722506937229, 11298.209125361145, 11328.603498877499, 11618.76762464746, 13402.0, 13486.797698034537, 13498.865011349957, 13504.729905402033, 8221.876671849926, 8307.210814972568, 8357.0, 8548.615312310962, 8552.61513231906, 6973.58158510491, 8617.181367770052, 8658.134186581417, 8672.479651220947, 8677.826443471095, 4208.789560521962, 4329.19909816685, 4427.712198707074, 4509.932351014738, 4542.000759832831, 1691.8900271482314, 1786.722493417213, 1856.1183437867176, 1894.9242030318908, 1904.2668572599648, 796.5101462600459, 891.4784850862318, 922.800359532605, 944.7449188719007, 990.5740531571494, 18774.1551630177, 20435.897820511098, 20563.764809039356, 21151.0, 21429.67855482169, 897.6947837735202, 963.9252233759308, 972.1056627902346, 996.7807082441851, 1010.3281317923645, 10664.360138391721, 11132.0, 11136.0, 11149.609763658233, 11192.160587955936, 587778.0, 591343.0, 593181.0, 619265.0, 631209.0, 69148.0, 70504.0, 109503.0, 111042.0, 111659.0, 872.8079822439054, 1047.251215380991, 1047.9685609431729, 1050.2123407444417, 1056.7252514346171, 16885.32458701638, 18129.093545322416, 18305.450836474927, 18337.449876503728, 18505.167267472727, 46656.533434665216, 47623.0, 49250.75374623104, 50192.49807501878, 50244.477996980444, 66623.0, 66894.32764180934, 67817.0, 68425.3157468419, 68733.96899046419, 8061.113277539349, 8077.394195435483, 8203.42576019673, 8211.630476628447, 8272.83454330922, 10593.788124237319, 13292.26892520882, 13583.728325433238, 13616.251106189255, 13658.385372658055, 11097.056750176003, 11520.366379849189, 11612.0, 11638.301701897575, 11752.236104653512, 9529.332946693665, 10781.62264320745, 11357.375344355809, 11854.466549005143, 11972.16194866386, 11341.546338146381, 11832.34922079294, 11915.2255103418, 12063.939680301894, 12126.27242365461, 8036.397270204875, 8043.959780201296, 8096.5546894921345, 8253.050899146676, 8324.83350333002, 8488.193621605938, 9860.753481163028, 10616.681499555025, 11815.113866459878, 11865.169438139592], "unit": "score", "name": "jquery.html", "value": 9044.620239693195}, {"lowerIsBetter": false, "replicates": [1545.1424459425018, 1560.4850399368206, 1668.5161303222067, 1812.2388596789347, 1890.8109189081094, 7958.283754462097, 8477.957610211955, 8785.165409286115, 8839.204471597555, 8957.820843583124, 7963.92036079639, 8132.593370331475, 8755.993060797995, 8853.247473964704, 8863.689770858005, 2467.617519284514, 2473.6907886514186, 2482.429041320497, 2493.5262300163004, 2514.4719608882065, 2049.9282525111626, 2467.457159424933, 2471.406862353031, 2478.863662498562, 2481.727010028895, 2417.4319035026756, 2483.515714435686, 2500.4874000829877, 2505.66173566568, 2511.359603301156, 2483.5777917753844, 2493.4265119022634, 2501.8874150663173, 2520.9369765756005, 2522.2937577478338, 2518.1312447205682, 2533.6579561759113, 2544.5419824431597, 2545.4527276635426, 2562.743725627441, 8763.992140903814, 8810.471371717718, 8816.206541411304, 8833.55832208387, 8834.955825220897, 5360.624756267063, 5526.668399896019, 5553.527950124244, 5574.804881829116, 5575.080111781551, 3588.2644057968055, 3661.707063434919, 3702.740808143431, 3715.071232191952, 3724.3110024645525, 1053.873535175784, 1055.203321492276, 1056.1497994114734, 1090.596479302655, 1105.7898999190209, 11873.465694043789, 11884.702882427922, 11945.163838531307, 12033.217840840318, 12059.57791477294, 4673.602743766818, 4751.0, 4773.856784296477, 4773.9761301193275, 4792.664513484093, 8990.325725570608, 9270.443773373485, 9272.258219342571, 9277.118673725985, 9302.627894884265, 5269.077911365495, 5392.622516423813, 5397.514223719884, 5425.864353391118, 5485.232067510552, 4462.928897064681, 4857.514248575114, 4943.72809495474, 4997.85006449807, 5023.120953833065, 3811.142492939122, 3816.332141875216, 3828.1195325075387, 3859.208862183246, 3864.903377415531, 880.3045593980684, 1184.1237484261585, 1188.7741329147607, 1189.5063548627395, 1191.065013964034, 1114.654457118296, 1119.121489630636, 1127.4982632728356, 1290.6579756364572, 1383.3221721356665, 7616.822896389278, 7690.346320562703, 7868.0, 7888.48724832884, 7973.72091976778, 508.5905845794171, 509.52868596548046, 512.8487096306599, 518.3106468397023, 526.3736153976755, 6063.787767428119, 6182.969085154546, 6219.346968568326, 6247.219097612799, 6249.6562689052535, 10500.579976800995, 10574.947125264478, 10818.621348252773, 10838.837417438745, 10847.294925829954, 10305.793884122426, 10566.841497377545, 10630.840537391945, 10677.572897084185, 10779.137668986463, 6767.0, 8314.708985185489, 8322.417430779788, 8387.496750194885, 8508.872366914502, 7345.632718363953, 7451.509698060518, 8027.678892844221, 8129.227723366271, 8171.673133074611, 9451.527423628928, 9551.42691438516, 9615.663451779154, 9698.127168554864, 9723.02769723022, 7817.921820781719, 9688.9031109688, 9842.60629574809, 9924.305298629026, 9959.153471954965, 6203.983705295706, 6897.965510172417, 7389.187189409268, 7452.06849143857, 7552.169261381134, 8241.052278987992, 8279.379046571652, 8284.917150828414, 8306.418550701394, 8331.625076871434, 7315.085614298213, 7405.379304165161, 7521.435892307989, 7577.696892124253, 7701.845963080819, 7370.742024029133, 7394.926050739424, 7438.73964411243, 7498.250174982458, 7506.3244308012545, 6520.836979075561, 7718.035245594301, 7857.489263198103, 7926.326262267541, 7940.483868548526, 6965.47758918073, 7063.117110361205, 7148.821279468055, 7174.605396703231, 7190.568565886064, 7155.42756579462, 7230.927690723025, 7241.058662374068, 7312.0, 7328.890066648898], "unit": "score", "name": "mootools.html", "value": 4800.051884655767}, {"lowerIsBetter": false, "replicates": [303.5371059134819, 325.9771815972881, 327.81806097615816, 334.6419331315492, 334.6636630186662, 6683.930571108624, 6755.189377274722, 6811.591304521726, 6821.727130914764, 6823.863522729549, 5364.651297665649, 6688.1305430294115, 6718.0, 6742.595444273335, 6767.830804229897, 4973.502649735034, 4980.153373926441, 4984.626153038518, 4994.67534610251, 4998.3252260944855, 4083.448734420845, 4919.631027672921, 4923.261510773377, 4987.276844857512, 4987.351644286256, 4948.703077815325, 4949.480304568023, 4951.0, 4959.6528243023, 4963.900721985558, 4664.300354946751, 4888.120138375091, 4937.2840938063955, 4947.109520286347, 4954.504549545035, 4076.2051399977017, 4110.486189226347, 4115.8971025724595, 4115.938260926088, 4120.608542188487, 5318.840434786963, 5632.211490391349, 6357.841053973688, 6367.363263673642, 6375.489960803171, 5581.441855814386, 5788.855278618026, 5806.506446952014, 5815.447532484407, 5831.475167234927, 7227.0, 7231.710731570731, 7238.0, 7245.058142441501, 7247.782566523013, 4611.976940115312, 4612.431773197096, 4621.2837010263465, 4622.2835460503675, 4639.188142075123, 7650.158482566913, 7694.269044440769, 7717.151113377524, 7719.228077192292, 7801.648925798353, 4453.799579018952, 4539.341795439709, 4554.612857907049, 4611.930821037688, 4645.094206629675, 4686.226772582554, 4687.039156972813, 4688.2733176357715, 4699.647526435463, 4707.599854012379, 4659.673822832437, 5583.553315734732, 5612.466815652507, 5620.85947851307, 5638.915416268759, 6169.9383006170265, 7157.606331651809, 7266.45501587383, 7266.600336981411, 7287.198408175096, 1638.7623794549725, 1657.8176400595926, 1658.2454982982713, 1659.6929568029711, 1663.2016632016457, 1027.635189507729, 1058.7882423515327, 1060.7136073260176, 1070.1011150633506, 1080.0873262093519, 6748.358905903931, 6766.492513061442, 6790.7623233186605, 6791.456683465311, 6803.217629972616, 6076.0, 6495.090687303781, 7165.925111233357, 7514.887276690854, 7550.735724249625, 6735.259121496631, 6773.356531129633, 6778.084958530634, 6779.186497620219, 6789.864202716017, 3826.9234615307537, 3985.740926839746, 4009.8797036088963, 4033.576474470197, 4034.1931613677384, 7858.0963189232825, 7891.960540197377, 7909.604519774103, 7912.84174316522, 7934.166912474223, 7791.844163116706, 7794.6882124714375, 7811.296983271533, 7821.178776228528, 7831.98184236057, 7885.802854928673, 7889.132195458495, 7892.605369731606, 7899.249571290718, 7916.287534121841, 6463.676816159267, 7250.492465527363, 7527.887081693889, 7551.358134558624, 7578.696852125853, 7386.667599958122, 7390.334869861738, 7403.185649578434, 7404.148522919718, 7417.369523590555, 6314.905276420949, 7886.526808391515, 7917.208279172267, 7921.316587786707, 7934.841303174019, 4663.860084197479, 4701.801040734591, 4703.929441058455, 4705.364775755229, 4712.7643617818285, 6549.443297319781, 6729.730810767514, 7422.517536360119, 7498.925010749823, 7538.133114691881, 7325.377342925911, 7333.413326933725, 7349.448791340564, 7367.77896663101, 7383.261673832574, 6598.60408375499, 7006.843870761268, 7328.1938986712485, 7356.705731770669, 7413.555186688816, 6122.846928826637, 7111.933210018332, 7192.748253811092, 7200.963995179991, 7212.459065570209, 7097.574145551283, 7360.263973602597, 7370.96314518424, 7401.666924988496, 7406.962965185139, 7160.713571457291, 7204.351608355273, 7221.4222862169845, 7246.746363877239, 7248.057752492142], "unit": "score", "name": "prototype.html", "value": 5225.4322036330295}, {"lowerIsBetter": false, "replicates": [682.7269092363056, 734.6510407556411, 736.4734215036254, 736.5249414127887, 777.2421888658558, 14976.326065327059, 15070.924645376785, 15190.620234494128, 15197.620059498518, 15201.695966080686, 13624.114432561877, 13633.182009079437, 13693.794593081111, 13722.794158087612, 13729.725405491885, 698.7414656577048, 859.1065292096213, 861.2636196052379, 867.9974629303165, 880.7049638371121, 854.8375808596378, 868.3704314372061, 879.0989236033085, 886.8182022685334, 887.0863011098579, 930.1163894300441, 933.5705575435308, 934.5654270764094, 935.8362286599852, 940.8823897012874, 891.9732408027704, 896.8654701794718, 913.3150137396952, 923.1553128887094, 927.0405130689771, 679.5548915460332, 690.6822861483723, 697.6546609428315, 697.9162500499973, 702.4731451411442, 14439.0, 14445.49440769568, 14482.34829432678, 14521.709565808731, 14545.854541454662, 10868.6195983141, 12670.683232919158, 12879.549215777402, 12983.480660773557, 13014.739705205937, 9650.517474126265, 9726.513674316328, 9771.462569558671, 9795.804083918352, 10456.895431045668, 3107.958833790683, 3344.3812894614575, 3448.2241495663525, 3477.4088404971217, 3596.4605309203566, 78219.0, 78808.60595696984, 79229.20770792276, 83968.58015709883, 85210.57394712987, 9440.763980900396, 9542.856857147148, 9614.0, 9962.108780618843, 9972.850407243897, 20987.685184722242, 21069.367918962456, 21219.46951326229, 21263.8936805315, 21284.680729789066, 7210.206877243499, 7380.889286660705, 7572.432067594952, 7672.232776722283, 7953.363730901514, 4010.498687664042, 4074.30736774749, 4106.979465102655, 4107.835686572564, 4127.855525056609, 3569.7501174918025, 3629.9637003630155, 3648.543932008499, 3650.1604630935035, 3651.3610118229735, 704.5983789240187, 709.8828693265657, 713.105053158283, 719.2124623537219, 731.4952682648956, 592.7658574862991, 594.8958932186937, 598.6228675934134, 620.1136380494543, 630.2027934662656, 8219.876701849476, 8515.914840851636, 8536.146385361415, 8729.99605045428, 8934.374593778373, 490.4066080043188, 551.2172714744992, 559.7844829740579, 569.8974184646803, 572.5505478199593, 3919.6864250859862, 3960.128771670228, 4021.4369988201674, 4065.024394145443, 4154.0, 91286.0, 91312.5434372824, 91575.54212228896, 92093.0, 92804.0, 79154.0, 79707.20292797114, 79819.20180798233, 80709.0, 81087.594562028, 70664.0, 71330.0, 71915.64042179755, 72435.2756472439, 72478.27521724715, 7983.84032319362, 8122.75631731049, 8163.551004694798, 8270.669173233244, 8363.665453381796, 42228.31086756618, 44841.0, 46103.0, 46293.305600416694, 47367.52632473769, 64307.0, 65403.67298163479, 66844.0, 67167.0, 67407.66296168488, 9034.774130646787, 9442.725232093579, 10087.899121008695, 10333.689989300334, 10359.119474844723, 11194.531767660013, 11292.774144517229, 11564.884351156381, 11707.180497365103, 11891.82162267584, 10286.588536458758, 10390.480475976019, 10735.980081892209, 10765.677029689123, 11258.09935205198, 10276.280660353703, 10432.68701938943, 10775.730606734895, 10791.40647264408, 11276.379799111128, 8780.956095219482, 9649.517524123907, 9938.701838944844, 10576.894231057591, 11124.388158651029, 7953.6818527258265, 8667.349948753743, 8792.736217913473, 8853.981792093991, 9183.0, 8310.719131614838, 8362.665493380196, 8623.267022302924, 8820.25027872638, 9220.907790922005], "unit": "score", "name": "yui.html", "value": 6767.068051618859}], "name": "dromaeo_css", "value": 7397.698609843639}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 115.0, 114.0, 113.0, 126.0, 114.0, 115.0, 115.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.8}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 186.0, 180.0, 122.0, 139.0, 129.0, 203.0, 149.0, 125.0], "unit": "score", "name": "audio-beat-detection", "value": 151.6}, {"lowerIsBetter": true, "replicates": [190.0, 195.0, 194.0, 207.0, 244.0, 279.0, 232.0, 196.0, 196.0, 197.0], "unit": "score", "name": "audio-dft", "value": 213.0}, {"lowerIsBetter": true, "replicates": [58.0, 73.0, 66.0, 75.0, 103.0, 105.0, 84.0, 89.0, 88.0, 116.0], "unit": "score", "name": "audio-fft", "value": 85.7}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 117.0, 64.0, 96.0, 124.0, 152.0, 86.0, 82.0, 112.0], "unit": "score", "name": "audio-oscillator", "value": 100.1}, {"lowerIsBetter": true, "replicates": [87.0, 92.0, 85.0, 92.0, 86.0, 91.0, 127.0, 143.0, 85.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.9}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 93.0, 95.0, 95.0, 94.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 94.6}, {"lowerIsBetter": true, "replicates": [146.0, 155.0, 91.0, 94.0, 91.0, 98.0, 93.0, 91.0, 89.0, 116.0], "unit": "score", "name": "imaging-desaturate", "value": 106.4}, {"lowerIsBetter": true, "replicates": [58.0, 58.0, 56.0, 55.0, 57.0, 57.0, 59.0, 66.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 57.7}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 66.0, 72.0, 85.0, 106.0, 95.0, 68.0, 66.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 76.2}, {"lowerIsBetter": true, "replicates": [86.0, 81.0, 88.0, 100.0, 81.0, 99.0, 117.0, 114.0, 113.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 96.7}, {"lowerIsBetter": true, "replicates": [134.0, 125.0, 135.0, 126.0, 124.0, 143.0, 135.0, 151.0, 142.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 133.8}, {"lowerIsBetter": true, "replicates": [181.0, 186.0, 139.0, 138.0, 141.0, 144.0, 143.0, 168.0, 182.0, 177.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 159.9}, {"lowerIsBetter": true, "replicates": [76.0, 99.0, 101.0, 96.0, 99.0, 83.0, 67.0, 74.0, 104.0, 100.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 89.9}], "name": "kraken", "value": 1578.3000000000002}]} 07:59:13 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1578.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7397.70"}}} 07:59:13 INFO - Return code: 0 07:59:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:59:13 ERROR - # TBPL SUCCESS # 07:59:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:59:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:59:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:59:13 INFO - 2016-02-22 07:59:13.520 screenresolution[1702:11160] starting screenresolution argv=screenresolution get 07:59:13 INFO - 2016-02-22 07:59:13.523 screenresolution[1702:11160] Display 0: 1600x1200x32@60 07:59:13 INFO - 2016-02-22 07:59:13.529 screenresolution[1703:11163] starting screenresolution argv=screenresolution list 07:59:13 INFO - Available Modes on Display 0 07:59:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:59:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:59:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:59:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:59:13 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:59:13 INFO - Intel Iris: 07:59:13 INFO - Chipset Model: Intel Iris 07:59:13 INFO - Type: GPU 07:59:13 INFO - Bus: Built-In 07:59:13 INFO - VRAM (Dynamic, Max): 1536 MB 07:59:13 INFO - Vendor: Intel (0x8086) 07:59:13 INFO - Device ID: 0x0a2e 07:59:13 INFO - Revision ID: 0x0009 07:59:13 INFO - Displays: 07:59:13 INFO - Display: 07:59:13 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:59:13 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:59:13 INFO - Display Serial Number: 1600x1200 60 07:59:13 INFO - Main Display: Yes 07:59:13 INFO - Mirror: Off 07:59:13 INFO - Online: Yes 07:59:13 INFO - Rotation: Supported 07:59:13 INFO - Return code: 0 07:59:13 INFO - Running post-action listener: _resource_record_post_action 07:59:13 INFO - Running post-run listener: _resource_record_post_run 07:59:14 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 33918464; Write bytes: 712583680; Read time: 356; Write time: 2238 07:59:14 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 404283904; Write bytes: 406046208; Read time: 30188; Write time: 727 07:59:14 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 32116224; Write bytes: 304985088; Read time: 336; Write time: 1508 07:59:14 INFO - Running post-run listener: _upload_blobber_files 07:59:14 INFO - Blob upload gear active. 07:59:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:59:14 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 07:59:14 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'] 07:59:14 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 07:59:15 INFO - (blobuploader) - INFO - Open directory for files ... 07:59:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:59:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:59:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:16 INFO - (blobuploader) - INFO - Done attempting. 07:59:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:59:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:59:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:17 INFO - (blobuploader) - INFO - Done attempting. 07:59:17 INFO - (blobuploader) - INFO - Iteration through files over. 07:59:17 INFO - Return code: 0 07:59:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:59:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:59:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61dde431041ae81efda1881c2fecfb08f8aeebf95ca119bce6c1a3cffd553d25df5ff7775130b62ae94767f8ae4b5d9caf70e60d6046b1d6a3ce276434521d77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae7972a5796d70bcc17b1b0175394f722aeceffe82cb36736fa171d0b1f811a8fc65888340394be2dbb9c49e04ef9e9fbab21861a09bdd43a9643133a890d20e"} 07:59:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:59:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:59:17 INFO - Contents: 07:59:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61dde431041ae81efda1881c2fecfb08f8aeebf95ca119bce6c1a3cffd553d25df5ff7775130b62ae94767f8ae4b5d9caf70e60d6046b1d6a3ce276434521d77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae7972a5796d70bcc17b1b0175394f722aeceffe82cb36736fa171d0b1f811a8fc65888340394be2dbb9c49e04ef9e9fbab21861a09bdd43a9643133a890d20e"} 07:59:17 INFO - Running post-run listener: copy_logs_to_upload_dir 07:59:17 INFO - Copying logs to upload dir... 07:59:17 INFO - mkdir: /builds/slave/test/build/upload/logs 07:59:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.728138 ========= master_lag: 0.31 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-02-22 07:59:17.426551) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 07:59:17.430178) ========= 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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61dde431041ae81efda1881c2fecfb08f8aeebf95ca119bce6c1a3cffd553d25df5ff7775130b62ae94767f8ae4b5d9caf70e60d6046b1d6a3ce276434521d77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae7972a5796d70bcc17b1b0175394f722aeceffe82cb36736fa171d0b1f811a8fc65888340394be2dbb9c49e04ef9e9fbab21861a09bdd43a9643133a890d20e"} build_url:https://queue.taskcluster.net/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011224 build_url: 'https://queue.taskcluster.net/v1/task/DW_B6u_6RG60l5KQjrRIHQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61dde431041ae81efda1881c2fecfb08f8aeebf95ca119bce6c1a3cffd553d25df5ff7775130b62ae94767f8ae4b5d9caf70e60d6046b1d6a3ce276434521d77", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ae7972a5796d70bcc17b1b0175394f722aeceffe82cb36736fa171d0b1f811a8fc65888340394be2dbb9c49e04ef9e9fbab21861a09bdd43a9643133a890d20e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-22 07:59:17.457437) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 07:59:17.457788) ========= 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.vhnvTrMFqz/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.6ThNCx6kXn/Listeners TMPDIR=/var/folders/bv/w75m6g3s5tv8p1fbxr1ssr2000000w/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.005128 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-22 07:59:17.506600) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 07:59:17.506938) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-22 07:59:17.507382) ========= ========= Total master_lag: 5.08 =========