builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0183 starttime: 1460468840.54 results: success (0) buildid: 20160412045151 builduid: 11577ef8f877486ea2da7d1401846101 revision: 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:20.545127) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:20.548652) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:20.548949) ========= 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.msXrZOpyE5/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.BLL4f0gT6L/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005554 basedir: '/builds/slave/test' ========= master_lag: 0.32 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:20.872425) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:20.872733) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:20.899898) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:20.900247) ========= 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.msXrZOpyE5/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.BLL4f0gT6L/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005296 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:20.948442) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:20.948739) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:20.949084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:20.952416) ========= 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.msXrZOpyE5/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.BLL4f0gT6L/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-04-12 06:47:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 178M=0s 2016-04-12 06:47:21 (178 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.190844 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:21.159127) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:21.162470) ========= 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.msXrZOpyE5/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.BLL4f0gT6L/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.026021 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:21.212022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:21.215511) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 --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 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.msXrZOpyE5/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.BLL4f0gT6L/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-04-12 06:47:21,290 truncating revision to first 12 chars 2016-04-12 06:47:21,290 Setting DEBUG logging. 2016-04-12 06:47:21,290 attempt 1/10 2016-04-12 06:47:21,291 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/49d7fb650c9d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 06:47:21,972 unpacking tar archive at: mozilla-central-49d7fb650c9d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.924525 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:22.161737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:22.162091) ========= echo 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.msXrZOpyE5/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.BLL4f0gT6L/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 program finished with exit code 0 elapsedTime=0.005473 script_repo_revision: '49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:22.212089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:22.215468) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 06:47:22.237883) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-04-12 06:47:22.238270) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.msXrZOpyE5/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.BLL4f0gT6L/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:47:22 INFO - MultiFileLogger online at 20160412 06:47:22 in /builds/slave/test 06:47:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:47:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:47:22 INFO - {'append_to_log': False, 06:47:22 INFO - 'base_work_dir': '/builds/slave/test', 06:47:22 INFO - 'blob_upload_branch': 'Firefox', 06:47:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:47:22 INFO - 'branch': 'Firefox', 06:47:22 INFO - 'buildbot_json_path': 'buildprops.json', 06:47:22 INFO - 'config_files': ('talos/mac_config.py',), 06:47:22 INFO - 'default_actions': ('clobber', 06:47:22 INFO - 'read-buildbot-config', 06:47:22 INFO - 'download-and-extract', 06:47:22 INFO - 'populate-webroot', 06:47:22 INFO - 'create-virtualenv', 06:47:22 INFO - 'install', 06:47:22 INFO - 'run-tests'), 06:47:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:47:22 INFO - 'download_minidump_stackwalk': True, 06:47:22 INFO - 'download_symbols': 'ondemand', 06:47:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:47:22 INFO - 'tooltool.py': '/tools/tooltool.py', 06:47:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:47:22 INFO - '/tools/misc-python/virtualenv.py')}, 06:47:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:47:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:47:22 INFO - 'installer_path': 'installer.exe', 06:47:22 INFO - 'log_level': 'info', 06:47:22 INFO - 'log_name': 'talos', 06:47:22 INFO - 'log_to_console': True, 06:47:22 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:47:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:47:22 INFO - 'opt_config_files': (), 06:47:22 INFO - 'pip_index': False, 06:47:22 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:47:22 INFO - 'cmd': ('bash', 06:47:22 INFO - '-c', 06:47:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:47:22 INFO - 'enabled': True, 06:47:22 INFO - 'halt_on_failure': False, 06:47:22 INFO - 'name': 'check_screen_resolution'},), 06:47:22 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:47:22 INFO - 'cmd': ('bash', 06:47:22 INFO - '-c', 06:47:22 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:47:22 INFO - 'enabled': True, 06:47:22 INFO - 'halt_on_failure': False, 06:47:22 INFO - 'name': 'check_screen_resolution'},), 06:47:22 INFO - 'run_cmd_checks_enabled': True, 06:47:22 INFO - 'sps_profile': False, 06:47:22 INFO - 'sps_profile_interval': 0, 06:47:22 INFO - 'suite': 'dromaeojs', 06:47:22 INFO - 'system_bits': '32', 06:47:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:47:22 INFO - 'title': 't-yosemite-r7-0183', 06:47:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:47:22 INFO - 'use_talos_json': True, 06:47:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:47:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:47:22 INFO - 'work_dir': 'build'} 06:47:22 INFO - ##### 06:47:22 INFO - ##### Running clobber step. 06:47:22 INFO - ##### 06:47:22 INFO - Running pre-action listener: _resource_record_pre_action 06:47:22 INFO - Running main action method: clobber 06:47:22 INFO - rmtree: /builds/slave/test/build 06:47:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:47:23 INFO - Running post-action listener: _resource_record_post_action 06:47:23 INFO - ##### 06:47:23 INFO - ##### Running read-buildbot-config step. 06:47:23 INFO - ##### 06:47:23 INFO - Running pre-action listener: _resource_record_pre_action 06:47:23 INFO - Running main action method: read_buildbot_config 06:47:23 INFO - Using buildbot properties: 06:47:23 INFO - { 06:47:23 INFO - "project": "", 06:47:23 INFO - "product": "firefox", 06:47:23 INFO - "script_repo_revision": "production", 06:47:23 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:47:23 INFO - "repository": "", 06:47:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:47:23 INFO - "buildid": "20160412045151", 06:47:23 INFO - "pgo_build": "False", 06:47:23 INFO - "basedir": "/builds/slave/test", 06:47:23 INFO - "buildnumber": 208, 06:47:23 INFO - "slavename": "t-yosemite-r7-0183", 06:47:23 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 06:47:23 INFO - "platform": "yosemite_r7", 06:47:23 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:47:23 INFO - "branch": "mozilla-central", 06:47:23 INFO - "repo_path": "mozilla-central", 06:47:23 INFO - "revision": "49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83", 06:47:23 INFO - "stage_platform": "macosx64", 06:47:23 INFO - "builduid": "11577ef8f877486ea2da7d1401846101", 06:47:23 INFO - "slavebuilddir": "test" 06:47:23 INFO - } 06:47:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 06:47:23 INFO - Running post-action listener: _resource_record_post_action 06:47:23 INFO - ##### 06:47:23 INFO - ##### Running download-and-extract step. 06:47:23 INFO - ##### 06:47:23 INFO - Running pre-action listener: _resource_record_pre_action 06:47:23 INFO - Running main action method: download_and_extract 06:47:23 INFO - mkdir: /builds/slave/test/build/tests 06:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:23 INFO - https://queue.taskcluster.net/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:47:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:47:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:47:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 06:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 06:47:24 INFO - Downloaded 1199 bytes. 06:47:24 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 06:47:24 INFO - Using the following test package requirements: 06:47:24 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:47:24 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:47:24 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 06:47:24 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:47:24 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 06:47:24 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:47:24 INFO - u'jsshell-mac.zip'], 06:47:24 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:47:24 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 06:47:24 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:47:24 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:47:24 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 06:47:24 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:47:24 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 06:47:24 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:47:24 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 06:47:24 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:47:24 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 06:47:24 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:24 INFO - https://queue.taskcluster.net/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:47:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:47:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:47:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:47:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:47:26 INFO - Downloaded 18021328 bytes. 06:47:26 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:47:26 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:47:29 INFO - Return code: 0 06:47:29 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:47:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:29 INFO - https://queue.taskcluster.net/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:47:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:47:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:47:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:47:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:47:36 INFO - Downloaded 18021328 bytes. 06:47:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:47:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:47:39 INFO - Return code: 0 06:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:39 INFO - https://queue.taskcluster.net/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:47:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:47:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:47:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:47:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:47:40 INFO - Downloaded 10841076 bytes. 06:47:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:47:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:47:41 INFO - Return code: 0 06:47: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')]} 06:47:41 INFO - https://queue.taskcluster.net/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 06:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 06:47:44 INFO - Downloaded 108944955 bytes. 06:47:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:47:44 INFO - mkdir: /builds/slave/test/properties 06:47:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:47:44 INFO - Writing to file /builds/slave/test/properties/build_url 06:47:44 INFO - Contents: 06:47:44 INFO - build_url:https://queue.taskcluster.net/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:47:46 INFO - Running post-action listener: _resource_record_post_action 06:47:46 INFO - Running post-action listener: set_extra_try_arguments 06:47:46 INFO - ##### 06:47:46 INFO - ##### Running populate-webroot step. 06:47:46 INFO - ##### 06:47:46 INFO - Running pre-action listener: _resource_record_pre_action 06:47:46 INFO - Running main action method: populate_webroot 06:47:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:47:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:47:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:47:46 INFO - '--tppagecycles', 06:47:46 INFO - '7'], 06:47:46 INFO - 'tests': ['tsvgm']}}, 06:47:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:47:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:47:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:47:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:47:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:47:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:47:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:46 INFO - 'talos_options': ['--disable-e10s'], 06:47:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:47:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:46 INFO - 'talos_options': ['--disable-e10s'], 06:47:46 INFO - 'tests': ['damp', 'tps']}, 06:47:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:46 INFO - 'tests': ['damp', 'tps']}, 06:47:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:47:46 INFO - 'tests': ['dromaeo_dom']}, 06:47:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:47:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:47:46 INFO - 'tests': ['a11yr', 06:47:46 INFO - 'ts_paint', 06:47:46 INFO - 'tpaint', 06:47:46 INFO - 'sessionrestore', 06:47:46 INFO - 'sessionrestore_no_auto_restore', 06:47:46 INFO - 'tabpaint']}, 06:47:46 INFO - 'other-e10s': {'tests': ['a11yr', 06:47:46 INFO - 'ts_paint', 06:47:46 INFO - 'tpaint', 06:47:46 INFO - 'sessionrestore', 06:47:46 INFO - 'sessionrestore_no_auto_restore', 06:47:46 INFO - 'tabpaint']}, 06:47:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:47:46 INFO - 'ts_paint', 06:47:46 INFO - 'tpaint', 06:47:46 INFO - 'sessionrestore', 06:47:46 INFO - 'sessionrestore_no_auto_restore', 06:47:46 INFO - 'tabpaint']}, 06:47:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:47:46 INFO - 'ts_paint', 06:47:46 INFO - 'tpaint', 06:47:46 INFO - 'sessionrestore', 06:47:46 INFO - 'sessionrestore_no_auto_restore', 06:47:46 INFO - 'tabpaint']}, 06:47:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:47:46 INFO - 'tests': ['a11yr', 06:47:46 INFO - 'ts_paint', 06:47:46 INFO - 'tpaint', 06:47:46 INFO - 'sessionrestore', 06:47:46 INFO - 'sessionrestore_no_auto_restore', 06:47:46 INFO - 'tabpaint']}, 06:47:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:47:46 INFO - 'tests': ['a11yr', 06:47:46 INFO - 'ts_paint', 06:47:46 INFO - 'tpaint', 06:47:46 INFO - 'sessionrestore', 06:47:46 INFO - 'sessionrestore_no_auto_restore', 06:47:46 INFO - 'tabpaint']}, 06:47:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:47:46 INFO - 'tests': ['tsvgx', 06:47:46 INFO - 'tsvgr_opacity', 06:47:46 INFO - 'tart', 06:47:46 INFO - 'tscrollx', 06:47:46 INFO - 'cart']}, 06:47:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:47:46 INFO - 'tsvgr_opacity', 06:47:46 INFO - 'tart', 06:47:46 INFO - 'tscrollx', 06:47:46 INFO - 'cart']}, 06:47:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:46 INFO - 'talos_options': ['--disable-e10s'], 06:47:46 INFO - 'tests': ['tp5o']}, 06:47:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:46 INFO - 'tests': ['tp5o']}, 06:47:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:46 INFO - 'talos_options': ['--disable-e10s', 06:47:46 INFO - '--xperf_path', 06:47:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:46 INFO - 'tests': ['tp5n']}, 06:47:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:47:46 INFO - 'talos_options': ['--xperf_path', 06:47:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:47:46 INFO - 'tests': ['tp5n']}}, 06:47:46 INFO - 'talos.zip': {'path': '', 06:47:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:47:46 INFO - Running post-action listener: _resource_record_post_action 06:47:46 INFO - ##### 06:47:46 INFO - ##### Running create-virtualenv step. 06:47:46 INFO - ##### 06:47:46 INFO - Running pre-action listener: _resource_record_pre_action 06:47:46 INFO - Running main action method: create_virtualenv 06:47:46 INFO - Creating virtualenv /builds/slave/test/build/venv 06:47:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:47:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:47:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:47:46 INFO - Using real prefix '/tools/python27' 06:47:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:47:47 INFO - Installing distribute.............................................................................................................................................................................................done. 06:47:50 INFO - Installing pip.................done. 06:47:50 INFO - Return code: 0 06:47:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10adcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10addc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe708490130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac6be00>, '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 0x10aa94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac66b20>, '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.msXrZOpyE5/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.BLL4f0gT6L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:47:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:47:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msXrZOpyE5/Render', 06:47:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:50 INFO - 'HOME': '/Users/cltbld', 06:47:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:50 INFO - 'LOGNAME': 'cltbld', 06:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:50 INFO - 'MOZ_NO_REMOTE': '1', 06:47:50 INFO - 'NO_EM_RESTART': '1', 06:47:50 INFO - 'PAGER': '/bin/cat', 06:47:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:50 INFO - 'PWD': '/builds/slave/test', 06:47:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:50 INFO - 'SHELL': '/bin/bash', 06:47:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLL4f0gT6L/Listeners', 06:47:50 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 06:47:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:50 INFO - 'USER': 'cltbld', 06:47:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:50 INFO - 'XPC_FLAGS': '0x0', 06:47:50 INFO - 'XPC_SERVICE_NAME': '0', 06:47:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:47:50 INFO - Cleaning up... 06:47:50 INFO - Return code: 0 06:47:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10adcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10addc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe708490130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac6be00>, '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 0x10aa94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac66b20>, '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.msXrZOpyE5/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.BLL4f0gT6L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:47:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 06:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 06:47:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msXrZOpyE5/Render', 06:47:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:50 INFO - 'HOME': '/Users/cltbld', 06:47:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:50 INFO - 'LOGNAME': 'cltbld', 06:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:50 INFO - 'MOZ_NO_REMOTE': '1', 06:47:50 INFO - 'NO_EM_RESTART': '1', 06:47:50 INFO - 'PAGER': '/bin/cat', 06:47:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:50 INFO - 'PWD': '/builds/slave/test', 06:47:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:50 INFO - 'SHELL': '/bin/bash', 06:47:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLL4f0gT6L/Listeners', 06:47:50 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 06:47:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:50 INFO - 'USER': 'cltbld', 06:47:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:50 INFO - 'XPC_FLAGS': '0x0', 06:47:50 INFO - 'XPC_SERVICE_NAME': '0', 06:47:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:50 INFO - Downloading/unpacking psutil>=0.7.1 06:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:47:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:53 INFO - Installing collected packages: psutil 06:47:53 INFO - Running setup.py install for psutil 06:47:53 INFO - building 'psutil._psutil_osx' extension 06:47:53 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:47:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:47:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:47:54 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:47:54 INFO - building 'psutil._psutil_posix' extension 06:47:54 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:47:54 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:47:54 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:47:54 INFO - ^ 06:47:54 INFO - 1 warning generated. 06:47:54 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:47:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:47:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:47:54 INFO - Successfully installed psutil 06:47:54 INFO - Cleaning up... 06:47:54 INFO - Return code: 0 06:47:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:54 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 0x10adcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10addc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe708490130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac6be00>, '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 0x10aa94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac66b20>, '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.msXrZOpyE5/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.BLL4f0gT6L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:47:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 06:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 06:47:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msXrZOpyE5/Render', 06:47:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:54 INFO - 'HOME': '/Users/cltbld', 06:47:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:54 INFO - 'LOGNAME': 'cltbld', 06:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:54 INFO - 'MOZ_NO_REMOTE': '1', 06:47:54 INFO - 'NO_EM_RESTART': '1', 06:47:54 INFO - 'PAGER': '/bin/cat', 06:47:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:54 INFO - 'PWD': '/builds/slave/test', 06:47:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:54 INFO - 'SHELL': '/bin/bash', 06:47:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLL4f0gT6L/Listeners', 06:47:54 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 06:47:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:54 INFO - 'USER': 'cltbld', 06:47:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:54 INFO - 'XPC_FLAGS': '0x0', 06:47:54 INFO - 'XPC_SERVICE_NAME': '0', 06:47:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:47: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 06:47: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 06:47: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 06:47: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 06:47: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 06:47: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 06:47:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:47:57 INFO - Installing collected packages: mozsystemmonitor 06:47:57 INFO - Running setup.py install for mozsystemmonitor 06:47:57 INFO - Successfully installed mozsystemmonitor 06:47:57 INFO - Cleaning up... 06:47:57 INFO - Return code: 0 06:47:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:47:57 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 0x10adcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10addc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe708490130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac6be00>, '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 0x10aa94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac66b20>, '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.msXrZOpyE5/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.BLL4f0gT6L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:47:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:47:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msXrZOpyE5/Render', 06:47:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:47:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:47:57 INFO - 'HOME': '/Users/cltbld', 06:47:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:47:57 INFO - 'LOGNAME': 'cltbld', 06:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:47:57 INFO - 'MOZ_NO_REMOTE': '1', 06:47:57 INFO - 'NO_EM_RESTART': '1', 06:47:57 INFO - 'PAGER': '/bin/cat', 06:47:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:47:57 INFO - 'PWD': '/builds/slave/test', 06:47:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:47:57 INFO - 'SHELL': '/bin/bash', 06:47:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLL4f0gT6L/Listeners', 06:47:57 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 06:47:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:47:57 INFO - 'USER': 'cltbld', 06:47:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:47:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:47:57 INFO - 'XPC_FLAGS': '0x0', 06:47:57 INFO - 'XPC_SERVICE_NAME': '0', 06:47:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:47:58 INFO - Downloading/unpacking blobuploader==1.2.4 06:47: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 06:47: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 06:47: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 06:47: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 06:47: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 06:47: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 06:48:00 INFO - Downloading blobuploader-1.2.4.tar.gz 06:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:48:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:48:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:01 INFO - Downloading docopt-0.6.1.tar.gz 06:48:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:48:01 INFO - Installing collected packages: blobuploader, requests, docopt 06:48:01 INFO - Running setup.py install for blobuploader 06:48:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:48:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:48:01 INFO - Running setup.py install for requests 06:48:02 INFO - Running setup.py install for docopt 06:48:02 INFO - Successfully installed blobuploader requests docopt 06:48:02 INFO - Cleaning up... 06:48:02 INFO - Return code: 0 06:48:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:02 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 0x10adcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10addc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe708490130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac6be00>, '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 0x10aa94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac66b20>, '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.msXrZOpyE5/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.BLL4f0gT6L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:48:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:48:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:48:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msXrZOpyE5/Render', 06:48:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:02 INFO - 'HOME': '/Users/cltbld', 06:48:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:02 INFO - 'LOGNAME': 'cltbld', 06:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:02 INFO - 'MOZ_NO_REMOTE': '1', 06:48:02 INFO - 'NO_EM_RESTART': '1', 06:48:02 INFO - 'PAGER': '/bin/cat', 06:48:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:02 INFO - 'PWD': '/builds/slave/test', 06:48:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:02 INFO - 'SHELL': '/bin/bash', 06:48:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLL4f0gT6L/Listeners', 06:48:02 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 06:48:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:02 INFO - 'USER': 'cltbld', 06:48:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:02 INFO - 'XPC_FLAGS': '0x0', 06:48:02 INFO - 'XPC_SERVICE_NAME': '0', 06:48:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:02 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-EUOcIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:03 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-TXwBIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:03 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-r1yiNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:03 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-yfB2LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:03 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-7wN1wU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:03 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-uzni_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:03 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-SNaMSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:03 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-vN1wJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:03 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-GBVnQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:03 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-Q1dD8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:03 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-xrt1j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:04 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-PWgfDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:04 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-JT3F5l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:04 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-ThBOP6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:04 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-bJcLLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:04 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-Qjpo47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:04 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-VpxHvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:48:04 INFO - Running setup.py install for manifestparser 06:48:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:48:04 INFO - Running setup.py install for mozcrash 06:48:04 INFO - Running setup.py install for mozdebug 06:48:05 INFO - Running setup.py install for mozdevice 06:48:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:48:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:48:05 INFO - Running setup.py install for mozfile 06:48:05 INFO - Running setup.py install for mozhttpd 06:48:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:48:05 INFO - Running setup.py install for mozinfo 06:48:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:48:05 INFO - Running setup.py install for mozInstall 06:48:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:48:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:48:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:48:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:48:05 INFO - Running setup.py install for mozleak 06:48:05 INFO - Running setup.py install for mozlog 06:48:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:48:06 INFO - Running setup.py install for moznetwork 06:48:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:48:06 INFO - Running setup.py install for mozprocess 06:48:06 INFO - Running setup.py install for mozprofile 06:48:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:48:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:48:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:48:06 INFO - Running setup.py install for mozrunner 06:48:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:48:06 INFO - Running setup.py install for mozscreenshot 06:48:06 INFO - Running setup.py install for moztest 06:48:07 INFO - Running setup.py install for mozversion 06:48:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:48:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:48:07 INFO - Cleaning up... 06:48:07 INFO - Return code: 0 06:48:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:07 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 0x10adcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10addc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe708490130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac6be00>, '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 0x10aa94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac66b20>, '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.msXrZOpyE5/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.BLL4f0gT6L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:48:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msXrZOpyE5/Render', 06:48:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:07 INFO - 'HOME': '/Users/cltbld', 06:48:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:07 INFO - 'LOGNAME': 'cltbld', 06:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:07 INFO - 'MOZ_NO_REMOTE': '1', 06:48:07 INFO - 'NO_EM_RESTART': '1', 06:48:07 INFO - 'PAGER': '/bin/cat', 06:48:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:07 INFO - 'PWD': '/builds/slave/test', 06:48:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:07 INFO - 'SHELL': '/bin/bash', 06:48:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLL4f0gT6L/Listeners', 06:48:07 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 06:48:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:07 INFO - 'USER': 'cltbld', 06:48:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:07 INFO - 'XPC_FLAGS': '0x0', 06:48:07 INFO - 'XPC_SERVICE_NAME': '0', 06:48:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:07 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-13866j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:07 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-rPP8mr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:07 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-_6tQ8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:07 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-RsVN4j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:48:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:07 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-PV72yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:08 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-Z7mVfc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:08 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-qjGHoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:08 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-xycUOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:08 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-An9YIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:08 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-ERgv7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:08 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-ilgd3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:08 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-cO7LQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:08 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-eSK7lq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:48:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:08 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-9o4n0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:09 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-0OIx4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:09 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-g8Sa4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:48:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:09 INFO - Running setup.py (path:/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/pip-ciVOuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:48:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:48:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:11 INFO - Downloading blessings-1.6.tar.gz 06:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:48:11 INFO - Installing collected packages: blessings 06:48:11 INFO - Running setup.py install for blessings 06:48:11 INFO - Successfully installed blessings 06:48:11 INFO - Cleaning up... 06:48:12 INFO - Return code: 0 06:48:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:12 INFO - Reading from file tmpfile_stdout 06:48:12 INFO - Current package versions: 06:48:12 INFO - blessings == 1.6 06:48:12 INFO - blobuploader == 1.2.4 06:48:12 INFO - docopt == 0.6.1 06:48:12 INFO - manifestparser == 1.1 06:48:12 INFO - mozInstall == 1.12 06:48:12 INFO - mozcrash == 0.17 06:48:12 INFO - mozdebug == 0.1 06:48:12 INFO - mozdevice == 0.48 06:48:12 INFO - mozfile == 1.2 06:48:12 INFO - mozhttpd == 0.7 06:48:12 INFO - mozinfo == 0.9 06:48:12 INFO - mozleak == 0.1 06:48:12 INFO - mozlog == 3.1 06:48:12 INFO - moznetwork == 0.27 06:48:12 INFO - mozprocess == 0.22 06:48:12 INFO - mozprofile == 0.28 06:48:12 INFO - mozrunner == 6.11 06:48:12 INFO - mozscreenshot == 0.1 06:48:12 INFO - mozsystemmonitor == 0.0 06:48:12 INFO - moztest == 0.7 06:48:12 INFO - mozversion == 1.4 06:48:12 INFO - psutil == 3.1.1 06:48:12 INFO - requests == 1.2.3 06:48:12 INFO - wsgiref == 0.1.2 06:48:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:12 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 0x10adcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10addc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe708490130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac6be00>, '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 0x10aa94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac66b20>, '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.msXrZOpyE5/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.BLL4f0gT6L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:48:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:48:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msXrZOpyE5/Render', 06:48:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:12 INFO - 'HOME': '/Users/cltbld', 06:48:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:12 INFO - 'LOGNAME': 'cltbld', 06:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:12 INFO - 'MOZ_NO_REMOTE': '1', 06:48:12 INFO - 'NO_EM_RESTART': '1', 06:48:12 INFO - 'PAGER': '/bin/cat', 06:48:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:12 INFO - 'PWD': '/builds/slave/test', 06:48:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:12 INFO - 'SHELL': '/bin/bash', 06:48:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLL4f0gT6L/Listeners', 06:48:12 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 06:48:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:12 INFO - 'USER': 'cltbld', 06:48:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:12 INFO - 'XPC_FLAGS': '0x0', 06:48:12 INFO - 'XPC_SERVICE_NAME': '0', 06:48:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:48:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:48:12 INFO - Cleaning up... 06:48:12 INFO - Return code: 0 06:48:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10adcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10addc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe708490130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac6be00>, '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 0x10aa94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac66b20>, '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.msXrZOpyE5/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.BLL4f0gT6L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:48:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:48:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msXrZOpyE5/Render', 06:48:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:12 INFO - 'HOME': '/Users/cltbld', 06:48:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:12 INFO - 'LOGNAME': 'cltbld', 06:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:12 INFO - 'MOZ_NO_REMOTE': '1', 06:48:12 INFO - 'NO_EM_RESTART': '1', 06:48:12 INFO - 'PAGER': '/bin/cat', 06:48:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:12 INFO - 'PWD': '/builds/slave/test', 06:48:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:12 INFO - 'SHELL': '/bin/bash', 06:48:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLL4f0gT6L/Listeners', 06:48:12 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 06:48:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:12 INFO - 'USER': 'cltbld', 06:48:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:12 INFO - 'XPC_FLAGS': '0x0', 06:48:12 INFO - 'XPC_SERVICE_NAME': '0', 06:48:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:13 INFO - Downloading/unpacking jsonschema 06:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:48:16 INFO - Downloading/unpacking functools32 (from jsonschema) 06:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:16 INFO - Downloading functools32-3.2.3-2.tar.gz 06:48:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:48:16 INFO - warning: no files found matching '*.txt' 06:48:16 INFO - no previously-included directories found matching 'build' 06:48:16 INFO - no previously-included directories found matching 'dist' 06:48:16 INFO - no previously-included directories found matching '.git*' 06:48:16 INFO - Installing collected packages: jsonschema, functools32 06:48:16 INFO - Running setup.py install for functools32 06:48:16 INFO - warning: no files found matching '*.txt' 06:48:16 INFO - no previously-included directories found matching 'build' 06:48:16 INFO - no previously-included directories found matching 'dist' 06:48:16 INFO - no previously-included directories found matching '.git*' 06:48:16 INFO - Successfully installed jsonschema functools32 06:48:16 INFO - Cleaning up... 06:48:16 INFO - Return code: 0 06:48:16 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:16 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 0x10adcca30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10addc420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe708490130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ac6be00>, '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 0x10aa94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac66b20>, '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.msXrZOpyE5/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.BLL4f0gT6L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:48:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 06:48:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 06:48:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msXrZOpyE5/Render', 06:48:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:16 INFO - 'HOME': '/Users/cltbld', 06:48:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:16 INFO - 'LOGNAME': 'cltbld', 06:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:16 INFO - 'MOZ_NO_REMOTE': '1', 06:48:16 INFO - 'NO_EM_RESTART': '1', 06:48:16 INFO - 'PAGER': '/bin/cat', 06:48:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:16 INFO - 'PWD': '/builds/slave/test', 06:48:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:16 INFO - 'SHELL': '/bin/bash', 06:48:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLL4f0gT6L/Listeners', 06:48:16 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 06:48:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:16 INFO - 'USER': 'cltbld', 06:48:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:16 INFO - 'XPC_FLAGS': '0x0', 06:48:16 INFO - 'XPC_SERVICE_NAME': '0', 06:48:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:17 INFO - Downloading/unpacking flake8 06:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:19 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:48:19 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:19 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:48:19 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:48:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:48:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:48:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:48:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:48:20 INFO - no previously-included directories found matching 'docs/_build' 06:48:20 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:48:20 INFO - Running setup.py install for pep8 06:48:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:48:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:48:20 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:48:20 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:48:20 INFO - no previously-included directories found matching 'docs/_build' 06:48:20 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:48:20 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:48:20 INFO - Cleaning up... 06:48:21 INFO - Return code: 0 06:48:21 INFO - Running post-action listener: _resource_record_post_action 06:48:21 INFO - Running post-action listener: _start_resource_monitoring 06:48:21 INFO - Starting resource monitoring. 06:48:21 INFO - ##### 06:48:21 INFO - ##### Running install step. 06:48:21 INFO - ##### 06:48:21 INFO - Running pre-action listener: _resource_record_pre_action 06:48:21 INFO - Running main action method: install 06:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:21 INFO - Reading from file tmpfile_stdout 06:48:21 INFO - Detecting whether we're running mozinstall >=1.0... 06:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:48:21 INFO - Reading from file tmpfile_stdout 06:48:21 INFO - Output received: 06:48:21 INFO - Usage: mozinstall [options] installer 06:48:21 INFO - Options: 06:48:21 INFO - -h, --help show this help message and exit 06:48:21 INFO - -d DEST, --destination=DEST 06:48:21 INFO - Directory to install application into. [default: 06:48:21 INFO - "/builds/slave/test"] 06:48:21 INFO - --app=APP Application being installed. [default: firefox] 06:48:21 INFO - mkdir: /builds/slave/test/build/application 06:48:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:48:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:48:54 INFO - Reading from file tmpfile_stdout 06:48:54 INFO - Output received: 06:48:54 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:48:54 INFO - Running post-action listener: _resource_record_post_action 06:48:54 INFO - ##### 06:48:54 INFO - ##### Running run-tests step. 06:48:54 INFO - ##### 06:48:54 INFO - Running pre-action listener: _resource_record_pre_action 06:48:54 INFO - Running main action method: run_tests 06:48:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:48:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:48:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:48:54 INFO - 2016-04-12 06:48:54.397 screenresolution[1645:7568] starting screenresolution argv=screenresolution get 06:48:54 INFO - 2016-04-12 06:48:54.399 screenresolution[1645:7568] Display 0: 1600x1200x32@60 06:48:54 INFO - 2016-04-12 06:48:54.405 screenresolution[1646:7570] starting screenresolution argv=screenresolution list 06:48:54 INFO - Available Modes on Display 0 06:48:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:48:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:48:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:48:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:48:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:48:54 INFO - Intel Iris: 06:48:54 INFO - Chipset Model: Intel Iris 06:48:54 INFO - Type: GPU 06:48:54 INFO - Bus: Built-In 06:48:54 INFO - VRAM (Dynamic, Max): 1536 MB 06:48:54 INFO - Vendor: Intel (0x8086) 06:48:54 INFO - Device ID: 0x0a2e 06:48:54 INFO - Revision ID: 0x0009 06:48:54 INFO - Displays: 06:48:54 INFO - Display: 06:48:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:48:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:48:54 INFO - Display Serial Number: 1600x1200 60 06:48:54 INFO - Main Display: Yes 06:48:54 INFO - Mirror: Off 06:48:54 INFO - Online: Yes 06:48:54 INFO - Rotation: Supported 06:48:54 INFO - Return code: 0 06:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:48:54 INFO - Python 2.7.3 06:48:54 INFO - Return code: 0 06:48:54 INFO - grabbing minidump binary from tooltool 06:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:48:54 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 0x10ac6be00>, '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 0x10aa94db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ac66b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:48:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:48:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:48:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:48:54 INFO - Return code: 0 06:48:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:48:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:48:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:48:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:48:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:48:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:48:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:48:55 INFO - Return code: 0 06:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0183', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0183 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:48:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.msXrZOpyE5/Render', 06:48:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:48:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:48:55 INFO - 'HOME': '/Users/cltbld', 06:48:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:48:55 INFO - 'LOGNAME': 'cltbld', 06:48:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:48:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:55 INFO - 'MOZ_NO_REMOTE': '1', 06:48:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:48:55 INFO - 'NO_EM_RESTART': '1', 06:48:55 INFO - 'PAGER': '/bin/cat', 06:48:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:55 INFO - 'PWD': '/builds/slave/test', 06:48:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:48:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:48:55 INFO - 'SHELL': '/bin/bash', 06:48:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BLL4f0gT6L/Listeners', 06:48:55 INFO - 'TMPDIR': '/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/', 06:48:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:48:55 INFO - 'USER': 'cltbld', 06:48:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:48:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:55 INFO - 'XPC_FLAGS': '0x0', 06:48:55 INFO - 'XPC_SERVICE_NAME': '0', 06:48:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:48:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0183', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:48:56 INFO - mozversion application_buildid: 20160412045151 06:48:56 INFO - mozversion application_changeset: 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 06:48:56 INFO - mozversion application_display_name: Nightly 06:48:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:48:56 INFO - mozversion application_name: Firefox 06:48:56 INFO - mozversion application_remotingname: firefox 06:48:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:48:56 INFO - mozversion application_vendor: Mozilla 06:48:56 INFO - mozversion application_version: 48.0a1 06:48:56 INFO - mozversion platform_buildid: 20160412045151 06:48:56 INFO - mozversion platform_changeset: 49d7fb650c9dde7cf6e4b2c7aa578a4a11e83f83 06:48:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:48:56 INFO - mozversion platform_version: 48.0a1 06:48:56 INFO - using testdate: 1460468936 06:48:56 INFO - actual date: 1460468936 06:48:56 INFO - starting webserver on 'localhost:49270' 06:48:56 INFO - SUITE-START | Running 2 tests 06:48:56 INFO - TEST-START | dromaeo_css 06:48:56 INFO - operating with platform_type : mac_ 06:48:56 INFO - Initialising browser for dromaeo_css test... 06:48:56 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmpgpsKrF/profile http://localhost:49270/getInfo.html) 06:48:58 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 06:48:58 INFO - PROCESS | 1664 | colorDepth:24 06:48:58 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 06:48:58 INFO - PROCESS | 1664 | __metrics 06:48:58 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:48:58 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:48:59 INFO - TEST-INFO | 1664: exit 0 06:48:59 INFO - Browser initialized. 06:48:59 INFO - Running cycle 1/1 for dromaeo_css test... 06:48:59 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmpgpsKrF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:49:11 INFO - PROCESS | 1666 | RSS: Main: 237678592 06:49:11 INFO - PROCESS | 1666 | 06:50:02 INFO - PROCESS | 1666 | 1460469002640 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 06:52:12 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 06:52:14 INFO - PROCESS | 1666 | RSS: Main: 360083456 06:52:14 INFO - PROCESS | 1666 | 06:55:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 06:55:17 INFO - PROCESS | 1666 | RSS: Main: 377589760 06:55:17 INFO - PROCESS | 1666 | 06:58:19 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 06:58:20 INFO - PROCESS | 1666 | RSS: Main: 374972416 06:58:20 INFO - PROCESS | 1666 | 07:01:22 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 07:01:23 INFO - PROCESS | 1666 | RSS: Main: 339910656 07:01:23 INFO - PROCESS | 1666 | 07:04:26 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 07:04:26 INFO - PROCESS | 1666 | RSS: Main: 336801792 07:04:26 INFO - PROCESS | 1666 | 07:07:29 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 07:07:29 INFO - PROCESS | 1666 | RSS: Main: 393723904 07:07:29 INFO - PROCESS | 1666 | 07:07:29 INFO - PROCESS | 1666 | __start_tp_report 07:07:29 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 07:07:29 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 07:07:29 INFO - PROCESS | 1666 | |i|pagename|runs| 07:07:29 INFO - PROCESS | 1666 | |0;dojo.html;3385.289089291249;3456.879009234677;3471.722262219022;3477.895663130104;3518.190816112294;5564.304461942257;5629.887402251952;5696;5709.4290570942885;5718.199452076713;5728.856778580527;5776.451237132476;5817.73820178092;5896.941030589693;5928.170056192126;5097.362829646294;5148.819791307305;5188.455212202721;5206.505381988705;5302.337207849019;5270.525652691257;5273.314469119009;5312.867178320535;5344.839654810362;5375.865603359908;5121.615878809085;5153.896922061538;5208.817691380802;5209.739513024371;5241.3448318959745;5210.140326846104;5212.635115541913;5218.399884013311;5227.712475813829;5235.528802407802;5183.714895680736;5197.558207552363;5217.765200565984;5244.921326180111;5249.42256351801;5458.153986132116;5597.63615365;5673.347565030033;5719.828405147852;5721.6853073080965;6166.568340216187;6183.81448556544;6186.226721659793;6196.473299769525;6202.379762023762;4071.9389209161886;5991.981363168228;6177.3822617738315;6199.845003874894;6204.87590248197;5733.770649174028;5794.797182098649;5898.528117750569;5906.8818623627285;5908.970455147697;6266.843328916813;6276.372362763778;6294.370562943761;6303.36966303366;6309.3690630936535;5996.430339117776;6172.783952561639;6183.227096612924;6185.443310102112;6191.318954914956;6153.169322141453;6164.47601953839;6245.437910588069;6292.465140463112;6297.4017468340435;6131.816045518642;6144.662043587646;6191.25704915413;6197.5351848611535;6227.159333489921;4882.5605695487575;6234.906476402857;6239.500839932794;6250.218722659668;6261.373862613702;4893.6329775266995;4906.656534042654;4953.90092198154;4960.330355401975;4995.150824359867;4386.824527018884;4395.670324725658;4397.252467080604;4404.537523560044;4420.756858372756;5519;5673.8297851064535;5687.829365119053;5687.943120568824;5719.628224165416;6158.507319414436;6189.50483961282;6191.19514463117;6299.5275354348605;6321.96839015802;5663.915041274384;5687.914681279784;5695.40198279183;5704.942950570441;5731.799387021434;5402.621816472809;5418.485243901823;5424.023675738326;5432.158015507603;5432.239486471897;4834.661573689808;5269.841904742864;6130.795626845537;6269.874602508015;6307.590006649553;6274.121622972696;6289.622622642656;6309.463695585743;6310.432061114522;6326.905096423466;6277.403646653561;6284.717187726655;6335.4931605472375;6338.651374174465;6356.364363563606;5994.850128746816;6068.332483426908;6081.179040829608;6133.946794548555;6170.7223174958135;6234.15838861766;6238.875222495615;6264.68676566179;6266.216722909637;6274.247090349188;6112.38876112403;6114.755409783559;6114.755409783559;6121.479674227562;6128.601640893327;5746.2529871116485;6012.338642749207;6075.1798507200965;6122;6137.867325793431;5969.3732158122775;6018.3379828217985;6019.187409699634;6036.728347224298;6052.969735151296;6113.57204995646;6135.049067394561;6154.661493617894;6163.137160797582;6178.907316390348;5868.23712917318;5976.282846058501;5984.401559844155;5985.850353741192;5986.281646202484 07:07:29 INFO - PROCESS | 1666 | |1;ext.html;505.93928728552555;528.5164074871492;530.9469053094689;578.4909279833746;603.1164344235697;29124.126276211722;34300.79947201849;37782.622173778254;38267.42598861016;38457.42313865287;40986.79506602463;41944.99999999993;41979.37030944538;42039.15921681564;42124.368134478005;8126.75619731406;8679.522626255553;9367.718968430958;9575.904240957605;9591.616335346613;8523.786905327355;8671.176238257356;11305.321680699144;11651.359175245358;11659.183857130005;11303.321800691943;11399.316041037522;11410.144239182053;11414.029807466375;11430.25703329281;11448.313101213913;11481.540738370455;11513.769724605545;11538.538458461651;11539.423028848609;11200.159988000933;11215.551377944872;11329.037031852302;11342.432878356049;11356.829647555292;37418.25163496742;37940.81029594862;39612.80193599042;39617.80191099055;39639.80180099081;3241.4117082629577;3296.324253528045;3378;3417.214040770612;3448.896533104011;26609.46781064368;29180.41639167226;29522.014528038653;29768.10695679133;29973;2498.7126480454617;2747.8076534642582;2771;2821.2523681224493;2862.298736809495;462257.68871155765;463022;465890;465910;466771;54173.72913135409;63893.68053159704;64579.677101614194;65028.34971650223;65063.67468162629;66914;67258.66370668115;67329;67379;67402.32597674058;16561.420350287925;16795.99224046561;16820.663586728442;16823.074730889675;16865.662686746196;12942.935285323512;13007.219566826021;13018.414171362312;13046.282454464907;13056.608301750963;17624.735628965576;18479.44561663152;18488.260469581335;18492.72260916087;18497.352592659194;5432.076546987022;5884.0585506318785;5992.760289588455;6211.859728349217;6395.424411802867;925.6852670092201;975.2685485885586;999.3011879804217;1010.6563768318659;1064.9520771565299;28929.42141157165;29029.12912612625;29705.554416683768;29719.108426747232;29884;962.8363178259713;1071.0093163823433;1077.3266708307308;1141.6118519703175;1165.2833507392893;11456.713582160346;13807.861921380858;14948.850511494964;15402.383904643688;15441.922790385976;574901;583046;583813;584503;585251;58192.709036455395;60000.69999650061;60102;60140;60143.39856601466;1215.8419405477232;1254.9874501255053;1318.1893135721655;1320.5972178485463;1448.9710205795825;24190.51618967646;29702.25744356322;29806.850965745034;30680.926167584028;30788.69211307948;47145.76427117842;47462;47992.760036199594;48059.75970120127;48127.27809082797;403490;406194;406232;406405;406452;23490;25485.490290194462;25846.870765646803;26067.217983459766;26678.866605666848;42324.78837605792;42650;42929.78535107429;43644.78177609092;43768;34322.97031089071;35170.64829351776;35295.470567942015;36062.278754425286;36340.81829590835;35028.9491315261;35088.82455587706;35443.645563544036;35816;35897;36027.81986090053;36428;36441.63558364382;36712.81643591765;36749;26373;32115.678843212205;32291;32662;33728.98813035613;24274.75725242725;24600.630990535516;24642.50714985726;24791.793723318304;24879.502409952063 07:07:29 INFO - PROCESS | 1666 | |2;jquery.html;395.6676391830861;395.87332053742807;399.60638770810766;400.1796317549026;409.1203911590083;13777.793333100011;19332.710009349852;20245;20342.593148137028;20652;16043;17471.73792393112;20087.598248035032;20467.48831279219;20517.48706282344;5562.16567514873;5847.444492773201;5875.706214689249;5877.617954832944;5882.5588080893895;5738.512226460756;5755.165501002352;5761.711914404284;5803.158542011406;5823.854403639901;4077.143799802045;4288;4325.98339390243;6064.3026052003925;6442.581232219914;6339.175907132043;6418.646974416405;6422.807315780534;6433.646149461754;6437.259715132773;5412.648177868426;5554.111342185231;5593.944060559383;5594.916076258859;5599.104143337087;24698.382540436633;25159.874200629063;25258.873705631537;25535.23394298174;25770.840312185996;2067.7208576842086;2115.175081718131;2130.2544109561686;2136.722226110596;2198.604251234777;13779.448822047107;14522.419103235858;14752.262386880613;14764.630884227872;14819.40722371104;1527.618095476131;1627.60123769676;1716.2534297580467;1756.7891852977596;1765.2497688482472;112682.87317126806;116807;117488;120094.39952800267;121228;9847.409155450696;10655.094316983143;11456.59901903446;11512.539498420138;11621;14834.92582537102;14866.959312848214;14889.404423823142;14919.030263032868;14938.775918361232;8314.708985185489;8502.574871256413;8520.19058189471;8589.398742087993;8663.610137543825;8332.208440198172;8333.624986875606;8350.582470876432;8456.701886264362;8460.746177614681;4464.196444639931;4539.16025535277;4540.886477838015;4599.931001034987;4600.815967361335;1479.3934486860335;1675.2880025988907;1934.8065193480538;1977;1983.2860170338668;801.7234054251275;936.5317341329335;946.5220063867703;949.6866034208695;976.1263669016191;19383.321583744502;19876.304329348404;20039.899800500905;20056.598868022556;20321.796782032285;858.9785255368665;943.217129782279;951.8572214167792;969.970900872975;1028.4343611013912;9763.707088787347;10405.53175107122;10537.15702743794;10594.57621695139;10608;595349;618035;629489;642505;643280;121262.39368803099;123422.38288808678;123687;123975;126785;1002.0189934943485;1004.7588578741049;1021.070825548747;1027.337367398024;1027.6505987964129;14170.858291416955;16273;17243.310267589157;17572.472825815246;17587.208575614382;33982;45940.77029614831;49302;51035.2344714837;51193;65130.674346627966;69612.65193673999;69786.60426791538;69896.86612525412;70868;8047.718329858427;8050.758477245692;8080.393970452122;8153.388495862952;8445.324374050184;10543.367397956146;10983;11475.885241147816;11908.404579770804;12550.1842380245;5656.519195868397;7381.557106573623;10164.542595583069;11008.779824403628;11062.944685276521;10537.578496860346;10726.352188172106;11053.28153670009;11053.557857685924;11273.71815704581;11126.274062854653;11243.55025798959;11323.207375483636;11616.361100139573;11700.414979251174;8032.759017229492;8110;8143.307818835466;8212.794680133044;8390.748277551684;9415.717528474157;11049.447527623748;11071.889281107085;11107.444627768418;11237.662870113909 07:07:29 INFO - PROCESS | 1666 | |3;mootools.html;1396.0646366934154;1579.4629825859208;1593.1237819199441;1838.779346478423;1967.1541237267968;7813.0624325081;8557.572121393929;8802.779930501725;8803.911960880398;8824.294056475483;8399.45403548769;8627.180417860292;8641.092685268051;8650.697225597105;8660.047394786585;2119.565489074736;2390.8445951013214;2395.053953688288;2430.5503481855912;2481.2928315430104;2478.8140889433366;2509.887055082526;2510;2516.748325167487;2517.5971844504884;2092.403664955488;2416.8791560421996;2457.987710061447;2459.6433517140003;2469.76537228963;2106.3470324199548;2356.670066190735;2437.049550675238;2440.4021014851473;2443.9755602443925;2446.2294377271282;2447.5839107351794;2464.9753502465105;2471.542764588539;2472.7279999200073;8596.441231320006;8648.870266946002;8670.696525621635;8679.262262707614;8679.696210632661;5203.115470370046;5400.702961337125;5403.864903377408;5414.269073675043;5434.2935418395755;2573.74262573743;3383.2895092030703;3564.803935783557;3603.855845766166;3666.0651533858963;872.8472517309509;1022.9539670714836;1035.2287545778443;1036.6630844975414;1053.5785685725693;11568.24806387582;11597.188196826226;11602.535898564047;11706.941465292704;11762.529498820037;4662.230731929261;4728.456227533878;4834.250691142878;4888.193448081027;4889.682170658896;8307.667693292322;9917.504124793732;9928.602855885829;9955.850662240073;9978.50322451638;5404.594655400782;5405.7837686492885;5426.050441172779;5432.483914028161;5467.20725494809;4419.801108950105;4569.794359253841;4601.378813860153;4763.976180119146;4974.77613507393;3643.2531331077066;3743.858123272428;3955.5055618047745;3997.8001099944886;4029.5164580250557;1338.9263590502421;1340.6124660975843;1345.8115863779078;1348.7976803479557;1352.4657760184673;1327.6680829792551;1332.1074879830537;1349.966250843717;1352.2562590575144;1357.0839683213792;7947.642356093989;7970.242826931432;7998;8009.519428834172;8052.074011488637;487.5611949245636;496.3299545613393;497.6019184652264;499.3383766509317;501.4985014985015;6200.100985357098;6292.2134733158355;6307.400796924285;6313.55805093639;6340;9559.90440095604;9972.152367048737;10256.794864102825;10761.139108871428;10783.946080269705;10485.895141048491;10593.84109238362;10632.893671063344;10678.1991350649;10833.945830270799;8018.358531317481;8078.071021832447;8083.232092951161;8098.919010809935;8163.469374490639;7707.499012564165;7916.4062695299235;7950.960245198737;7952.204779522001;7967.84064318722;9710.368826026568;9753.951230244087;9769.75575610587;9827.852582211415;9985.800283994426;8656.350773692124;9782.217422606316;10239.283250172417;10243.282970192015;10253.948730256301;7345.1553071397475;7348.742794002184;7375;7418.851622967619;7418.998435211178;8038.718644847402;8041.718539851077;8118.75643730689;8118.75643730689;8131.308838748772;7128.714851405885;7302.19675835647;7355.080614923135;7410.888836667346;7444.330010299099;7054.964725176546;7153.892691609526;7209.71161153548;7276.345128938421;7390.5196162249285;7614.505057171266;7671.2712292332135;7680.846383072419;7693.615319233904;7699.9990001299475;6849.075374824534;6923.342282483156;6993.19578248508;6998.020277161099;7006.754763583454;6013.669248191217;7067.399271061811;7098.893516597358;7101.7159313628945;7116.323949224816 07:07:29 INFO - PROCESS | 1666 | |4;prototype.html;316.5663041632963;322.3874638187444;328.1075474708791;328.27451332555046;333.9916502087448;4698.966227429968;5331;5780.855478613037;6065.6032621731865;6110.450059494639;5187.821115131645;5660.575456840733;5748.425157484249;6017.247844019497;6050.334463209055;4267.722598031133;4366.345048242773;4418.845340413086;4590.632749380042;4609.1473077480605;3792.374258247386;4550.907782132281;4559.2249317615915;4560.179167749804;4590.495045544987;4539.614132798716;4544.750038747868;4558.361829343895;4563.589276965073;4586.4266966629175;4279.315309550457;4279.550647182048;4538.682292239545;4564.5435456454425;4566.566176213288;3240.562524059269;3888.8250028748776;3903.082775547744;3912.784796836173;3927.9410808837893;4537.546245375469;5763.991301522259;5781.364049954502;5797.811448653016;5804.2744656917885;4626.421697287839;5020.698758074527;5080.74596270185;5258.55302299305;5306.893862122736;5833.774907269479;6321.336259692712;6382.744690212386;6424.229092508882;6492;3643.8360273787744;4188.518320393133;4338.6095251427205;4344.0008797976325;4348.195583816972;5594.440555944454;5675.886482270373;6795.864082718367;6819.863602727967;6843.349881761224;4359.411479450234;4389.770864158041;4404.229259879508;4411.382406463098;4422.380866678667;4254.106637606137;4483.461984561874;4486.484054333728;4494.617957473652;4498.100379924028;4322.3516472528745;4440.533743956903;5173.146430838945;5238.449962753856;5257.263983042377;6468.6442245676935;6476.6114033158165;6500.9349906501275;6501.219853617502;6515.609063456208;1178.63462326679;1509.6678730679232;1523.3221216558748;1554.85228903254;1555.688862227559;880.7709995401113;917.7705573606598;948.0661548374845;964.9903500965041;968.138356862393;5158.4067832199025;5246.76389562463;5854.736536855852;5926.621825559389;5929.822105336847;5578.553715702734;5849.912251316234;6576.8355791105605;6577.14497115372;6752.62860542665;5817.94182058174;6017.909731354033;6020.21392992572;6044.607100538539;6046.395360464006;3503;3519.51567947735;3541.8583256669444;3546;3553.6446355364774;6315.768425157142;6344.397282258178;6466.224053113562;6979.651017449107;7002.964985175042;6208.255009398901;6774.290283886485;6884.208316043719;6905.620190889449;6934.583924964519;5778.422157784188;6652.534322597372;6961.443084553325;6975.8604827903155;7015.789526314116;5725.623866095524;6350.206224221973;6689.732410703517;6701.296363881722;6709.865802684017;5529.06482731057;6167.722452489738;6186.370792413296;6586.1438013059915;6640.302768209269;5540.204959602685;6637.800865974028;6952.687129079305;6993.615351155735;7012.4390048796995;3637.472566477899;4267.573242675708;4296;4298.485386049197;4299.247631664509;5968.373320801427;6339.746410143543;6622.238442578972;6720.764773232913;6744.831379215559;5926.703664816828;6456.612603243821;6523.64119973406;6539.869202616016;6553.180852393451;6228.813135605939;6468.935310647022;6496.642684652389;6499.155109835691;6515.641639709862;6021.187139736079;6148.661823599566;6241.751649669994;6331.113644089739;6334.683265836782;6447.871042579216;6457.515686323639;6462.903056454251;6464.414234306127;6484.211788930805;5563.833085007456;6101.725422356093;6346.301906790157;6358.205224346957;6384.776532821515 07:07:29 INFO - PROCESS | 1666 | |5;yui.html;641.9743210271589;721.3399739238597;753.2016062973253;764.5680190692259;768.4812751392808;15161.241937903102;15418.845811541882;16574.502764917055;17291.654166916687;17307.39424120156;15730;15819.367225310974;15897.1256580888;15931.840681593181;15938.840611593881;725.713343229424;915.9816803663939;926.4719110107242;927.3045216087934;928.9024652411501;745.4781652843004;884.2837301785543;918.7703074231442;918.8116436130578;921.1525396635112;963.9277054220961;964.479181242132;968.1335204991528;968.9079537443931;969.1132613658494;757.0385610274975;779.9220077992212;957.5834511987273;959.5921733263335;962.3311798300184;580.3007376111775;582.1006544888115;697.7941507255372;718.3140101203338;721.1850608812061;14706.411743530245;14749.262536873113;14752.926235368754;14767.04014239071;14778.556643300719;12742.171758835646;12859.742805143938;12961.287129207889;13226.73546529064;13227.272500012496;10013.549390277454;10019.078768056706;10243.28297019209;10552.419616921066;10687.625933092382;3476.687098161178;3522.982385088058;3559.57285125784;3561.216532362876;3599.3881040222964;74762;75631.62184189043;75908.62045689792;75911.62044189744;76680.23319766787;9660.468674222986;9751.853722194173;9753.170980466597;10054.497275136215;10241.129503992244;22477.662835057487;22498.775012249997;22507.099716011176;22527.774722252896;22533.88733056357;7478.439117066242;7554.773356799305;7696.923030769733;7716;7892.289693927574;4073.307537718595;4125.154343359604;4131.421600975866;4140.171965606891;4141.420201171838;3534.8939531814085;3631.5097461842843;3644.817759112034;3648.2703459308245;3653.5615726113037;628.5882746800853;644.7421031587309;648.2286079565303;655.2071992888563;656.494499235586;562.521856422038;574.8589050734289;593.1162567774072;593.6260156101629;607.5838050935035;6249.34381889895;7550.622468876534;7630.7710768677025;7830.569318687413;7933.127355990837;532.3478738545251;548.6077454619966;553.1453903718764;586.9207656966255;590.6957916672917;3500.6149323574386;3846.1730727893078;3851.9807400963377;4044.3529035354204;4094.733842300241;75668;80041.19958800338;84788;85364.57317713372;85412.71880921791;77249.84125238014;77798;78202.43595128065;78599;78966.81549776757;57813.71093144507;59541.70229148826;64105.67947160234;64217.35782642207;68042.31957680458;7247.91281307808;7825.569593672402;7905.486143400891;8056.919430805617;8096.190380961857;38102.61897381102;43503.56496434995;43734;43847.465338712995;44975;58706;59080.704596476746;63444.682776585825;63633.68183159055;63884;9128.543572821465;10663.733406664895;10864.487142530554;10949.781004379709;11391.829122563002;11873.703157420789;11885.346305953255;11906.642800715992;11948.581799636971;12455.501779929064;11398.259113157617;11435.885641143483;11769.35268560203;11782.705432364259;12001.81997270059;11569.305841649528;11618.244814087057;11626.186166968231;11736.823947640622;11881.227720198505;11185.832212516982;11210;11269.411384699612;11380.54477820878;11549.422528873354;9534.809303814023;9597.664081757104;9664.951675241578;9724.805503889742;9978.700638980843;9238.353315267866;9576.904230957602;9653.082957119062;9667.854982175133;9731.075547822946 07:07:29 INFO - PROCESS | 1666 | __end_tp_report 07:07:29 INFO - PROCESS | 1666 | __start_cc_report 07:07:29 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1300 07:07:29 INFO - PROCESS | 1666 | __end_cc_report 07:07:29 INFO - PROCESS | 1666 | __startTimestamp1460470049912__endTimestamp 07:07:29 INFO - PROCESS | 1666 | 07:07:29 INFO - PROCESS | 1666 | ------- Summary: start ------- 07:07:29 INFO - PROCESS | 1666 | Number of tests: 6 07:07:29 INFO - PROCESS | 1666 | 07:07:29 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5716.65 Median:5976.28 stddev:640.73 (10.7%) stddev-sans-first:616.04 07:07:29 INFO - PROCESS | 1666 | Values: 3385.3 3456.9 3471.7 3477.9 3518.2 5564.3 5629.9 5696.0 5709.4 5718.2 5728.9 5776.5 5817.7 5896.9 5928.2 5097.4 5148.8 5188.5 5206.5 5302.3 5270.5 5273.3 5312.9 5344.8 5375.9 5121.6 5153.9 5208.8 5209.7 5241.3 5210.1 5212.6 5218.4 5227.7 5235.5 5183.7 5197.6 5217.8 5244.9 5249.4 5458.2 5597.6 5673.3 5719.8 5721.7 6166.6 6183.8 6186.2 6196.5 6202.4 4071.9 5992.0 6177.4 6199.8 6204.9 5733.8 5794.8 5898.5 5906.9 5909.0 6266.8 6276.4 6294.4 6303.4 6309.4 5996.4 6172.8 6183.2 6185.4 6191.3 6153.2 6164.5 6245.4 6292.5 6297.4 6131.8 6144.7 6191.3 6197.5 6227.2 4882.6 6234.9 6239.5 6250.2 6261.4 4893.6 4906.7 4953.9 4960.3 4995.2 4386.8 4395.7 4397.3 4404.5 4420.8 5519.0 5673.8 5687.8 5687.9 5719.6 6158.5 6189.5 6191.2 6299.5 6322.0 5663.9 5687.9 5695.4 5704.9 5731.8 5402.6 5418.5 5424.0 5432.2 5432.2 4834.7 5269.8 6130.8 6269.9 6307.6 6274.1 6289.6 6309.5 6310.4 6326.9 6277.4 6284.7 6335.5 6338.7 6356.4 5994.9 6068.3 6081.2 6133.9 6170.7 6234.2 6238.9 6264.7 6266.2 6274.2 6112.4 6114.8 6114.8 6121.5 6128.6 5746.3 6012.3 6075.2 6122.0 6137.9 5969.4 6018.3 6019.2 6036.7 6053.0 6113.6 6135.0 6154.7 6163.1 6178.9 5868.2 5976.3 5984.4 5985.9 5986.3 07:07:29 INFO - PROCESS | 1666 | 07:07:29 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:62717.09 Median:18885.93 stddev:130439.94 (690.7%) stddev-sans-first:130722.23 07:07:29 INFO - PROCESS | 1666 | Values: 505.9 528.5 530.9 578.5 603.1 29124.1 34300.8 37782.6 38267.4 38457.4 40986.8 41945.0 41979.4 42039.2 42124.4 8126.8 8679.5 9367.7 9575.9 9591.6 8523.8 8671.2 11305.3 11651.4 11659.2 11303.3 11399.3 11410.1 11414.0 11430.3 11448.3 11481.5 11513.8 11538.5 11539.4 11200.2 11215.6 11329.0 11342.4 11356.8 37418.3 37940.8 39612.8 39617.8 39639.8 3241.4 3296.3 3378.0 3417.2 3448.9 26609.5 29180.4 29522.0 29768.1 29973.0 2498.7 2747.8 2771.0 2821.3 2862.3 462257.7 463022.0 465890.0 465910.0 466771.0 54173.7 63893.7 64579.7 65028.3 65063.7 66914.0 67258.7 67329.0 67379.0 67402.3 16561.4 16796.0 16820.7 16823.1 16865.7 12942.9 13007.2 13018.4 13046.3 13056.6 17624.7 18479.4 18488.3 18492.7 18497.4 5432.1 5884.1 5992.8 6211.9 6395.4 925.7 975.3 999.3 1010.7 1065.0 28929.4 29029.1 29705.6 29719.1 29884.0 962.8 1071.0 1077.3 1141.6 1165.3 11456.7 13807.9 14948.9 15402.4 15441.9 574901.0 583046.0 583813.0 584503.0 585251.0 58192.7 60000.7 60102.0 60140.0 60143.4 1215.8 1255.0 1318.2 1320.6 1449.0 24190.5 29702.3 29806.9 30680.9 30788.7 47145.8 47462.0 47992.8 48059.8 48127.3 403490.0 406194.0 406232.0 406405.0 406452.0 23490.0 25485.5 25846.9 26067.2 26678.9 42324.8 42650.0 42929.8 43644.8 43768.0 34323.0 35170.6 35295.5 36062.3 36340.8 35028.9 35088.8 35443.6 35816.0 35897.0 36027.8 36428.0 36441.6 36712.8 36749.0 26373.0 32115.7 32291.0 32662.0 33729.0 24274.8 24600.6 24642.5 24791.8 24879.5 07:07:29 INFO - PROCESS | 1666 | 07:07:29 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:35052.73 Median:13448.49 stddev:104042.83 (773.6%) stddev-sans-first:104302.15 07:07:29 INFO - PROCESS | 1666 | Values: 395.7 395.9 399.6 400.2 409.1 13777.8 19332.7 20245.0 20342.6 20652.0 16043.0 17471.7 20087.6 20467.5 20517.5 5562.2 5847.4 5875.7 5877.6 5882.6 5738.5 5755.2 5761.7 5803.2 5823.9 4077.1 4288.0 4326.0 6064.3 6442.6 6339.2 6418.6 6422.8 6433.6 6437.3 5412.6 5554.1 5593.9 5594.9 5599.1 24698.4 25159.9 25258.9 25535.2 25770.8 2067.7 2115.2 2130.3 2136.7 2198.6 13779.4 14522.4 14752.3 14764.6 14819.4 1527.6 1627.6 1716.3 1756.8 1765.2 112682.9 116807.0 117488.0 120094.4 121228.0 9847.4 10655.1 11456.6 11512.5 11621.0 14834.9 14867.0 14889.4 14919.0 14938.8 8314.7 8502.6 8520.2 8589.4 8663.6 8332.2 8333.6 8350.6 8456.7 8460.7 4464.2 4539.2 4540.9 4599.9 4600.8 1479.4 1675.3 1934.8 1977.0 1983.3 801.7 936.5 946.5 949.7 976.1 19383.3 19876.3 20039.9 20056.6 20321.8 859.0 943.2 951.9 970.0 1028.4 9763.7 10405.5 10537.2 10594.6 10608.0 595349.0 618035.0 629489.0 642505.0 643280.0 121262.4 123422.4 123687.0 123975.0 126785.0 1002.0 1004.8 1021.1 1027.3 1027.7 14170.9 16273.0 17243.3 17572.5 17587.2 33982.0 45940.8 49302.0 51035.2 51193.0 65130.7 69612.7 69786.6 69896.9 70868.0 8047.7 8050.8 8080.4 8153.4 8445.3 10543.4 10983.0 11475.9 11908.4 12550.2 5656.5 7381.6 10164.5 11008.8 11062.9 10537.6 10726.4 11053.3 11053.6 11273.7 11126.3 11243.6 11323.2 11616.4 11700.4 8032.8 8110.0 8143.3 8212.8 8390.7 9415.7 11049.4 11071.9 11107.4 11237.7 07:07:29 INFO - PROCESS | 1666 | 07:07:29 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5968.26 Median:5420.16 stddev:3167.52 (58.4%) stddev-sans-first:3157.76 07:07:29 INFO - PROCESS | 1666 | Values: 1396.1 1579.5 1593.1 1838.8 1967.2 7813.1 8557.6 8802.8 8803.9 8824.3 8399.5 8627.2 8641.1 8650.7 8660.0 2119.6 2390.8 2395.1 2430.6 2481.3 2478.8 2509.9 2510.0 2516.7 2517.6 2092.4 2416.9 2458.0 2459.6 2469.8 2106.3 2356.7 2437.0 2440.4 2444.0 2446.2 2447.6 2465.0 2471.5 2472.7 8596.4 8648.9 8670.7 8679.3 8679.7 5203.1 5400.7 5403.9 5414.3 5434.3 2573.7 3383.3 3564.8 3603.9 3666.1 872.8 1023.0 1035.2 1036.7 1053.6 11568.2 11597.2 11602.5 11706.9 11762.5 4662.2 4728.5 4834.3 4888.2 4889.7 8307.7 9917.5 9928.6 9955.9 9978.5 5404.6 5405.8 5426.1 5432.5 5467.2 4419.8 4569.8 4601.4 4764.0 4974.8 3643.3 3743.9 3955.5 3997.8 4029.5 1338.9 1340.6 1345.8 1348.8 1352.5 1327.7 1332.1 1350.0 1352.3 1357.1 7947.6 7970.2 7998.0 8009.5 8052.1 487.6 496.3 497.6 499.3 501.5 6200.1 6292.2 6307.4 6313.6 6340.0 9559.9 9972.2 10256.8 10761.1 10783.9 10485.9 10593.8 10632.9 10678.2 10833.9 8018.4 8078.1 8083.2 8098.9 8163.5 7707.5 7916.4 7951.0 7952.2 7967.8 9710.4 9754.0 9769.8 9827.9 9985.8 8656.4 9782.2 10239.3 10243.3 10253.9 7345.2 7348.7 7375.0 7418.9 7419.0 8038.7 8041.7 8118.8 8118.8 8131.3 7128.7 7302.2 7355.1 7410.9 7444.3 7055.0 7153.9 7209.7 7276.3 7390.5 7614.5 7671.3 7680.8 7693.6 7700.0 6849.1 6923.3 6993.2 6998.0 7006.8 6013.7 7067.4 7098.9 7101.7 7116.3 07:07:29 INFO - PROCESS | 1666 | 07:07:29 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5176.92 Median:5811.11 stddev:1633.85 (28.1%) stddev-sans-first:1597.18 07:07:29 INFO - PROCESS | 1666 | Values: 316.6 322.4 328.1 328.3 334.0 4699.0 5331.0 5780.9 6065.6 6110.5 5187.8 5660.6 5748.4 6017.2 6050.3 4267.7 4366.3 4418.8 4590.6 4609.1 3792.4 4550.9 4559.2 4560.2 4590.5 4539.6 4544.8 4558.4 4563.6 4586.4 4279.3 4279.6 4538.7 4564.5 4566.6 3240.6 3888.8 3903.1 3912.8 3927.9 4537.5 5764.0 5781.4 5797.8 5804.3 4626.4 5020.7 5080.7 5258.6 5306.9 5833.8 6321.3 6382.7 6424.2 6492.0 3643.8 4188.5 4338.6 4344.0 4348.2 5594.4 5675.9 6795.9 6819.9 6843.3 4359.4 4389.8 4404.2 4411.4 4422.4 4254.1 4483.5 4486.5 4494.6 4498.1 4322.4 4440.5 5173.1 5238.4 5257.3 6468.6 6476.6 6500.9 6501.2 6515.6 1178.6 1509.7 1523.3 1554.9 1555.7 880.8 917.8 948.1 965.0 968.1 5158.4 5246.8 5854.7 5926.6 5929.8 5578.6 5849.9 6576.8 6577.1 6752.6 5817.9 6017.9 6020.2 6044.6 6046.4 3503.0 3519.5 3541.9 3546.0 3553.6 6315.8 6344.4 6466.2 6979.7 7003.0 6208.3 6774.3 6884.2 6905.6 6934.6 5778.4 6652.5 6961.4 6975.9 7015.8 5725.6 6350.2 6689.7 6701.3 6709.9 5529.1 6167.7 6186.4 6586.1 6640.3 5540.2 6637.8 6952.7 6993.6 7012.4 3637.5 4267.6 4296.0 4298.5 4299.2 5968.4 6339.7 6622.2 6720.8 6744.8 5926.7 6456.6 6523.6 6539.9 6553.2 6228.8 6468.9 6496.6 6499.2 6515.6 6021.2 6148.7 6241.8 6331.1 6334.7 6447.9 6457.5 6462.9 6464.4 6484.2 5563.8 6101.7 6346.3 6358.2 6384.8 07:07:29 INFO - PROCESS | 1666 | 07:07:29 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:17434.83 Median:29648.35 stddev:23635.98 (79.7%) stddev-sans-first:23668.65 07:07:29 INFO - PROCESS | 1666 | Values: 642.0 721.3 753.2 764.6 768.5 15161.2 15418.8 16574.5 17291.7 17307.4 15730.0 15819.4 15897.1 15931.8 15938.8 725.7 916.0 926.5 927.3 928.9 745.5 884.3 918.8 918.8 921.2 963.9 964.5 968.1 968.9 969.1 757.0 779.9 957.6 959.6 962.3 580.3 582.1 697.8 718.3 721.2 14706.4 14749.3 14752.9 14767.0 14778.6 12742.2 12859.7 12961.3 13226.7 13227.3 10013.5 10019.1 10243.3 10552.4 10687.6 3476.7 3523.0 3559.6 3561.2 3599.4 74762.0 75631.6 75908.6 75911.6 76680.2 9660.5 9751.9 9753.2 10054.5 10241.1 22477.7 22498.8 22507.1 22527.8 22533.9 7478.4 7554.8 7696.9 7716.0 7892.3 4073.3 4125.2 4131.4 4140.2 4141.4 3534.9 3631.5 3644.8 3648.3 3653.6 628.6 644.7 648.2 655.2 656.5 562.5 574.9 593.1 593.6 607.6 6249.3 7550.6 7630.8 7830.6 7933.1 532.3 548.6 553.1 586.9 590.7 3500.6 3846.2 3852.0 4044.4 4094.7 75668.0 80041.2 84788.0 85364.6 85412.7 77249.8 77798.0 78202.4 78599.0 78966.8 57813.7 59541.7 64105.7 64217.4 68042.3 7247.9 7825.6 7905.5 8056.9 8096.2 38102.6 43503.6 43734.0 43847.5 44975.0 58706.0 59080.7 63444.7 63633.7 63884.0 9128.5 10663.7 10864.5 10949.8 11391.8 11873.7 11885.3 11906.6 11948.6 12455.5 11398.3 11435.9 11769.4 11782.7 12001.8 11569.3 11618.2 11626.2 11736.8 11881.2 11185.8 11210.0 11269.4 11380.5 11549.4 9534.8 9597.7 9665.0 9724.8 9978.7 9238.4 9576.9 9653.1 9667.9 9731.1 07:07:29 INFO - PROCESS | 1666 | -------- Summary: end -------- 07:07:29 INFO - PROCESS | 1666 | 07:07:30 INFO - TEST-INFO | 1666: exit 0 07:07:30 INFO - TEST-OK | dromaeo_css | took 1114273ms 07:07:30 INFO - TEST-START | kraken 07:07:30 INFO - operating with platform_type : mac_ 07:07:30 INFO - Initialising browser for kraken test... 07:07:30 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmpTjouYV/profile http://localhost:49270/getInfo.html) 07:07:32 INFO - PROCESS | 1675 | __metrics Screen width/height:1600/1200 07:07:32 INFO - PROCESS | 1675 | colorDepth:24 07:07:32 INFO - PROCESS | 1675 | Browser inner width/height: 1024/689 07:07:32 INFO - PROCESS | 1675 | __metrics 07:07:32 INFO - PROCESS | 1675 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:07:32 ERROR - PROCESS | 1675 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:07:33 INFO - TEST-INFO | 1675: exit 0 07:07:33 INFO - Browser initialized. 07:07:33 INFO - Running cycle 1/1 for kraken test... 07:07:33 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/tmpTjouYV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:45 INFO - PROCESS | 1677 | RSS: Main: 237920256 07:07:45 INFO - PROCESS | 1677 | 07:07:48 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 07:07:48 INFO - PROCESS | 1677 | RSS: Main: 285478912 07:07:48 INFO - PROCESS | 1677 | 07:07:51 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 07:07:52 INFO - PROCESS | 1677 | RSS: Main: 299208704 07:07:52 INFO - PROCESS | 1677 | 07:07:55 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 07:07:56 INFO - PROCESS | 1677 | RSS: Main: 384114688 07:07:56 INFO - PROCESS | 1677 | 07:07:58 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 07:07:58 INFO - PROCESS | 1677 | RSS: Main: 286298112 07:07:58 INFO - PROCESS | 1677 | 07:08:01 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:08:01 INFO - PROCESS | 1677 | RSS: Main: 291024896 07:08:01 INFO - PROCESS | 1677 | 07:08:04 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 07:08:04 INFO - PROCESS | 1677 | RSS: Main: 327610368 07:08:04 INFO - PROCESS | 1677 | 07:08:07 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 07:08:08 INFO - PROCESS | 1677 | RSS: Main: 327266304 07:08:08 INFO - PROCESS | 1677 | 07:08:11 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 07:08:11 INFO - PROCESS | 1677 | RSS: Main: 327094272 07:08:11 INFO - PROCESS | 1677 | 07:08:13 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:08:13 INFO - PROCESS | 1677 | RSS: Main: 319922176 07:08:13 INFO - PROCESS | 1677 | 07:08:15 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:08:16 INFO - PROCESS | 1677 | RSS: Main: 326991872 07:08:16 INFO - PROCESS | 1677 | 07:08:18 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:08:19 INFO - PROCESS | 1677 | RSS: Main: 329826304 07:08:19 INFO - PROCESS | 1677 | 07:08:21 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:08:22 INFO - PROCESS | 1677 | RSS: Main: 334450688 07:08:22 INFO - PROCESS | 1677 | 07:08:25 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:08:26 INFO - PROCESS | 1677 | RSS: Main: 332374016 07:08:26 INFO - PROCESS | 1677 | 07:08:27 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 07:08:28 INFO - PROCESS | 1677 | RSS: Main: 396169216 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | __start_tp_report 07:08:28 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 07:08:28 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 07:08:28 INFO - PROCESS | 1677 | |i|pagename|runs| 07:08:28 INFO - PROCESS | 1677 | |0;ai-astar;113;111;113;112;114;115;120;112;113;113 07:08:28 INFO - PROCESS | 1677 | |1;audio-beat-detection;157;126;136;166;119;140;139;118;169;121 07:08:28 INFO - PROCESS | 1677 | |2;audio-dft;185;186;187;184;185;184;181;184;184;187 07:08:28 INFO - PROCESS | 1677 | |3;audio-fft;80;73;87;92;74;82;81;98;85;56 07:08:28 INFO - PROCESS | 1677 | |4;audio-oscillator;97;99;133;79;76;77;123;80;77;123 07:08:28 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;89;86;87;85;87;84;88;85;87;85 07:08:28 INFO - PROCESS | 1677 | |6;imaging-darkroom;93;93;93;94;93;92;94;93;93;93 07:08:28 INFO - PROCESS | 1677 | |7;imaging-desaturate;85;86;85;86;86;86;86;87;84;85 07:08:28 INFO - PROCESS | 1677 | |8;json-parse-financial;53;56;53;54;55;54;54;73;56;53 07:08:28 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;64;70;80;76;73;69;68;68;68;68 07:08:28 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;86;89;86;87;85;85;86;84;86;83 07:08:28 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;144;145;143;144;145;153;140;140;181;143 07:08:28 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;170;172;169;181;170;169;168;168;173;166 07:08:28 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;68;67;69;67;70;67;68;68;66;67 07:08:28 INFO - PROCESS | 1677 | __end_tp_report 07:08:28 INFO - PROCESS | 1677 | __start_cc_report 07:08:28 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1893 07:08:28 INFO - PROCESS | 1677 | __end_cc_report 07:08:28 INFO - PROCESS | 1677 | __startTimestamp1460470108022__endTimestamp 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | ------- Summary: start ------- 07:08:28 INFO - PROCESS | 1677 | Number of tests: 14 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:113.60 Median:113.00 stddev:2.50 (2.2%) stddev-sans-first:2.65 07:08:28 INFO - PROCESS | 1677 | Values: 113.0 111.0 113.0 112.0 114.0 115.0 120.0 112.0 113.0 113.0 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:139.50 stddev:19.14 (13.7%) stddev-sans-first:19.17 07:08:28 INFO - PROCESS | 1677 | Values: 157.0 126.0 136.0 166.0 119.0 140.0 139.0 118.0 169.0 121.0 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.00 stddev:1.77 (1.0%) stddev-sans-first:1.87 07:08:28 INFO - PROCESS | 1677 | Values: 185.0 186.0 187.0 184.0 185.0 184.0 181.0 184.0 184.0 187.0 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:80.80 Median:83.50 stddev:11.55 (13.8%) stddev-sans-first:12.25 07:08:28 INFO - PROCESS | 1677 | Values: 80.0 73.0 87.0 92.0 74.0 82.0 81.0 98.0 85.0 56.0 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:96.40 Median:78.00 stddev:22.37 (28.7%) stddev-sans-first:23.72 07:08:28 INFO - PROCESS | 1677 | Values: 97.0 99.0 133.0 79.0 76.0 77.0 123.0 80.0 77.0 123.0 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.00 stddev:1.57 (1.8%) stddev-sans-first:1.32 07:08:28 INFO - PROCESS | 1677 | Values: 89.0 86.0 87.0 85.0 87.0 84.0 88.0 85.0 87.0 85.0 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 07:08:28 INFO - PROCESS | 1677 | Values: 93.0 93.0 93.0 94.0 93.0 92.0 94.0 93.0 93.0 93.0 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:0.84 (1.0%) stddev-sans-first:0.87 07:08:28 INFO - PROCESS | 1677 | Values: 85.0 86.0 85.0 86.0 86.0 86.0 86.0 87.0 84.0 85.0 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:54.50 stddev:6.05 (11.1%) stddev-sans-first:6.31 07:08:28 INFO - PROCESS | 1677 | Values: 53.0 56.0 53.0 54.0 55.0 54.0 54.0 73.0 56.0 53.0 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:69.50 stddev:4.67 (6.7%) stddev-sans-first:4.34 07:08:28 INFO - PROCESS | 1677 | Values: 64.0 70.0 80.0 76.0 73.0 69.0 68.0 68.0 68.0 68.0 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:1.64 (1.9%) stddev-sans-first:1.73 07:08:28 INFO - PROCESS | 1677 | Values: 86.0 89.0 86.0 87.0 85.0 85.0 86.0 84.0 86.0 83.0 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:147.80 Median:144.50 stddev:12.21 (8.4%) stddev-sans-first:12.87 07:08:28 INFO - PROCESS | 1677 | Values: 144.0 145.0 143.0 144.0 145.0 153.0 140.0 140.0 181.0 143.0 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:170.00 stddev:4.17 (2.5%) stddev-sans-first:4.42 07:08:28 INFO - PROCESS | 1677 | Values: 170.0 172.0 169.0 181.0 170.0 169.0 168.0 168.0 173.0 166.0 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:1.16 (1.7%) stddev-sans-first:1.22 07:08:28 INFO - PROCESS | 1677 | Values: 68.0 67.0 69.0 67.0 70.0 67.0 68.0 68.0 66.0 67.0 07:08:28 INFO - PROCESS | 1677 | -------- Summary: end -------- 07:08:28 INFO - PROCESS | 1677 | 07:08:28 INFO - TEST-INFO | 1677: exit 0 07:08:28 INFO - TEST-OK | kraken | took 58337ms 07:08:28 INFO - SUITE-END | took 1172s 07:08:29 INFO - Completed test suite (00:19:33) 07:08:29 INFO - javascript benchmark 07:08:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3385.289089291249, 3456.879009234677, 3471.722262219022, 3477.895663130104, 3518.190816112294, 5564.304461942257, 5629.887402251952, 5696.0, 5709.4290570942885, 5718.199452076713, 5728.856778580527, 5776.451237132476, 5817.73820178092, 5896.941030589693, 5928.170056192126, 5097.362829646294, 5148.819791307305, 5188.455212202721, 5206.505381988705, 5302.337207849019, 5270.525652691257, 5273.314469119009, 5312.867178320535, 5344.839654810362, 5375.865603359908, 5121.615878809085, 5153.896922061538, 5208.817691380802, 5209.739513024371, 5241.3448318959745, 5210.140326846104, 5212.635115541913, 5218.399884013311, 5227.712475813829, 5235.528802407802, 5183.714895680736, 5197.558207552363, 5217.765200565984, 5244.921326180111, 5249.42256351801, 5458.153986132116, 5597.63615365, 5673.347565030033, 5719.828405147852, 5721.6853073080965, 6166.568340216187, 6183.81448556544, 6186.226721659793, 6196.473299769525, 6202.379762023762, 4071.9389209161886, 5991.981363168228, 6177.3822617738315, 6199.845003874894, 6204.87590248197, 5733.770649174028, 5794.797182098649, 5898.528117750569, 5906.8818623627285, 5908.970455147697, 6266.843328916813, 6276.372362763778, 6294.370562943761, 6303.36966303366, 6309.3690630936535, 5996.430339117776, 6172.783952561639, 6183.227096612924, 6185.443310102112, 6191.318954914956, 6153.169322141453, 6164.47601953839, 6245.437910588069, 6292.465140463112, 6297.4017468340435, 6131.816045518642, 6144.662043587646, 6191.25704915413, 6197.5351848611535, 6227.159333489921, 4882.5605695487575, 6234.906476402857, 6239.500839932794, 6250.218722659668, 6261.373862613702, 4893.6329775266995, 4906.656534042654, 4953.90092198154, 4960.330355401975, 4995.150824359867, 4386.824527018884, 4395.670324725658, 4397.252467080604, 4404.537523560044, 4420.756858372756, 5519.0, 5673.8297851064535, 5687.829365119053, 5687.943120568824, 5719.628224165416, 6158.507319414436, 6189.50483961282, 6191.19514463117, 6299.5275354348605, 6321.96839015802, 5663.915041274384, 5687.914681279784, 5695.40198279183, 5704.942950570441, 5731.799387021434, 5402.621816472809, 5418.485243901823, 5424.023675738326, 5432.158015507603, 5432.239486471897, 4834.661573689808, 5269.841904742864, 6130.795626845537, 6269.874602508015, 6307.590006649553, 6274.121622972696, 6289.622622642656, 6309.463695585743, 6310.432061114522, 6326.905096423466, 6277.403646653561, 6284.717187726655, 6335.4931605472375, 6338.651374174465, 6356.364363563606, 5994.850128746816, 6068.332483426908, 6081.179040829608, 6133.946794548555, 6170.7223174958135, 6234.15838861766, 6238.875222495615, 6264.68676566179, 6266.216722909637, 6274.247090349188, 6112.38876112403, 6114.755409783559, 6114.755409783559, 6121.479674227562, 6128.601640893327, 5746.2529871116485, 6012.338642749207, 6075.1798507200965, 6122.0, 6137.867325793431, 5969.3732158122775, 6018.3379828217985, 6019.187409699634, 6036.728347224298, 6052.969735151296, 6113.57204995646, 6135.049067394561, 6154.661493617894, 6163.137160797582, 6178.907316390348, 5868.23712917318, 5976.282846058501, 5984.401559844155, 5985.850353741192, 5986.281646202484], "value": 5679.056284289975, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.93928728552555, 528.5164074871492, 530.9469053094689, 578.4909279833746, 603.1164344235697, 29124.126276211722, 34300.79947201849, 37782.622173778254, 38267.42598861016, 38457.42313865287, 40986.79506602463, 41944.99999999993, 41979.37030944538, 42039.15921681564, 42124.368134478005, 8126.75619731406, 8679.522626255553, 9367.718968430958, 9575.904240957605, 9591.616335346613, 8523.786905327355, 8671.176238257356, 11305.321680699144, 11651.359175245358, 11659.183857130005, 11303.321800691943, 11399.316041037522, 11410.144239182053, 11414.029807466375, 11430.25703329281, 11448.313101213913, 11481.540738370455, 11513.769724605545, 11538.538458461651, 11539.423028848609, 11200.159988000933, 11215.551377944872, 11329.037031852302, 11342.432878356049, 11356.829647555292, 37418.25163496742, 37940.81029594862, 39612.80193599042, 39617.80191099055, 39639.80180099081, 3241.4117082629577, 3296.324253528045, 3378.0, 3417.214040770612, 3448.896533104011, 26609.46781064368, 29180.41639167226, 29522.014528038653, 29768.10695679133, 29973.0, 2498.7126480454617, 2747.8076534642582, 2771.0, 2821.2523681224493, 2862.298736809495, 462257.68871155765, 463022.0, 465890.0, 465910.0, 466771.0, 54173.72913135409, 63893.68053159704, 64579.677101614194, 65028.34971650223, 65063.67468162629, 66914.0, 67258.66370668115, 67329.0, 67379.0, 67402.32597674058, 16561.420350287925, 16795.99224046561, 16820.663586728442, 16823.074730889675, 16865.662686746196, 12942.935285323512, 13007.219566826021, 13018.414171362312, 13046.282454464907, 13056.608301750963, 17624.735628965576, 18479.44561663152, 18488.260469581335, 18492.72260916087, 18497.352592659194, 5432.076546987022, 5884.0585506318785, 5992.760289588455, 6211.859728349217, 6395.424411802867, 925.6852670092201, 975.2685485885586, 999.3011879804217, 1010.6563768318659, 1064.9520771565299, 28929.42141157165, 29029.12912612625, 29705.554416683768, 29719.108426747232, 29884.0, 962.8363178259713, 1071.0093163823433, 1077.3266708307308, 1141.6118519703175, 1165.2833507392893, 11456.713582160346, 13807.861921380858, 14948.850511494964, 15402.383904643688, 15441.922790385976, 574901.0, 583046.0, 583813.0, 584503.0, 585251.0, 58192.709036455395, 60000.69999650061, 60102.0, 60140.0, 60143.39856601466, 1215.8419405477232, 1254.9874501255053, 1318.1893135721655, 1320.5972178485463, 1448.9710205795825, 24190.51618967646, 29702.25744356322, 29806.850965745034, 30680.926167584028, 30788.69211307948, 47145.76427117842, 47462.0, 47992.760036199594, 48059.75970120127, 48127.27809082797, 403490.0, 406194.0, 406232.0, 406405.0, 406452.0, 23490.0, 25485.490290194462, 25846.870765646803, 26067.217983459766, 26678.866605666848, 42324.78837605792, 42650.0, 42929.78535107429, 43644.78177609092, 43768.0, 34322.97031089071, 35170.64829351776, 35295.470567942015, 36062.278754425286, 36340.81829590835, 35028.9491315261, 35088.82455587706, 35443.645563544036, 35816.0, 35897.0, 36027.81986090053, 36428.0, 36441.63558364382, 36712.81643591765, 36749.0, 26373.0, 32115.678843212205, 32291.0, 32662.0, 33728.98813035613, 24274.75725242725, 24600.630990535516, 24642.50714985726, 24791.793723318304, 24879.502409952063], "value": 19446.137866022305, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.6676391830861, 395.87332053742807, 399.60638770810766, 400.1796317549026, 409.1203911590083, 13777.793333100011, 19332.710009349852, 20245.0, 20342.593148137028, 20652.0, 16043.0, 17471.73792393112, 20087.598248035032, 20467.48831279219, 20517.48706282344, 5562.16567514873, 5847.444492773201, 5875.706214689249, 5877.617954832944, 5882.5588080893895, 5738.512226460756, 5755.165501002352, 5761.711914404284, 5803.158542011406, 5823.854403639901, 4077.143799802045, 4288.0, 4325.98339390243, 6064.3026052003925, 6442.581232219914, 6339.175907132043, 6418.646974416405, 6422.807315780534, 6433.646149461754, 6437.259715132773, 5412.648177868426, 5554.111342185231, 5593.944060559383, 5594.916076258859, 5599.104143337087, 24698.382540436633, 25159.874200629063, 25258.873705631537, 25535.23394298174, 25770.840312185996, 2067.7208576842086, 2115.175081718131, 2130.2544109561686, 2136.722226110596, 2198.604251234777, 13779.448822047107, 14522.419103235858, 14752.262386880613, 14764.630884227872, 14819.40722371104, 1527.618095476131, 1627.60123769676, 1716.2534297580467, 1756.7891852977596, 1765.2497688482472, 112682.87317126806, 116807.0, 117488.0, 120094.39952800267, 121228.0, 9847.409155450696, 10655.094316983143, 11456.59901903446, 11512.539498420138, 11621.0, 14834.92582537102, 14866.959312848214, 14889.404423823142, 14919.030263032868, 14938.775918361232, 8314.708985185489, 8502.574871256413, 8520.19058189471, 8589.398742087993, 8663.610137543825, 8332.208440198172, 8333.624986875606, 8350.582470876432, 8456.701886264362, 8460.746177614681, 4464.196444639931, 4539.16025535277, 4540.886477838015, 4599.931001034987, 4600.815967361335, 1479.3934486860335, 1675.2880025988907, 1934.8065193480538, 1977.0, 1983.2860170338668, 801.7234054251275, 936.5317341329335, 946.5220063867703, 949.6866034208695, 976.1263669016191, 19383.321583744502, 19876.304329348404, 20039.899800500905, 20056.598868022556, 20321.796782032285, 858.9785255368665, 943.217129782279, 951.8572214167792, 969.970900872975, 1028.4343611013912, 9763.707088787347, 10405.53175107122, 10537.15702743794, 10594.57621695139, 10608.0, 595349.0, 618035.0, 629489.0, 642505.0, 643280.0, 121262.39368803099, 123422.38288808678, 123687.0, 123975.0, 126785.0, 1002.0189934943485, 1004.7588578741049, 1021.070825548747, 1027.337367398024, 1027.6505987964129, 14170.858291416955, 16273.0, 17243.310267589157, 17572.472825815246, 17587.208575614382, 33982.0, 45940.77029614831, 49302.0, 51035.2344714837, 51193.0, 65130.674346627966, 69612.65193673999, 69786.60426791538, 69896.86612525412, 70868.0, 8047.718329858427, 8050.758477245692, 8080.393970452122, 8153.388495862952, 8445.324374050184, 10543.367397956146, 10983.0, 11475.885241147816, 11908.404579770804, 12550.1842380245, 5656.519195868397, 7381.557106573623, 10164.542595583069, 11008.779824403628, 11062.944685276521, 10537.578496860346, 10726.352188172106, 11053.28153670009, 11053.557857685924, 11273.71815704581, 11126.274062854653, 11243.55025798959, 11323.207375483636, 11616.361100139573, 11700.414979251174, 8032.759017229492, 8110.0, 8143.307818835466, 8212.794680133044, 8390.748277551684, 9415.717528474157, 11049.447527623748, 11071.889281107085, 11107.444627768418, 11237.662870113909], "value": 9355.701921751452, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1396.0646366934154, 1579.4629825859208, 1593.1237819199441, 1838.779346478423, 1967.1541237267968, 7813.0624325081, 8557.572121393929, 8802.779930501725, 8803.911960880398, 8824.294056475483, 8399.45403548769, 8627.180417860292, 8641.092685268051, 8650.697225597105, 8660.047394786585, 2119.565489074736, 2390.8445951013214, 2395.053953688288, 2430.5503481855912, 2481.2928315430104, 2478.8140889433366, 2509.887055082526, 2510.0, 2516.748325167487, 2517.5971844504884, 2092.403664955488, 2416.8791560421996, 2457.987710061447, 2459.6433517140003, 2469.76537228963, 2106.3470324199548, 2356.670066190735, 2437.049550675238, 2440.4021014851473, 2443.9755602443925, 2446.2294377271282, 2447.5839107351794, 2464.9753502465105, 2471.542764588539, 2472.7279999200073, 8596.441231320006, 8648.870266946002, 8670.696525621635, 8679.262262707614, 8679.696210632661, 5203.115470370046, 5400.702961337125, 5403.864903377408, 5414.269073675043, 5434.2935418395755, 2573.74262573743, 3383.2895092030703, 3564.803935783557, 3603.855845766166, 3666.0651533858963, 872.8472517309509, 1022.9539670714836, 1035.2287545778443, 1036.6630844975414, 1053.5785685725693, 11568.24806387582, 11597.188196826226, 11602.535898564047, 11706.941465292704, 11762.529498820037, 4662.230731929261, 4728.456227533878, 4834.250691142878, 4888.193448081027, 4889.682170658896, 8307.667693292322, 9917.504124793732, 9928.602855885829, 9955.850662240073, 9978.50322451638, 5404.594655400782, 5405.7837686492885, 5426.050441172779, 5432.483914028161, 5467.20725494809, 4419.801108950105, 4569.794359253841, 4601.378813860153, 4763.976180119146, 4974.77613507393, 3643.2531331077066, 3743.858123272428, 3955.5055618047745, 3997.8001099944886, 4029.5164580250557, 1338.9263590502421, 1340.6124660975843, 1345.8115863779078, 1348.7976803479557, 1352.4657760184673, 1327.6680829792551, 1332.1074879830537, 1349.966250843717, 1352.2562590575144, 1357.0839683213792, 7947.642356093989, 7970.242826931432, 7998.0, 8009.519428834172, 8052.074011488637, 487.5611949245636, 496.3299545613393, 497.6019184652264, 499.3383766509317, 501.4985014985015, 6200.100985357098, 6292.2134733158355, 6307.400796924285, 6313.55805093639, 6340.0, 9559.90440095604, 9972.152367048737, 10256.794864102825, 10761.139108871428, 10783.946080269705, 10485.895141048491, 10593.84109238362, 10632.893671063344, 10678.1991350649, 10833.945830270799, 8018.358531317481, 8078.071021832447, 8083.232092951161, 8098.919010809935, 8163.469374490639, 7707.499012564165, 7916.4062695299235, 7950.960245198737, 7952.204779522001, 7967.84064318722, 9710.368826026568, 9753.951230244087, 9769.75575610587, 9827.852582211415, 9985.800283994426, 8656.350773692124, 9782.217422606316, 10239.283250172417, 10243.282970192015, 10253.948730256301, 7345.1553071397475, 7348.742794002184, 7375.0, 7418.851622967619, 7418.998435211178, 8038.718644847402, 8041.718539851077, 8118.75643730689, 8118.75643730689, 8131.308838748772, 7128.714851405885, 7302.19675835647, 7355.080614923135, 7410.888836667346, 7444.330010299099, 7054.964725176546, 7153.892691609526, 7209.71161153548, 7276.345128938421, 7390.5196162249285, 7614.505057171266, 7671.2712292332135, 7680.846383072419, 7693.615319233904, 7699.9990001299475, 6849.075374824534, 6923.342282483156, 6993.19578248508, 6998.020277161099, 7006.754763583454, 6013.669248191217, 7067.399271061811, 7098.893516597358, 7101.7159313628945, 7116.323949224816], "value": 4783.082509535981, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.5663041632963, 322.3874638187444, 328.1075474708791, 328.27451332555046, 333.9916502087448, 4698.966227429968, 5331.0, 5780.855478613037, 6065.6032621731865, 6110.450059494639, 5187.821115131645, 5660.575456840733, 5748.425157484249, 6017.247844019497, 6050.334463209055, 4267.722598031133, 4366.345048242773, 4418.845340413086, 4590.632749380042, 4609.1473077480605, 3792.374258247386, 4550.907782132281, 4559.2249317615915, 4560.179167749804, 4590.495045544987, 4539.614132798716, 4544.750038747868, 4558.361829343895, 4563.589276965073, 4586.4266966629175, 4279.315309550457, 4279.550647182048, 4538.682292239545, 4564.5435456454425, 4566.566176213288, 3240.562524059269, 3888.8250028748776, 3903.082775547744, 3912.784796836173, 3927.9410808837893, 4537.546245375469, 5763.991301522259, 5781.364049954502, 5797.811448653016, 5804.2744656917885, 4626.421697287839, 5020.698758074527, 5080.74596270185, 5258.55302299305, 5306.893862122736, 5833.774907269479, 6321.336259692712, 6382.744690212386, 6424.229092508882, 6492.0, 3643.8360273787744, 4188.518320393133, 4338.6095251427205, 4344.0008797976325, 4348.195583816972, 5594.440555944454, 5675.886482270373, 6795.864082718367, 6819.863602727967, 6843.349881761224, 4359.411479450234, 4389.770864158041, 4404.229259879508, 4411.382406463098, 4422.380866678667, 4254.106637606137, 4483.461984561874, 4486.484054333728, 4494.617957473652, 4498.100379924028, 4322.3516472528745, 4440.533743956903, 5173.146430838945, 5238.449962753856, 5257.263983042377, 6468.6442245676935, 6476.6114033158165, 6500.9349906501275, 6501.219853617502, 6515.609063456208, 1178.63462326679, 1509.6678730679232, 1523.3221216558748, 1554.85228903254, 1555.688862227559, 880.7709995401113, 917.7705573606598, 948.0661548374845, 964.9903500965041, 968.138356862393, 5158.4067832199025, 5246.76389562463, 5854.736536855852, 5926.621825559389, 5929.822105336847, 5578.553715702734, 5849.912251316234, 6576.8355791105605, 6577.14497115372, 6752.62860542665, 5817.94182058174, 6017.909731354033, 6020.21392992572, 6044.607100538539, 6046.395360464006, 3503.0, 3519.51567947735, 3541.8583256669444, 3546.0, 3553.6446355364774, 6315.768425157142, 6344.397282258178, 6466.224053113562, 6979.651017449107, 7002.964985175042, 6208.255009398901, 6774.290283886485, 6884.208316043719, 6905.620190889449, 6934.583924964519, 5778.422157784188, 6652.534322597372, 6961.443084553325, 6975.8604827903155, 7015.789526314116, 5725.623866095524, 6350.206224221973, 6689.732410703517, 6701.296363881722, 6709.865802684017, 5529.06482731057, 6167.722452489738, 6186.370792413296, 6586.1438013059915, 6640.302768209269, 5540.204959602685, 6637.800865974028, 6952.687129079305, 6993.615351155735, 7012.4390048796995, 3637.472566477899, 4267.573242675708, 4296.0, 4298.485386049197, 4299.247631664509, 5968.373320801427, 6339.746410143543, 6622.238442578972, 6720.764773232913, 6744.831379215559, 5926.703664816828, 6456.612603243821, 6523.64119973406, 6539.869202616016, 6553.180852393451, 6228.813135605939, 6468.935310647022, 6496.642684652389, 6499.155109835691, 6515.641639709862, 6021.187139736079, 6148.661823599566, 6241.751649669994, 6331.113644089739, 6334.683265836782, 6447.871042579216, 6457.515686323639, 6462.903056454251, 6464.414234306127, 6484.211788930805, 5563.833085007456, 6101.725422356093, 6346.301906790157, 6358.205224346957, 6384.776532821515], "value": 4643.02681629768, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.9743210271589, 721.3399739238597, 753.2016062973253, 764.5680190692259, 768.4812751392808, 15161.241937903102, 15418.845811541882, 16574.502764917055, 17291.654166916687, 17307.39424120156, 15730.0, 15819.367225310974, 15897.1256580888, 15931.840681593181, 15938.840611593881, 725.713343229424, 915.9816803663939, 926.4719110107242, 927.3045216087934, 928.9024652411501, 745.4781652843004, 884.2837301785543, 918.7703074231442, 918.8116436130578, 921.1525396635112, 963.9277054220961, 964.479181242132, 968.1335204991528, 968.9079537443931, 969.1132613658494, 757.0385610274975, 779.9220077992212, 957.5834511987273, 959.5921733263335, 962.3311798300184, 580.3007376111775, 582.1006544888115, 697.7941507255372, 718.3140101203338, 721.1850608812061, 14706.411743530245, 14749.262536873113, 14752.926235368754, 14767.04014239071, 14778.556643300719, 12742.171758835646, 12859.742805143938, 12961.287129207889, 13226.73546529064, 13227.272500012496, 10013.549390277454, 10019.078768056706, 10243.28297019209, 10552.419616921066, 10687.625933092382, 3476.687098161178, 3522.982385088058, 3559.57285125784, 3561.216532362876, 3599.3881040222964, 74762.0, 75631.62184189043, 75908.62045689792, 75911.62044189744, 76680.23319766787, 9660.468674222986, 9751.853722194173, 9753.170980466597, 10054.497275136215, 10241.129503992244, 22477.662835057487, 22498.775012249997, 22507.099716011176, 22527.774722252896, 22533.88733056357, 7478.439117066242, 7554.773356799305, 7696.923030769733, 7716.0, 7892.289693927574, 4073.307537718595, 4125.154343359604, 4131.421600975866, 4140.171965606891, 4141.420201171838, 3534.8939531814085, 3631.5097461842843, 3644.817759112034, 3648.2703459308245, 3653.5615726113037, 628.5882746800853, 644.7421031587309, 648.2286079565303, 655.2071992888563, 656.494499235586, 562.521856422038, 574.8589050734289, 593.1162567774072, 593.6260156101629, 607.5838050935035, 6249.34381889895, 7550.622468876534, 7630.7710768677025, 7830.569318687413, 7933.127355990837, 532.3478738545251, 548.6077454619966, 553.1453903718764, 586.9207656966255, 590.6957916672917, 3500.6149323574386, 3846.1730727893078, 3851.9807400963377, 4044.3529035354204, 4094.733842300241, 75668.0, 80041.19958800338, 84788.0, 85364.57317713372, 85412.71880921791, 77249.84125238014, 77798.0, 78202.43595128065, 78599.0, 78966.81549776757, 57813.71093144507, 59541.70229148826, 64105.67947160234, 64217.35782642207, 68042.31957680458, 7247.91281307808, 7825.569593672402, 7905.486143400891, 8056.919430805617, 8096.190380961857, 38102.61897381102, 43503.56496434995, 43734.0, 43847.465338712995, 44975.0, 58706.0, 59080.704596476746, 63444.682776585825, 63633.68183159055, 63884.0, 9128.543572821465, 10663.733406664895, 10864.487142530554, 10949.781004379709, 11391.829122563002, 11873.703157420789, 11885.346305953255, 11906.642800715992, 11948.581799636971, 12455.501779929064, 11398.259113157617, 11435.885641143483, 11769.35268560203, 11782.705432364259, 12001.81997270059, 11569.305841649528, 11618.244814087057, 11626.186166968231, 11736.823947640622, 11881.227720198505, 11185.832212516982, 11210.0, 11269.411384699612, 11380.54477820878, 11549.422528873354, 9534.809303814023, 9597.664081757104, 9664.951675241578, 9724.805503889742, 9978.700638980843, 9238.353315267866, 9576.904230957602, 9653.082957119062, 9667.854982175133, 9731.075547822946], "value": 6823.902311665252, "unit": "score"}], "name": "dromaeo_css", "value": 7341.661221195532, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 113.0, 112.0, 114.0, 115.0, 120.0, 112.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 126.0, 136.0, 166.0, 119.0, 140.0, 139.0, 118.0, 169.0, 121.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 186.0, 187.0, 184.0, 185.0, 184.0, 181.0, 184.0, 184.0, 187.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 73.0, 87.0, 92.0, 74.0, 82.0, 81.0, 98.0, 85.0, 56.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 99.0, 133.0, 79.0, 76.0, 77.0, 123.0, 80.0, 77.0, 123.0], "value": 96.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 87.0, 85.0, 87.0, 84.0, 88.0, 85.0, 87.0, 85.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 93.0, 94.0, 93.0, 92.0, 94.0, 93.0, 93.0, 93.0], "value": 93.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 86.0, 86.0, 86.0, 86.0, 87.0, 84.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 53.0, 54.0, 55.0, 54.0, 54.0, 73.0, 56.0, 53.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 80.0, 76.0, 73.0, 69.0, 68.0, 68.0, 68.0, 68.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 89.0, 86.0, 87.0, 85.0, 85.0, 86.0, 84.0, 86.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 143.0, 144.0, 145.0, 153.0, 140.0, 140.0, 181.0, 143.0], "value": 147.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 169.0, 181.0, 170.0, 169.0, 168.0, 168.0, 173.0, 166.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 69.0, 67.0, 70.0, 67.0, 68.0, 68.0, 66.0, 67.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1477.8999999999999, "alertThreshold": 2.0}]} 07:08:29 INFO - Return code: 0 07:08:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:08:29 ERROR - # TBPL SUCCESS # 07:08:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:08:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:08:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:08:29 INFO - 2016-04-12 07:08:29.339 screenresolution[1681:9938] starting screenresolution argv=screenresolution get 07:08:29 INFO - 2016-04-12 07:08:29.342 screenresolution[1681:9938] Display 0: 1600x1200x32@60 07:08:29 INFO - 2016-04-12 07:08:29.348 screenresolution[1682:9941] starting screenresolution argv=screenresolution list 07:08:29 INFO - Available Modes on Display 0 07:08:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:08:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:08:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:08:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:08:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:08:29 INFO - Intel Iris: 07:08:29 INFO - Chipset Model: Intel Iris 07:08:29 INFO - Type: GPU 07:08:29 INFO - Bus: Built-In 07:08:29 INFO - VRAM (Dynamic, Max): 1536 MB 07:08:29 INFO - Vendor: Intel (0x8086) 07:08:29 INFO - Device ID: 0x0a2e 07:08:29 INFO - Revision ID: 0x0009 07:08:29 INFO - Displays: 07:08:29 INFO - Display: 07:08:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:08:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:08:29 INFO - Display Serial Number: 1600x1200 60 07:08:29 INFO - Main Display: Yes 07:08:29 INFO - Mirror: Off 07:08:29 INFO - Online: Yes 07:08:29 INFO - Rotation: Supported 07:08:29 INFO - Return code: 0 07:08:29 INFO - Running post-action listener: _resource_record_post_action 07:08:29 INFO - Running post-run listener: _resource_record_post_run 07:08:30 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 37590528; Write bytes: 694098944; Read time: 392; Write time: 2043 07:08:30 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 390396416; Write bytes: 383350784; Read time: 28683; Write time: 771 07:08:30 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 35730944; Write bytes: 297460736; Read time: 369; Write time: 1240 07:08:30 INFO - Running post-run listener: _upload_blobber_files 07:08:30 INFO - Blob upload gear active. 07:08:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:08:30 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:08:30 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:08:30 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:08:31 INFO - (blobuploader) - INFO - Open directory for files ... 07:08:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:08:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:08:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:32 INFO - (blobuploader) - INFO - Done attempting. 07:08:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:08:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:08:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:33 INFO - (blobuploader) - INFO - Done attempting. 07:08:33 INFO - (blobuploader) - INFO - Iteration through files over. 07:08:33 INFO - Return code: 0 07:08:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:08:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:08:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/620201fbc175818aa80d18e665c2522af1ebb67c6b96034931d6c3e34301c8941c8385fd4c7014c6cf5281be1e51ff966ee8317618f6210fe61f7cbe00740049", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29f3960b565138b777ddb94e6fb1c6391ec40ddcf200402e39dbf61bc87c245a8b94e0663ee5cee82fcade744d7ec37cb62c234cbf5a426fc6a385f363734400"} 07:08:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:08:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:08:33 INFO - Contents: 07:08:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/620201fbc175818aa80d18e665c2522af1ebb67c6b96034931d6c3e34301c8941c8385fd4c7014c6cf5281be1e51ff966ee8317618f6210fe61f7cbe00740049", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29f3960b565138b777ddb94e6fb1c6391ec40ddcf200402e39dbf61bc87c245a8b94e0663ee5cee82fcade744d7ec37cb62c234cbf5a426fc6a385f363734400"} 07:08:33 INFO - Running post-run listener: copy_logs_to_upload_dir 07:08:33 INFO - Copying logs to upload dir... 07:08:33 INFO - mkdir: /builds/slave/test/build/upload/logs 07:08:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.925835 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-04-12 07:08:33.202745) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 07:08:33.206896) ========= 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.msXrZOpyE5/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.BLL4f0gT6L/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/620201fbc175818aa80d18e665c2522af1ebb67c6b96034931d6c3e34301c8941c8385fd4c7014c6cf5281be1e51ff966ee8317618f6210fe61f7cbe00740049", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29f3960b565138b777ddb94e6fb1c6391ec40ddcf200402e39dbf61bc87c245a8b94e0663ee5cee82fcade744d7ec37cb62c234cbf5a426fc6a385f363734400"} build_url:https://queue.taskcluster.net/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010915 build_url: 'https://queue.taskcluster.net/v1/task/a9wzpY4MRVeOf3PKqFA-kA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/620201fbc175818aa80d18e665c2522af1ebb67c6b96034931d6c3e34301c8941c8385fd4c7014c6cf5281be1e51ff966ee8317618f6210fe61f7cbe00740049", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/29f3960b565138b777ddb94e6fb1c6391ec40ddcf200402e39dbf61bc87c245a8b94e0663ee5cee82fcade744d7ec37cb62c234cbf5a426fc6a385f363734400"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 07:08:33.234275) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 07:08:33.234653) ========= 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.msXrZOpyE5/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.BLL4f0gT6L/Listeners TMPDIR=/var/folders/q3/qr1dz7h156sc9qr571g_8l4r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005059 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 07:08:33.283502) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 07:08:33.283875) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 07:08:33.284286) ========= ========= Total master_lag: 0.57 =========