builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0174 starttime: 1459982631.67 results: success (0) buildid: 20160406112610 builduid: 54e806c800bf4a1c8905f8c301e39873 revision: 55f0de142be46043246b18108299aebf2bd95a64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:51.674806) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:51.675230) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:51.675523) ========= 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.fC2x3yAfRT/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.lWWxxruTXe/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005741 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:51.735496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:51.735833) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:51.756220) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:51.756547) ========= 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.fC2x3yAfRT/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.lWWxxruTXe/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005062 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:51.804795) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:51.805095) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:51.805462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:51.805779) ========= 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.fC2x3yAfRT/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.lWWxxruTXe/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-06 15:43:51-- 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% 10.0M=0.001s 2016-04-06 15:43:51 (10.0 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.165423 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:51.994431) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:51.994758) ========= 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.fC2x3yAfRT/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.lWWxxruTXe/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.021027 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:52.047579) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-06 15:43:52.048350) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 55f0de142be46043246b18108299aebf2bd95a64 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 55f0de142be46043246b18108299aebf2bd95a64 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fC2x3yAfRT/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.lWWxxruTXe/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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-06 15:43:52,129 truncating revision to first 12 chars 2016-04-06 15:43:52,129 Setting DEBUG logging. 2016-04-06 15:43:52,129 attempt 1/10 2016-04-06 15:43:52,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/55f0de142be4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-06 15:43:53,551 unpacking tar archive at: fx-team-55f0de142be4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.671501 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-06 15:43:53.746983) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:53.747367) ========= echo 55f0de142be46043246b18108299aebf2bd95a64 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'55f0de142be46043246b18108299aebf2bd95a64'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fC2x3yAfRT/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.lWWxxruTXe/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 55f0de142be46043246b18108299aebf2bd95a64 program finished with exit code 0 elapsedTime=0.005059 script_repo_revision: '55f0de142be46043246b18108299aebf2bd95a64' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:53.799269) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:53.799636) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-06 15:43:54.026795) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-04-06 15:43:54.027170) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fC2x3yAfRT/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.lWWxxruTXe/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 15:43:54 INFO - MultiFileLogger online at 20160406 15:43:54 in /builds/slave/test 15:43:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:43:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:43:54 INFO - {'append_to_log': False, 15:43:54 INFO - 'base_work_dir': '/builds/slave/test', 15:43:54 INFO - 'blob_upload_branch': 'Fx-Team', 15:43:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:43:54 INFO - 'branch': 'Fx-Team', 15:43:54 INFO - 'buildbot_json_path': 'buildprops.json', 15:43:54 INFO - 'config_files': ('talos/mac_config.py',), 15:43:54 INFO - 'default_actions': ('clobber', 15:43:54 INFO - 'read-buildbot-config', 15:43:54 INFO - 'download-and-extract', 15:43:54 INFO - 'populate-webroot', 15:43:54 INFO - 'create-virtualenv', 15:43:54 INFO - 'install', 15:43:54 INFO - 'run-tests'), 15:43:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:43:54 INFO - 'download_minidump_stackwalk': True, 15:43:54 INFO - 'download_symbols': 'ondemand', 15:43:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:43:54 INFO - 'tooltool.py': '/tools/tooltool.py', 15:43:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:43:54 INFO - '/tools/misc-python/virtualenv.py')}, 15:43:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:43:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:43:54 INFO - 'installer_path': 'installer.exe', 15:43:54 INFO - 'log_level': 'info', 15:43:54 INFO - 'log_name': 'talos', 15:43:54 INFO - 'log_to_console': True, 15:43:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:43:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:43:54 INFO - 'opt_config_files': (), 15:43:54 INFO - 'pip_index': False, 15:43:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:43:54 INFO - 'cmd': ('bash', 15:43:54 INFO - '-c', 15:43:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:43:54 INFO - 'enabled': True, 15:43:54 INFO - 'halt_on_failure': False, 15:43:54 INFO - 'name': 'check_screen_resolution'},), 15:43:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:43:54 INFO - 'cmd': ('bash', 15:43:54 INFO - '-c', 15:43:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:43:54 INFO - 'enabled': True, 15:43:54 INFO - 'halt_on_failure': False, 15:43:54 INFO - 'name': 'check_screen_resolution'},), 15:43:54 INFO - 'run_cmd_checks_enabled': True, 15:43:54 INFO - 'sps_profile': False, 15:43:54 INFO - 'sps_profile_interval': 0, 15:43:54 INFO - 'suite': 'dromaeojs-e10s', 15:43:54 INFO - 'system_bits': '32', 15:43:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:43:54 INFO - 'title': 't-yosemite-r7-0174', 15:43:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:43:54 INFO - 'use_talos_json': True, 15:43:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:43:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:43:54 INFO - 'work_dir': 'build'} 15:43:54 INFO - ##### 15:43:54 INFO - ##### Running clobber step. 15:43:54 INFO - ##### 15:43:54 INFO - Running pre-action listener: _resource_record_pre_action 15:43:54 INFO - Running main action method: clobber 15:43:54 INFO - rmtree: /builds/slave/test/build 15:43:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:43:55 INFO - Running post-action listener: _resource_record_post_action 15:43:55 INFO - ##### 15:43:55 INFO - ##### Running read-buildbot-config step. 15:43:55 INFO - ##### 15:43:55 INFO - Running pre-action listener: _resource_record_pre_action 15:43:55 INFO - Running main action method: read_buildbot_config 15:43:55 INFO - Using buildbot properties: 15:43:55 INFO - { 15:43:55 INFO - "project": "", 15:43:55 INFO - "product": "firefox", 15:43:55 INFO - "script_repo_revision": "production", 15:43:55 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 15:43:55 INFO - "repository": "", 15:43:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 15:43:55 INFO - "buildid": "20160406112610", 15:43:55 INFO - "pgo_build": "False", 15:43:55 INFO - "basedir": "/builds/slave/test", 15:43:55 INFO - "buildnumber": 657, 15:43:55 INFO - "slavename": "t-yosemite-r7-0174", 15:43:55 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 15:43:55 INFO - "platform": "yosemite_r7", 15:43:55 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 15:43:55 INFO - "branch": "fx-team", 15:43:55 INFO - "repo_path": "integration/fx-team", 15:43:55 INFO - "revision": "55f0de142be46043246b18108299aebf2bd95a64", 15:43:55 INFO - "stage_platform": "macosx64", 15:43:55 INFO - "builduid": "54e806c800bf4a1c8905f8c301e39873", 15:43:55 INFO - "slavebuilddir": "test" 15:43:55 INFO - } 15:43:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 15:43:55 INFO - Running post-action listener: _resource_record_post_action 15:43:55 INFO - ##### 15:43:55 INFO - ##### Running download-and-extract step. 15:43:55 INFO - ##### 15:43:55 INFO - Running pre-action listener: _resource_record_pre_action 15:43:55 INFO - Running main action method: download_and_extract 15:43:55 INFO - mkdir: /builds/slave/test/build/tests 15:43:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:43:55 INFO - https://queue.taskcluster.net/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 15:43:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:43:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 15:43:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/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 15:43:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/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 15:43:57 INFO - Downloaded 1199 bytes. 15:43:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 15:43:57 INFO - Using the following test package requirements: 15:43:57 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:43:57 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:57 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 15:43:57 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:57 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 15:43:57 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:57 INFO - u'jsshell-mac.zip'], 15:43:57 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:57 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 15:43:57 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 15:43:57 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:57 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 15:43:57 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:57 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 15:43:57 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:57 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 15:43:57 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 15:43:57 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 15:43:57 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:43: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')]} 15:43:57 INFO - https://queue.taskcluster.net/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:43:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:43:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:43:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/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 15:43:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/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 15:44:07 INFO - Downloaded 17970719 bytes. 15:44:07 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'] 15:44:07 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 15:44:10 INFO - Return code: 0 15:44:10 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 15:44:10 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')]} 15:44:10 INFO - https://queue.taskcluster.net/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 15:44:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:44:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 15:44:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/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 15:44:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/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 15:44:22 INFO - Downloaded 17970719 bytes. 15:44:22 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'] 15:44:22 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 15:44:25 INFO - Return code: 0 15:44:25 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')]} 15:44:25 INFO - https://queue.taskcluster.net/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 15:44:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:44:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 15:44:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/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 15:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/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 15:44:34 INFO - Downloaded 10847617 bytes. 15:44:34 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'] 15:44:34 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 15:44:34 INFO - Return code: 0 15:44:34 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')]} 15:44:34 INFO - https://queue.taskcluster.net/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 15:44:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:44:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:44:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 15:44:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/K67dFzEKQp6t48T3zTf6kg/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 15:44:51 INFO - Downloaded 108918781 bytes. 15:44:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:44:51 INFO - mkdir: /builds/slave/test/properties 15:44:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:44:51 INFO - Writing to file /builds/slave/test/properties/build_url 15:44:51 INFO - Contents: 15:44:51 INFO - build_url:https://queue.taskcluster.net/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 15:44:52 INFO - Running post-action listener: _resource_record_post_action 15:44:52 INFO - Running post-action listener: set_extra_try_arguments 15:44:52 INFO - ##### 15:44:52 INFO - ##### Running populate-webroot step. 15:44:52 INFO - ##### 15:44:52 INFO - Running pre-action listener: _resource_record_pre_action 15:44:52 INFO - Running main action method: populate_webroot 15:44:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:44:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:44:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:44:52 INFO - '--tppagecycles', 15:44:52 INFO - '7'], 15:44:52 INFO - 'tests': ['tsvgm']}}, 15:44:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:44:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:44:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:44:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:44:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:44:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:44:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:52 INFO - 'talos_options': ['--disable-e10s'], 15:44:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:52 INFO - 'talos_options': ['--disable-e10s'], 15:44:52 INFO - 'tests': ['damp', 'tps']}, 15:44:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:52 INFO - 'tests': ['damp', 'tps']}, 15:44:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:44:52 INFO - 'tests': ['dromaeo_dom']}, 15:44:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:44:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:44:52 INFO - 'tests': ['a11yr', 15:44:52 INFO - 'ts_paint', 15:44:52 INFO - 'tpaint', 15:44:52 INFO - 'sessionrestore', 15:44:52 INFO - 'sessionrestore_no_auto_restore', 15:44:52 INFO - 'tabpaint']}, 15:44:52 INFO - 'other-e10s': {'tests': ['a11yr', 15:44:52 INFO - 'ts_paint', 15:44:52 INFO - 'tpaint', 15:44:52 INFO - 'sessionrestore', 15:44:52 INFO - 'sessionrestore_no_auto_restore', 15:44:52 INFO - 'tabpaint']}, 15:44:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:44:52 INFO - 'ts_paint', 15:44:52 INFO - 'tpaint', 15:44:52 INFO - 'sessionrestore', 15:44:52 INFO - 'sessionrestore_no_auto_restore', 15:44:52 INFO - 'tabpaint']}, 15:44:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:44:52 INFO - 'ts_paint', 15:44:52 INFO - 'tpaint', 15:44:52 INFO - 'sessionrestore', 15:44:52 INFO - 'sessionrestore_no_auto_restore', 15:44:52 INFO - 'tabpaint']}, 15:44:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:44:52 INFO - 'tests': ['a11yr', 15:44:52 INFO - 'ts_paint', 15:44:52 INFO - 'tpaint', 15:44:52 INFO - 'sessionrestore', 15:44:52 INFO - 'sessionrestore_no_auto_restore', 15:44:52 INFO - 'tabpaint']}, 15:44:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:44:52 INFO - 'tests': ['a11yr', 15:44:52 INFO - 'ts_paint', 15:44:52 INFO - 'tpaint', 15:44:52 INFO - 'sessionrestore', 15:44:52 INFO - 'sessionrestore_no_auto_restore', 15:44:52 INFO - 'tabpaint']}, 15:44:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:44:52 INFO - 'tests': ['tsvgx', 15:44:52 INFO - 'tsvgr_opacity', 15:44:52 INFO - 'tart', 15:44:52 INFO - 'tscrollx', 15:44:52 INFO - 'cart']}, 15:44:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:44:52 INFO - 'tsvgr_opacity', 15:44:52 INFO - 'tart', 15:44:52 INFO - 'tscrollx', 15:44:52 INFO - 'cart']}, 15:44:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:52 INFO - 'talos_options': ['--disable-e10s'], 15:44:52 INFO - 'tests': ['tp5o']}, 15:44:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:52 INFO - 'tests': ['tp5o']}, 15:44:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:52 INFO - 'talos_options': ['--disable-e10s', 15:44:52 INFO - '--xperf_path', 15:44:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:52 INFO - 'tests': ['tp5n']}, 15:44:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:52 INFO - 'talos_options': ['--xperf_path', 15:44:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:52 INFO - 'tests': ['tp5n']}}, 15:44:52 INFO - 'talos.zip': {'path': '', 15:44:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:44:52 INFO - Running post-action listener: _resource_record_post_action 15:44:52 INFO - ##### 15:44:52 INFO - ##### Running create-virtualenv step. 15:44:52 INFO - ##### 15:44:52 INFO - Running pre-action listener: _resource_record_pre_action 15:44:52 INFO - Running main action method: create_virtualenv 15:44:52 INFO - Creating virtualenv /builds/slave/test/build/venv 15:44:52 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 15:44:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:44:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:44:53 INFO - Using real prefix '/tools/python27' 15:44:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:44:53 INFO - Installing distribute.............................................................................................................................................................................................done. 15:44:56 INFO - Installing pip.................done. 15:44:56 INFO - Return code: 0 15:44:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:44:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103709420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad9b54afb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103598e00>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103593b20>, '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.fC2x3yAfRT/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.lWWxxruTXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 15:44:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:44:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:44:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fC2x3yAfRT/Render', 15:44:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:56 INFO - 'HOME': '/Users/cltbld', 15:44:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:56 INFO - 'LOGNAME': 'cltbld', 15:44:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:56 INFO - 'MOZ_NO_REMOTE': '1', 15:44:56 INFO - 'NO_EM_RESTART': '1', 15:44:56 INFO - 'PAGER': '/bin/cat', 15:44:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:56 INFO - 'PWD': '/builds/slave/test', 15:44:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:56 INFO - 'SHELL': '/bin/bash', 15:44:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWWxxruTXe/Listeners', 15:44:56 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:44:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:56 INFO - 'USER': 'cltbld', 15:44:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:56 INFO - 'XPC_FLAGS': '0x0', 15:44:56 INFO - 'XPC_SERVICE_NAME': '0', 15:44:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:56 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 15:44:56 INFO - Cleaning up... 15:44:57 INFO - Return code: 0 15:44:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:44: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')]} 15:44:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44: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')]} 15:44:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44: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', '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 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103709420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad9b54afb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103598e00>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103593b20>, '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.fC2x3yAfRT/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.lWWxxruTXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 15:44: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', 'psutil>=0.7.1'] in /builds/slave/test/build 15:44: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 psutil>=0.7.1 15:44:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fC2x3yAfRT/Render', 15:44:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:44:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:44:57 INFO - 'HOME': '/Users/cltbld', 15:44:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:44:57 INFO - 'LOGNAME': 'cltbld', 15:44:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:57 INFO - 'MOZ_NO_REMOTE': '1', 15:44:57 INFO - 'NO_EM_RESTART': '1', 15:44:57 INFO - 'PAGER': '/bin/cat', 15:44:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:44:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:57 INFO - 'PWD': '/builds/slave/test', 15:44:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:44:57 INFO - 'SHELL': '/bin/bash', 15:44:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWWxxruTXe/Listeners', 15:44:57 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:44:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:44:57 INFO - 'USER': 'cltbld', 15:44:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:44:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:44:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:57 INFO - 'XPC_FLAGS': '0x0', 15:44:57 INFO - 'XPC_SERVICE_NAME': '0', 15:44:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:44:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:57 INFO - Downloading/unpacking psutil>=0.7.1 15:44:57 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 15:44:57 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 15:44:57 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 15:44:57 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 15:44:57 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 15:44:57 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 15:45:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:45:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:00 INFO - Installing collected packages: psutil 15:45:00 INFO - Running setup.py install for psutil 15:45:00 INFO - building 'psutil._psutil_osx' extension 15:45:00 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 15:45:00 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 15:45:00 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 15:45:01 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 15:45:01 INFO - building 'psutil._psutil_posix' extension 15:45:01 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 15:45:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:45:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:45:01 INFO - ^ 15:45:01 INFO - 1 warning generated. 15:45:01 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 15:45:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:01 INFO - Successfully installed psutil 15:45:01 INFO - Cleaning up... 15:45:01 INFO - Return code: 0 15:45:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103709420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad9b54afb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103598e00>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103593b20>, '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.fC2x3yAfRT/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.lWWxxruTXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 15:45:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 15:45:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:45:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fC2x3yAfRT/Render', 15:45:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:01 INFO - 'HOME': '/Users/cltbld', 15:45:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:01 INFO - 'LOGNAME': 'cltbld', 15:45:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:01 INFO - 'MOZ_NO_REMOTE': '1', 15:45:01 INFO - 'NO_EM_RESTART': '1', 15:45:01 INFO - 'PAGER': '/bin/cat', 15:45:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:01 INFO - 'PWD': '/builds/slave/test', 15:45:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:01 INFO - 'SHELL': '/bin/bash', 15:45:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWWxxruTXe/Listeners', 15:45:01 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:45:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:01 INFO - 'USER': 'cltbld', 15:45:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:01 INFO - 'XPC_FLAGS': '0x0', 15:45:01 INFO - 'XPC_SERVICE_NAME': '0', 15:45:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:45:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:45:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:45:04 INFO - Installing collected packages: mozsystemmonitor 15:45:04 INFO - Running setup.py install for mozsystemmonitor 15:45:04 INFO - Successfully installed mozsystemmonitor 15:45:04 INFO - Cleaning up... 15:45:04 INFO - Return code: 0 15:45:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103709420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad9b54afb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103598e00>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103593b20>, '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.fC2x3yAfRT/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.lWWxxruTXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 15:45:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:45:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:45:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fC2x3yAfRT/Render', 15:45:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:04 INFO - 'HOME': '/Users/cltbld', 15:45:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:04 INFO - 'LOGNAME': 'cltbld', 15:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:04 INFO - 'MOZ_NO_REMOTE': '1', 15:45:04 INFO - 'NO_EM_RESTART': '1', 15:45:04 INFO - 'PAGER': '/bin/cat', 15:45:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:04 INFO - 'PWD': '/builds/slave/test', 15:45:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:04 INFO - 'SHELL': '/bin/bash', 15:45:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWWxxruTXe/Listeners', 15:45:04 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:45:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:04 INFO - 'USER': 'cltbld', 15:45:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:04 INFO - 'XPC_FLAGS': '0x0', 15:45:04 INFO - 'XPC_SERVICE_NAME': '0', 15:45:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:04 INFO - Downloading/unpacking blobuploader==1.2.4 15:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:07 INFO - Downloading blobuploader-1.2.4.tar.gz 15:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:45:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:45:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:08 INFO - Downloading docopt-0.6.1.tar.gz 15:45:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:45:08 INFO - Installing collected packages: blobuploader, requests, docopt 15:45:08 INFO - Running setup.py install for blobuploader 15:45:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:45:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:45:08 INFO - Running setup.py install for requests 15:45:09 INFO - Running setup.py install for docopt 15:45:09 INFO - Successfully installed blobuploader requests docopt 15:45:09 INFO - Cleaning up... 15:45:09 INFO - Return code: 0 15:45:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:09 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 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103709420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad9b54afb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103598e00>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103593b20>, '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.fC2x3yAfRT/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.lWWxxruTXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 15:45:09 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 15:45:09 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 15:45:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fC2x3yAfRT/Render', 15:45:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:09 INFO - 'HOME': '/Users/cltbld', 15:45:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:09 INFO - 'LOGNAME': 'cltbld', 15:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:09 INFO - 'MOZ_NO_REMOTE': '1', 15:45:09 INFO - 'NO_EM_RESTART': '1', 15:45:09 INFO - 'PAGER': '/bin/cat', 15:45:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:09 INFO - 'PWD': '/builds/slave/test', 15:45:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:09 INFO - 'SHELL': '/bin/bash', 15:45:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWWxxruTXe/Listeners', 15:45:09 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:45:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:09 INFO - 'USER': 'cltbld', 15:45:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:09 INFO - 'XPC_FLAGS': '0x0', 15:45:09 INFO - 'XPC_SERVICE_NAME': '0', 15:45:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:09 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-xnWzZv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:09 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-zlDtkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:09 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-zPpbCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:09 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-9GLxhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:09 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-gKflsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:10 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-gqftpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:10 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-UHeujz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:10 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-04vza5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:10 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-vDnYBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:10 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-RQ22KI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:10 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-v5qCSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:10 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-7JVon0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:10 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-bCvgIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:10 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-ANV5m8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:11 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-gkFpeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:11 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-V0Va3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:11 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-5JTJmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:45:11 INFO - Running setup.py install for manifestparser 15:45:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:45:11 INFO - Running setup.py install for mozcrash 15:45:11 INFO - Running setup.py install for mozdebug 15:45:11 INFO - Running setup.py install for mozdevice 15:45:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:45:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:45:11 INFO - Running setup.py install for mozfile 15:45:12 INFO - Running setup.py install for mozhttpd 15:45:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:45:12 INFO - Running setup.py install for mozinfo 15:45:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:45:12 INFO - Running setup.py install for mozInstall 15:45:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:45:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:45:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:45:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:45:12 INFO - Running setup.py install for mozleak 15:45:12 INFO - Running setup.py install for mozlog 15:45:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:45:12 INFO - Running setup.py install for moznetwork 15:45:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:45:12 INFO - Running setup.py install for mozprocess 15:45:13 INFO - Running setup.py install for mozprofile 15:45:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:45:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:45:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:45:13 INFO - Running setup.py install for mozrunner 15:45:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:45:13 INFO - Running setup.py install for mozscreenshot 15:45:13 INFO - Running setup.py install for moztest 15:45:13 INFO - Running setup.py install for mozversion 15:45:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:45:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:45:13 INFO - Cleaning up... 15:45:13 INFO - Return code: 0 15:45:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:13 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 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103709420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad9b54afb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103598e00>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103593b20>, '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.fC2x3yAfRT/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.lWWxxruTXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 15:45:13 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 15:45:13 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 15:45:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fC2x3yAfRT/Render', 15:45:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:13 INFO - 'HOME': '/Users/cltbld', 15:45:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:13 INFO - 'LOGNAME': 'cltbld', 15:45:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:13 INFO - 'MOZ_NO_REMOTE': '1', 15:45:13 INFO - 'NO_EM_RESTART': '1', 15:45:13 INFO - 'PAGER': '/bin/cat', 15:45:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:13 INFO - 'PWD': '/builds/slave/test', 15:45:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:13 INFO - 'SHELL': '/bin/bash', 15:45:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWWxxruTXe/Listeners', 15:45:13 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:45:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:13 INFO - 'USER': 'cltbld', 15:45:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:13 INFO - 'XPC_FLAGS': '0x0', 15:45:13 INFO - 'XPC_SERVICE_NAME': '0', 15:45:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:45:14 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-sFQFcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:45:14 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)) 15:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:45:14 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-o9_I98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:45:14 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)) 15:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:45:14 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-AMjwcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:45:14 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)) 15:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:45:14 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-gmIru5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:45:14 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)) 15:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:45:14 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-crFTc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:45:14 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)) 15:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:45:14 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-ZDC9zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:45:14 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)) 15:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:45:14 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-rgNsNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:45:14 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)) 15:45:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:45:14 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-m6q6Rv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:45:15 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)) 15:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:45:15 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-qGtFeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:45:15 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)) 15:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:45:15 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-Pna1h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:45:15 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)) 15:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:45:15 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-UabIa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:45:15 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)) 15:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:45:15 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-H0bjTx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:45:15 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)) 15:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:45:15 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-aJakdo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:45:15 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)) 15:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:45:15 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-eLdxDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:45:15 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)) 15:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:15 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-TDKn_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:45:15 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)) 15:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:45:15 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-IT2kjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:45:15 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)) 15:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:45:15 INFO - Running setup.py (path:/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/pip-65l0Y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:45:16 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)) 15:45:16 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)) 15:45:16 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)) 15:45:16 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)) 15:45:16 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)) 15:45:16 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)) 15:45:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45:18 INFO - Downloading blessings-1.6.tar.gz 15:45:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:45:18 INFO - Installing collected packages: blessings 15:45:18 INFO - Running setup.py install for blessings 15:45:18 INFO - Successfully installed blessings 15:45:18 INFO - Cleaning up... 15:45:18 INFO - Return code: 0 15:45:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:45:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:45:19 INFO - Reading from file tmpfile_stdout 15:45:19 INFO - Current package versions: 15:45:19 INFO - blessings == 1.6 15:45:19 INFO - blobuploader == 1.2.4 15:45:19 INFO - docopt == 0.6.1 15:45:19 INFO - manifestparser == 1.1 15:45:19 INFO - mozInstall == 1.12 15:45:19 INFO - mozcrash == 0.17 15:45:19 INFO - mozdebug == 0.1 15:45:19 INFO - mozdevice == 0.48 15:45:19 INFO - mozfile == 1.2 15:45:19 INFO - mozhttpd == 0.7 15:45:19 INFO - mozinfo == 0.9 15:45:19 INFO - mozleak == 0.1 15:45:19 INFO - mozlog == 3.1 15:45:19 INFO - moznetwork == 0.27 15:45:19 INFO - mozprocess == 0.22 15:45:19 INFO - mozprofile == 0.28 15:45:19 INFO - mozrunner == 6.11 15:45:19 INFO - mozscreenshot == 0.1 15:45:19 INFO - mozsystemmonitor == 0.0 15:45:19 INFO - moztest == 0.7 15:45:19 INFO - mozversion == 1.4 15:45:19 INFO - psutil == 3.1.1 15:45:19 INFO - requests == 1.2.3 15:45:19 INFO - wsgiref == 0.1.2 15:45:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:45:19 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')]} 15:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:19 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')]} 15:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:19 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 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103709420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad9b54afb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103598e00>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103593b20>, '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.fC2x3yAfRT/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.lWWxxruTXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 15:45:19 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 15:45:19 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 15:45:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fC2x3yAfRT/Render', 15:45:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:19 INFO - 'HOME': '/Users/cltbld', 15:45:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:19 INFO - 'LOGNAME': 'cltbld', 15:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:19 INFO - 'MOZ_NO_REMOTE': '1', 15:45:19 INFO - 'NO_EM_RESTART': '1', 15:45:19 INFO - 'PAGER': '/bin/cat', 15:45:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:19 INFO - 'PWD': '/builds/slave/test', 15:45:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:19 INFO - 'SHELL': '/bin/bash', 15:45:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWWxxruTXe/Listeners', 15:45:19 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:45:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:19 INFO - 'USER': 'cltbld', 15:45:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:19 INFO - 'XPC_FLAGS': '0x0', 15:45:19 INFO - 'XPC_SERVICE_NAME': '0', 15:45:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 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)) 15:45:19 INFO - Cleaning up... 15:45:19 INFO - Return code: 0 15:45:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:45:19 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')]} 15:45:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:19 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')]} 15:45:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:19 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 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103709420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad9b54afb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103598e00>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103593b20>, '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.fC2x3yAfRT/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.lWWxxruTXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 15:45:19 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 15:45:19 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 15:45:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fC2x3yAfRT/Render', 15:45:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:19 INFO - 'HOME': '/Users/cltbld', 15:45:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:19 INFO - 'LOGNAME': 'cltbld', 15:45:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:19 INFO - 'MOZ_NO_REMOTE': '1', 15:45:19 INFO - 'NO_EM_RESTART': '1', 15:45:19 INFO - 'PAGER': '/bin/cat', 15:45:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:19 INFO - 'PWD': '/builds/slave/test', 15:45:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:19 INFO - 'SHELL': '/bin/bash', 15:45:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWWxxruTXe/Listeners', 15:45:19 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:45:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:19 INFO - 'USER': 'cltbld', 15:45:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:19 INFO - 'XPC_FLAGS': '0x0', 15:45:19 INFO - 'XPC_SERVICE_NAME': '0', 15:45:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:19 INFO - Downloading/unpacking jsonschema 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45: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 15:45:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:45:22 INFO - Downloading/unpacking functools32 (from jsonschema) 15:45:22 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 15:45:22 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 15:45:22 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 15:45:22 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 15:45:22 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 15:45:22 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 15:45:22 INFO - Downloading functools32-3.2.3-2.tar.gz 15:45:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:45:22 INFO - warning: no files found matching '*.txt' 15:45:22 INFO - no previously-included directories found matching 'build' 15:45:22 INFO - no previously-included directories found matching 'dist' 15:45:22 INFO - no previously-included directories found matching '.git*' 15:45:22 INFO - Installing collected packages: jsonschema, functools32 15:45:22 INFO - Running setup.py install for functools32 15:45:22 INFO - warning: no files found matching '*.txt' 15:45:22 INFO - no previously-included directories found matching 'build' 15:45:22 INFO - no previously-included directories found matching 'dist' 15:45:22 INFO - no previously-included directories found matching '.git*' 15:45:22 INFO - Successfully installed jsonschema functools32 15:45:22 INFO - Cleaning up... 15:45:22 INFO - Return code: 0 15:45:22 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:45:22 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')]} 15:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:22 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')]} 15:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:22 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 0x1036f9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103709420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fad9b54afb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103598e00>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103593b20>, '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.fC2x3yAfRT/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.lWWxxruTXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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 15:45:22 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 15:45:22 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 15:45:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fC2x3yAfRT/Render', 15:45:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:45:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:45:22 INFO - 'HOME': '/Users/cltbld', 15:45:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:45:22 INFO - 'LOGNAME': 'cltbld', 15:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:22 INFO - 'MOZ_NO_REMOTE': '1', 15:45:22 INFO - 'NO_EM_RESTART': '1', 15:45:22 INFO - 'PAGER': '/bin/cat', 15:45:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:22 INFO - 'PWD': '/builds/slave/test', 15:45:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:45:22 INFO - 'SHELL': '/bin/bash', 15:45:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWWxxruTXe/Listeners', 15:45:22 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:45:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:45:22 INFO - 'USER': 'cltbld', 15:45:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:45:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:22 INFO - 'XPC_FLAGS': '0x0', 15:45:22 INFO - 'XPC_SERVICE_NAME': '0', 15:45:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:45:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:23 INFO - Downloading/unpacking flake8 15:45:23 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 15:45:23 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 15:45:23 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 15:45:23 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 15:45:23 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 15:45:23 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 15:45:25 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:45:25 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:45:25 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 15:45:25 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 15:45:25 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 15:45:25 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 15:45:25 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 15:45:25 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 15:45:25 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:45:25 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:45:25 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 15:45:25 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 15:45:25 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 15:45:25 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 15:45:25 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 15:45:25 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 15:45:26 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:45:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:45:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:45:26 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:45:26 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:45:26 INFO - no previously-included directories found matching 'docs/_build' 15:45:26 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:45:26 INFO - Running setup.py install for pep8 15:45:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:45:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:45:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:45:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:45:27 INFO - no previously-included directories found matching 'docs/_build' 15:45:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:45:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:45:27 INFO - Cleaning up... 15:45:27 INFO - Return code: 0 15:45:27 INFO - Running post-action listener: _resource_record_post_action 15:45:27 INFO - Running post-action listener: _start_resource_monitoring 15:45:27 INFO - Starting resource monitoring. 15:45:27 INFO - ##### 15:45:27 INFO - ##### Running install step. 15:45:27 INFO - ##### 15:45:27 INFO - Running pre-action listener: _resource_record_pre_action 15:45:27 INFO - Running main action method: install 15:45:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:45:27 INFO - Reading from file tmpfile_stdout 15:45:27 INFO - Detecting whether we're running mozinstall >=1.0... 15:45:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:45:27 INFO - Reading from file tmpfile_stdout 15:45:27 INFO - Output received: 15:45:27 INFO - Usage: mozinstall [options] installer 15:45:27 INFO - Options: 15:45:27 INFO - -h, --help show this help message and exit 15:45:27 INFO - -d DEST, --destination=DEST 15:45:27 INFO - Directory to install application into. [default: 15:45:27 INFO - "/builds/slave/test"] 15:45:27 INFO - --app=APP Application being installed. [default: firefox] 15:45:27 INFO - mkdir: /builds/slave/test/build/application 15:45:27 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'] 15:45:27 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 15:46:00 INFO - Reading from file tmpfile_stdout 15:46:00 INFO - Output received: 15:46:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:46:00 INFO - Running post-action listener: _resource_record_post_action 15:46:00 INFO - ##### 15:46:00 INFO - ##### Running run-tests step. 15:46:00 INFO - ##### 15:46:00 INFO - Running pre-action listener: _resource_record_pre_action 15:46:00 INFO - Running main action method: run_tests 15:46:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:46:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:46:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:46:00 INFO - 2016-04-06 15:46:00.890 screenresolution[2257:15484] starting screenresolution argv=screenresolution get 15:46:00 INFO - 2016-04-06 15:46:00.893 screenresolution[2257:15484] Display 0: 1600x1200x32@60 15:46:00 INFO - 2016-04-06 15:46:00.899 screenresolution[2258:15486] starting screenresolution argv=screenresolution list 15:46:00 INFO - Available Modes on Display 0 15:46:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:46:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:46:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:46:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:46:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:46:01 INFO - Intel Iris: 15:46:01 INFO - Chipset Model: Intel Iris 15:46:01 INFO - Type: GPU 15:46:01 INFO - Bus: Built-In 15:46:01 INFO - VRAM (Dynamic, Max): 1536 MB 15:46:01 INFO - Vendor: Intel (0x8086) 15:46:01 INFO - Device ID: 0x0a2e 15:46:01 INFO - Revision ID: 0x0009 15:46:01 INFO - Displays: 15:46:01 INFO - Display: 15:46:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:46:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:46:01 INFO - Display Serial Number: 1600x1200 60 15:46:01 INFO - Main Display: Yes 15:46:01 INFO - Mirror: Off 15:46:01 INFO - Online: Yes 15:46:01 INFO - Rotation: Supported 15:46:01 INFO - Return code: 0 15:46:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:46:01 INFO - Python 2.7.3 15:46:01 INFO - Return code: 0 15:46:01 INFO - grabbing minidump binary from tooltool 15:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:01 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 0x103598e00>, '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 0x103401db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103593b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:46:01 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 15:46:01 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 15:46:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:46:01 INFO - Return code: 0 15:46:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:46:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:46:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:46:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:46:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:46:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:46:02 INFO - Return code: 0 15:46:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0174 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:46:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fC2x3yAfRT/Render', 15:46:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:46:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:46:02 INFO - 'HOME': '/Users/cltbld', 15:46:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:46:02 INFO - 'LOGNAME': 'cltbld', 15:46:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:46:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:02 INFO - 'MOZ_NO_REMOTE': '1', 15:46:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:46:02 INFO - 'NO_EM_RESTART': '1', 15:46:02 INFO - 'PAGER': '/bin/cat', 15:46:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:46:02 INFO - 'PWD': '/builds/slave/test', 15:46:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:46:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:46:02 INFO - 'SHELL': '/bin/bash', 15:46:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lWWxxruTXe/Listeners', 15:46:02 INFO - 'TMPDIR': '/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/', 15:46:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:46:02 INFO - 'USER': 'cltbld', 15:46:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:46:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:02 INFO - 'XPC_FLAGS': '0x0', 15:46:02 INFO - 'XPC_SERVICE_NAME': '0', 15:46:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:46:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0174', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:46:02 INFO - mozversion application_buildid: 20160406112610 15:46:02 INFO - mozversion application_changeset: 55f0de142be46043246b18108299aebf2bd95a64 15:46:02 INFO - mozversion application_display_name: Nightly 15:46:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:46:02 INFO - mozversion application_name: Firefox 15:46:02 INFO - mozversion application_remotingname: firefox 15:46:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:46:02 INFO - mozversion application_vendor: Mozilla 15:46:02 INFO - mozversion application_version: 48.0a1 15:46:02 INFO - mozversion platform_buildid: 20160406112610 15:46:02 INFO - mozversion platform_changeset: 55f0de142be46043246b18108299aebf2bd95a64 15:46:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:46:02 INFO - mozversion platform_version: 48.0a1 15:46:02 INFO - using testdate: 1459982762 15:46:02 INFO - actual date: 1459982762 15:46:02 INFO - starting webserver on 'localhost:50113' 15:46:02 INFO - SUITE-START | Running 2 tests 15:46:02 INFO - TEST-START | dromaeo_css 15:46:02 INFO - operating with platform_type : mac_ 15:46:02 INFO - Initialising browser for dromaeo_css test... 15:46:02 INFO - TEST-INFO | started process 2276 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpro4bfv/profile http://localhost:50113/getInfo.html) 15:46:04 INFO - PROCESS | 2276 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 15:46:05 INFO - PROCESS | 2276 | __metrics Screen width/height:1600/1200 15:46:05 INFO - PROCESS | 2276 | colorDepth:24 15:46:05 INFO - PROCESS | 2276 | Browser inner width/height: 1024/689 15:46:05 INFO - PROCESS | 2276 | __metrics 15:46:05 ERROR - PROCESS | 2276 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 15:46:06 INFO - TEST-INFO | 2276: exit 0 15:46:06 INFO - Browser initialized. 15:46:06 INFO - Running cycle 1/1 for dromaeo_css test... 15:46:06 INFO - TEST-INFO | started process 2279 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmpro4bfv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:18 INFO - PROCESS | 2279 | RSS: Main: 247234560 15:46:18 INFO - PROCESS | 2279 | 15:47:08 INFO - PROCESS | 2279 | 1459982828135 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] 15:49:19 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:50113/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50113/tests/dromaeo/cssquery-ext.html) 15:49:20 INFO - PROCESS | 2279 | RSS: Main: 259203072 15:49:20 INFO - PROCESS | 2279 | 15:52:22 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:50113/tests/dromaeo/cssquery-ext.html (next: http://localhost:50113/tests/dromaeo/cssquery-jquery.html) 15:52:23 INFO - PROCESS | 2279 | RSS: Main: 271179776 15:52:23 INFO - PROCESS | 2279 | 15:55:25 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:50113/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50113/tests/dromaeo/cssquery-mootools.html) 15:55:25 INFO - PROCESS | 2279 | RSS: Main: 273285120 15:55:25 INFO - PROCESS | 2279 | 15:58:27 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:50113/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50113/tests/dromaeo/cssquery-prototype.html) 15:58:28 INFO - PROCESS | 2279 | RSS: Main: 274915328 15:58:28 INFO - PROCESS | 2279 | 16:01:30 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:50113/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50113/tests/dromaeo/cssquery-yui.html) 16:01:31 INFO - PROCESS | 2279 | RSS: Main: 277684224 16:01:31 INFO - PROCESS | 2279 | 16:04:34 INFO - PROCESS | 2279 | Cycle 1(1): loaded http://localhost:50113/tests/dromaeo/cssquery-yui.html (next: http://localhost:50113/tests/dromaeo/cssquery-dojo.html) 16:04:34 INFO - PROCESS | 2279 | RSS: Main: 278990848 16:04:34 INFO - PROCESS | 2279 | 16:04:34 INFO - PROCESS | 2279 | __start_tp_report 16:04:34 INFO - PROCESS | 2279 | _x_x_mozilla_page_load 16:04:34 INFO - PROCESS | 2279 | _x_x_mozilla_page_load_details 16:04:34 INFO - PROCESS | 2279 | |i|pagename|runs| 16:04:34 INFO - PROCESS | 2279 | |0;dojo.html;3443.3285509325683;3483.7561370704043;3519.8240087995596;3520.894373168804;3542.521759562458;5681.545476361892;5800.4489573490555;5816.185733997244;5825.737841797119;5854.121881717744;4760.2859571064355;5150.948490515094;5515.172724091388;5673.659580425177;5755.568332375067;5182.974085129569;5198.09033419152;5223.242629818674;5269.394019687747;5292.020976119411;795.0656946411646;5221.817236396727;5229.555487783524;5288.68267903927;5354.812581559646;5209.6874187548865;5229.607779416521;5254.789808407659;5255.343082114736;5273.598528948844;5119.923201151985;5257.290265814105;5291.074062039128;5296.417394086648;5301.73491325436;5094.541491265767;5134.101532231882;5138.049460849717;5171.327727395452;5225.059489291926;5564.221009058735;5681.630694004918;5704.77180912763;5733.541316694655;5759.395263497357;6109.663968481732;6145.647957449354;6173.969130154321;6264.843378915518;6276.5292603054495;6181.320054793969;6235;6237.937620623827;6240.31356550779;6247.125402443661;5929.466348028698;5940.613860099123;5940.790879588899;5954.166416701665;5966;6153.507719382528;6207.286162091327;6222.439980401786;6285.685715714196;6288.276848162428;6147.293061298008;6218.067289906459;6222.097795819581;6244.1570387997945;6250.74997000124;6193.597416167935;6213.974694175501;6246.562740608114;6249.125122482856;6256.843578910563;6136.509079273647;6143.358355907003;6228.377162283826;6228.937710622836;6266.342034086447;6129.570930034854;6138.970878344271;6231.252249729971;6241.719122639402;6250.718717657716;4896.020795840846;4911.950880491149;4921.188003979303;4924.236743304794;4935.555799978019;4385.429894113745;4405.052913623586;4447.911041779146;4463.888402789891;4472.664550158751;5754.309482862083;5754.424557544212;5783.161441590946;5817.127430885401;5828.854278642983;5406.486383793534;6105.633661980295;6225.252969643671;6261.96869015652;6269.843253918689;4795.784189711471;5624.55003599711;5805.970970145122;5818.5636077294375;5833;5352.839414817562;5397.10947693634;5408.3509978802795;5425.457454254622;5440.292761940922;5133.6919784813035;6015.819525414245;6339.334369891188;6340.968295158495;6345.809625711144;5046.722430266371;6216.875662486635;6234.532410069172;6235.875282494416;6236.781712640036;6256.436920677161;6264.5301602379095;6268.968655156695;6299;6303.4642055423965;6136.048912418582;6139.584134579286;6226.719797609209;6237.8752424950335;6237.875242495215;4662.790174442091;6157.076438534255;6185.84535386619;6204.348543402878;6225.968870155802;5924.348321684697;6121.112438696453;6147.938520614915;6155;6232.844178895564;6026.306974697965;6133.089845874549;6173.876522469615;6194.566380353332;6227.688615569294;5410.2696136022705;5758.62568933018;5901.232839730979;5911.083782013795;6047.727852246571;6158.661273629993;6170.907436388368;6180.876382472416;6206.131141640264;6214.658193799384;5257.211418287287;5901.144334071621;5944.6730429826775;5992.161097446448;6097.481714054177 16:04:34 INFO - PROCESS | 2279 | |1;ext.html;473.7938996536505;515.7885267040513;556.6743455078779;600.4355905448881;631.4127861089187;37675.24649507012;38350.616493835056;38426.80786596067;38473.61526384735;38489.615103848955;41109.766706998766;42138.25787873941;42144.57855421445;42168.57831421685;42214.94462638436;9451;9664.613415463373;9697.321187516876;9708.17480514157;9712.66005689801;9513;9624.37441566296;9627.663031793889;9657.758556036086;9671.226301895831;8915.153060459246;9014.549272536347;9605.95197024014;9699.951500242525;9702.563384647672;8324.334053275723;8415.410921235454;9145.588448519833;9672.516374181263;9701.90298097017;8639.438436501607;9160.81678366429;9465.384749991228;9615.90384096164;9618.711438656852;32048.038558843273;32849.6715032849;37931.24137517262;38274;38833.80583097066;3008.5186370180886;3111.6110486189227;3182.80903145812;3353.6478669739813;3358.8824391146436;26820.59769103465;27117.86441067802;27528.724712752817;27602.723972760217;28289.434211315864;2647.232302632234;2688.5563881959647;2689.39488615062;2717.2255907066587;2718.9048383306686;339178;340997;341465;341496;341772.2911385452;45544.8613784658;46253.38113166023;62312.688436557524;65716.3570910731;65852.68294634177;38812.805935970704;45322.77338613286;45782;45866;45989.080218395444;15453.459128930434;15701.371945122295;15788.842111578966;15811.762823557656;15834;10595.364278143335;12513.874861251454;12544.749105017849;12634.684132896751;12697.111202215756;14518.330392005055;14804.259787010606;14864.925675371771;14909.254537273093;14990;5936.821895343147;6002.189704389939;6484.708188131545;6534.705938232791;6551.427657362199;868.8522951098329;944.2964991081689;953.6328513522205;981.4454833019321;993.8012397520525;27876.16371508858;29024.564631530546;29334;29438.030171942504;29774.55338169929;1048.9475526223657;1105.7622611138643;1116.7989761842784;1143.2111842828422;1204.9156559040782;13606.047576669736;14179.858201417854;14280.429152793184;14526.782098268535;14588.270586470633;558713;651659;656948;668630;671009;58920.705396472746;59182.40817591855;59382;60045.69977150086;60198.699006504685;1410.7178564287183;1419.921904295253;1468.1704836767192;1470.4706305729715;1470.9411623534938;25550;27485.31286717848;27767.72232277732;27950.09946120974;28296.71703283023;43166.78416607897;43361.34957975696;43761.343579846965;43814;44027.8993025177;450877;452792;457070;457367;459824;32679;33038.33923321472;33436;37379.43930840985;43659.56340436555;34618.7883424079;43134.70595882129;43346;44035.77982110069;44311;34524.82737586296;36180;36761.81619091994;36779.26441471209;36800.26399471942;35245.29509409849;35349.82325088358;35461;36035.099122522144;36251.81874090613;32492.83753581217;35973.28053438864;37351.25297493981;37782.81108594439;38315;27763.75063122124;33181.50227746634;34254.82872585621;34499.4825077619;34559.13602159966;19528.707069394255;24084;24124.27627171188;24132.37004897977;24412.87793561021 16:04:34 INFO - PROCESS | 2279 | |2;jquery.html;353.800102941838;359.1900264902645;364.40965635670216;368.36640977518675;369.5159341262947;18531.907340463295;18779.906100469496;20127.496812579655;20159.59680806383;20168.899155504238;19128.61742765144;19166;19484.61030779387;19636.607267854633;19662.410127696192;5219.45195754446;5623.156526521024;5942.821715348525;5961.761529538813;5965.671888046156;4170;5822.679752613604;6234.563580549363;6518.054882042101;6526.706298216592;6452.257990331102;6458.58019228751;6459.35406459355;6461.8707625847455;6463.192100987377;7189.928100719005;7472.813179670497;7498.212687667771;7528.774136775905;7636.160022397532;7055.506114571982;7175.533590316612;7178.856422871566;7230.2046774854725;7245.963770181168;25008.249752507454;25722.35694107662;26115.347116322053;26246.606300905503;26364.472710545873;1918.7793403758608;2074.502119491326;2221.533477969628;2748.560230363152;3070.4319700855413;11440.771184576344;14336.784948225784;14975.400983960628;15225.781937444977;15560.766588501068;1807.4667972948012;1812.2932056497975;1887.829545681686;1909.4748944040361;1910.4459706685045;101209.49395253051;104262;104645.47677261564;105633.47183264034;106973;18664.813351866578;18853.434396968114;18880.52798680044;18919.52701182454;18950.81049189518;28083.859580701966;28313;28316.433671326457;28369;28425.43149137006;8669.653213871501;10570.841437378445;10596.735081622866;10636.255462117577;10645.520951557199;8904.643814247358;8997;9025.05236950124;9063.773405664779;9151.496667683341;8399.8320033599;8482.529814388687;8516.148385161434;8518.105598912149;8523.82952340962;1817.4184261036605;1871.9812801872079;1878.8778729382545;1890.2722451856134;3454.360943225511;855.8630619101039;881.9867701984475;913.6893456224915;918.6417297254076;935.6163972771132;18997.145128469252;19464.221431142596;19837.60324793525;19840.50398740043;20010.69983950242;901.2474583722534;923.5105394141116;972.7713987212999;984.9113579777711;997.0577803975319;8019.95740553736;8973.865392019125;9881.308308418485;10665.986731260518;10764;602186;602898;610087;625137;627282;108760.45619771851;111701.44149279202;113727;118113;119317;873.6112429968603;1015.7816069544936;1057.4606950455322;1061.0609610494614;1067.69570672358;17422.825771742122;17633.67747418923;17678.116094195495;17939.103044847445;18020.729689054413;44892.77553612211;46362.76818615885;46622.76688616535;47120.29319560141;48583.05667773249;61310.69344653248;62623.6868815653;62695;62737.37262627315;62800.68599656972;5971.313298970674;6387.945988911778;7289.088863892013;7338.119425668954;7367.705291788268;8843.778905527155;10961.013508784248;11762.294262344287;11980;12057.51769929193;9914.652987145415;10336.328138670962;10478.528466219192;10549.947250264007;10552.894471055191;9287.860682089638;10124.190064794651;10298.3820970742;10450.268481206243;10489.213309001703;9450.574724137568;10360.171186305228;10365.222608304559;10788.29876058085;10904.945475272572;7360.116785985716;7376.336129748348;7441.181470038399;7506.737264195727;7554.735584254525;7853.214678532101;9626.32615716893;10366.948165259126;10371.740706482398;10632.468376581295 16:04:34 INFO - PROCESS | 2279 | |3;mootools.html;1369.1716511510535;1577.7081239970603;1810.375420479934;1955.0908827395258;1976.5256338478769;7932.841343173148;8620.439671421353;8685.47887126772;8908.821823563532;8919.375643704936;8354.707585234519;8376.078631350547;8377.37169712271;8464.576771161448;8470;2446.474008088256;2467.2721547143547;2467.642191882176;2471.9134830280946;2476.071473197551;2434.7200071991683;2457.827952043349;2470.6788117544693;2474.5793215153376;2504.3989442533843;2441;2441.157800558813;2448.6816713827266;2456.2876765737915;2470.703515578133;2449.644801503781;2472.418981539337;2473.146764366291;2485.0805202075167;2494.064725727852;2452.080469823816;2462.630605409185;2480.7891329237036;2486.316263027664;2493.376655836041;7186.4969452138375;7864.898914151966;8488.490690558587;8510.829783404359;8569.271611912995;5357.973210133963;5375.784968601251;5459.426760190202;5492.148716948879;5497.532709719679;2978.7468065214484;3550.378683730337;3595.993121925865;3635.709143268532;3661.8901432957055;1013.640157744005;1030.5517100061497;1039.3400190878772;1042.2183362478142;1056.646023582101;11337.036351910097;11363.147763917657;11486.368249746261;11541.13441491883;11562.017228535584;4674.579287864109;4678.251479763221;4714.599259062949;4754.23932170851;4754.405699287589;9159.358844880928;9236.168744813;9238.676646317346;9245.491497967676;9305.581248843819;4976.825811096594;5020.121478741279;5339.786408543692;5365.302510673588;5370.812021579304;4474.284114541658;4881.194602890483;4955.058538877602;4994.101061808909;5081.136206844845;3693.8153092345274;3710.962890371116;3779.3008293465796;3781.470594116826;3833.080060785447;1187.5962172861268;1191.350713860948;1194.3550482739397;1198.17924721566;1210.3887536794039;1327.707904261061;1346.7912473566612;1369.1511263016794;1372.7529044771836;1380.4133243371527;8184.058833234254;8357.414980951397;8377.37169712274;8380.455270407405;8404.747857564284;505.96205284603803;513.7405610166917;516.2333934107846;518.157993260951;519.9428062913076;6187.474064704461;6233.875322493524;6286.8428289292215;6292.056191571301;6326.525510586633;10508.789824203473;10724.410157441416;10846.403447810288;10881.945590271998;10923;10549.261551691461;10622.681319560426;10710.143188545053;10770.78458430827;10794.082502987334;6996.6151861648095;8339;8343.332533397435;8439.367047471464;8448.155184481626;7760.728374506865;7853.921460785547;7897.526148431112;7949.562774047252;7997.080335761462;8840.425372350777;9435.339526233098;9499.667511637059;9540.093691099335;9563.521823908915;9665.71002869915;9806.166475849348;9969.800603988024;10021.348612340174;10166.898331016891;6348;6780.694868731018;6978.09284792994;6997.825054373681;7102.964485177541;8194.385421093322;8274.958625206835;8279.875801863098;8317.95841020791;8345.123762004901;6507.414332709889;7331.816704582215;7406.555606663617;7488.625568721651;7631.847363052597;7303.233160518069;7359.37445317154;7359.926400736138;7416;7422.888656670047;7700.884486732815;7771.533707977539;7784.727534536264;7800.648970796441;7877.527348359117;6292.653904035322;6466.612003279818;6968.581885086911;7035.718571257093;7081.82295442618;6018.548608854266;6044.818655440344;6158.507319414346;7142.178649455172;7252.89120663201 16:04:34 INFO - PROCESS | 2279 | |4;prototype.html;301.42879243832937;328.1779143246169;330.20585491891995;335.06850954346925;337.2210194450819;6889.207741109773;6897.724091036359;6924.338158841867;6925.826854328644;6955.686994085266;6717.697703603338;6828;6868.484863635223;6884.380405763481;6892.4830637702125;4788.162071637467;4889.26661000851;4986.800527978877;4997.075541024922;5053.4946505349535;4990.426100998396;4992.67547609406;5002.424721157059;5003.47463516331;5005.224190250517;4911.993041426499;4923.359963204778;4930.186519224324;4969.031038947407;4985.376827896513;4951.975240123795;5001.874953126183;5019.272205530177;5021.096202683516;5056.367954005767;4298.20483210607;4302.806373713159;4314.460692413449;4319.200947824663;4328.091100868822;5445.50990410865;6287.642134199675;6670.399664030212;6683.6658167091455;6702.530822842403;5861.17943487912;5915.704214789286;5917.349091599921;5917.745240117918;5943.405659434022;7302.561846289186;7394.926050739477;7403.259674032607;7405.296496832846;7418.814529636748;4697.318888761145;4719.551642593948;4730.621550276004;4737.26572381278;4739.909820741249;7388.482806203568;7683.923160768377;7772.7668169954995;7790.415718821111;7835.96082019592;3949.0522274653877;4647.697899636512;4662.7202367858035;4718.339432479455;4756.904861902743;4819.373481447389;4822.855314340575;4825.276208568743;4856.980034192859;4859.125357435625;5572.944270557324;5711.657300561979;5881.5000724938;5886.264216972879;5893.852653683693;6422.137580101718;6967.8606427871155;7405.074365704287;7408.888866667005;7411.85176296471;1372.4373007067054;1593.4502596604152;1669.8413650703164;1680.2270955360427;1699.3967141664778;946.6308139825474;1045.4318522216674;1058.1481907064888;1073.9677809665723;1074.8011617850723;5519.917201241985;6755.695993680198;6764.289749576322;6772.492063095287;6784.0841486399695;7615.847683046419;7624.961875190699;7649.464537482434;7653.732119375906;7664.888591154251;6746.494012949049;6752.324767523307;6754.831129221809;6775.898361524581;6796.150481189851;3722.683571896365;4029.6776257899296;4063.2076745034433;4072.0430698785763;4081.510218773766;7832.255935686101;7923.286904178652;8049.879251811228;8059.63731632078;8103.594820259082;8030.07654119772;8033.6786528538205;8033.718819841394;8045.879311810328;8048.758537243892;6459.677016149174;6949.617771022642;8080.4243172581955;8091.231333023354;8095.9880014998125;7567.744722689836;7709.111267739439;7780.844383112193;7817.296443320129;7823.84352312962;7568.924310756822;7598.924010759822;7643.923560764543;7644.3120119187315;7666.041744781903;5761.654300741969;6680.298568650222;7707.845843083219;7878.896954426499;7883.093444253984;4760.976195119002;4771.832985845479;4772.928406073981;4778.593819525379;4797.64017698667;6307.684615769285;7458.291462311072;7723.9227607723205;7730.92269077302;7760.45676802641;7460.0674915635545;7484.775456736306;7490.588017659081;7504;7533.660985255787;6102.389761023862;7453.217412171861;7453.329200371993;7465.925340746523;7468.738594149178;7251.202367739439;7263.891041634274;7282.089738782653;7301.415886729155;7306.342429181399;7144.928550714426;7430.4798664093;7431.331180193809;7450.36671882896;7520.699172033057;7251.311125443074;7333.376662983706;7346.37555807741;7376.926230737624;7377.483576149618 16:04:34 INFO - PROCESS | 2279 | |5;yui.html;681.7273090763694;709.8012556484186;740.3817812126874;763.1185980192878;763.6410886883162;14051.227182504957;14173.503927362544;14428.20644864532;14510.766584840301;14892;13906.165630062203;13955.162690238592;14019.088759230643;14029.298535073256;14071.718565628682;736.8857827036791;884.783228109111;906.5739102621757;910.1308250620641;913.4245425382001;919.6873063158524;923.607466826596;923.9214666753334;924.7410724997012;927.14702473724;939.4785893828922;953.1802649721269;965.0783501755807;969.6121551379434;973.0172525749009;928.972130836076;944.1172503708985;957.7078990907805;967.5936106835076;969.903009699028;715.5098757351232;719.1083057009271;719.7768691705536;721.0662192460776;723.6056349289597;14809.333579988926;14820.851791482055;15043.548693539211;15058.397664093423;15125;12798.16811907223;12812.29532375719;12851.100422970396;13050.086493945428;13263.60209193716;9986.151177149952;10040.799184016352;10060.69817905464;10077.949610251975;10096.091351778376;3438.3123375324785;3498.6851183393615;3535.222251104753;3537.6816086552335;3546.184377593168;77770.83343749848;77916;77993.61003194947;78098.60950695266;78314.82527762088;9282.396644218104;9408;9543;9573.664921727845;9916.107550320507;18398;22068.779312206672;22068.88965555162;22081.227157049747;22095;7288.6720097595735;7564.092308922965;7760.18518055596;7847.882281765778;7855.960720196476;3991.760494370289;4004.4593979812935;4022.8189731462153;4093.201825643971;4107.938380924288;3427.485877118402;3538.9646103538635;3569.1077230692326;3593.1915319053005;3616.4213725803747;637.5600835423636;642.5341627320156;645.3901063495045;646.3149061994301;651.4625434016955;515.259218076758;557.9581531385162;591.4292707537161;608.428077607048;613.6287546034674;7448.664810083559;8167.836643267101;8354.122817104238;8372.916270837213;8396.874046889301;528.5480913818707;570.8373113662669;587.2014060877203;595.559286128262;600.4205941266698;3485.9825700871334;3673.7428380013143;3824.330742120118;3891.8637847675195;4064.6545043671026;73075.53848922992;73108.26891731122;73698;77978;83365.58317208375;52914;69980;73170.63414682893;74235.62882185554;74592.62703686446;50920.23619645708;63485;63656.681716592044;64911.67544162249;65408.69182616321;8330.083690794128;8391.412601117863;8425.873611895704;8479.660813567389;8507.532085735344;42566.574334256264;43434;43961.34057989069;47349.52650473589;50047.74976125096;55075;56217;57861.4213857856;60827.087593687014;66572;10797.29817561856;10941.343519388543;10968.835467467834;11145.49845256949;11463;11908.940455298014;12007.879921200676;12264.631551608789;12330.951869091228;12583.370831458573;11612.5354985803;11880.227785193934;11939.940300298791;11969.461374238006;12261.75476490483;11477.196596238517;11508.251963622337;11609;11792.646220613395;11905.047596192457;11079.390633515233;11257.380844053656;11361.147913906656;11634.301941883514;11740.41297935117;9337.53312334367;9562.521873906138;9563.665271715456;10029.892703013038;10040.648577300051;9634.13292803651;9689.903100969183;9699;9719.902800972182;9770.609175632895 16:04:34 INFO - PROCESS | 2279 | __end_tp_report 16:04:34 INFO - PROCESS | 2279 | __start_cc_report 16:04:34 INFO - PROCESS | 2279 | _x_x_mozilla_cycle_collect,384 16:04:34 INFO - PROCESS | 2279 | __end_cc_report 16:04:34 INFO - PROCESS | 2279 | __startTimestamp1459983874272__endTimestamp 16:04:34 INFO - PROCESS | 2279 | 16:04:34 INFO - PROCESS | 2279 | ------- Summary: start ------- 16:04:34 INFO - PROCESS | 2279 | Number of tests: 6 16:04:34 INFO - PROCESS | 2279 | 16:04:34 INFO - PROCESS | 2279 | [#0] dojo.html Cycles:165 Average:5688.79 Median:5940.79 stddev:742.05 (12.5%) stddev-sans-first:723.12 16:04:34 INFO - PROCESS | 2279 | Values: 3443.3 3483.8 3519.8 3520.9 3542.5 5681.5 5800.4 5816.2 5825.7 5854.1 4760.3 5150.9 5515.2 5673.7 5755.6 5183.0 5198.1 5223.2 5269.4 5292.0 795.1 5221.8 5229.6 5288.7 5354.8 5209.7 5229.6 5254.8 5255.3 5273.6 5119.9 5257.3 5291.1 5296.4 5301.7 5094.5 5134.1 5138.0 5171.3 5225.1 5564.2 5681.6 5704.8 5733.5 5759.4 6109.7 6145.6 6174.0 6264.8 6276.5 6181.3 6235.0 6237.9 6240.3 6247.1 5929.5 5940.6 5940.8 5954.2 5966.0 6153.5 6207.3 6222.4 6285.7 6288.3 6147.3 6218.1 6222.1 6244.2 6250.7 6193.6 6214.0 6246.6 6249.1 6256.8 6136.5 6143.4 6228.4 6228.9 6266.3 6129.6 6139.0 6231.3 6241.7 6250.7 4896.0 4912.0 4921.2 4924.2 4935.6 4385.4 4405.1 4447.9 4463.9 4472.7 5754.3 5754.4 5783.2 5817.1 5828.9 5406.5 6105.6 6225.3 6262.0 6269.8 4795.8 5624.6 5806.0 5818.6 5833.0 5352.8 5397.1 5408.4 5425.5 5440.3 5133.7 6015.8 6339.3 6341.0 6345.8 5046.7 6216.9 6234.5 6235.9 6236.8 6256.4 6264.5 6269.0 6299.0 6303.5 6136.0 6139.6 6226.7 6237.9 6237.9 4662.8 6157.1 6185.8 6204.3 6226.0 5924.3 6121.1 6147.9 6155.0 6232.8 6026.3 6133.1 6173.9 6194.6 6227.7 5410.3 5758.6 5901.2 5911.1 6047.7 6158.7 6170.9 6180.9 6206.1 6214.7 5257.2 5901.1 5944.7 5992.2 6097.5 16:04:34 INFO - PROCESS | 2279 | 16:04:34 INFO - PROCESS | 2279 | [#1] ext.html Cycles:180 Average:61260.09 Median:37729.03 stddev:132602.92 (351.5%) stddev-sans-first:132896.36 16:04:34 INFO - PROCESS | 2279 | Values: 473.8 515.8 556.7 600.4 631.4 37675.2 38350.6 38426.8 38473.6 38489.6 41109.8 42138.3 42144.6 42168.6 42214.9 9451.0 9664.6 9697.3 9708.2 9712.7 9513.0 9624.4 9627.7 9657.8 9671.2 8915.2 9014.5 9606.0 9700.0 9702.6 8324.3 8415.4 9145.6 9672.5 9701.9 8639.4 9160.8 9465.4 9615.9 9618.7 32048.0 32849.7 37931.2 38274.0 38833.8 3008.5 3111.6 3182.8 3353.6 3358.9 26820.6 27117.9 27528.7 27602.7 28289.4 2647.2 2688.6 2689.4 2717.2 2718.9 339178.0 340997.0 341465.0 341496.0 341772.3 45544.9 46253.4 62312.7 65716.4 65852.7 38812.8 45322.8 45782.0 45866.0 45989.1 15453.5 15701.4 15788.8 15811.8 15834.0 10595.4 12513.9 12544.7 12634.7 12697.1 14518.3 14804.3 14864.9 14909.3 14990.0 5936.8 6002.2 6484.7 6534.7 6551.4 868.9 944.3 953.6 981.4 993.8 27876.2 29024.6 29334.0 29438.0 29774.6 1048.9 1105.8 1116.8 1143.2 1204.9 13606.0 14179.9 14280.4 14526.8 14588.3 558713.0 651659.0 656948.0 668630.0 671009.0 58920.7 59182.4 59382.0 60045.7 60198.7 1410.7 1419.9 1468.2 1470.5 1470.9 25550.0 27485.3 27767.7 27950.1 28296.7 43166.8 43361.3 43761.3 43814.0 44027.9 450877.0 452792.0 457070.0 457367.0 459824.0 32679.0 33038.3 33436.0 37379.4 43659.6 34618.8 43134.7 43346.0 44035.8 44311.0 34524.8 36180.0 36761.8 36779.3 36800.3 35245.3 35349.8 35461.0 36035.1 36251.8 32492.8 35973.3 37351.3 37782.8 38315.0 27763.8 33181.5 34254.8 34499.5 34559.1 19528.7 24084.0 24124.3 24132.4 24412.9 16:04:34 INFO - PROCESS | 2279 | 16:04:34 INFO - PROCESS | 2279 | [#2] jquery.html Cycles:180 Average:34752.75 Median:28397.22 stddev:101368.59 (357.0%) stddev-sans-first:101620.05 16:04:34 INFO - PROCESS | 2279 | Values: 353.8 359.2 364.4 368.4 369.5 18531.9 18779.9 20127.5 20159.6 20168.9 19128.6 19166.0 19484.6 19636.6 19662.4 5219.5 5623.2 5942.8 5961.8 5965.7 4170.0 5822.7 6234.6 6518.1 6526.7 6452.3 6458.6 6459.4 6461.9 6463.2 7189.9 7472.8 7498.2 7528.8 7636.2 7055.5 7175.5 7178.9 7230.2 7246.0 25008.2 25722.4 26115.3 26246.6 26364.5 1918.8 2074.5 2221.5 2748.6 3070.4 11440.8 14336.8 14975.4 15225.8 15560.8 1807.5 1812.3 1887.8 1909.5 1910.4 101209.5 104262.0 104645.5 105633.5 106973.0 18664.8 18853.4 18880.5 18919.5 18950.8 28083.9 28313.0 28316.4 28369.0 28425.4 8669.7 10570.8 10596.7 10636.3 10645.5 8904.6 8997.0 9025.1 9063.8 9151.5 8399.8 8482.5 8516.1 8518.1 8523.8 1817.4 1872.0 1878.9 1890.3 3454.4 855.9 882.0 913.7 918.6 935.6 18997.1 19464.2 19837.6 19840.5 20010.7 901.2 923.5 972.8 984.9 997.1 8020.0 8973.9 9881.3 10666.0 10764.0 602186.0 602898.0 610087.0 625137.0 627282.0 108760.5 111701.4 113727.0 118113.0 119317.0 873.6 1015.8 1057.5 1061.1 1067.7 17422.8 17633.7 17678.1 17939.1 18020.7 44892.8 46362.8 46622.8 47120.3 48583.1 61310.7 62623.7 62695.0 62737.4 62800.7 5971.3 6387.9 7289.1 7338.1 7367.7 8843.8 10961.0 11762.3 11980.0 12057.5 9914.7 10336.3 10478.5 10549.9 10552.9 9287.9 10124.2 10298.4 10450.3 10489.2 9450.6 10360.2 10365.2 10788.3 10904.9 7360.1 7376.3 7441.2 7506.7 7554.7 7853.2 9626.3 10366.9 10371.7 10632.5 16:04:34 INFO - PROCESS | 2279 | 16:04:34 INFO - PROCESS | 2279 | [#3] mootools.html Cycles:180 Average:5937.16 Median:5361.64 stddev:3139.25 (58.6%) stddev-sans-first:3129.28 16:04:34 INFO - PROCESS | 2279 | Values: 1369.2 1577.7 1810.4 1955.1 1976.5 7932.8 8620.4 8685.5 8908.8 8919.4 8354.7 8376.1 8377.4 8464.6 8470.0 2446.5 2467.3 2467.6 2471.9 2476.1 2434.7 2457.8 2470.7 2474.6 2504.4 2441.0 2441.2 2448.7 2456.3 2470.7 2449.6 2472.4 2473.1 2485.1 2494.1 2452.1 2462.6 2480.8 2486.3 2493.4 7186.5 7864.9 8488.5 8510.8 8569.3 5358.0 5375.8 5459.4 5492.1 5497.5 2978.7 3550.4 3596.0 3635.7 3661.9 1013.6 1030.6 1039.3 1042.2 1056.6 11337.0 11363.1 11486.4 11541.1 11562.0 4674.6 4678.3 4714.6 4754.2 4754.4 9159.4 9236.2 9238.7 9245.5 9305.6 4976.8 5020.1 5339.8 5365.3 5370.8 4474.3 4881.2 4955.1 4994.1 5081.1 3693.8 3711.0 3779.3 3781.5 3833.1 1187.6 1191.4 1194.4 1198.2 1210.4 1327.7 1346.8 1369.2 1372.8 1380.4 8184.1 8357.4 8377.4 8380.5 8404.7 506.0 513.7 516.2 518.2 519.9 6187.5 6233.9 6286.8 6292.1 6326.5 10508.8 10724.4 10846.4 10881.9 10923.0 10549.3 10622.7 10710.1 10770.8 10794.1 6996.6 8339.0 8343.3 8439.4 8448.2 7760.7 7853.9 7897.5 7949.6 7997.1 8840.4 9435.3 9499.7 9540.1 9563.5 9665.7 9806.2 9969.8 10021.3 10166.9 6348.0 6780.7 6978.1 6997.8 7103.0 8194.4 8275.0 8279.9 8318.0 8345.1 6507.4 7331.8 7406.6 7488.6 7631.8 7303.2 7359.4 7359.9 7416.0 7422.9 7700.9 7771.5 7784.7 7800.6 7877.5 6292.7 6466.6 6968.6 7035.7 7081.8 6018.5 6044.8 6158.5 7142.2 7252.9 16:04:34 INFO - PROCESS | 2279 | 16:04:34 INFO - PROCESS | 2279 | [#4] prototype.html Cycles:180 Average:5977.99 Median:6759.99 stddev:1951.14 (28.9%) stddev-sans-first:1909.53 16:04:34 INFO - PROCESS | 2279 | Values: 301.4 328.2 330.2 335.1 337.2 6889.2 6897.7 6924.3 6925.8 6955.7 6717.7 6828.0 6868.5 6884.4 6892.5 4788.2 4889.3 4986.8 4997.1 5053.5 4990.4 4992.7 5002.4 5003.5 5005.2 4912.0 4923.4 4930.2 4969.0 4985.4 4952.0 5001.9 5019.3 5021.1 5056.4 4298.2 4302.8 4314.5 4319.2 4328.1 5445.5 6287.6 6670.4 6683.7 6702.5 5861.2 5915.7 5917.3 5917.7 5943.4 7302.6 7394.9 7403.3 7405.3 7418.8 4697.3 4719.6 4730.6 4737.3 4739.9 7388.5 7683.9 7772.8 7790.4 7836.0 3949.1 4647.7 4662.7 4718.3 4756.9 4819.4 4822.9 4825.3 4857.0 4859.1 5572.9 5711.7 5881.5 5886.3 5893.9 6422.1 6967.9 7405.1 7408.9 7411.9 1372.4 1593.5 1669.8 1680.2 1699.4 946.6 1045.4 1058.1 1074.0 1074.8 5519.9 6755.7 6764.3 6772.5 6784.1 7615.8 7625.0 7649.5 7653.7 7664.9 6746.5 6752.3 6754.8 6775.9 6796.2 3722.7 4029.7 4063.2 4072.0 4081.5 7832.3 7923.3 8049.9 8059.6 8103.6 8030.1 8033.7 8033.7 8045.9 8048.8 6459.7 6949.6 8080.4 8091.2 8096.0 7567.7 7709.1 7780.8 7817.3 7823.8 7568.9 7598.9 7643.9 7644.3 7666.0 5761.7 6680.3 7707.8 7878.9 7883.1 4761.0 4771.8 4772.9 4778.6 4797.6 6307.7 7458.3 7723.9 7730.9 7760.5 7460.1 7484.8 7490.6 7504.0 7533.7 6102.4 7453.2 7453.3 7465.9 7468.7 7251.2 7263.9 7282.1 7301.4 7306.3 7144.9 7430.5 7431.3 7450.4 7520.7 7251.3 7333.4 7346.4 7376.9 7377.5 16:04:34 INFO - PROCESS | 2279 | 16:04:34 INFO - PROCESS | 2279 | [#5] yui.html Cycles:180 Average:16965.58 Median:589.32 stddev:22667.97 (3846.5%) stddev-sans-first:22698.58 16:04:34 INFO - PROCESS | 2279 | Values: 681.7 709.8 740.4 763.1 763.6 14051.2 14173.5 14428.2 14510.8 14892.0 13906.2 13955.2 14019.1 14029.3 14071.7 736.9 884.8 906.6 910.1 913.4 919.7 923.6 923.9 924.7 927.1 939.5 953.2 965.1 969.6 973.0 929.0 944.1 957.7 967.6 969.9 715.5 719.1 719.8 721.1 723.6 14809.3 14820.9 15043.5 15058.4 15125.0 12798.2 12812.3 12851.1 13050.1 13263.6 9986.2 10040.8 10060.7 10077.9 10096.1 3438.3 3498.7 3535.2 3537.7 3546.2 77770.8 77916.0 77993.6 78098.6 78314.8 9282.4 9408.0 9543.0 9573.7 9916.1 18398.0 22068.8 22068.9 22081.2 22095.0 7288.7 7564.1 7760.2 7847.9 7856.0 3991.8 4004.5 4022.8 4093.2 4107.9 3427.5 3539.0 3569.1 3593.2 3616.4 637.6 642.5 645.4 646.3 651.5 515.3 558.0 591.4 608.4 613.6 7448.7 8167.8 8354.1 8372.9 8396.9 528.5 570.8 587.2 595.6 600.4 3486.0 3673.7 3824.3 3891.9 4064.7 73075.5 73108.3 73698.0 77978.0 83365.6 52914.0 69980.0 73170.6 74235.6 74592.6 50920.2 63485.0 63656.7 64911.7 65408.7 8330.1 8391.4 8425.9 8479.7 8507.5 42566.6 43434.0 43961.3 47349.5 50047.7 55075.0 56217.0 57861.4 60827.1 66572.0 10797.3 10941.3 10968.8 11145.5 11463.0 11908.9 12007.9 12264.6 12331.0 12583.4 11612.5 11880.2 11939.9 11969.5 12261.8 11477.2 11508.3 11609.0 11792.6 11905.0 11079.4 11257.4 11361.1 11634.3 11740.4 9337.5 9562.5 9563.7 10029.9 10040.6 9634.1 9689.9 9699.0 9719.9 9770.6 16:04:34 INFO - PROCESS | 2279 | -------- Summary: end -------- 16:04:34 INFO - PROCESS | 2279 | 16:04:34 INFO - TEST-INFO | 2279: exit 0 16:04:34 INFO - TEST-OK | dromaeo_css | took 1112203ms 16:04:34 INFO - TEST-START | kraken 16:04:34 INFO - operating with platform_type : mac_ 16:04:34 INFO - Initialising browser for kraken test... 16:04:34 INFO - TEST-INFO | started process 2284 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmph73vRX/profile http://localhost:50113/getInfo.html) 16:04:37 INFO - PROCESS | 2284 | JavaScript error: jar:file:///builds/slave/test/build/application/Nightly.app/Contents/Resources/omni.ja!/components/Weave.js, line 13: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIXPCComponents_Utils.import] 16:04:38 INFO - PROCESS | 2284 | __metrics Screen width/height:1600/1200 16:04:38 INFO - PROCESS | 2284 | colorDepth:24 16:04:38 INFO - PROCESS | 2284 | Browser inner width/height: 1024/689 16:04:38 INFO - PROCESS | 2284 | __metrics 16:04:38 ERROR - PROCESS | 2284 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2881: TypeError: this.tabs is undefined 16:04:38 INFO - TEST-INFO | 2284: exit 0 16:04:38 INFO - Browser initialized. 16:04:38 INFO - Running cycle 1/1 for kraken test... 16:04:38 INFO - TEST-INFO | started process 2287 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/tmph73vRX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:50 INFO - PROCESS | 2287 | RSS: Main: 247472128 16:04:50 INFO - PROCESS | 2287 | 16:04:53 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50113/tests/kraken/driver.html?testName=audio-beat-detection) 16:04:53 INFO - PROCESS | 2287 | RSS: Main: 259682304 16:04:53 INFO - PROCESS | 2287 | 16:04:56 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50113/tests/kraken/driver.html?testName=audio-dft) 16:04:57 INFO - PROCESS | 2287 | RSS: Main: 268611584 16:04:57 INFO - PROCESS | 2287 | 16:05:00 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50113/tests/kraken/driver.html?testName=audio-fft) 16:05:01 INFO - PROCESS | 2287 | RSS: Main: 272064512 16:05:01 INFO - PROCESS | 2287 | 16:05:03 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50113/tests/kraken/driver.html?testName=audio-oscillator) 16:05:04 INFO - PROCESS | 2287 | RSS: Main: 273907712 16:05:04 INFO - PROCESS | 2287 | 16:05:06 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50113/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:05:06 INFO - PROCESS | 2287 | RSS: Main: 274395136 16:05:06 INFO - PROCESS | 2287 | 16:05:09 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50113/tests/kraken/driver.html?testName=imaging-darkroom) 16:05:10 INFO - PROCESS | 2287 | RSS: Main: 274853888 16:05:10 INFO - PROCESS | 2287 | 16:05:13 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50113/tests/kraken/driver.html?testName=imaging-desaturate) 16:05:13 INFO - PROCESS | 2287 | RSS: Main: 274554880 16:05:13 INFO - PROCESS | 2287 | 16:05:16 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50113/tests/kraken/driver.html?testName=json-parse-financial) 16:05:17 INFO - PROCESS | 2287 | RSS: Main: 274604032 16:05:17 INFO - PROCESS | 2287 | 16:05:18 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50113/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:05:19 INFO - PROCESS | 2287 | RSS: Main: 274542592 16:05:19 INFO - PROCESS | 2287 | 16:05:21 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50113/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:05:22 INFO - PROCESS | 2287 | RSS: Main: 274780160 16:05:22 INFO - PROCESS | 2287 | 16:05:24 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50113/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:05:24 INFO - PROCESS | 2287 | RSS: Main: 275415040 16:05:24 INFO - PROCESS | 2287 | 16:05:27 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50113/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:05:28 INFO - PROCESS | 2287 | RSS: Main: 275271680 16:05:28 INFO - PROCESS | 2287 | 16:05:30 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50113/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:05:31 INFO - PROCESS | 2287 | RSS: Main: 275034112 16:05:31 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | Cycle 1(1): loaded http://localhost:50113/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50113/tests/kraken/driver.html?testName=ai-astar) 16:05:33 INFO - PROCESS | 2287 | RSS: Main: 276934656 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | __start_tp_report 16:05:33 INFO - PROCESS | 2287 | _x_x_mozilla_page_load 16:05:33 INFO - PROCESS | 2287 | _x_x_mozilla_page_load_details 16:05:33 INFO - PROCESS | 2287 | |i|pagename|runs| 16:05:33 INFO - PROCESS | 2287 | |0;ai-astar;114;106;116;116;167;142;114;115;116;120 16:05:33 INFO - PROCESS | 2287 | |1;audio-beat-detection;157;121;146;160;124;141;141;140;193;151 16:05:33 INFO - PROCESS | 2287 | |2;audio-dft;268;254;193;199;252;258;271;214;195;197 16:05:33 INFO - PROCESS | 2287 | |3;audio-fft;56;93;77;84;95;58;141;79;79;83 16:05:33 INFO - PROCESS | 2287 | |4;audio-oscillator;78;81;123;76;79;83;120;80;79;115 16:05:33 INFO - PROCESS | 2287 | |5;imaging-gaussian-blur;89;86;88;87;90;86;89;86;101;111 16:05:33 INFO - PROCESS | 2287 | |6;imaging-darkroom;95;115;91;145;137;96;105;142;129;95 16:05:33 INFO - PROCESS | 2287 | |7;imaging-desaturate;92;92;94;90;107;131;91;91;90;139 16:05:33 INFO - PROCESS | 2287 | |8;json-parse-financial;57;57;54;56;64;67;79;87;58;54 16:05:33 INFO - PROCESS | 2287 | |9;json-stringify-tinderbox;68;72;67;78;60;86;96;98;99;94 16:05:33 INFO - PROCESS | 2287 | |10;stanford-crypto-aes;90;108;102;85;88;84;89;85;84;87 16:05:33 INFO - PROCESS | 2287 | |11;stanford-crypto-ccm;139;139;132;142;121;123;123;129;132;130 16:05:33 INFO - PROCESS | 2287 | |12;stanford-crypto-pbkdf2;130;142;142;155;175;179;131;144;143;141 16:05:33 INFO - PROCESS | 2287 | |13;stanford-crypto-sha256-iterative;68;71;62;97;96;91;92;56;86;66 16:05:33 INFO - PROCESS | 2287 | __end_tp_report 16:05:33 INFO - PROCESS | 2287 | __start_cc_report 16:05:33 INFO - PROCESS | 2287 | _x_x_mozilla_cycle_collect,971 16:05:33 INFO - PROCESS | 2287 | __end_cc_report 16:05:33 INFO - PROCESS | 2287 | __startTimestamp1459983933293__endTimestamp 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | ------- Summary: start ------- 16:05:33 INFO - PROCESS | 2287 | Number of tests: 14 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#0] ai-astar Cycles:10 Average:122.60 Median:116.00 stddev:18.15 (15.7%) stddev-sans-first:18.99 16:05:33 INFO - PROCESS | 2287 | Values: 114.0 106.0 116.0 116.0 167.0 142.0 114.0 115.0 116.0 120.0 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#1] audio-beat-detection Cycles:10 Average:147.40 Median:148.50 stddev:20.35 (13.7%) stddev-sans-first:21.28 16:05:33 INFO - PROCESS | 2287 | Values: 157.0 121.0 146.0 160.0 124.0 141.0 141.0 140.0 193.0 151.0 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#2] audio-dft Cycles:10 Average:230.10 Median:253.00 stddev:33.11 (13.1%) stddev-sans-first:32.16 16:05:33 INFO - PROCESS | 2287 | Values: 268.0 254.0 193.0 199.0 252.0 258.0 271.0 214.0 195.0 197.0 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#3] audio-fft Cycles:10 Average:84.50 Median:81.00 stddev:23.59 (29.1%) stddev-sans-first:22.66 16:05:33 INFO - PROCESS | 2287 | Values: 56.0 93.0 77.0 84.0 95.0 58.0 141.0 79.0 79.0 83.0 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:79.00 stddev:19.45 (24.6%) stddev-sans-first:20.02 16:05:33 INFO - PROCESS | 2287 | Values: 78.0 81.0 123.0 76.0 79.0 83.0 120.0 80.0 79.0 115.0 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#5] imaging-gaussian-blur Cycles:10 Average:91.30 Median:87.50 stddev:8.22 (9.4%) stddev-sans-first:8.68 16:05:33 INFO - PROCESS | 2287 | Values: 89.0 86.0 88.0 87.0 90.0 86.0 89.0 86.0 101.0 111.0 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#6] imaging-darkroom Cycles:10 Average:115.00 Median:118.00 stddev:21.46 (18.2%) stddev-sans-first:21.51 16:05:33 INFO - PROCESS | 2287 | Values: 95.0 115.0 91.0 145.0 137.0 96.0 105.0 142.0 129.0 95.0 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#7] imaging-desaturate Cycles:10 Average:101.70 Median:91.00 stddev:18.34 (20.2%) stddev-sans-first:19.12 16:05:33 INFO - PROCESS | 2287 | Values: 92.0 92.0 94.0 90.0 107.0 131.0 91.0 91.0 90.0 139.0 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:61.00 stddev:11.33 (18.6%) stddev-sans-first:11.79 16:05:33 INFO - PROCESS | 2287 | Values: 57.0 57.0 54.0 56.0 64.0 67.0 79.0 87.0 58.0 54.0 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#9] json-stringify-tinderbox Cycles:10 Average:81.80 Median:90.00 stddev:14.61 (16.2%) stddev-sans-first:14.62 16:05:33 INFO - PROCESS | 2287 | Values: 68.0 72.0 67.0 78.0 60.0 86.0 96.0 98.0 99.0 94.0 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#10] stanford-crypto-aes Cycles:10 Average:90.20 Median:86.00 stddev:8.19 (9.5%) stddev-sans-first:8.69 16:05:33 INFO - PROCESS | 2287 | Values: 90.0 108.0 102.0 85.0 88.0 84.0 89.0 85.0 84.0 87.0 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#11] stanford-crypto-ccm Cycles:10 Average:131.00 Median:132.00 stddev:7.33 (5.6%) stddev-sans-first:7.18 16:05:33 INFO - PROCESS | 2287 | Values: 139.0 139.0 132.0 142.0 121.0 123.0 123.0 129.0 132.0 130.0 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.20 Median:143.50 stddev:16.71 (11.6%) stddev-sans-first:16.38 16:05:33 INFO - PROCESS | 2287 | Values: 130.0 142.0 142.0 155.0 175.0 179.0 131.0 144.0 143.0 141.0 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - PROCESS | 2287 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.50 Median:88.50 stddev:15.44 (17.4%) stddev-sans-first:15.90 16:05:33 INFO - PROCESS | 2287 | Values: 68.0 71.0 62.0 97.0 96.0 91.0 92.0 56.0 86.0 66.0 16:05:33 INFO - PROCESS | 2287 | -------- Summary: end -------- 16:05:33 INFO - PROCESS | 2287 | 16:05:33 INFO - TEST-INFO | 2287: exit 0 16:05:34 INFO - TEST-OK | kraken | took 59182ms 16:05:34 INFO - SUITE-END | took 1171s 16:05:34 INFO - Completed test suite (00:19:31) 16:05:34 INFO - javascript benchmark 16:05:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3443.3285509325683, 3483.7561370704043, 3519.8240087995596, 3520.894373168804, 3542.521759562458, 5681.545476361892, 5800.4489573490555, 5816.185733997244, 5825.737841797119, 5854.121881717744, 4760.2859571064355, 5150.948490515094, 5515.172724091388, 5673.659580425177, 5755.568332375067, 5182.974085129569, 5198.09033419152, 5223.242629818674, 5269.394019687747, 5292.020976119411, 795.0656946411646, 5221.817236396727, 5229.555487783524, 5288.68267903927, 5354.812581559646, 5209.6874187548865, 5229.607779416521, 5254.789808407659, 5255.343082114736, 5273.598528948844, 5119.923201151985, 5257.290265814105, 5291.074062039128, 5296.417394086648, 5301.73491325436, 5094.541491265767, 5134.101532231882, 5138.049460849717, 5171.327727395452, 5225.059489291926, 5564.221009058735, 5681.630694004918, 5704.77180912763, 5733.541316694655, 5759.395263497357, 6109.663968481732, 6145.647957449354, 6173.969130154321, 6264.843378915518, 6276.5292603054495, 6181.320054793969, 6235.0, 6237.937620623827, 6240.31356550779, 6247.125402443661, 5929.466348028698, 5940.613860099123, 5940.790879588899, 5954.166416701665, 5966.0, 6153.507719382528, 6207.286162091327, 6222.439980401786, 6285.685715714196, 6288.276848162428, 6147.293061298008, 6218.067289906459, 6222.097795819581, 6244.1570387997945, 6250.74997000124, 6193.597416167935, 6213.974694175501, 6246.562740608114, 6249.125122482856, 6256.843578910563, 6136.509079273647, 6143.358355907003, 6228.377162283826, 6228.937710622836, 6266.342034086447, 6129.570930034854, 6138.970878344271, 6231.252249729971, 6241.719122639402, 6250.718717657716, 4896.020795840846, 4911.950880491149, 4921.188003979303, 4924.236743304794, 4935.555799978019, 4385.429894113745, 4405.052913623586, 4447.911041779146, 4463.888402789891, 4472.664550158751, 5754.309482862083, 5754.424557544212, 5783.161441590946, 5817.127430885401, 5828.854278642983, 5406.486383793534, 6105.633661980295, 6225.252969643671, 6261.96869015652, 6269.843253918689, 4795.784189711471, 5624.55003599711, 5805.970970145122, 5818.5636077294375, 5833.0, 5352.839414817562, 5397.10947693634, 5408.3509978802795, 5425.457454254622, 5440.292761940922, 5133.6919784813035, 6015.819525414245, 6339.334369891188, 6340.968295158495, 6345.809625711144, 5046.722430266371, 6216.875662486635, 6234.532410069172, 6235.875282494416, 6236.781712640036, 6256.436920677161, 6264.5301602379095, 6268.968655156695, 6299.0, 6303.4642055423965, 6136.048912418582, 6139.584134579286, 6226.719797609209, 6237.8752424950335, 6237.875242495215, 4662.790174442091, 6157.076438534255, 6185.84535386619, 6204.348543402878, 6225.968870155802, 5924.348321684697, 6121.112438696453, 6147.938520614915, 6155.0, 6232.844178895564, 6026.306974697965, 6133.089845874549, 6173.876522469615, 6194.566380353332, 6227.688615569294, 5410.2696136022705, 5758.62568933018, 5901.232839730979, 5911.083782013795, 6047.727852246571, 6158.661273629993, 6170.907436388368, 6180.876382472416, 6206.131141640264, 6214.658193799384, 5257.211418287287, 5901.144334071621, 5944.6730429826775, 5992.161097446448, 6097.481714054177], "unit": "score", "name": "dojo.html", "value": 5647.1489946961765}, {"lowerIsBetter": false, "replicates": [473.7938996536505, 515.7885267040513, 556.6743455078779, 600.4355905448881, 631.4127861089187, 37675.24649507012, 38350.616493835056, 38426.80786596067, 38473.61526384735, 38489.615103848955, 41109.766706998766, 42138.25787873941, 42144.57855421445, 42168.57831421685, 42214.94462638436, 9451.0, 9664.613415463373, 9697.321187516876, 9708.17480514157, 9712.66005689801, 9513.0, 9624.37441566296, 9627.663031793889, 9657.758556036086, 9671.226301895831, 8915.153060459246, 9014.549272536347, 9605.95197024014, 9699.951500242525, 9702.563384647672, 8324.334053275723, 8415.410921235454, 9145.588448519833, 9672.516374181263, 9701.90298097017, 8639.438436501607, 9160.81678366429, 9465.384749991228, 9615.90384096164, 9618.711438656852, 32048.038558843273, 32849.6715032849, 37931.24137517262, 38274.0, 38833.80583097066, 3008.5186370180886, 3111.6110486189227, 3182.80903145812, 3353.6478669739813, 3358.8824391146436, 26820.59769103465, 27117.86441067802, 27528.724712752817, 27602.723972760217, 28289.434211315864, 2647.232302632234, 2688.5563881959647, 2689.39488615062, 2717.2255907066587, 2718.9048383306686, 339178.0, 340997.0, 341465.0, 341496.0, 341772.2911385452, 45544.8613784658, 46253.38113166023, 62312.688436557524, 65716.3570910731, 65852.68294634177, 38812.805935970704, 45322.77338613286, 45782.0, 45866.0, 45989.080218395444, 15453.459128930434, 15701.371945122295, 15788.842111578966, 15811.762823557656, 15834.0, 10595.364278143335, 12513.874861251454, 12544.749105017849, 12634.684132896751, 12697.111202215756, 14518.330392005055, 14804.259787010606, 14864.925675371771, 14909.254537273093, 14990.0, 5936.821895343147, 6002.189704389939, 6484.708188131545, 6534.705938232791, 6551.427657362199, 868.8522951098329, 944.2964991081689, 953.6328513522205, 981.4454833019321, 993.8012397520525, 27876.16371508858, 29024.564631530546, 29334.0, 29438.030171942504, 29774.55338169929, 1048.9475526223657, 1105.7622611138643, 1116.7989761842784, 1143.2111842828422, 1204.9156559040782, 13606.047576669736, 14179.858201417854, 14280.429152793184, 14526.782098268535, 14588.270586470633, 558713.0, 651659.0, 656948.0, 668630.0, 671009.0, 58920.705396472746, 59182.40817591855, 59382.0, 60045.69977150086, 60198.699006504685, 1410.7178564287183, 1419.921904295253, 1468.1704836767192, 1470.4706305729715, 1470.9411623534938, 25550.0, 27485.31286717848, 27767.72232277732, 27950.09946120974, 28296.71703283023, 43166.78416607897, 43361.34957975696, 43761.343579846965, 43814.0, 44027.8993025177, 450877.0, 452792.0, 457070.0, 457367.0, 459824.0, 32679.0, 33038.33923321472, 33436.0, 37379.43930840985, 43659.56340436555, 34618.7883424079, 43134.70595882129, 43346.0, 44035.77982110069, 44311.0, 34524.82737586296, 36180.0, 36761.81619091994, 36779.26441471209, 36800.26399471942, 35245.29509409849, 35349.82325088358, 35461.0, 36035.099122522144, 36251.81874090613, 32492.83753581217, 35973.28053438864, 37351.25297493981, 37782.81108594439, 38315.0, 27763.75063122124, 33181.50227746634, 34254.82872585621, 34499.4825077619, 34559.13602159966, 19528.707069394255, 24084.0, 24124.27627171188, 24132.37004897977, 24412.87793561021], "unit": "score", "name": "ext.html", "value": 18711.492687523205}, {"lowerIsBetter": false, "replicates": [353.800102941838, 359.1900264902645, 364.40965635670216, 368.36640977518675, 369.5159341262947, 18531.907340463295, 18779.906100469496, 20127.496812579655, 20159.59680806383, 20168.899155504238, 19128.61742765144, 19166.0, 19484.61030779387, 19636.607267854633, 19662.410127696192, 5219.45195754446, 5623.156526521024, 5942.821715348525, 5961.761529538813, 5965.671888046156, 4170.0, 5822.679752613604, 6234.563580549363, 6518.054882042101, 6526.706298216592, 6452.257990331102, 6458.58019228751, 6459.35406459355, 6461.8707625847455, 6463.192100987377, 7189.928100719005, 7472.813179670497, 7498.212687667771, 7528.774136775905, 7636.160022397532, 7055.506114571982, 7175.533590316612, 7178.856422871566, 7230.2046774854725, 7245.963770181168, 25008.249752507454, 25722.35694107662, 26115.347116322053, 26246.606300905503, 26364.472710545873, 1918.7793403758608, 2074.502119491326, 2221.533477969628, 2748.560230363152, 3070.4319700855413, 11440.771184576344, 14336.784948225784, 14975.400983960628, 15225.781937444977, 15560.766588501068, 1807.4667972948012, 1812.2932056497975, 1887.829545681686, 1909.4748944040361, 1910.4459706685045, 101209.49395253051, 104262.0, 104645.47677261564, 105633.47183264034, 106973.0, 18664.813351866578, 18853.434396968114, 18880.52798680044, 18919.52701182454, 18950.81049189518, 28083.859580701966, 28313.0, 28316.433671326457, 28369.0, 28425.43149137006, 8669.653213871501, 10570.841437378445, 10596.735081622866, 10636.255462117577, 10645.520951557199, 8904.643814247358, 8997.0, 9025.05236950124, 9063.773405664779, 9151.496667683341, 8399.8320033599, 8482.529814388687, 8516.148385161434, 8518.105598912149, 8523.82952340962, 1817.4184261036605, 1871.9812801872079, 1878.8778729382545, 1890.2722451856134, 3454.360943225511, 855.8630619101039, 881.9867701984475, 913.6893456224915, 918.6417297254076, 935.6163972771132, 18997.145128469252, 19464.221431142596, 19837.60324793525, 19840.50398740043, 20010.69983950242, 901.2474583722534, 923.5105394141116, 972.7713987212999, 984.9113579777711, 997.0577803975319, 8019.95740553736, 8973.865392019125, 9881.308308418485, 10665.986731260518, 10764.0, 602186.0, 602898.0, 610087.0, 625137.0, 627282.0, 108760.45619771851, 111701.44149279202, 113727.0, 118113.0, 119317.0, 873.6112429968603, 1015.7816069544936, 1057.4606950455322, 1061.0609610494614, 1067.69570672358, 17422.825771742122, 17633.67747418923, 17678.116094195495, 17939.103044847445, 18020.729689054413, 44892.77553612211, 46362.76818615885, 46622.76688616535, 47120.29319560141, 48583.05667773249, 61310.69344653248, 62623.6868815653, 62695.0, 62737.37262627315, 62800.68599656972, 5971.313298970674, 6387.945988911778, 7289.088863892013, 7338.119425668954, 7367.705291788268, 8843.778905527155, 10961.013508784248, 11762.294262344287, 11980.0, 12057.51769929193, 9914.652987145415, 10336.328138670962, 10478.528466219192, 10549.947250264007, 10552.894471055191, 9287.860682089638, 10124.190064794651, 10298.3820970742, 10450.268481206243, 10489.213309001703, 9450.574724137568, 10360.171186305228, 10365.222608304559, 10788.29876058085, 10904.945475272572, 7360.116785985716, 7376.336129748348, 7441.181470038399, 7506.737264195727, 7554.735584254525, 7853.214678532101, 9626.32615716893, 10366.948165259126, 10371.740706482398, 10632.468376581295], "unit": "score", "name": "jquery.html", "value": 9980.800037086787}, {"lowerIsBetter": false, "replicates": [1369.1716511510535, 1577.7081239970603, 1810.375420479934, 1955.0908827395258, 1976.5256338478769, 7932.841343173148, 8620.439671421353, 8685.47887126772, 8908.821823563532, 8919.375643704936, 8354.707585234519, 8376.078631350547, 8377.37169712271, 8464.576771161448, 8470.0, 2446.474008088256, 2467.2721547143547, 2467.642191882176, 2471.9134830280946, 2476.071473197551, 2434.7200071991683, 2457.827952043349, 2470.6788117544693, 2474.5793215153376, 2504.3989442533843, 2441.0, 2441.157800558813, 2448.6816713827266, 2456.2876765737915, 2470.703515578133, 2449.644801503781, 2472.418981539337, 2473.146764366291, 2485.0805202075167, 2494.064725727852, 2452.080469823816, 2462.630605409185, 2480.7891329237036, 2486.316263027664, 2493.376655836041, 7186.4969452138375, 7864.898914151966, 8488.490690558587, 8510.829783404359, 8569.271611912995, 5357.973210133963, 5375.784968601251, 5459.426760190202, 5492.148716948879, 5497.532709719679, 2978.7468065214484, 3550.378683730337, 3595.993121925865, 3635.709143268532, 3661.8901432957055, 1013.640157744005, 1030.5517100061497, 1039.3400190878772, 1042.2183362478142, 1056.646023582101, 11337.036351910097, 11363.147763917657, 11486.368249746261, 11541.13441491883, 11562.017228535584, 4674.579287864109, 4678.251479763221, 4714.599259062949, 4754.23932170851, 4754.405699287589, 9159.358844880928, 9236.168744813, 9238.676646317346, 9245.491497967676, 9305.581248843819, 4976.825811096594, 5020.121478741279, 5339.786408543692, 5365.302510673588, 5370.812021579304, 4474.284114541658, 4881.194602890483, 4955.058538877602, 4994.101061808909, 5081.136206844845, 3693.8153092345274, 3710.962890371116, 3779.3008293465796, 3781.470594116826, 3833.080060785447, 1187.5962172861268, 1191.350713860948, 1194.3550482739397, 1198.17924721566, 1210.3887536794039, 1327.707904261061, 1346.7912473566612, 1369.1511263016794, 1372.7529044771836, 1380.4133243371527, 8184.058833234254, 8357.414980951397, 8377.37169712274, 8380.455270407405, 8404.747857564284, 505.96205284603803, 513.7405610166917, 516.2333934107846, 518.157993260951, 519.9428062913076, 6187.474064704461, 6233.875322493524, 6286.8428289292215, 6292.056191571301, 6326.525510586633, 10508.789824203473, 10724.410157441416, 10846.403447810288, 10881.945590271998, 10923.0, 10549.261551691461, 10622.681319560426, 10710.143188545053, 10770.78458430827, 10794.082502987334, 6996.6151861648095, 8339.0, 8343.332533397435, 8439.367047471464, 8448.155184481626, 7760.728374506865, 7853.921460785547, 7897.526148431112, 7949.562774047252, 7997.080335761462, 8840.425372350777, 9435.339526233098, 9499.667511637059, 9540.093691099335, 9563.521823908915, 9665.71002869915, 9806.166475849348, 9969.800603988024, 10021.348612340174, 10166.898331016891, 6348.0, 6780.694868731018, 6978.09284792994, 6997.825054373681, 7102.964485177541, 8194.385421093322, 8274.958625206835, 8279.875801863098, 8317.95841020791, 8345.123762004901, 6507.414332709889, 7331.816704582215, 7406.555606663617, 7488.625568721651, 7631.847363052597, 7303.233160518069, 7359.37445317154, 7359.926400736138, 7416.0, 7422.888656670047, 7700.884486732815, 7771.533707977539, 7784.727534536264, 7800.648970796441, 7877.527348359117, 6292.653904035322, 6466.612003279818, 6968.581885086911, 7035.718571257093, 7081.82295442618, 6018.548608854266, 6044.818655440344, 6158.507319414346, 7142.178649455172, 7252.89120663201], "unit": "score", "name": "mootools.html", "value": 4774.196894451438}, {"lowerIsBetter": false, "replicates": [301.42879243832937, 328.1779143246169, 330.20585491891995, 335.06850954346925, 337.2210194450819, 6889.207741109773, 6897.724091036359, 6924.338158841867, 6925.826854328644, 6955.686994085266, 6717.697703603338, 6828.0, 6868.484863635223, 6884.380405763481, 6892.4830637702125, 4788.162071637467, 4889.26661000851, 4986.800527978877, 4997.075541024922, 5053.4946505349535, 4990.426100998396, 4992.67547609406, 5002.424721157059, 5003.47463516331, 5005.224190250517, 4911.993041426499, 4923.359963204778, 4930.186519224324, 4969.031038947407, 4985.376827896513, 4951.975240123795, 5001.874953126183, 5019.272205530177, 5021.096202683516, 5056.367954005767, 4298.20483210607, 4302.806373713159, 4314.460692413449, 4319.200947824663, 4328.091100868822, 5445.50990410865, 6287.642134199675, 6670.399664030212, 6683.6658167091455, 6702.530822842403, 5861.17943487912, 5915.704214789286, 5917.349091599921, 5917.745240117918, 5943.405659434022, 7302.561846289186, 7394.926050739477, 7403.259674032607, 7405.296496832846, 7418.814529636748, 4697.318888761145, 4719.551642593948, 4730.621550276004, 4737.26572381278, 4739.909820741249, 7388.482806203568, 7683.923160768377, 7772.7668169954995, 7790.415718821111, 7835.96082019592, 3949.0522274653877, 4647.697899636512, 4662.7202367858035, 4718.339432479455, 4756.904861902743, 4819.373481447389, 4822.855314340575, 4825.276208568743, 4856.980034192859, 4859.125357435625, 5572.944270557324, 5711.657300561979, 5881.5000724938, 5886.264216972879, 5893.852653683693, 6422.137580101718, 6967.8606427871155, 7405.074365704287, 7408.888866667005, 7411.85176296471, 1372.4373007067054, 1593.4502596604152, 1669.8413650703164, 1680.2270955360427, 1699.3967141664778, 946.6308139825474, 1045.4318522216674, 1058.1481907064888, 1073.9677809665723, 1074.8011617850723, 5519.917201241985, 6755.695993680198, 6764.289749576322, 6772.492063095287, 6784.0841486399695, 7615.847683046419, 7624.961875190699, 7649.464537482434, 7653.732119375906, 7664.888591154251, 6746.494012949049, 6752.324767523307, 6754.831129221809, 6775.898361524581, 6796.150481189851, 3722.683571896365, 4029.6776257899296, 4063.2076745034433, 4072.0430698785763, 4081.510218773766, 7832.255935686101, 7923.286904178652, 8049.879251811228, 8059.63731632078, 8103.594820259082, 8030.07654119772, 8033.6786528538205, 8033.718819841394, 8045.879311810328, 8048.758537243892, 6459.677016149174, 6949.617771022642, 8080.4243172581955, 8091.231333023354, 8095.9880014998125, 7567.744722689836, 7709.111267739439, 7780.844383112193, 7817.296443320129, 7823.84352312962, 7568.924310756822, 7598.924010759822, 7643.923560764543, 7644.3120119187315, 7666.041744781903, 5761.654300741969, 6680.298568650222, 7707.845843083219, 7878.896954426499, 7883.093444253984, 4760.976195119002, 4771.832985845479, 4772.928406073981, 4778.593819525379, 4797.64017698667, 6307.684615769285, 7458.291462311072, 7723.9227607723205, 7730.92269077302, 7760.45676802641, 7460.0674915635545, 7484.775456736306, 7490.588017659081, 7504.0, 7533.660985255787, 6102.389761023862, 7453.217412171861, 7453.329200371993, 7465.925340746523, 7468.738594149178, 7251.202367739439, 7263.891041634274, 7282.089738782653, 7301.415886729155, 7306.342429181399, 7144.928550714426, 7430.4798664093, 7431.331180193809, 7450.36671882896, 7520.699172033057, 7251.311125443074, 7333.376662983706, 7346.37555807741, 7376.926230737624, 7377.483576149618], "unit": "score", "name": "prototype.html", "value": 5313.092527118227}, {"lowerIsBetter": false, "replicates": [681.7273090763694, 709.8012556484186, 740.3817812126874, 763.1185980192878, 763.6410886883162, 14051.227182504957, 14173.503927362544, 14428.20644864532, 14510.766584840301, 14892.0, 13906.165630062203, 13955.162690238592, 14019.088759230643, 14029.298535073256, 14071.718565628682, 736.8857827036791, 884.783228109111, 906.5739102621757, 910.1308250620641, 913.4245425382001, 919.6873063158524, 923.607466826596, 923.9214666753334, 924.7410724997012, 927.14702473724, 939.4785893828922, 953.1802649721269, 965.0783501755807, 969.6121551379434, 973.0172525749009, 928.972130836076, 944.1172503708985, 957.7078990907805, 967.5936106835076, 969.903009699028, 715.5098757351232, 719.1083057009271, 719.7768691705536, 721.0662192460776, 723.6056349289597, 14809.333579988926, 14820.851791482055, 15043.548693539211, 15058.397664093423, 15125.0, 12798.16811907223, 12812.29532375719, 12851.100422970396, 13050.086493945428, 13263.60209193716, 9986.151177149952, 10040.799184016352, 10060.69817905464, 10077.949610251975, 10096.091351778376, 3438.3123375324785, 3498.6851183393615, 3535.222251104753, 3537.6816086552335, 3546.184377593168, 77770.83343749848, 77916.0, 77993.61003194947, 78098.60950695266, 78314.82527762088, 9282.396644218104, 9408.0, 9543.0, 9573.664921727845, 9916.107550320507, 18398.0, 22068.779312206672, 22068.88965555162, 22081.227157049747, 22095.0, 7288.6720097595735, 7564.092308922965, 7760.18518055596, 7847.882281765778, 7855.960720196476, 3991.760494370289, 4004.4593979812935, 4022.8189731462153, 4093.201825643971, 4107.938380924288, 3427.485877118402, 3538.9646103538635, 3569.1077230692326, 3593.1915319053005, 3616.4213725803747, 637.5600835423636, 642.5341627320156, 645.3901063495045, 646.3149061994301, 651.4625434016955, 515.259218076758, 557.9581531385162, 591.4292707537161, 608.428077607048, 613.6287546034674, 7448.664810083559, 8167.836643267101, 8354.122817104238, 8372.916270837213, 8396.874046889301, 528.5480913818707, 570.8373113662669, 587.2014060877203, 595.559286128262, 600.4205941266698, 3485.9825700871334, 3673.7428380013143, 3824.330742120118, 3891.8637847675195, 4064.6545043671026, 73075.53848922992, 73108.26891731122, 73698.0, 77978.0, 83365.58317208375, 52914.0, 69980.0, 73170.63414682893, 74235.62882185554, 74592.62703686446, 50920.23619645708, 63485.0, 63656.681716592044, 64911.67544162249, 65408.69182616321, 8330.083690794128, 8391.412601117863, 8425.873611895704, 8479.660813567389, 8507.532085735344, 42566.574334256264, 43434.0, 43961.34057989069, 47349.52650473589, 50047.74976125096, 55075.0, 56217.0, 57861.4213857856, 60827.087593687014, 66572.0, 10797.29817561856, 10941.343519388543, 10968.835467467834, 11145.49845256949, 11463.0, 11908.940455298014, 12007.879921200676, 12264.631551608789, 12330.951869091228, 12583.370831458573, 11612.5354985803, 11880.227785193934, 11939.940300298791, 11969.461374238006, 12261.75476490483, 11477.196596238517, 11508.251963622337, 11609.0, 11792.646220613395, 11905.047596192457, 11079.390633515233, 11257.380844053656, 11361.147913906656, 11634.301941883514, 11740.41297935117, 9337.53312334367, 9562.521873906138, 9563.665271715456, 10029.892703013038, 10040.648577300051, 9634.13292803651, 9689.903100969183, 9699.0, 9719.902800972182, 9770.609175632895], "unit": "score", "name": "yui.html", "value": 6799.74625173872}], "name": "dromaeo_css", "value": 7527.421679446619}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 106.0, 116.0, 116.0, 167.0, 142.0, 114.0, 115.0, 116.0, 120.0], "unit": "score", "name": "ai-astar", "value": 122.6}, {"lowerIsBetter": true, "replicates": [157.0, 121.0, 146.0, 160.0, 124.0, 141.0, 141.0, 140.0, 193.0, 151.0], "unit": "score", "name": "audio-beat-detection", "value": 147.4}, {"lowerIsBetter": true, "replicates": [268.0, 254.0, 193.0, 199.0, 252.0, 258.0, 271.0, 214.0, 195.0, 197.0], "unit": "score", "name": "audio-dft", "value": 230.1}, {"lowerIsBetter": true, "replicates": [56.0, 93.0, 77.0, 84.0, 95.0, 58.0, 141.0, 79.0, 79.0, 83.0], "unit": "score", "name": "audio-fft", "value": 84.5}, {"lowerIsBetter": true, "replicates": [78.0, 81.0, 123.0, 76.0, 79.0, 83.0, 120.0, 80.0, 79.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 91.4}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 88.0, 87.0, 90.0, 86.0, 89.0, 86.0, 101.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.3}, {"lowerIsBetter": true, "replicates": [95.0, 115.0, 91.0, 145.0, 137.0, 96.0, 105.0, 142.0, 129.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 115.0}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 94.0, 90.0, 107.0, 131.0, 91.0, 91.0, 90.0, 139.0], "unit": "score", "name": "imaging-desaturate", "value": 101.7}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 54.0, 56.0, 64.0, 67.0, 79.0, 87.0, 58.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 63.3}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 67.0, 78.0, 60.0, 86.0, 96.0, 98.0, 99.0, 94.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 81.8}, {"lowerIsBetter": true, "replicates": [90.0, 108.0, 102.0, 85.0, 88.0, 84.0, 89.0, 85.0, 84.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.2}, {"lowerIsBetter": true, "replicates": [139.0, 139.0, 132.0, 142.0, 121.0, 123.0, 123.0, 129.0, 132.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.0}, {"lowerIsBetter": true, "replicates": [130.0, 142.0, 142.0, 155.0, 175.0, 179.0, 131.0, 144.0, 143.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.2}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 62.0, 97.0, 96.0, 91.0, 92.0, 56.0, 86.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 78.5}], "name": "kraken", "value": 1577.0}]} 16:05:34 INFO - Return code: 0 16:05:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:05:34 ERROR - # TBPL SUCCESS # 16:05:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:05:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:05:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:05:34 INFO - 2016-04-06 16:05:34.604 screenresolution[2292:18202] starting screenresolution argv=screenresolution get 16:05:34 INFO - 2016-04-06 16:05:34.607 screenresolution[2292:18202] Display 0: 1600x1200x32@60 16:05:34 INFO - 2016-04-06 16:05:34.612 screenresolution[2293:18205] starting screenresolution argv=screenresolution list 16:05:34 INFO - Available Modes on Display 0 16:05:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:05:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:05:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:05:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:05:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:05:34 INFO - Intel Iris: 16:05:34 INFO - Chipset Model: Intel Iris 16:05:34 INFO - Type: GPU 16:05:34 INFO - Bus: Built-In 16:05:34 INFO - VRAM (Dynamic, Max): 1536 MB 16:05:34 INFO - Vendor: Intel (0x8086) 16:05:34 INFO - Device ID: 0x0a2e 16:05:34 INFO - Revision ID: 0x0009 16:05:34 INFO - Displays: 16:05:34 INFO - Display: 16:05:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:05:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:05:34 INFO - Display Serial Number: 1600x1200 60 16:05:34 INFO - Main Display: Yes 16:05:34 INFO - Mirror: Off 16:05:34 INFO - Online: Yes 16:05:34 INFO - Rotation: Supported 16:05:34 INFO - Return code: 0 16:05:34 INFO - Running post-action listener: _resource_record_post_action 16:05:34 INFO - Running post-run listener: _resource_record_post_run 16:05:35 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 4096; Write bytes: 697449984; Read time: 0; Write time: 1997 16:05:35 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 379568640; Write bytes: 374658560; Read time: 28004; Write time: 709 16:05:35 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 4096; Write bytes: 301131776; Read time: 0; Write time: 1242 16:05:35 INFO - Running post-run listener: _upload_blobber_files 16:05:35 INFO - Blob upload gear active. 16:05:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:05:35 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:05:35 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:05:35 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:05:36 INFO - (blobuploader) - INFO - Open directory for files ... 16:05:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:05:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:05:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:37 INFO - (blobuploader) - INFO - Done attempting. 16:05:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:05:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:05:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:38 INFO - (blobuploader) - INFO - Done attempting. 16:05:38 INFO - (blobuploader) - INFO - Iteration through files over. 16:05:38 INFO - Return code: 0 16:05:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:05:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:05:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a477efe54b75c620dd41dc11f7db8fbd115d6085b53ecce7f92029409511361d2e2a8bd90cb6e50ee47ac21694d30c844413a043cd7fb8ed2035ca6edf4fc55c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9dde398a1c6cada2f56d3f08811a5d067bab1ef58adc77f87ef9f18e1b5d2dd5c370fa4671c4de578e3298ba1dbe85dda92492afe9af88e52149efc56519fd0e"} 16:05:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:05:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:05:38 INFO - Contents: 16:05:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a477efe54b75c620dd41dc11f7db8fbd115d6085b53ecce7f92029409511361d2e2a8bd90cb6e50ee47ac21694d30c844413a043cd7fb8ed2035ca6edf4fc55c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9dde398a1c6cada2f56d3f08811a5d067bab1ef58adc77f87ef9f18e1b5d2dd5c370fa4671c4de578e3298ba1dbe85dda92492afe9af88e52149efc56519fd0e"} 16:05:38 INFO - Running post-run listener: copy_logs_to_upload_dir 16:05:38 INFO - Copying logs to upload dir... 16:05:38 INFO - mkdir: /builds/slave/test/build/upload/logs 16:05:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1304.454947 ========= master_lag: 4.41 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 48 secs) (at 2016-04-06 16:05:42.890069) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 16:05:42.895764) ========= 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.fC2x3yAfRT/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.lWWxxruTXe/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a477efe54b75c620dd41dc11f7db8fbd115d6085b53ecce7f92029409511361d2e2a8bd90cb6e50ee47ac21694d30c844413a043cd7fb8ed2035ca6edf4fc55c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9dde398a1c6cada2f56d3f08811a5d067bab1ef58adc77f87ef9f18e1b5d2dd5c370fa4671c4de578e3298ba1dbe85dda92492afe9af88e52149efc56519fd0e"} build_url:https://queue.taskcluster.net/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011238 build_url: 'https://queue.taskcluster.net/v1/task/K67dFzEKQp6t48T3zTf6kg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a477efe54b75c620dd41dc11f7db8fbd115d6085b53ecce7f92029409511361d2e2a8bd90cb6e50ee47ac21694d30c844413a043cd7fb8ed2035ca6edf4fc55c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9dde398a1c6cada2f56d3f08811a5d067bab1ef58adc77f87ef9f18e1b5d2dd5c370fa4671c4de578e3298ba1dbe85dda92492afe9af88e52149efc56519fd0e"}' ========= master_lag: 0.56 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-06 16:05:43.465061) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 16:05:43.465393) ========= 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.fC2x3yAfRT/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.lWWxxruTXe/Listeners TMPDIR=/var/folders/yy/pzwmkny90h5716w0lfhkq8zh00000w/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.005156 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-06 16:05:43.495146) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 16:05:43.495433) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-06 16:05:43.495850) ========= ========= Total master_lag: 5.22 =========