builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0178 starttime: 1456334942.6 results: success (0) buildid: 20160224082844 builduid: b35ed84b2eda4fcb882520d41f72eab5 revision: 254c6ce06541ff04ed083dbc58623a4a2cebb110 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.597454) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.597949) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.598239) ========= 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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005378 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.620310) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.620588) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.636116) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.636373) ========= 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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005348 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.684433) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.684710) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.685058) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.685327) ========= 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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-24 09:29:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.2M=0.001s 2016-02-24 09:29:02 (13.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.161114 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.861730) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.862053) ========= 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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.020565 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:02.910822) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-24 09:29:02.911186) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 254c6ce06541ff04ed083dbc58623a4a2cebb110 --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 254c6ce06541ff04ed083dbc58623a4a2cebb110 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eexlwtdmyk/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.Cg7G2wpcm7/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-24 09:29:02,991 truncating revision to first 12 chars 2016-02-24 09:29:02,991 Setting DEBUG logging. 2016-02-24 09:29:02,991 attempt 1/10 2016-02-24 09:29:02,991 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/254c6ce06541?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 09:29:04,890 unpacking tar archive at: fx-team-254c6ce06541/testing/mozharness/ program finished with exit code 0 elapsedTime=2.145284 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-24 09:29:05.073893) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:05.074329) ========= echo 254c6ce06541ff04ed083dbc58623a4a2cebb110 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'254c6ce06541ff04ed083dbc58623a4a2cebb110'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eexlwtdmyk/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.Cg7G2wpcm7/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 254c6ce06541ff04ed083dbc58623a4a2cebb110 program finished with exit code 0 elapsedTime=0.004918 script_repo_revision: '254c6ce06541ff04ed083dbc58623a4a2cebb110' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:05.125670) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:05.126063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 09:29:05.139252) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-24 09:29:05.139600) ========= /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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 09:29:05 INFO - MultiFileLogger online at 20160224 09:29:05 in /builds/slave/test 09:29:05 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 09:29:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:29:05 INFO - {'append_to_log': False, 09:29:05 INFO - 'base_work_dir': '/builds/slave/test', 09:29:05 INFO - 'blob_upload_branch': 'Fx-Team', 09:29:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:29:05 INFO - 'branch': 'Fx-Team', 09:29:05 INFO - 'buildbot_json_path': 'buildprops.json', 09:29:05 INFO - 'config_files': ('talos/mac_config.py',), 09:29:05 INFO - 'default_actions': ('clobber', 09:29:05 INFO - 'read-buildbot-config', 09:29:05 INFO - 'download-and-extract', 09:29:05 INFO - 'populate-webroot', 09:29:05 INFO - 'create-virtualenv', 09:29:05 INFO - 'install', 09:29:05 INFO - 'run-tests'), 09:29:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:29:05 INFO - 'download_minidump_stackwalk': True, 09:29:05 INFO - 'download_symbols': 'ondemand', 09:29:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:29:05 INFO - 'tooltool.py': '/tools/tooltool.py', 09:29:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:29:05 INFO - '/tools/misc-python/virtualenv.py')}, 09:29:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:29:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:29:05 INFO - 'installer_path': 'installer.exe', 09:29:05 INFO - 'log_level': 'info', 09:29:05 INFO - 'log_name': 'talos', 09:29:05 INFO - 'log_to_console': True, 09:29:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:29:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:29:05 INFO - 'opt_config_files': (), 09:29:05 INFO - 'pip_index': False, 09:29:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:29:05 INFO - 'cmd': ('bash', 09:29:05 INFO - '-c', 09:29:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:29:05 INFO - 'enabled': True, 09:29:05 INFO - 'halt_on_failure': False, 09:29:05 INFO - 'name': 'check_screen_resolution'},), 09:29:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:29:05 INFO - 'cmd': ('bash', 09:29:05 INFO - '-c', 09:29:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:29:05 INFO - 'enabled': True, 09:29:05 INFO - 'halt_on_failure': False, 09:29:05 INFO - 'name': 'check_screen_resolution'},), 09:29:05 INFO - 'run_cmd_checks_enabled': True, 09:29:05 INFO - 'sps_profile': False, 09:29:05 INFO - 'sps_profile_interval': 0, 09:29:05 INFO - 'suite': 'dromaeojs-e10s', 09:29:05 INFO - 'system_bits': '32', 09:29:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:29:05 INFO - 'title': 't-yosemite-r7-0178', 09:29:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:29:05 INFO - 'use_talos_json': True, 09:29:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:29:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:29:05 INFO - 'work_dir': 'build'} 09:29:05 INFO - ##### 09:29:05 INFO - ##### Running clobber step. 09:29:05 INFO - ##### 09:29:05 INFO - Running pre-action listener: _resource_record_pre_action 09:29:05 INFO - Running main action method: clobber 09:29:05 INFO - rmtree: /builds/slave/test/build 09:29:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:29:05 INFO - Running post-action listener: _resource_record_post_action 09:29:05 INFO - ##### 09:29:05 INFO - ##### Running read-buildbot-config step. 09:29:05 INFO - ##### 09:29:05 INFO - Running pre-action listener: _resource_record_pre_action 09:29:05 INFO - Running main action method: read_buildbot_config 09:29:05 INFO - Using buildbot properties: 09:29:05 INFO - { 09:29:05 INFO - "project": "", 09:29:05 INFO - "product": "firefox", 09:29:05 INFO - "script_repo_revision": "production", 09:29:05 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:29:05 INFO - "repository": "", 09:29:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:29:05 INFO - "buildid": "20160224082844", 09:29:05 INFO - "pgo_build": "False", 09:29:05 INFO - "basedir": "/builds/slave/test", 09:29:05 INFO - "buildnumber": 412, 09:29:05 INFO - "slavename": "t-yosemite-r7-0178", 09:29:05 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 09:29:05 INFO - "platform": "yosemite_r7", 09:29:05 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:29:05 INFO - "branch": "fx-team", 09:29:05 INFO - "repo_path": "integration/fx-team", 09:29:05 INFO - "revision": "254c6ce06541ff04ed083dbc58623a4a2cebb110", 09:29:05 INFO - "stage_platform": "macosx64", 09:29:05 INFO - "builduid": "b35ed84b2eda4fcb882520d41f72eab5", 09:29:05 INFO - "slavebuilddir": "test" 09:29:05 INFO - } 09:29:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 09:29:05 INFO - Running post-action listener: _resource_record_post_action 09:29:05 INFO - ##### 09:29:05 INFO - ##### Running download-and-extract step. 09:29:05 INFO - ##### 09:29:05 INFO - Running pre-action listener: _resource_record_pre_action 09:29:05 INFO - Running main action method: download_and_extract 09:29:05 INFO - mkdir: /builds/slave/test/build/tests 09:29:05 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')]} 09:29:05 INFO - https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:29:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/test_packages.json 09:29:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/test_packages.json 09:29:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:29:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:29:06 INFO - Downloaded 1277 bytes. 09:29:06 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:29:06 INFO - Using the following test package requirements: 09:29:06 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:29:06 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:29:06 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 09:29:06 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:29:06 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 09:29:06 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:29:06 INFO - u'jsshell-mac.zip'], 09:29:06 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:29:06 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 09:29:06 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:29:06 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:29:06 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 09:29:06 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:29:06 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 09:29:06 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:29:06 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 09:29:06 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:29:06 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:29:06 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 09:29:06 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:29:06 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')]} 09:29:06 INFO - https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:29:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:29:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:29:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:29:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:29:07 INFO - Downloaded 17827707 bytes. 09:29:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:29:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:29:10 INFO - Return code: 0 09:29:10 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:29: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')]} 09:29:10 INFO - https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:29:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:29:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:29:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:29:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:29:12 INFO - Downloaded 17827707 bytes. 09:29:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:29:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:29:15 INFO - Return code: 0 09:29:15 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')]} 09:29:15 INFO - https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:29:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:29:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:29:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:29:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:29:16 INFO - Downloaded 10707015 bytes. 09:29:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:29:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:29:16 INFO - Return code: 0 09:29:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:16 INFO - https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:29:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:29:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:29:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 09:29:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 09:29:20 INFO - Downloaded 111441828 bytes. 09:29:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:29:20 INFO - mkdir: /builds/slave/test/properties 09:29:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:29:20 INFO - Writing to file /builds/slave/test/properties/build_url 09:29:20 INFO - Contents: 09:29:20 INFO - build_url:https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:29:21 INFO - Running post-action listener: _resource_record_post_action 09:29:21 INFO - Running post-action listener: set_extra_try_arguments 09:29:21 INFO - ##### 09:29:21 INFO - ##### Running populate-webroot step. 09:29:21 INFO - ##### 09:29:21 INFO - Running pre-action listener: _resource_record_pre_action 09:29:21 INFO - Running main action method: populate_webroot 09:29:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:29:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:29:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:29:21 INFO - '--tppagecycles', 09:29:21 INFO - '7'], 09:29:21 INFO - 'tests': ['tsvgm']}}, 09:29:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:29:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:29:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:29:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:29:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:29:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:29:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:21 INFO - 'talos_options': ['--e10s'], 09:29:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:29:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:21 INFO - 'tests': ['damp', 'tps']}, 09:29:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:21 INFO - 'talos_options': ['--e10s'], 09:29:21 INFO - 'tests': ['damp', 'tps']}, 09:29:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:29:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:29:21 INFO - 'other': {'tests': ['a11yr', 09:29:21 INFO - 'ts_paint', 09:29:21 INFO - 'tpaint', 09:29:21 INFO - 'sessionrestore', 09:29:21 INFO - 'sessionrestore_no_auto_restore']}, 09:29:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:29:21 INFO - 'tests': ['a11yr', 09:29:21 INFO - 'ts_paint', 09:29:21 INFO - 'tpaint', 09:29:21 INFO - 'sessionrestore', 09:29:21 INFO - 'sessionrestore_no_auto_restore']}, 09:29:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:29:21 INFO - 'tests': ['a11yr', 09:29:21 INFO - 'ts_paint', 09:29:21 INFO - 'tpaint', 09:29:21 INFO - 'sessionrestore', 09:29:21 INFO - 'sessionrestore_no_auto_restore']}, 09:29:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:29:21 INFO - 'tests': ['a11yr', 09:29:21 INFO - 'ts_paint', 09:29:21 INFO - 'tpaint', 09:29:21 INFO - 'sessionrestore', 09:29:21 INFO - 'sessionrestore_no_auto_restore']}, 09:29:21 INFO - 'other_l64': {'tests': ['a11yr', 09:29:21 INFO - 'ts_paint', 09:29:21 INFO - 'tpaint', 09:29:21 INFO - 'sessionrestore', 09:29:21 INFO - 'sessionrestore_no_auto_restore']}, 09:29:21 INFO - 'other_nol64': {'tests': ['a11yr', 09:29:21 INFO - 'ts_paint', 09:29:21 INFO - 'tpaint', 09:29:21 INFO - 'sessionrestore', 09:29:21 INFO - 'sessionrestore_no_auto_restore']}, 09:29:21 INFO - 'svgr': {'tests': ['tsvgx', 09:29:21 INFO - 'tsvgr_opacity', 09:29:21 INFO - 'tart', 09:29:21 INFO - 'tscrollx', 09:29:21 INFO - 'cart']}, 09:29:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:29:21 INFO - 'tests': ['tsvgx', 09:29:21 INFO - 'tsvgr_opacity', 09:29:21 INFO - 'tart', 09:29:21 INFO - 'tscrollx', 09:29:21 INFO - 'cart']}, 09:29:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:21 INFO - 'tests': ['tp5o']}, 09:29:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:21 INFO - 'talos_options': ['--e10s'], 09:29:21 INFO - 'tests': ['tp5o']}, 09:29:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:21 INFO - 'talos_options': ['--xperf_path', 09:29:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:21 INFO - 'tests': ['tp5n']}, 09:29:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:29:21 INFO - 'talos_options': ['--e10s', 09:29:21 INFO - '--xperf_path', 09:29:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:29:21 INFO - 'tests': ['tp5n']}}, 09:29:21 INFO - 'talos.zip': {'path': '', 09:29:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:29:21 INFO - Running post-action listener: _resource_record_post_action 09:29:21 INFO - ##### 09:29:21 INFO - ##### Running create-virtualenv step. 09:29:21 INFO - ##### 09:29:21 INFO - Running pre-action listener: _resource_record_pre_action 09:29:21 INFO - Running main action method: create_virtualenv 09:29:21 INFO - Creating virtualenv /builds/slave/test/build/venv 09:29:21 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 09:29:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:29:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:29:21 INFO - Using real prefix '/tools/python27' 09:29:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:29:22 INFO - Installing distribute.............................................................................................................................................................................................done. 09:29:24 INFO - Installing pip.................done. 09:29:24 INFO - Return code: 0 09:29:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1095daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa13b4a0f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10947ed30>, '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 0x1092a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109475b20>, '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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 09:29:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:29:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:29:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eexlwtdmyk/Render', 09:29:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:24 INFO - 'HOME': '/Users/cltbld', 09:29:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:24 INFO - 'LOGNAME': 'cltbld', 09:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:24 INFO - 'MOZ_NO_REMOTE': '1', 09:29:24 INFO - 'NO_EM_RESTART': '1', 09:29:24 INFO - 'PAGER': '/bin/cat', 09:29:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:24 INFO - 'PWD': '/builds/slave/test', 09:29:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:24 INFO - 'SHELL': '/bin/bash', 09:29:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cg7G2wpcm7/Listeners', 09:29:24 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 09:29:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:24 INFO - 'USER': 'cltbld', 09:29:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:24 INFO - 'XPC_FLAGS': '0x0', 09:29:24 INFO - 'XPC_SERVICE_NAME': '0', 09:29:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:25 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 09:29:25 INFO - Cleaning up... 09:29:25 INFO - Return code: 0 09:29:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:29: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')]} 09:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29: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')]} 09:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:25 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 0x1095daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa13b4a0f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10947ed30>, '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 0x1092a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109475b20>, '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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 09:29:25 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 09:29:25 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 09:29:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eexlwtdmyk/Render', 09:29:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:25 INFO - 'HOME': '/Users/cltbld', 09:29:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:25 INFO - 'LOGNAME': 'cltbld', 09:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:25 INFO - 'MOZ_NO_REMOTE': '1', 09:29:25 INFO - 'NO_EM_RESTART': '1', 09:29:25 INFO - 'PAGER': '/bin/cat', 09:29:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:25 INFO - 'PWD': '/builds/slave/test', 09:29:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:25 INFO - 'SHELL': '/bin/bash', 09:29:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cg7G2wpcm7/Listeners', 09:29:25 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 09:29:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:25 INFO - 'USER': 'cltbld', 09:29:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:25 INFO - 'XPC_FLAGS': '0x0', 09:29:25 INFO - 'XPC_SERVICE_NAME': '0', 09:29:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:25 INFO - Downloading/unpacking psutil>=0.7.1 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29: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 09:29:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:29:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:27 INFO - Installing collected packages: psutil 09:29:27 INFO - Running setup.py install for psutil 09:29:28 INFO - building 'psutil._psutil_osx' extension 09:29:28 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 09:29:28 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 09:29:28 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 09:29:28 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 09:29:28 INFO - building 'psutil._psutil_posix' extension 09:29:28 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 09:29:28 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:29:28 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:29:28 INFO - ^ 09:29:28 INFO - 1 warning generated. 09:29:28 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 09:29:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:29:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:29:28 INFO - Successfully installed psutil 09:29:28 INFO - Cleaning up... 09:29:28 INFO - Return code: 0 09:29:28 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:28 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 0x1095daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa13b4a0f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10947ed30>, '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 0x1092a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109475b20>, '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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 09:29:28 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 09:29:28 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 09:29:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eexlwtdmyk/Render', 09:29:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:28 INFO - 'HOME': '/Users/cltbld', 09:29:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:28 INFO - 'LOGNAME': 'cltbld', 09:29:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:28 INFO - 'MOZ_NO_REMOTE': '1', 09:29:28 INFO - 'NO_EM_RESTART': '1', 09:29:28 INFO - 'PAGER': '/bin/cat', 09:29:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:28 INFO - 'PWD': '/builds/slave/test', 09:29:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:28 INFO - 'SHELL': '/bin/bash', 09:29:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cg7G2wpcm7/Listeners', 09:29:28 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 09:29:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:28 INFO - 'USER': 'cltbld', 09:29:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:28 INFO - 'XPC_FLAGS': '0x0', 09:29:28 INFO - 'XPC_SERVICE_NAME': '0', 09:29:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:29:29 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 09:29:29 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 09:29:29 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 09:29:29 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 09:29:29 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 09:29:29 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 09:29:31 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:29:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:29:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:29:31 INFO - Installing collected packages: mozsystemmonitor 09:29:31 INFO - Running setup.py install for mozsystemmonitor 09:29:31 INFO - Successfully installed mozsystemmonitor 09:29:31 INFO - Cleaning up... 09:29:31 INFO - Return code: 0 09:29:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:29:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:31 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 0x1095daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa13b4a0f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10947ed30>, '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 0x1092a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109475b20>, '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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 09:29:31 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 09:29:31 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 09:29:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eexlwtdmyk/Render', 09:29:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:31 INFO - 'HOME': '/Users/cltbld', 09:29:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:31 INFO - 'LOGNAME': 'cltbld', 09:29:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:31 INFO - 'MOZ_NO_REMOTE': '1', 09:29:31 INFO - 'NO_EM_RESTART': '1', 09:29:31 INFO - 'PAGER': '/bin/cat', 09:29:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:31 INFO - 'PWD': '/builds/slave/test', 09:29:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:31 INFO - 'SHELL': '/bin/bash', 09:29:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cg7G2wpcm7/Listeners', 09:29:31 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 09:29:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:31 INFO - 'USER': 'cltbld', 09:29:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:31 INFO - 'XPC_FLAGS': '0x0', 09:29:31 INFO - 'XPC_SERVICE_NAME': '0', 09:29:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:29:32 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 09:29:32 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 09:29:32 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 09:29:32 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 09:29:32 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 09:29:32 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 09:29:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:29:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:29:34 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 09:29:34 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 09:29:34 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 09:29:34 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 09:29:34 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 09:29:34 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 09:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:29:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:35 INFO - Downloading docopt-0.6.1.tar.gz 09:29:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:29:35 INFO - Installing collected packages: blobuploader, requests, docopt 09:29:35 INFO - Running setup.py install for blobuploader 09:29:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:29:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:29:35 INFO - Running setup.py install for requests 09:29:36 INFO - Running setup.py install for docopt 09:29:36 INFO - Successfully installed blobuploader requests docopt 09:29:36 INFO - Cleaning up... 09:29:36 INFO - Return code: 0 09:29:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:36 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')]} 09:29:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:36 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')]} 09:29:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:36 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 0x1095daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa13b4a0f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10947ed30>, '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 0x1092a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109475b20>, '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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 09:29:36 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 09:29:36 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 09:29:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eexlwtdmyk/Render', 09:29:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:36 INFO - 'HOME': '/Users/cltbld', 09:29:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:36 INFO - 'LOGNAME': 'cltbld', 09:29:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:36 INFO - 'MOZ_NO_REMOTE': '1', 09:29:36 INFO - 'NO_EM_RESTART': '1', 09:29:36 INFO - 'PAGER': '/bin/cat', 09:29:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:36 INFO - 'PWD': '/builds/slave/test', 09:29:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:36 INFO - 'SHELL': '/bin/bash', 09:29:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cg7G2wpcm7/Listeners', 09:29:36 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 09:29:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:36 INFO - 'USER': 'cltbld', 09:29:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:36 INFO - 'XPC_FLAGS': '0x0', 09:29:36 INFO - 'XPC_SERVICE_NAME': '0', 09:29:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:29:36 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-xym8De-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:29:36 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-H2Z4F1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:29:36 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ZJHQuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:29:37 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-DotMOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:29:37 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-qO53t8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:29:37 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-CZ3eqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:29:37 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-OSUJ59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:29:37 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-mskciX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:29:37 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-QEOElM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:29:37 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-pre9o2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:29:37 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-zrpDec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:29:37 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-4KSrb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:29:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:29:37 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-E8Og8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:29:38 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-assKIm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:38 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-5xXQsY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:29:38 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-U1SCSt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:29:38 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-1FOg_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:29:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:29:38 INFO - Running setup.py install for manifestparser 09:29:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:29:38 INFO - Running setup.py install for mozcrash 09:29:38 INFO - Running setup.py install for mozdebug 09:29:38 INFO - Running setup.py install for mozdevice 09:29:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:29:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:29:39 INFO - Running setup.py install for mozfile 09:29:39 INFO - Running setup.py install for mozhttpd 09:29:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:29:39 INFO - Running setup.py install for mozinfo 09:29:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:29:39 INFO - Running setup.py install for mozInstall 09:29:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:29:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:29:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:29:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:29:39 INFO - Running setup.py install for mozleak 09:29:39 INFO - Running setup.py install for mozlog 09:29:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:29:39 INFO - Running setup.py install for moznetwork 09:29:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:29:40 INFO - Running setup.py install for mozprocess 09:29:40 INFO - Running setup.py install for mozprofile 09:29:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:29:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:29:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:29:40 INFO - Running setup.py install for mozrunner 09:29:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:29:40 INFO - Running setup.py install for mozscreenshot 09:29:40 INFO - Running setup.py install for moztest 09:29:40 INFO - Running setup.py install for mozversion 09:29:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:29:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:29:40 INFO - Cleaning up... 09:29:41 INFO - Return code: 0 09:29:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:41 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 0x1095daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa13b4a0f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10947ed30>, '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 0x1092a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109475b20>, '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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 09:29:41 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 09:29:41 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 09:29:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eexlwtdmyk/Render', 09:29:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:41 INFO - 'HOME': '/Users/cltbld', 09:29:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:41 INFO - 'LOGNAME': 'cltbld', 09:29:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:41 INFO - 'MOZ_NO_REMOTE': '1', 09:29:41 INFO - 'NO_EM_RESTART': '1', 09:29:41 INFO - 'PAGER': '/bin/cat', 09:29:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:41 INFO - 'PWD': '/builds/slave/test', 09:29:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:41 INFO - 'SHELL': '/bin/bash', 09:29:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cg7G2wpcm7/Listeners', 09:29:41 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 09:29:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:41 INFO - 'USER': 'cltbld', 09:29:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:41 INFO - 'XPC_FLAGS': '0x0', 09:29:41 INFO - 'XPC_SERVICE_NAME': '0', 09:29:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:29:41 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-s9Hb8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:29:41 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)) 09:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:29:41 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-iY1hvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:29:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:29:41 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-EUtlWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:29:41 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)) 09:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:29:41 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-yVEjxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:29:41 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)) 09:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:29:41 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-eMcvOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:29:41 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)) 09:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:29:41 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-EudTs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:29:41 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)) 09:29:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:29:41 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-a0fGMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:29:42 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)) 09:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:29:42 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-rc9I1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:29:42 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)) 09:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:29:42 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-qeUTRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:29:42 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)) 09:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:29:42 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-e8Lq_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:29:42 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)) 09:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:29:42 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-EZuaxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:29:42 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)) 09:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:29:42 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-dKA90z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:29:42 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)) 09:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:29:42 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-eOSRF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:29:42 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)) 09:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:29:42 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-q5epmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:29:42 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)) 09:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:42 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-GJ83QP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:29:42 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)) 09:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:29:42 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-aadEHM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:29:42 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)) 09:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:29:42 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-cj50b5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:29:43 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)) 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:29:43 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)) 09:29:43 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)) 09:29:43 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)) 09:29:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:45 INFO - Downloading blessings-1.6.tar.gz 09:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:29:45 INFO - Installing collected packages: blessings 09:29:45 INFO - Running setup.py install for blessings 09:29:45 INFO - Successfully installed blessings 09:29:45 INFO - Cleaning up... 09:29:45 INFO - Return code: 0 09:29:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:45 INFO - Reading from file tmpfile_stdout 09:29:45 INFO - Current package versions: 09:29:45 INFO - blessings == 1.6 09:29:45 INFO - blobuploader == 1.2.4 09:29:45 INFO - docopt == 0.6.1 09:29:45 INFO - manifestparser == 1.1 09:29:45 INFO - mozInstall == 1.12 09:29:45 INFO - mozcrash == 0.16 09:29:45 INFO - mozdebug == 0.1 09:29:45 INFO - mozdevice == 0.48 09:29:45 INFO - mozfile == 1.2 09:29:45 INFO - mozhttpd == 0.7 09:29:45 INFO - mozinfo == 0.9 09:29:45 INFO - mozleak == 0.1 09:29:45 INFO - mozlog == 3.1 09:29:45 INFO - moznetwork == 0.27 09:29:45 INFO - mozprocess == 0.22 09:29:45 INFO - mozprofile == 0.28 09:29:45 INFO - mozrunner == 6.11 09:29:45 INFO - mozscreenshot == 0.1 09:29:45 INFO - mozsystemmonitor == 0.0 09:29:45 INFO - moztest == 0.7 09:29:45 INFO - mozversion == 1.4 09:29:45 INFO - psutil == 3.1.1 09:29:45 INFO - requests == 1.2.3 09:29:45 INFO - wsgiref == 0.1.2 09:29:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:29:45 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')]} 09:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:45 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')]} 09:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:46 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 0x1095daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa13b4a0f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10947ed30>, '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 0x1092a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109475b20>, '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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 09:29:46 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 09:29:46 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 09:29:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eexlwtdmyk/Render', 09:29:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:46 INFO - 'HOME': '/Users/cltbld', 09:29:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:46 INFO - 'LOGNAME': 'cltbld', 09:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:46 INFO - 'MOZ_NO_REMOTE': '1', 09:29:46 INFO - 'NO_EM_RESTART': '1', 09:29:46 INFO - 'PAGER': '/bin/cat', 09:29:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:46 INFO - 'PWD': '/builds/slave/test', 09:29:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:46 INFO - 'SHELL': '/bin/bash', 09:29:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cg7G2wpcm7/Listeners', 09:29:46 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 09:29:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:46 INFO - 'USER': 'cltbld', 09:29:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:46 INFO - 'XPC_FLAGS': '0x0', 09:29:46 INFO - 'XPC_SERVICE_NAME': '0', 09:29:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:46 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)) 09:29:46 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)) 09:29:46 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)) 09:29:46 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)) 09:29:46 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)) 09:29:46 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)) 09:29:46 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)) 09:29:46 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)) 09:29:46 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)) 09:29:46 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)) 09:29:46 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)) 09:29:46 INFO - Cleaning up... 09:29:46 INFO - Return code: 0 09:29:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:46 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 0x1095daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa13b4a0f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10947ed30>, '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 0x1092a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109475b20>, '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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 09:29:46 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 09:29:46 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 09:29:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eexlwtdmyk/Render', 09:29:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:46 INFO - 'HOME': '/Users/cltbld', 09:29:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:46 INFO - 'LOGNAME': 'cltbld', 09:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:46 INFO - 'MOZ_NO_REMOTE': '1', 09:29:46 INFO - 'NO_EM_RESTART': '1', 09:29:46 INFO - 'PAGER': '/bin/cat', 09:29:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:46 INFO - 'PWD': '/builds/slave/test', 09:29:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:46 INFO - 'SHELL': '/bin/bash', 09:29:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cg7G2wpcm7/Listeners', 09:29:46 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 09:29:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:46 INFO - 'USER': 'cltbld', 09:29:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:46 INFO - 'XPC_FLAGS': '0x0', 09:29:46 INFO - 'XPC_SERVICE_NAME': '0', 09:29:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:46 INFO - Downloading/unpacking jsonschema 09:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:29:48 INFO - Downloading/unpacking functools32 (from jsonschema) 09:29:48 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 09:29:48 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 09:29:48 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 09:29:48 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 09:29:48 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 09:29:48 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 09:29:49 INFO - Downloading functools32-3.2.3-2.tar.gz 09:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:29:49 INFO - warning: no files found matching '*.txt' 09:29:49 INFO - no previously-included directories found matching 'build' 09:29:49 INFO - no previously-included directories found matching 'dist' 09:29:49 INFO - no previously-included directories found matching '.git*' 09:29:49 INFO - Installing collected packages: jsonschema, functools32 09:29:49 INFO - Running setup.py install for functools32 09:29:49 INFO - warning: no files found matching '*.txt' 09:29:49 INFO - no previously-included directories found matching 'build' 09:29:49 INFO - no previously-included directories found matching 'dist' 09:29:49 INFO - no previously-included directories found matching '.git*' 09:29:49 INFO - Successfully installed jsonschema functools32 09:29:49 INFO - Cleaning up... 09:29:49 INFO - Return code: 0 09:29:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:29:49 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')]} 09:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:49 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')]} 09:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:29:49 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 0x1095daa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095e14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa13b4a0f80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10947ed30>, '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 0x1092a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109475b20>, '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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 09:29:49 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 09:29:49 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 09:29:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eexlwtdmyk/Render', 09:29:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:29:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:29:49 INFO - 'HOME': '/Users/cltbld', 09:29:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:29:49 INFO - 'LOGNAME': 'cltbld', 09:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:29:49 INFO - 'MOZ_NO_REMOTE': '1', 09:29:49 INFO - 'NO_EM_RESTART': '1', 09:29:49 INFO - 'PAGER': '/bin/cat', 09:29:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:29:49 INFO - 'PWD': '/builds/slave/test', 09:29:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:29:49 INFO - 'SHELL': '/bin/bash', 09:29:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cg7G2wpcm7/Listeners', 09:29:49 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 09:29:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:29:49 INFO - 'USER': 'cltbld', 09:29:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:29:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:29:49 INFO - 'XPC_FLAGS': '0x0', 09:29:49 INFO - 'XPC_SERVICE_NAME': '0', 09:29:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:29:49 INFO - Downloading/unpacking flake8 09:29:49 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 09:29:49 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 09:29:49 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 09:29:49 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 09:29:49 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 09:29:49 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 09:29:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:29:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:52 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 09:29:52 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 09:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:29:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:52 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 09:29:52 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 09:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:52 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 09:29:52 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 09:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:29:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:29:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:29:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:29:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:29:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:29:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:29:53 INFO - no previously-included directories found matching 'docs/_build' 09:29:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:29:53 INFO - Running setup.py install for pep8 09:29:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:29:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:29:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:29:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:29:53 INFO - no previously-included directories found matching 'docs/_build' 09:29:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:29:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:29:53 INFO - Cleaning up... 09:29:53 INFO - Return code: 0 09:29:53 INFO - Running post-action listener: _resource_record_post_action 09:29:53 INFO - Running post-action listener: _start_resource_monitoring 09:29:53 INFO - Starting resource monitoring. 09:29:53 INFO - ##### 09:29:53 INFO - ##### Running install step. 09:29:53 INFO - ##### 09:29:53 INFO - Running pre-action listener: _resource_record_pre_action 09:29:53 INFO - Running main action method: install 09:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:29:53 INFO - Reading from file tmpfile_stdout 09:29:53 INFO - Detecting whether we're running mozinstall >=1.0... 09:29:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:29:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:29:54 INFO - Reading from file tmpfile_stdout 09:29:54 INFO - Output received: 09:29:54 INFO - Usage: mozinstall [options] installer 09:29:54 INFO - Options: 09:29:54 INFO - -h, --help show this help message and exit 09:29:54 INFO - -d DEST, --destination=DEST 09:29:54 INFO - Directory to install application into. [default: 09:29:54 INFO - "/builds/slave/test"] 09:29:54 INFO - --app=APP Application being installed. [default: firefox] 09:29:54 INFO - mkdir: /builds/slave/test/build/application 09:29:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:29:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:30:27 INFO - Reading from file tmpfile_stdout 09:30:27 INFO - Output received: 09:30:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:30:27 INFO - Running post-action listener: _resource_record_post_action 09:30:27 INFO - ##### 09:30:27 INFO - ##### Running run-tests step. 09:30:27 INFO - ##### 09:30:27 INFO - Running pre-action listener: _resource_record_pre_action 09:30:27 INFO - Running main action method: run_tests 09:30:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:30:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:30:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:30:27 INFO - 2016-02-24 09:30:27.664 screenresolution[1920:9131] starting screenresolution argv=screenresolution get 09:30:27 INFO - 2016-02-24 09:30:27.667 screenresolution[1920:9131] Display 0: 1600x1200x32@60 09:30:27 INFO - 2016-02-24 09:30:27.672 screenresolution[1921:9133] starting screenresolution argv=screenresolution list 09:30:27 INFO - Available Modes on Display 0 09:30:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:30:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:30:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:30:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:30:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:30:27 INFO - Intel Iris: 09:30:27 INFO - Chipset Model: Intel Iris 09:30:27 INFO - Type: GPU 09:30:27 INFO - Bus: Built-In 09:30:27 INFO - VRAM (Dynamic, Max): 1536 MB 09:30:27 INFO - Vendor: Intel (0x8086) 09:30:27 INFO - Device ID: 0x0a2e 09:30:27 INFO - Revision ID: 0x0009 09:30:27 INFO - Displays: 09:30:27 INFO - Display: 09:30:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:30:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:30:27 INFO - Display Serial Number: 1600x1200 60 09:30:27 INFO - Main Display: Yes 09:30:27 INFO - Mirror: Off 09:30:27 INFO - Online: Yes 09:30:27 INFO - Rotation: Supported 09:30:27 INFO - Return code: 0 09:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:30:27 INFO - Python 2.7.3 09:30:27 INFO - Return code: 0 09:30:27 INFO - grabbing minidump binary from tooltool 09:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:30:27 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 0x10947ed30>, '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 0x1092a2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109475b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:30:27 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 09:30:27 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 09:30:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:30:27 INFO - Return code: 0 09:30:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:30:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:30:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:30:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:30:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:30:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:30:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:30:29 INFO - Return code: 0 09:30:29 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/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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 09:30:29 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/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0178 --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 09:30:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eexlwtdmyk/Render', 09:30:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:30:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:30:29 INFO - 'HOME': '/Users/cltbld', 09:30:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:30:29 INFO - 'LOGNAME': 'cltbld', 09:30:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:30:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:30:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:30:29 INFO - 'MOZ_NO_REMOTE': '1', 09:30:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:30:29 INFO - 'NO_EM_RESTART': '1', 09:30:29 INFO - 'PAGER': '/bin/cat', 09:30:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:30:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:30:29 INFO - 'PWD': '/builds/slave/test', 09:30:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:30:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:30:29 INFO - 'SHELL': '/bin/bash', 09:30:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Cg7G2wpcm7/Listeners', 09:30:29 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 09:30:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:30:29 INFO - 'USER': 'cltbld', 09:30:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:30:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:30:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:30:29 INFO - 'XPC_FLAGS': '0x0', 09:30:29 INFO - 'XPC_SERVICE_NAME': '0', 09:30:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:30:29 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/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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 09:30:29 INFO - mozversion application_buildid: 20160224082844 09:30:29 INFO - mozversion application_changeset: 254c6ce06541ff04ed083dbc58623a4a2cebb110 09:30:29 INFO - mozversion application_display_name: Nightly 09:30:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:30:29 INFO - mozversion application_name: Firefox 09:30:29 INFO - mozversion application_remotingname: firefox 09:30:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:30:29 INFO - mozversion application_vendor: Mozilla 09:30:29 INFO - mozversion application_version: 47.0a1 09:30:29 INFO - mozversion platform_buildid: 20160224082844 09:30:29 INFO - mozversion platform_changeset: 254c6ce06541ff04ed083dbc58623a4a2cebb110 09:30:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:30:29 INFO - mozversion platform_version: 47.0a1 09:30:29 INFO - using testdate: 1456335029 09:30:29 INFO - actual date: 1456335029 09:30:29 INFO - starting webserver on 'localhost:49473' 09:30:29 INFO - SUITE-START | Running 2 tests 09:30:29 INFO - TEST-START | dromaeo_css 09:30:29 INFO - operating with platform_type : mac_ 09:30:29 INFO - Initialising browser for dromaeo_css test... 09:30:29 INFO - TEST-INFO | started process 1939 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpS917h8/profile http://localhost:49473/getInfo.html) 09:30:32 INFO - PROCESS | 1939 | __metrics Screen width/height:1600/1200 09:30:32 INFO - PROCESS | 1939 | colorDepth:24 09:30:32 INFO - PROCESS | 1939 | Browser inner width/height: 1024/689 09:30:32 INFO - PROCESS | 1939 | __metrics 09:30:32 ERROR - PROCESS | 1939 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:30:32 INFO - TEST-INFO | 1939: exit 0 09:30:32 INFO - Browser initialized. 09:30:32 INFO - Running cycle 1/1 for dromaeo_css test... 09:30:32 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpS917h8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:44 INFO - PROCESS | 1943 | RSS: Main: 255627264 09:30:44 INFO - PROCESS | 1943 | 09:31:34 INFO - PROCESS | 1943 | 1456335094594 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] 09:33:44 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49473/tests/dromaeo/cssquery-ext.html) 09:33:46 INFO - PROCESS | 1943 | RSS: Main: 272863232 09:33:46 INFO - PROCESS | 1943 | 09:36:48 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-ext.html (next: http://localhost:49473/tests/dromaeo/cssquery-jquery.html) 09:36:48 INFO - PROCESS | 1943 | RSS: Main: 284696576 09:36:48 INFO - PROCESS | 1943 | 09:39:50 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49473/tests/dromaeo/cssquery-mootools.html) 09:39:51 INFO - PROCESS | 1943 | RSS: Main: 285130752 09:39:51 INFO - PROCESS | 1943 | 09:42:53 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49473/tests/dromaeo/cssquery-prototype.html) 09:42:53 INFO - PROCESS | 1943 | RSS: Main: 286679040 09:42:53 INFO - PROCESS | 1943 | 09:45:56 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49473/tests/dromaeo/cssquery-yui.html) 09:45:56 INFO - PROCESS | 1943 | RSS: Main: 288665600 09:45:56 INFO - PROCESS | 1943 | 09:48:59 INFO - PROCESS | 1943 | Cycle 1(1): loaded http://localhost:49473/tests/dromaeo/cssquery-yui.html (next: http://localhost:49473/tests/dromaeo/cssquery-dojo.html) 09:48:59 INFO - PROCESS | 1943 | RSS: Main: 291311616 09:48:59 INFO - PROCESS | 1943 | 09:48:59 INFO - PROCESS | 1943 | __start_tp_report 09:48:59 INFO - PROCESS | 1943 | _x_x_mozilla_page_load 09:48:59 INFO - PROCESS | 1943 | _x_x_mozilla_page_load_details 09:48:59 INFO - PROCESS | 1943 | |i|pagename|runs| 09:48:59 INFO - PROCESS | 1943 | |0;dojo.html;3496.5629296337956;3512.104413374589;3559.5728512578494;3586.910327241819;3591.1560783215946;5832.270966129234;5833.912491312629;5866.970665146669;5872.060470324744;5881.617694849842;5661.971690141554;5803.187553742479;5813.389594092623;5886.6468011919205;5926.911096333559;5201.531862132408;5246;5287.444818294081;5302.522772950434;5327.946720532803;5296.735163241842;5298.814541491049;5329.440408757083;5351.304330437038;5355.169948657965;5136.332276804029;5258.894822103555;5291.788328466895;5294.68231906083;5297.152455607084;5241.187615919539;5288.10102282609;5324.787008519655;5328.520433161034;5347.598930080259;5121.6683662247715;5136.922946155811;5288.0745869472685;5298.09932311508;5301.3373328333955;5505.532029777473;5561.443855614447;5691.573132015074;5729.828105156852;5771.394003629601;6144.187464697925;6163.952128138182;6240.469560087398;6241.251049873998;6260.937390626081;6197.690115494207;6243.500519958392;6245.3442388549;6245.968770156165;6264.812055638338;5719.111004516927;5883.646981181143;5907.734151963172;5913.46778789911;5931.436513531207;6168.629882207082;6241.469475094668;6302.401271879256;6306.2747784004505;6320.083587879732;6155.938440615537;6156.353582873823;6164.7842325518395;6170.444659980623;6205.751769929243;6231.4391704745885;6237.719302631393;6238.812835614939;6240.157578726905;6261.78083767066;6112.755489780359;6132.080177996013;6213.689315534205;6214.37856214384;6228.781992630236;6175.938240617626;6194.132821405007;6204.627722336674;6205.162303089115;6219.689015549295;4853.708777473293;4909.729964851967;4921.409430868247;4961.280614310905;4965.627577931669;4372.038151606642;4422.226110430662;4425.22558552252;4435.622972047412;4453.51011388747;5788.797392091256;5808.680522571215;5844.59087863854;5854.8536286592325;5865.354810970875;6112.755489780359;6138.602983404986;6223.190985171898;6228.844278893064;6237.407446292595;4940.530649588283;5772;5840.211571437886;5850.297964244318;5850.5027072699295;4605.102005109038;5337.19942008694;5398.1632846908005;5409.350877894678;5428.891422171613;5823;6254.687265636791;6327.620342779448;6339.207599050119;6345;5857.326407463026;6165.229346331708;6253.437190652863;6254.8123556293385;6259.96870015647;6295.527835412271;6336.683165841598;6357;6385;6395.328490508429;6198.256209254918;6199.132121502903;6213.720382582705;6217.347178546188;6222.191115155001;6193.349698281796;6231.096491008688;6231.906521402092;6239.688015599111;6240.781572644935;6168.136460895388;6181.505479561534;6184.824883272164;6193.721282542387;6197.287311959182;6064.241969753781;6118.632882027093;6155.322914479314;6167.506599472121;6180.7527698891545;5716.685582293014;5972.313183983897;6050.757969681164;6085.695715214133;6091.451769340781;4978.701277923191;6185.659788711664;6196.47329976957;6203.751849925952;6209.565330426827;6010.789622363196;6079.976141362322;6082.239720034996;6107.006761825686;6108.645631960618 09:48:59 INFO - PROCESS | 1943 | |1;ext.html;438.12156625964934;456.5571395746125;495.26700483284736;499.30347165703864;556.6103727390827;36199.45700814487;36774.08064798375;36791.26417471649;36807;36921.26157476849;37824.621753782456;38329.61670383295;38383;38430;38434.42348364777;9218.95390523048;9367.953160234189;9382.67160649374;9420.293477989144;9449.81100377992;9392;9607.855882161773;9660.323777335554;9660.5169741513;9702.66040688576;7931;9411.388259763127;9576.377535460208;9644.421334719904;9647.131758141766;9586.90413095867;9643.180329671986;9681.322307438482;9696.660616878446;9697.466639334834;9425.858612120825;9581.329306948517;9583.520823958774;9597.664081757175;9614.086661767122;36942.89171324838;36976.81511592452;37056.62943370559;37115.628843711485;37144.814275928446;3057.7095175958248;3437.8281085945855;3583.552055993001;3640.4357324614725;3951.762894226327;27834.721652783417;27995.440091198267;28128;28425.857870710723;28460.146195614165;2756.297144228229;2758.4069425073503;2781.3463835998523;2794.413173233623;2945.425641999811;480961;482315;483939.58030209976;485868;494447;50373.49626503688;60508;60550;60974.695126524086;61126;58271.41728582745;58607;59000.11499827506;59097;59270;15323.693526129415;15454.536363909101;15675.981061230983;15684;15690.607734806494;11970.162088653884;12069.456874440672;12076.396180190955;12275.079369047357;12313.630591082281;18856.05719714009;18888.527786805163;19115.375193108463;19190.8485490871;19221.711674324615;7008.614526201006;7953.5227886327;8154.5514996674565;8186.918130818734;8198.344132469389;931;942.1002942190329;974.605284859633;1077.8275475923972;1082.8197264981052;28686.856565717037;29266.853665731534;29356.412871742446;29730.40539189204;30150.79396824146;1033.4471057983942;1051.0645525482328;1077.0952399983894;1078.7087486378634;1111.294328101645;13561.423329567351;13610.59168224955;13641.727165456834;13697.383617737225;13739.381727822272;414620;415289;415416;418571;419337;52936.94126117533;53378;53855.11507097233;53996.73001634967;54087;1239.3988915376035;1308.8952883769275;1324.523171658183;1370.2737549098993;1545.6058705030146;26697.932082716474;27092.593611095454;27120.457590848466;27293;27368.178954630595;45614.08771824479;46221;46494.30258546192;46505.76747116243;46548.767256163504;488730;493748;495116;495764;498270;30847.691523084482;31120.53319200259;31244.218894527818;31272.9054483092;31470.842645786626;36026;41793;42545.7236282912;43025.92435189145;43180.78409607932;34766.47850282197;35110.82444587761;35142.82428587841;35666.286674266885;35728.464073038405;34675.65324346825;35060.874061038645;35080.94757157289;35098;35369.93890183299;29602.96389626353;34441.82779086189;35394;35536.11159721028;37126.70056548116;25658.58877761741;29433.411331773674;30792.97340214353;33036.33927321488;33189.50215746718;23932.803359832287;23997.444319100665;24017.759822401553;24236.87881560581;24245.03019879185 09:48:59 INFO - PROCESS | 1943 | |2;jquery.html;353.45920741265854;358.0386661813032;358.36032681663227;364.61897317303414;365.5923645135675;15373.923130384332;18554.628907421862;18853.434396968096;20038.799612003877;20086.497837554067;19662.803371966274;20191.596168076667;20767.68848467274;21425.14299428025;21506.139754409804;5344.278522399465;6586.736530538773;6605.834854128661;6620.801375958717;6650.5012124090645;6487.7729279475225;6514.706838192269;6589.505787065966;6604.438622717051;6623.668816559177;4631.189541830183;6420.133282006939;6630.403263706289;7232.746853860116;7520.3983681305635;7142.678579463936;7443.8883416748795;7445.553266804009;7514.736984205554;7528.021357223581;7147.142342918831;7151.678174482161;7159.355657990805;7186.92813071873;7207.027051348054;25427.745722542724;25577.872110639513;26371.604425933627;26373.868130659223;26612.80242389097;2118.2480219522004;2221.9333419997424;2297.3337732057685;2491.9252422427357;3081.6764239754953;15357.308921098578;15481.612959675986;15804.367825286974;15902.284397202038;16258.674826503404;1610.6456579552596;1802.7566278552358;1876.2307453943954;1902.1915685833465;1956.432634535983;72531;98835;123774.14338784925;125009;126185;19018.904905475385;19495.927723975034;19540.90229548843;19701.60596788056;19846.404607861787;22672.546549068928;27573;28646.570301445496;28750.568741468895;28771.424571508873;10390.220733445021;10573.312734672221;10583.523741431654;10614.734631634117;10634.73413164677;8936.106389361012;8961.014288428267;9014.41406308601;9055.320850936207;9086.091390860993;8690.478571285743;8803.955980220186;8829.646814127364;8867.379283450226;8894.777630559287;3166.3034132490816;3176.6188057433255;3466.5493485847182;3710.666040056408;3754.887353379403;377.8450835157572;388.2351767018968;406.5223362548993;406.65434380776696;413.3345314044386;11553.595624153115;11783.057355411547;19938.60122797536;20732.859692717044;20755.792442075384;927.4898805656861;958.4584709639032;962.7532345612449;1014.8122597319372;1036.9740756481149;10300;10690;10715.035646791826;10789.028987391015;10987.945060274647;499033;499149;501446;558266;638725;111389;115801;115909;117392.41303793427;118064.40967795106;1030.6959446963165;1052.9157667386592;1054.9261551691309;1068.631322193842;1072.1904961753826;18087.638247234718;18384.81615183831;18410.539736506693;18423.81576184221;18568;50591.49408506015;50641.74679126581;51424.74287628538;52348.47651523588;52966.470335297694;70791;72928.63535682288;74902;82836;83387.5830620843;7266.600336981517;7914.366850651819;8019.959900200462;8113.878291825746;8371.204735550113;9423.10480504351;12912.35438228066;13718.45126194941;13764.587062388144;13778;8439.409241353293;9193.724188274362;9464.574094165917;11570.710732231424;11757.706057348634;9852.162566181954;10812.5134368952;11454;11592.188546801643;11748.530058797553;9737.269704772028;9870.161036311707;10086.394816311045;11565.190436669352;11610.94194529022;6359.586626869239;7915.248051435105;8139.4709343892455;8191.017077950446;8228.25945664893;11252.656045808762;11578;11684.766304673689;11708.648740537797;11925.403729813648 09:48:59 INFO - PROCESS | 1943 | |3;mootools.html;1544.6524531980306;1562.2891584329127;1798.2217474002664;1911.2164012754774;1916.3580200632787;7412.258774122585;7800.765977020698;8376.95811520943;8805.867911981326;8816.691415800447;8472.36457265706;8483.91516084839;8515.91484085159;8588.012378576466;8615.913840861589;2436.707595088592;2447.3759191406166;2457.766512181349;2469.876506174693;2472.5178590174924;2396.9041238350446;2454.067454367338;2460.323411061954;2468.062136388179;2489.5394352044927;2082.79172082792;2382.725986511556;2418.1899063813644;2449.4243852694603;2458.655788189646;2331.230693871027;2368.301351101429;2375.8336916415856;2376.607859703147;2377.0848223434105;2437.4881274932286;2439.621858611918;2441.597136472498;2441.865697386643;2442.829001969863;8690.261327787146;8700.825983480358;8744.213020828156;8768.430052046597;8771.868421973675;5375.139977603565;5478.205660179292;5513.228148059275;5525.944740552583;5540.113581826929;3552.520409744677;3552.964470355289;3655.963440365589;3678.8160591970563;3745.1198968242443;996.3125443444001;1006.4967516241879;1025.3130402630256;1027.2449749434234;1078.0190027075323;11857.407129643483;11878.643640690792;12007.639770806889;12018.39908004605;12030;4260.275753121977;4849.060375849618;4898.53463920927;4944.752762361867;4965.975170124127;10060.195184385231;10082.24383171265;10140.188784897191;10142.492875356204;10144.847827282596;5392.892142157135;5415.323084614423;5429.185622156708;5445.319335083114;5467.043267428184;4265.936010959838;4833.589144922651;4897.2654101885;4912.877178070506;4929.137400954819;3935;3963.9405408918888;3974.8012599370495;3993.961569991823;4007.8396864125107;1208.6374087773634;1302.3943866102309;1304.1392680830606;1307.607717684691;1314.6713321669583;1104.5968221599057;1114.996503147158;1146.5757669662278;1277.1187880362706;1363.0935427940508;7835.764927052198;7944.324732397696;7968.920310796933;8113.8377232456205;8299.6680132794;1168.7545615420686;1169.7543515861764;1193.0574845871838;1197.4072833947253;1205.102198861836;6273.65494897785;6292.622442653455;6297.937020629735;6347.777827776005;6367.968160159169;9727.221822254203;10355.896441035493;10669.626563070255;10684.412357320267;10759;10015.449150296658;10371.118454931264;10478.37129772216;10530.73673158162;10817.242793004414;8243.793905152419;8287.751367458986;8365.24712775853;8375.371847111492;8379.62291696875;7773.222677732181;7866.960665196638;7899.881501777593;7935.523868567904;7976.880346794919;9274.860877086983;9421.15209631109;9431.056894310514;9478.620855165716;9593.520323983912;9547.093026162504;9742.171915387271;9845.901540984498;9853.753656158653;9862.950685246527;7451.590162540895;7472.738454154079;7535.924640753522;7555.848883022419;7577.014988051518;8124.83750325002;8129.227723366271;8200.58997050157;8235.176482351957;8277.917220827714;6839.863202735818;7268.164161121539;7419.109706835215;7510.774676759706;7548.735794247175;7111.359977602041;7204.24355442671;7222.205557388578;7266.2007179211305;7273.563586184846;7537.886931695919;7566.772996810105;7587.506812057199;7611.809704757204;7627;6825.2833452486775;6857.828554286183;6910.93089069123;6935.063766391472;6943.79168624942;7049.823754405976;7090.716371345088;7125.1093613298335;7126.85746285061;7132.750353737594 09:48:59 INFO - PROCESS | 1943 | |4;prototype.html;324.62667931878343;330.4267096587422;332.0172290021536;335.7280602711803;339.5874013074116;6669.19969603647;6771.898421523675;6775.08536347593;6798.048273241744;6798.796036118918;5433.864153396157;5470.781168753255;6701.49738769593;6732.9663351683175;6734.259231484545;4077.2049450357194;4948.1093403187415;4979.60163186946;4995.650304478688;5007.774650140753;4133.400656904747;5001.749912504379;5012.72430016349;5019.54824065834;5027.472115427882;4067.6745860331253;4944.777485013183;4958.479359667237;4968.826091086813;4995.975020124894;4704.200285951397;4993.400791904976;4995.100881841267;4996.725180115092;5010.924836127461;3599.784012959231;3915.177812659345;4043.9890027493125;4061.817218225187;4119.9176016479505;5499.917501237484;5581.190727344553;6447;6461.224653041665;6534.771283005072;4870.928395752964;5635.830925072213;5653.717314134276;5770.134479828017;5770.711464426804;7180.138383394026;7183.066201393785;7183.964080179566;7185.389241914443;7199.4600404969315;3878.631530004673;4587.3348364486965;4603.066711980942;4608.377868987677;4610.861674149747;7362.74833278344;7630.580318082559;7694.422918281095;7720.922790772077;7723.613819309068;4621.468531118964;4652.371929789503;4663.090697313991;4666.95333046672;4667.813287468463;4171.520275168334;4383.772543687773;4405.735655860594;4742.359781429532;4744.69159504638;5670.461306175906;5676.148577713294;5680.807030523636;5686.630369026;5688.601797874109;7018.350687588412;7271.127464704164;7288.234735352712;7291.30732580404;7311.853762924712;1607.541850572581;1631.208863701104;1634.525987463646;1635.8854880158513;1636.5499487640993;997.2846703669677;1052.5368837711383;1053.710229686827;1061.098066643347;1071.3678929431674;6751.628660423626;6826.146731658543;6866.862662746717;6870.3473170048765;6870.656467176721;7601.619919004028;7604.467687261949;7613.162552119263;7624.809379765439;7631.503952243197;6818.454523638097;6890.758823441155;6892.517523773287;6926.792196234121;6944.409725173316;3891.124496988155;4032.1129351542613;4042.3734321180264;4052.8176232069627;4075.8777236682945;6583.44040756541;6940.7223711052;8018.679252829821;8020.95727555414;8042.316403105685;6803.65981700913;7932.0878099019355;7936.246056624612;7939.126696063428;7944.9205507945335;6914.688839002257;7689.653965571562;8015.839683206304;8046.597670116471;8076.232757887991;7415.814604634711;7698.499597526143;7701.422393320636;7717;7733.226677332222;7497.587632680255;7502.287282708134;7511.586862722603;7529.247075292646;7546.283103105416;8001.639926203451;8004.079530853794;8045.195480451908;8046.919530804851;8058.959705201437;4738.668293219442;4745.738984355894;4750.904981900274;4751.121042607128;4757.238841785298;5835.278592815214;6275.843103922439;7447.813804654927;7661;7675.923240767745;6042.90935635957;7317.5609463432365;7379.963100184465;7382.6677799498075;7405.074365704287;6066.393360663898;7322.157951835394;7367.889481657672;7378.413641067196;7391.630418478947;7159.284071592799;7178.246284140299;7198.136223653195;7204;7204.063471748639;7091.184513780981;7366.116066072105;7369.889451658337;7379.3358597726465;7394.593297368697;6883.449324053963;7026.051483049927;7144.428445724226;7178.676959536938;7189.784306470814 09:48:59 INFO - PROCESS | 1943 | |5;yui.html;668.6355936014875;693.7259782385961;714.4591266951065;722.4184531452181;727.7089164334267;14631.048981816175;14737.705245895102;14813.333399996998;14822.77765833512;14846.257687115642;13445.462181512728;13477;13586.728265434685;13628.863711362883;13634.795478067837;842.9452085614415;873.7247766953406;882.7175303902753;892.8258989497051;893.7676204186894;884.0275696733573;884.9734507964771;885.8361203177401;886.2732559301376;889.181952603603;893.6425429828088;932.2309094996621;932.7714709896085;934.2992755433424;938.2353381993653;876.2070326354659;915.8397280475923;920.4017388697333;930.1303281431883;930.6370515498961;663.7875879718492;689.5724650716538;691.629977961788;692.6779047742824;693.2789898505548;13034.022448316415;13050;13071.281079540622;13116.606501804961;13123.343832808321;10822.24244302899;10881.183911206612;10937.015668589785;11066;11245.15661325404;9528.380655257386;9546.713598592054;9559.522023898777;9568.09103135201;9910.801783964353;3395.47370157626;3399.2351720862857;3421.606515250753;3453.3783918894587;3461.6365281645317;70072.649636752;74034.88947665843;76679.84980225301;78321;87647.24705505918;9325.300602454707;9356.485393303297;9394.765130871647;9421.670241541513;9883.11052005323;17565.473035808947;19788.70316945247;19899.60200795976;20028.799712002983;20054.799452005293;7111.573305601681;7236.891446628305;7282;7427.591482468408;7592.81017974555;4100.65144462724;4114.259433301974;4119.8352065917625;4130.772807495617;4131.669466442678;3488.284901595167;3491.4064609016527;3514.8594056237976;3544.2379888324135;3547.290541891632;651.6025224612982;652.083822229768;665.4476784269045;667.6594936582378;669.9732010719614;576.7577617400618;581.4331027248398;582.5601670738565;612.6875293600295;620.5283984172062;8320.875186872201;8420.78948026292;8505.19568419789;8535.95732021336;8582.742517724479;559.8208573256519;587.7472686744655;597.0626116996361;621.8227805075622;632.4560877645222;3972.7219094663096;3973.1259122992897;4032.5564187939303;4245.12974840157;4336.262835318003;79855;80166.59916700496;81283.59358203171;85410;89714.55142724376;49570.752146239036;59599.21202363936;68583.65708171428;71960.56078878498;78876;62276.37723622796;63811.4047148825;63895;63979.72040559163;65054;8520.74437766868;8631.309495240492;8719.34604904622;8841.970952082043;8862.20240178387;46249.76875115603;48083.03833923372;48104.759476202395;48626;50012.24981625351;62547.6872615634;64642.67678661577;64686.676566616865;65569.01646475402;66498.33501664922;10749.838752418564;10928.78142437131;10955.233133680566;11252.381119038531;11628.069754419457;11834.289942603471;12263.080268979684;12270.263784172977;12276.815847762113;12514.812277815658;11179.385133817717;11261.493232804707;11266.380349080879;11647.6505704829;11836.526538938346;11067.335959842436;11256.155788316073;11759.118066145244;11809.23239989398;12295.815562766744;11181.385023823768;11231.26996745209;11341.829872551752;11379.601713939972;11897.870734891863;9502.144806967406;9578.9042109578;9598;9688.176504996873;9903.950480247553;8778.824423511367;9296.442213467213;9806.460644664612;9892.85160722604;9911.45486998222 09:48:59 INFO - PROCESS | 1943 | __end_tp_report 09:48:59 INFO - PROCESS | 1943 | __start_cc_report 09:48:59 INFO - PROCESS | 1943 | _x_x_mozilla_cycle_collect,346 09:48:59 INFO - PROCESS | 1943 | __end_cc_report 09:48:59 INFO - PROCESS | 1943 | __startTimestamp1456336139553__endTimestamp 09:48:59 INFO - PROCESS | 1943 | 09:48:59 INFO - PROCESS | 1943 | ------- Summary: start ------- 09:48:59 INFO - PROCESS | 1943 | Number of tests: 6 09:48:59 INFO - PROCESS | 1943 | 09:48:59 INFO - PROCESS | 1943 | [#0] dojo.html Cycles:165 Average:5769.87 Median:6064.24 stddev:624.24 (10.3%) stddev-sans-first:600.14 09:48:59 INFO - PROCESS | 1943 | Values: 3496.6 3512.1 3559.6 3586.9 3591.2 5832.3 5833.9 5867.0 5872.1 5881.6 5662.0 5803.2 5813.4 5886.6 5926.9 5201.5 5246.0 5287.4 5302.5 5327.9 5296.7 5298.8 5329.4 5351.3 5355.2 5136.3 5258.9 5291.8 5294.7 5297.2 5241.2 5288.1 5324.8 5328.5 5347.6 5121.7 5136.9 5288.1 5298.1 5301.3 5505.5 5561.4 5691.6 5729.8 5771.4 6144.2 6164.0 6240.5 6241.3 6260.9 6197.7 6243.5 6245.3 6246.0 6264.8 5719.1 5883.6 5907.7 5913.5 5931.4 6168.6 6241.5 6302.4 6306.3 6320.1 6155.9 6156.4 6164.8 6170.4 6205.8 6231.4 6237.7 6238.8 6240.2 6261.8 6112.8 6132.1 6213.7 6214.4 6228.8 6175.9 6194.1 6204.6 6205.2 6219.7 4853.7 4909.7 4921.4 4961.3 4965.6 4372.0 4422.2 4425.2 4435.6 4453.5 5788.8 5808.7 5844.6 5854.9 5865.4 6112.8 6138.6 6223.2 6228.8 6237.4 4940.5 5772.0 5840.2 5850.3 5850.5 4605.1 5337.2 5398.2 5409.4 5428.9 5823.0 6254.7 6327.6 6339.2 6345.0 5857.3 6165.2 6253.4 6254.8 6260.0 6295.5 6336.7 6357.0 6385.0 6395.3 6198.3 6199.1 6213.7 6217.3 6222.2 6193.3 6231.1 6231.9 6239.7 6240.8 6168.1 6181.5 6184.8 6193.7 6197.3 6064.2 6118.6 6155.3 6167.5 6180.8 5716.7 5972.3 6050.8 6085.7 6091.5 4978.7 6185.7 6196.5 6203.8 6209.6 6010.8 6080.0 6082.2 6107.0 6108.6 09:48:59 INFO - PROCESS | 1943 | 09:48:59 INFO - PROCESS | 1943 | [#1] ext.html Cycles:180 Average:60235.88 Median:36932.08 stddev:124055.59 (335.9%) stddev-sans-first:124322.36 09:48:59 INFO - PROCESS | 1943 | Values: 438.1 456.6 495.3 499.3 556.6 36199.5 36774.1 36791.3 36807.0 36921.3 37824.6 38329.6 38383.0 38430.0 38434.4 9219.0 9368.0 9382.7 9420.3 9449.8 9392.0 9607.9 9660.3 9660.5 9702.7 7931.0 9411.4 9576.4 9644.4 9647.1 9586.9 9643.2 9681.3 9696.7 9697.5 9425.9 9581.3 9583.5 9597.7 9614.1 36942.9 36976.8 37056.6 37115.6 37144.8 3057.7 3437.8 3583.6 3640.4 3951.8 27834.7 27995.4 28128.0 28425.9 28460.1 2756.3 2758.4 2781.3 2794.4 2945.4 480961.0 482315.0 483939.6 485868.0 494447.0 50373.5 60508.0 60550.0 60974.7 61126.0 58271.4 58607.0 59000.1 59097.0 59270.0 15323.7 15454.5 15676.0 15684.0 15690.6 11970.2 12069.5 12076.4 12275.1 12313.6 18856.1 18888.5 19115.4 19190.8 19221.7 7008.6 7953.5 8154.6 8186.9 8198.3 931.0 942.1 974.6 1077.8 1082.8 28686.9 29266.9 29356.4 29730.4 30150.8 1033.4 1051.1 1077.1 1078.7 1111.3 13561.4 13610.6 13641.7 13697.4 13739.4 414620.0 415289.0 415416.0 418571.0 419337.0 52936.9 53378.0 53855.1 53996.7 54087.0 1239.4 1308.9 1324.5 1370.3 1545.6 26697.9 27092.6 27120.5 27293.0 27368.2 45614.1 46221.0 46494.3 46505.8 46548.8 488730.0 493748.0 495116.0 495764.0 498270.0 30847.7 31120.5 31244.2 31272.9 31470.8 36026.0 41793.0 42545.7 43025.9 43180.8 34766.5 35110.8 35142.8 35666.3 35728.5 34675.7 35060.9 35080.9 35098.0 35369.9 29603.0 34441.8 35394.0 35536.1 37126.7 25658.6 29433.4 30793.0 33036.3 33189.5 23932.8 23997.4 24017.8 24236.9 24245.0 09:48:59 INFO - PROCESS | 1943 | 09:48:59 INFO - PROCESS | 1943 | [#2] jquery.html Cycles:180 Average:33653.60 Median:28761.00 stddev:90367.78 (314.2%) stddev-sans-first:90586.69 09:48:59 INFO - PROCESS | 1943 | Values: 353.5 358.0 358.4 364.6 365.6 15373.9 18554.6 18853.4 20038.8 20086.5 19662.8 20191.6 20767.7 21425.1 21506.1 5344.3 6586.7 6605.8 6620.8 6650.5 6487.8 6514.7 6589.5 6604.4 6623.7 4631.2 6420.1 6630.4 7232.7 7520.4 7142.7 7443.9 7445.6 7514.7 7528.0 7147.1 7151.7 7159.4 7186.9 7207.0 25427.7 25577.9 26371.6 26373.9 26612.8 2118.2 2221.9 2297.3 2491.9 3081.7 15357.3 15481.6 15804.4 15902.3 16258.7 1610.6 1802.8 1876.2 1902.2 1956.4 72531.0 98835.0 123774.1 125009.0 126185.0 19018.9 19495.9 19540.9 19701.6 19846.4 22672.5 27573.0 28646.6 28750.6 28771.4 10390.2 10573.3 10583.5 10614.7 10634.7 8936.1 8961.0 9014.4 9055.3 9086.1 8690.5 8804.0 8829.6 8867.4 8894.8 3166.3 3176.6 3466.5 3710.7 3754.9 377.8 388.2 406.5 406.7 413.3 11553.6 11783.1 19938.6 20732.9 20755.8 927.5 958.5 962.8 1014.8 1037.0 10300.0 10690.0 10715.0 10789.0 10987.9 499033.0 499149.0 501446.0 558266.0 638725.0 111389.0 115801.0 115909.0 117392.4 118064.4 1030.7 1052.9 1054.9 1068.6 1072.2 18087.6 18384.8 18410.5 18423.8 18568.0 50591.5 50641.7 51424.7 52348.5 52966.5 70791.0 72928.6 74902.0 82836.0 83387.6 7266.6 7914.4 8020.0 8113.9 8371.2 9423.1 12912.4 13718.5 13764.6 13778.0 8439.4 9193.7 9464.6 11570.7 11757.7 9852.2 10812.5 11454.0 11592.2 11748.5 9737.3 9870.2 10086.4 11565.2 11610.9 6359.6 7915.2 8139.5 8191.0 8228.3 11252.7 11578.0 11684.8 11708.6 11925.4 09:48:59 INFO - PROCESS | 1943 | 09:48:59 INFO - PROCESS | 1943 | [#3] mootools.html Cycles:180 Average:6018.94 Median:5422.25 stddev:3147.19 (58.0%) stddev-sans-first:3138.05 09:48:59 INFO - PROCESS | 1943 | Values: 1544.7 1562.3 1798.2 1911.2 1916.4 7412.3 7800.8 8377.0 8805.9 8816.7 8472.4 8483.9 8515.9 8588.0 8615.9 2436.7 2447.4 2457.8 2469.9 2472.5 2396.9 2454.1 2460.3 2468.1 2489.5 2082.8 2382.7 2418.2 2449.4 2458.7 2331.2 2368.3 2375.8 2376.6 2377.1 2437.5 2439.6 2441.6 2441.9 2442.8 8690.3 8700.8 8744.2 8768.4 8771.9 5375.1 5478.2 5513.2 5525.9 5540.1 3552.5 3553.0 3656.0 3678.8 3745.1 996.3 1006.5 1025.3 1027.2 1078.0 11857.4 11878.6 12007.6 12018.4 12030.0 4260.3 4849.1 4898.5 4944.8 4966.0 10060.2 10082.2 10140.2 10142.5 10144.8 5392.9 5415.3 5429.2 5445.3 5467.0 4265.9 4833.6 4897.3 4912.9 4929.1 3935.0 3963.9 3974.8 3994.0 4007.8 1208.6 1302.4 1304.1 1307.6 1314.7 1104.6 1115.0 1146.6 1277.1 1363.1 7835.8 7944.3 7968.9 8113.8 8299.7 1168.8 1169.8 1193.1 1197.4 1205.1 6273.7 6292.6 6297.9 6347.8 6368.0 9727.2 10355.9 10669.6 10684.4 10759.0 10015.4 10371.1 10478.4 10530.7 10817.2 8243.8 8287.8 8365.2 8375.4 8379.6 7773.2 7867.0 7899.9 7935.5 7976.9 9274.9 9421.2 9431.1 9478.6 9593.5 9547.1 9742.2 9845.9 9853.8 9863.0 7451.6 7472.7 7535.9 7555.8 7577.0 8124.8 8129.2 8200.6 8235.2 8277.9 6839.9 7268.2 7419.1 7510.8 7548.7 7111.4 7204.2 7222.2 7266.2 7273.6 7537.9 7566.8 7587.5 7611.8 7627.0 6825.3 6857.8 6910.9 6935.1 6943.8 7049.8 7090.7 7125.1 7126.9 7132.8 09:48:59 INFO - PROCESS | 1943 | 09:48:59 INFO - PROCESS | 1943 | [#4] prototype.html Cycles:180 Average:5871.09 Median:6761.76 stddev:1948.08 (28.8%) stddev-sans-first:1908.54 09:48:59 INFO - PROCESS | 1943 | Values: 324.6 330.4 332.0 335.7 339.6 6669.2 6771.9 6775.1 6798.0 6798.8 5433.9 5470.8 6701.5 6733.0 6734.3 4077.2 4948.1 4979.6 4995.7 5007.8 4133.4 5001.7 5012.7 5019.5 5027.5 4067.7 4944.8 4958.5 4968.8 4996.0 4704.2 4993.4 4995.1 4996.7 5010.9 3599.8 3915.2 4044.0 4061.8 4119.9 5499.9 5581.2 6447.0 6461.2 6534.8 4870.9 5635.8 5653.7 5770.1 5770.7 7180.1 7183.1 7184.0 7185.4 7199.5 3878.6 4587.3 4603.1 4608.4 4610.9 7362.7 7630.6 7694.4 7720.9 7723.6 4621.5 4652.4 4663.1 4667.0 4667.8 4171.5 4383.8 4405.7 4742.4 4744.7 5670.5 5676.1 5680.8 5686.6 5688.6 7018.4 7271.1 7288.2 7291.3 7311.9 1607.5 1631.2 1634.5 1635.9 1636.5 997.3 1052.5 1053.7 1061.1 1071.4 6751.6 6826.1 6866.9 6870.3 6870.7 7601.6 7604.5 7613.2 7624.8 7631.5 6818.5 6890.8 6892.5 6926.8 6944.4 3891.1 4032.1 4042.4 4052.8 4075.9 6583.4 6940.7 8018.7 8021.0 8042.3 6803.7 7932.1 7936.2 7939.1 7944.9 6914.7 7689.7 8015.8 8046.6 8076.2 7415.8 7698.5 7701.4 7717.0 7733.2 7497.6 7502.3 7511.6 7529.2 7546.3 8001.6 8004.1 8045.2 8046.9 8059.0 4738.7 4745.7 4750.9 4751.1 4757.2 5835.3 6275.8 7447.8 7661.0 7675.9 6042.9 7317.6 7380.0 7382.7 7405.1 6066.4 7322.2 7367.9 7378.4 7391.6 7159.3 7178.2 7198.1 7204.0 7204.1 7091.2 7366.1 7369.9 7379.3 7394.6 6883.4 7026.1 7144.4 7178.7 7189.8 09:48:59 INFO - PROCESS | 1943 | 09:48:59 INFO - PROCESS | 1943 | [#5] yui.html Cycles:180 Average:17157.68 Median:63937.36 stddev:23496.84 (36.7%) stddev-sans-first:23530.13 09:48:59 INFO - PROCESS | 1943 | Values: 668.6 693.7 714.5 722.4 727.7 14631.0 14737.7 14813.3 14822.8 14846.3 13445.5 13477.0 13586.7 13628.9 13634.8 842.9 873.7 882.7 892.8 893.8 884.0 885.0 885.8 886.3 889.2 893.6 932.2 932.8 934.3 938.2 876.2 915.8 920.4 930.1 930.6 663.8 689.6 691.6 692.7 693.3 13034.0 13050.0 13071.3 13116.6 13123.3 10822.2 10881.2 10937.0 11066.0 11245.2 9528.4 9546.7 9559.5 9568.1 9910.8 3395.5 3399.2 3421.6 3453.4 3461.6 70072.6 74034.9 76679.8 78321.0 87647.2 9325.3 9356.5 9394.8 9421.7 9883.1 17565.5 19788.7 19899.6 20028.8 20054.8 7111.6 7236.9 7282.0 7427.6 7592.8 4100.7 4114.3 4119.8 4130.8 4131.7 3488.3 3491.4 3514.9 3544.2 3547.3 651.6 652.1 665.4 667.7 670.0 576.8 581.4 582.6 612.7 620.5 8320.9 8420.8 8505.2 8536.0 8582.7 559.8 587.7 597.1 621.8 632.5 3972.7 3973.1 4032.6 4245.1 4336.3 79855.0 80166.6 81283.6 85410.0 89714.6 49570.8 59599.2 68583.7 71960.6 78876.0 62276.4 63811.4 63895.0 63979.7 65054.0 8520.7 8631.3 8719.3 8842.0 8862.2 46249.8 48083.0 48104.8 48626.0 50012.2 62547.7 64642.7 64686.7 65569.0 66498.3 10749.8 10928.8 10955.2 11252.4 11628.1 11834.3 12263.1 12270.3 12276.8 12514.8 11179.4 11261.5 11266.4 11647.7 11836.5 11067.3 11256.2 11759.1 11809.2 12295.8 11181.4 11231.3 11341.8 11379.6 11897.9 9502.1 9578.9 9598.0 9688.2 9904.0 8778.8 9296.4 9806.5 9892.9 9911.5 09:48:59 INFO - PROCESS | 1943 | -------- Summary: end -------- 09:48:59 INFO - PROCESS | 1943 | 09:49:00 INFO - TEST-INFO | 1943: exit 0 09:49:00 INFO - TEST-OK | dromaeo_css | took 1110615ms 09:49:00 INFO - TEST-START | kraken 09:49:00 INFO - operating with platform_type : mac_ 09:49:00 INFO - Initialising browser for kraken test... 09:49:00 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpxVixpZ/profile http://localhost:49473/getInfo.html) 09:49:03 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 09:49:03 INFO - PROCESS | 1950 | colorDepth:24 09:49:03 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 09:49:03 INFO - PROCESS | 1950 | __metrics 09:49:03 ERROR - PROCESS | 1950 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:49:03 INFO - TEST-INFO | 1950: exit 0 09:49:03 INFO - Browser initialized. 09:49:03 INFO - Running cycle 1/1 for kraken test... 09:49:03 INFO - TEST-INFO | started process 1953 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpxVixpZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:15 INFO - PROCESS | 1953 | RSS: Main: 255680512 09:49:15 INFO - PROCESS | 1953 | 09:49:18 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49473/tests/kraken/driver.html?testName=audio-beat-detection) 09:49:19 INFO - PROCESS | 1953 | RSS: Main: 269176832 09:49:19 INFO - PROCESS | 1953 | 09:49:22 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49473/tests/kraken/driver.html?testName=audio-dft) 09:49:22 INFO - PROCESS | 1953 | RSS: Main: 276348928 09:49:22 INFO - PROCESS | 1953 | 09:49:25 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49473/tests/kraken/driver.html?testName=audio-fft) 09:49:26 INFO - PROCESS | 1953 | RSS: Main: 280809472 09:49:26 INFO - PROCESS | 1953 | 09:49:28 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49473/tests/kraken/driver.html?testName=audio-oscillator) 09:49:29 INFO - PROCESS | 1953 | RSS: Main: 281997312 09:49:29 INFO - PROCESS | 1953 | 09:49:31 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49473/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:49:31 INFO - PROCESS | 1953 | RSS: Main: 282460160 09:49:31 INFO - PROCESS | 1953 | 09:49:34 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49473/tests/kraken/driver.html?testName=imaging-darkroom) 09:49:35 INFO - PROCESS | 1953 | RSS: Main: 283525120 09:49:35 INFO - PROCESS | 1953 | 09:49:37 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49473/tests/kraken/driver.html?testName=imaging-desaturate) 09:49:38 INFO - PROCESS | 1953 | RSS: Main: 283713536 09:49:38 INFO - PROCESS | 1953 | 09:49:41 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49473/tests/kraken/driver.html?testName=json-parse-financial) 09:49:41 INFO - PROCESS | 1953 | RSS: Main: 284004352 09:49:41 INFO - PROCESS | 1953 | 09:49:43 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49473/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:49:43 INFO - PROCESS | 1953 | RSS: Main: 283668480 09:49:43 INFO - PROCESS | 1953 | 09:49:45 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:49:46 INFO - PROCESS | 1953 | RSS: Main: 282951680 09:49:46 INFO - PROCESS | 1953 | 09:49:48 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:49:49 INFO - PROCESS | 1953 | RSS: Main: 283181056 09:49:49 INFO - PROCESS | 1953 | 09:49:51 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:49:52 INFO - PROCESS | 1953 | RSS: Main: 284647424 09:49:52 INFO - PROCESS | 1953 | 09:49:55 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:49:55 INFO - PROCESS | 1953 | RSS: Main: 283787264 09:49:55 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | Cycle 1(1): loaded http://localhost:49473/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49473/tests/kraken/driver.html?testName=ai-astar) 09:49:57 INFO - PROCESS | 1953 | RSS: Main: 284975104 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | __start_tp_report 09:49:57 INFO - PROCESS | 1953 | _x_x_mozilla_page_load 09:49:57 INFO - PROCESS | 1953 | _x_x_mozilla_page_load_details 09:49:57 INFO - PROCESS | 1953 | |i|pagename|runs| 09:49:57 INFO - PROCESS | 1953 | |0;ai-astar;158;152;159;116;117;111;154;168;169;94 09:49:57 INFO - PROCESS | 1953 | |1;audio-beat-detection;189;130;149;157;123;148;134;195;173;121 09:49:57 INFO - PROCESS | 1953 | |2;audio-dft;196;200;206;233;196;200;201;199;204;198 09:49:57 INFO - PROCESS | 1953 | |3;audio-fft;72;74;71;114;57;55;65;77;113;59 09:49:57 INFO - PROCESS | 1953 | |4;audio-oscillator;83;74;125;83;82;84;119;86;99;109 09:49:57 INFO - PROCESS | 1953 | |5;imaging-gaussian-blur;106;92;85;91;104;116;86;91;86;93 09:49:57 INFO - PROCESS | 1953 | |6;imaging-darkroom;95;96;99;94;95;94;95;96;94;100 09:49:57 INFO - PROCESS | 1953 | |7;imaging-desaturate;95;95;91;93;95;93;92;96;93;92 09:49:57 INFO - PROCESS | 1953 | |8;json-parse-financial;55;57;57;54;54;56;60;88;47;55 09:49:57 INFO - PROCESS | 1953 | |9;json-stringify-tinderbox;63;68;75;85;96;101;62;93;60;78 09:49:57 INFO - PROCESS | 1953 | |10;stanford-crypto-aes;86;88;86;87;87;85;86;85;86;89 09:49:57 INFO - PROCESS | 1953 | |11;stanford-crypto-ccm;131;138;138;128;125;174;113;131;135;139 09:49:57 INFO - PROCESS | 1953 | |12;stanford-crypto-pbkdf2;134;144;144;148;132;165;142;139;134;182 09:49:57 INFO - PROCESS | 1953 | |13;stanford-crypto-sha256-iterative;68;69;69;67;71;69;66;70;68;68 09:49:57 INFO - PROCESS | 1953 | __end_tp_report 09:49:57 INFO - PROCESS | 1953 | __start_cc_report 09:49:57 INFO - PROCESS | 1953 | _x_x_mozilla_cycle_collect,896 09:49:57 INFO - PROCESS | 1953 | __end_cc_report 09:49:57 INFO - PROCESS | 1953 | __startTimestamp1456336197597__endTimestamp 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | ------- Summary: start ------- 09:49:57 INFO - PROCESS | 1953 | Number of tests: 14 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#0] ai-astar Cycles:10 Average:139.80 Median:158.50 stddev:27.31 (17.2%) stddev-sans-first:28.16 09:49:57 INFO - PROCESS | 1953 | Values: 158.0 152.0 159.0 116.0 117.0 111.0 154.0 168.0 169.0 94.0 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:153.00 stddev:26.50 (17.3%) stddev-sans-first:24.47 09:49:57 INFO - PROCESS | 1953 | Values: 189.0 130.0 149.0 157.0 123.0 148.0 134.0 195.0 173.0 121.0 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#2] audio-dft Cycles:10 Average:203.30 Median:200.50 stddev:10.90 (5.4%) stddev-sans-first:11.24 09:49:57 INFO - PROCESS | 1953 | Values: 196.0 200.0 206.0 233.0 196.0 200.0 201.0 199.0 204.0 198.0 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#3] audio-fft Cycles:10 Average:75.70 Median:68.00 stddev:21.27 (31.3%) stddev-sans-first:22.51 09:49:57 INFO - PROCESS | 1953 | Values: 72.0 74.0 71.0 114.0 57.0 55.0 65.0 77.0 113.0 59.0 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:83.00 stddev:17.59 (21.2%) stddev-sans-first:18.17 09:49:57 INFO - PROCESS | 1953 | Values: 83.0 74.0 125.0 83.0 82.0 84.0 119.0 86.0 99.0 109.0 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#5] imaging-gaussian-blur Cycles:10 Average:95.00 Median:88.50 stddev:10.27 (11.6%) stddev-sans-first:10.10 09:49:57 INFO - PROCESS | 1953 | Values: 106.0 92.0 85.0 91.0 104.0 116.0 86.0 91.0 86.0 93.0 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#6] imaging-darkroom Cycles:10 Average:95.80 Median:95.00 stddev:2.10 (2.2%) stddev-sans-first:2.20 09:49:57 INFO - PROCESS | 1953 | Values: 95.0 96.0 99.0 94.0 95.0 94.0 95.0 96.0 94.0 100.0 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:94.00 stddev:1.65 (1.8%) stddev-sans-first:1.66 09:49:57 INFO - PROCESS | 1953 | Values: 95.0 95.0 91.0 93.0 95.0 93.0 92.0 96.0 93.0 92.0 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#8] json-parse-financial Cycles:10 Average:58.30 Median:56.50 stddev:10.95 (19.4%) stddev-sans-first:11.55 09:49:57 INFO - PROCESS | 1953 | Values: 55.0 57.0 57.0 54.0 54.0 56.0 60.0 88.0 47.0 55.0 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#9] json-stringify-tinderbox Cycles:10 Average:78.10 Median:76.50 stddev:15.06 (19.7%) stddev-sans-first:14.95 09:49:57 INFO - PROCESS | 1953 | Values: 63.0 68.0 75.0 85.0 96.0 101.0 62.0 93.0 60.0 78.0 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.50 stddev:1.27 (1.5%) stddev-sans-first:1.33 09:49:57 INFO - PROCESS | 1953 | Values: 86.0 88.0 86.0 87.0 87.0 85.0 86.0 85.0 86.0 89.0 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#11] stanford-crypto-ccm Cycles:10 Average:135.20 Median:136.50 stddev:15.70 (11.5%) stddev-sans-first:16.58 09:49:57 INFO - PROCESS | 1953 | Values: 131.0 138.0 138.0 128.0 125.0 174.0 113.0 131.0 135.0 139.0 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.40 Median:144.00 stddev:15.69 (10.9%) stddev-sans-first:15.99 09:49:57 INFO - PROCESS | 1953 | Values: 134.0 144.0 144.0 148.0 132.0 165.0 142.0 139.0 134.0 182.0 09:49:57 INFO - PROCESS | 1953 | 09:49:57 INFO - PROCESS | 1953 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:69.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 09:49:57 INFO - PROCESS | 1953 | Values: 68.0 69.0 69.0 67.0 71.0 69.0 66.0 70.0 68.0 68.0 09:49:57 INFO - PROCESS | 1953 | -------- Summary: end -------- 09:49:57 INFO - PROCESS | 1953 | 09:49:58 INFO - TEST-INFO | 1953: exit 0 09:49:58 INFO - TEST-OK | kraken | took 58190ms 09:49:58 INFO - SUITE-END | took 1168s 09:49:58 INFO - Completed test suite (00:19:29) 09:49:58 INFO - Working with test: dromaeo_css 09:49:58 INFO - Generating results file: dromaeo_css 09:49:58 INFO - Working with test: kraken 09:49:58 INFO - Generating results file: kraken 09:49:58 INFO - javascript benchmark 09:49:58 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:49:58 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 09:49:58 INFO - process_Request line: dromaeo_css 7593.09 graph.html#tests=[[72,64,61]] 09:49:58 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:49:58 INFO - process_Request line: kraken 1522.40 graph.html#tests=[[232,64,61]] 09:49:58 INFO - RETURN: dromaeo_css: 7593.09 09:49:58 INFO - RETURN: kraken: 1522.40 09:49:58 INFO - javascript benchmark 09:49:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3496.5629296337956, 3512.104413374589, 3559.5728512578494, 3586.910327241819, 3591.1560783215946, 5832.270966129234, 5833.912491312629, 5866.970665146669, 5872.060470324744, 5881.617694849842, 5661.971690141554, 5803.187553742479, 5813.389594092623, 5886.6468011919205, 5926.911096333559, 5201.531862132408, 5246.0, 5287.444818294081, 5302.522772950434, 5327.946720532803, 5296.735163241842, 5298.814541491049, 5329.440408757083, 5351.304330437038, 5355.169948657965, 5136.332276804029, 5258.894822103555, 5291.788328466895, 5294.68231906083, 5297.152455607084, 5241.187615919539, 5288.10102282609, 5324.787008519655, 5328.520433161034, 5347.598930080259, 5121.6683662247715, 5136.922946155811, 5288.0745869472685, 5298.09932311508, 5301.3373328333955, 5505.532029777473, 5561.443855614447, 5691.573132015074, 5729.828105156852, 5771.394003629601, 6144.187464697925, 6163.952128138182, 6240.469560087398, 6241.251049873998, 6260.937390626081, 6197.690115494207, 6243.500519958392, 6245.3442388549, 6245.968770156165, 6264.812055638338, 5719.111004516927, 5883.646981181143, 5907.734151963172, 5913.46778789911, 5931.436513531207, 6168.629882207082, 6241.469475094668, 6302.401271879256, 6306.2747784004505, 6320.083587879732, 6155.938440615537, 6156.353582873823, 6164.7842325518395, 6170.444659980623, 6205.751769929243, 6231.4391704745885, 6237.719302631393, 6238.812835614939, 6240.157578726905, 6261.78083767066, 6112.755489780359, 6132.080177996013, 6213.689315534205, 6214.37856214384, 6228.781992630236, 6175.938240617626, 6194.132821405007, 6204.627722336674, 6205.162303089115, 6219.689015549295, 4853.708777473293, 4909.729964851967, 4921.409430868247, 4961.280614310905, 4965.627577931669, 4372.038151606642, 4422.226110430662, 4425.22558552252, 4435.622972047412, 4453.51011388747, 5788.797392091256, 5808.680522571215, 5844.59087863854, 5854.8536286592325, 5865.354810970875, 6112.755489780359, 6138.602983404986, 6223.190985171898, 6228.844278893064, 6237.407446292595, 4940.530649588283, 5772.0, 5840.211571437886, 5850.297964244318, 5850.5027072699295, 4605.102005109038, 5337.19942008694, 5398.1632846908005, 5409.350877894678, 5428.891422171613, 5823.0, 6254.687265636791, 6327.620342779448, 6339.207599050119, 6345.0, 5857.326407463026, 6165.229346331708, 6253.437190652863, 6254.8123556293385, 6259.96870015647, 6295.527835412271, 6336.683165841598, 6357.0, 6385.0, 6395.328490508429, 6198.256209254918, 6199.132121502903, 6213.720382582705, 6217.347178546188, 6222.191115155001, 6193.349698281796, 6231.096491008688, 6231.906521402092, 6239.688015599111, 6240.781572644935, 6168.136460895388, 6181.505479561534, 6184.824883272164, 6193.721282542387, 6197.287311959182, 6064.241969753781, 6118.632882027093, 6155.322914479314, 6167.506599472121, 6180.7527698891545, 5716.685582293014, 5972.313183983897, 6050.757969681164, 6085.695715214133, 6091.451769340781, 4978.701277923191, 6185.659788711664, 6196.47329976957, 6203.751849925952, 6209.565330426827, 6010.789622363196, 6079.976141362322, 6082.239720034996, 6107.006761825686, 6108.645631960618], "unit": "score", "name": "dojo.html", "value": 5732.362174024813}, {"lowerIsBetter": false, "replicates": [438.12156625964934, 456.5571395746125, 495.26700483284736, 499.30347165703864, 556.6103727390827, 36199.45700814487, 36774.08064798375, 36791.26417471649, 36807.0, 36921.26157476849, 37824.621753782456, 38329.61670383295, 38383.0, 38430.0, 38434.42348364777, 9218.95390523048, 9367.953160234189, 9382.67160649374, 9420.293477989144, 9449.81100377992, 9392.0, 9607.855882161773, 9660.323777335554, 9660.5169741513, 9702.66040688576, 7931.0, 9411.388259763127, 9576.377535460208, 9644.421334719904, 9647.131758141766, 9586.90413095867, 9643.180329671986, 9681.322307438482, 9696.660616878446, 9697.466639334834, 9425.858612120825, 9581.329306948517, 9583.520823958774, 9597.664081757175, 9614.086661767122, 36942.89171324838, 36976.81511592452, 37056.62943370559, 37115.628843711485, 37144.814275928446, 3057.7095175958248, 3437.8281085945855, 3583.552055993001, 3640.4357324614725, 3951.762894226327, 27834.721652783417, 27995.440091198267, 28128.0, 28425.857870710723, 28460.146195614165, 2756.297144228229, 2758.4069425073503, 2781.3463835998523, 2794.413173233623, 2945.425641999811, 480961.0, 482315.0, 483939.58030209976, 485868.0, 494447.0, 50373.49626503688, 60508.0, 60550.0, 60974.695126524086, 61126.0, 58271.41728582745, 58607.0, 59000.11499827506, 59097.0, 59270.0, 15323.693526129415, 15454.536363909101, 15675.981061230983, 15684.0, 15690.607734806494, 11970.162088653884, 12069.456874440672, 12076.396180190955, 12275.079369047357, 12313.630591082281, 18856.05719714009, 18888.527786805163, 19115.375193108463, 19190.8485490871, 19221.711674324615, 7008.614526201006, 7953.5227886327, 8154.5514996674565, 8186.918130818734, 8198.344132469389, 931.0, 942.1002942190329, 974.605284859633, 1077.8275475923972, 1082.8197264981052, 28686.856565717037, 29266.853665731534, 29356.412871742446, 29730.40539189204, 30150.79396824146, 1033.4471057983942, 1051.0645525482328, 1077.0952399983894, 1078.7087486378634, 1111.294328101645, 13561.423329567351, 13610.59168224955, 13641.727165456834, 13697.383617737225, 13739.381727822272, 414620.0, 415289.0, 415416.0, 418571.0, 419337.0, 52936.94126117533, 53378.0, 53855.11507097233, 53996.73001634967, 54087.0, 1239.3988915376035, 1308.8952883769275, 1324.523171658183, 1370.2737549098993, 1545.6058705030146, 26697.932082716474, 27092.593611095454, 27120.457590848466, 27293.0, 27368.178954630595, 45614.08771824479, 46221.0, 46494.30258546192, 46505.76747116243, 46548.767256163504, 488730.0, 493748.0, 495116.0, 495764.0, 498270.0, 30847.691523084482, 31120.53319200259, 31244.218894527818, 31272.9054483092, 31470.842645786626, 36026.0, 41793.0, 42545.7236282912, 43025.92435189145, 43180.78409607932, 34766.47850282197, 35110.82444587761, 35142.82428587841, 35666.286674266885, 35728.464073038405, 34675.65324346825, 35060.874061038645, 35080.94757157289, 35098.0, 35369.93890183299, 29602.96389626353, 34441.82779086189, 35394.0, 35536.11159721028, 37126.70056548116, 25658.58877761741, 29433.411331773674, 30792.97340214353, 33036.33927321488, 33189.50215746718, 23932.803359832287, 23997.444319100665, 24017.759822401553, 24236.87881560581, 24245.03019879185], "unit": "score", "name": "ext.html", "value": 18874.65867942406}, {"lowerIsBetter": false, "replicates": [353.45920741265854, 358.0386661813032, 358.36032681663227, 364.61897317303414, 365.5923645135675, 15373.923130384332, 18554.628907421862, 18853.434396968096, 20038.799612003877, 20086.497837554067, 19662.803371966274, 20191.596168076667, 20767.68848467274, 21425.14299428025, 21506.139754409804, 5344.278522399465, 6586.736530538773, 6605.834854128661, 6620.801375958717, 6650.5012124090645, 6487.7729279475225, 6514.706838192269, 6589.505787065966, 6604.438622717051, 6623.668816559177, 4631.189541830183, 6420.133282006939, 6630.403263706289, 7232.746853860116, 7520.3983681305635, 7142.678579463936, 7443.8883416748795, 7445.553266804009, 7514.736984205554, 7528.021357223581, 7147.142342918831, 7151.678174482161, 7159.355657990805, 7186.92813071873, 7207.027051348054, 25427.745722542724, 25577.872110639513, 26371.604425933627, 26373.868130659223, 26612.80242389097, 2118.2480219522004, 2221.9333419997424, 2297.3337732057685, 2491.9252422427357, 3081.6764239754953, 15357.308921098578, 15481.612959675986, 15804.367825286974, 15902.284397202038, 16258.674826503404, 1610.6456579552596, 1802.7566278552358, 1876.2307453943954, 1902.1915685833465, 1956.432634535983, 72531.0, 98835.0, 123774.14338784925, 125009.0, 126185.0, 19018.904905475385, 19495.927723975034, 19540.90229548843, 19701.60596788056, 19846.404607861787, 22672.546549068928, 27573.0, 28646.570301445496, 28750.568741468895, 28771.424571508873, 10390.220733445021, 10573.312734672221, 10583.523741431654, 10614.734631634117, 10634.73413164677, 8936.106389361012, 8961.014288428267, 9014.41406308601, 9055.320850936207, 9086.091390860993, 8690.478571285743, 8803.955980220186, 8829.646814127364, 8867.379283450226, 8894.777630559287, 3166.3034132490816, 3176.6188057433255, 3466.5493485847182, 3710.666040056408, 3754.887353379403, 377.8450835157572, 388.2351767018968, 406.5223362548993, 406.65434380776696, 413.3345314044386, 11553.595624153115, 11783.057355411547, 19938.60122797536, 20732.859692717044, 20755.792442075384, 927.4898805656861, 958.4584709639032, 962.7532345612449, 1014.8122597319372, 1036.9740756481149, 10300.0, 10690.0, 10715.035646791826, 10789.028987391015, 10987.945060274647, 499033.0, 499149.0, 501446.0, 558266.0, 638725.0, 111389.0, 115801.0, 115909.0, 117392.41303793427, 118064.40967795106, 1030.6959446963165, 1052.9157667386592, 1054.9261551691309, 1068.631322193842, 1072.1904961753826, 18087.638247234718, 18384.81615183831, 18410.539736506693, 18423.81576184221, 18568.0, 50591.49408506015, 50641.74679126581, 51424.74287628538, 52348.47651523588, 52966.470335297694, 70791.0, 72928.63535682288, 74902.0, 82836.0, 83387.5830620843, 7266.600336981517, 7914.366850651819, 8019.959900200462, 8113.878291825746, 8371.204735550113, 9423.10480504351, 12912.35438228066, 13718.45126194941, 13764.587062388144, 13778.0, 8439.409241353293, 9193.724188274362, 9464.574094165917, 11570.710732231424, 11757.706057348634, 9852.162566181954, 10812.5134368952, 11454.0, 11592.188546801643, 11748.530058797553, 9737.269704772028, 9870.161036311707, 10086.394816311045, 11565.190436669352, 11610.94194529022, 6359.586626869239, 7915.248051435105, 8139.4709343892455, 8191.017077950446, 8228.25945664893, 11252.656045808762, 11578.0, 11684.766304673689, 11708.648740537797, 11925.403729813648], "unit": "score", "name": "jquery.html", "value": 10232.412621907324}, {"lowerIsBetter": false, "replicates": [1544.6524531980306, 1562.2891584329127, 1798.2217474002664, 1911.2164012754774, 1916.3580200632787, 7412.258774122585, 7800.765977020698, 8376.95811520943, 8805.867911981326, 8816.691415800447, 8472.36457265706, 8483.91516084839, 8515.91484085159, 8588.012378576466, 8615.913840861589, 2436.707595088592, 2447.3759191406166, 2457.766512181349, 2469.876506174693, 2472.5178590174924, 2396.9041238350446, 2454.067454367338, 2460.323411061954, 2468.062136388179, 2489.5394352044927, 2082.79172082792, 2382.725986511556, 2418.1899063813644, 2449.4243852694603, 2458.655788189646, 2331.230693871027, 2368.301351101429, 2375.8336916415856, 2376.607859703147, 2377.0848223434105, 2437.4881274932286, 2439.621858611918, 2441.597136472498, 2441.865697386643, 2442.829001969863, 8690.261327787146, 8700.825983480358, 8744.213020828156, 8768.430052046597, 8771.868421973675, 5375.139977603565, 5478.205660179292, 5513.228148059275, 5525.944740552583, 5540.113581826929, 3552.520409744677, 3552.964470355289, 3655.963440365589, 3678.8160591970563, 3745.1198968242443, 996.3125443444001, 1006.4967516241879, 1025.3130402630256, 1027.2449749434234, 1078.0190027075323, 11857.407129643483, 11878.643640690792, 12007.639770806889, 12018.39908004605, 12030.0, 4260.275753121977, 4849.060375849618, 4898.53463920927, 4944.752762361867, 4965.975170124127, 10060.195184385231, 10082.24383171265, 10140.188784897191, 10142.492875356204, 10144.847827282596, 5392.892142157135, 5415.323084614423, 5429.185622156708, 5445.319335083114, 5467.043267428184, 4265.936010959838, 4833.589144922651, 4897.2654101885, 4912.877178070506, 4929.137400954819, 3935.0, 3963.9405408918888, 3974.8012599370495, 3993.961569991823, 4007.8396864125107, 1208.6374087773634, 1302.3943866102309, 1304.1392680830606, 1307.607717684691, 1314.6713321669583, 1104.5968221599057, 1114.996503147158, 1146.5757669662278, 1277.1187880362706, 1363.0935427940508, 7835.764927052198, 7944.324732397696, 7968.920310796933, 8113.8377232456205, 8299.6680132794, 1168.7545615420686, 1169.7543515861764, 1193.0574845871838, 1197.4072833947253, 1205.102198861836, 6273.65494897785, 6292.622442653455, 6297.937020629735, 6347.777827776005, 6367.968160159169, 9727.221822254203, 10355.896441035493, 10669.626563070255, 10684.412357320267, 10759.0, 10015.449150296658, 10371.118454931264, 10478.37129772216, 10530.73673158162, 10817.242793004414, 8243.793905152419, 8287.751367458986, 8365.24712775853, 8375.371847111492, 8379.62291696875, 7773.222677732181, 7866.960665196638, 7899.881501777593, 7935.523868567904, 7976.880346794919, 9274.860877086983, 9421.15209631109, 9431.056894310514, 9478.620855165716, 9593.520323983912, 9547.093026162504, 9742.171915387271, 9845.901540984498, 9853.753656158653, 9862.950685246527, 7451.590162540895, 7472.738454154079, 7535.924640753522, 7555.848883022419, 7577.014988051518, 8124.83750325002, 8129.227723366271, 8200.58997050157, 8235.176482351957, 8277.917220827714, 6839.863202735818, 7268.164161121539, 7419.109706835215, 7510.774676759706, 7548.735794247175, 7111.359977602041, 7204.24355442671, 7222.205557388578, 7266.2007179211305, 7273.563586184846, 7537.886931695919, 7566.772996810105, 7587.506812057199, 7611.809704757204, 7627.0, 6825.2833452486775, 6857.828554286183, 6910.93089069123, 6935.063766391472, 6943.79168624942, 7049.823754405976, 7090.716371345088, 7125.1093613298335, 7126.85746285061, 7132.750353737594], "unit": "score", "name": "mootools.html", "value": 4917.856092928677}, {"lowerIsBetter": false, "replicates": [324.62667931878343, 330.4267096587422, 332.0172290021536, 335.7280602711803, 339.5874013074116, 6669.19969603647, 6771.898421523675, 6775.08536347593, 6798.048273241744, 6798.796036118918, 5433.864153396157, 5470.781168753255, 6701.49738769593, 6732.9663351683175, 6734.259231484545, 4077.2049450357194, 4948.1093403187415, 4979.60163186946, 4995.650304478688, 5007.774650140753, 4133.400656904747, 5001.749912504379, 5012.72430016349, 5019.54824065834, 5027.472115427882, 4067.6745860331253, 4944.777485013183, 4958.479359667237, 4968.826091086813, 4995.975020124894, 4704.200285951397, 4993.400791904976, 4995.100881841267, 4996.725180115092, 5010.924836127461, 3599.784012959231, 3915.177812659345, 4043.9890027493125, 4061.817218225187, 4119.9176016479505, 5499.917501237484, 5581.190727344553, 6447.0, 6461.224653041665, 6534.771283005072, 4870.928395752964, 5635.830925072213, 5653.717314134276, 5770.134479828017, 5770.711464426804, 7180.138383394026, 7183.066201393785, 7183.964080179566, 7185.389241914443, 7199.4600404969315, 3878.631530004673, 4587.3348364486965, 4603.066711980942, 4608.377868987677, 4610.861674149747, 7362.74833278344, 7630.580318082559, 7694.422918281095, 7720.922790772077, 7723.613819309068, 4621.468531118964, 4652.371929789503, 4663.090697313991, 4666.95333046672, 4667.813287468463, 4171.520275168334, 4383.772543687773, 4405.735655860594, 4742.359781429532, 4744.69159504638, 5670.461306175906, 5676.148577713294, 5680.807030523636, 5686.630369026, 5688.601797874109, 7018.350687588412, 7271.127464704164, 7288.234735352712, 7291.30732580404, 7311.853762924712, 1607.541850572581, 1631.208863701104, 1634.525987463646, 1635.8854880158513, 1636.5499487640993, 997.2846703669677, 1052.5368837711383, 1053.710229686827, 1061.098066643347, 1071.3678929431674, 6751.628660423626, 6826.146731658543, 6866.862662746717, 6870.3473170048765, 6870.656467176721, 7601.619919004028, 7604.467687261949, 7613.162552119263, 7624.809379765439, 7631.503952243197, 6818.454523638097, 6890.758823441155, 6892.517523773287, 6926.792196234121, 6944.409725173316, 3891.124496988155, 4032.1129351542613, 4042.3734321180264, 4052.8176232069627, 4075.8777236682945, 6583.44040756541, 6940.7223711052, 8018.679252829821, 8020.95727555414, 8042.316403105685, 6803.65981700913, 7932.0878099019355, 7936.246056624612, 7939.126696063428, 7944.9205507945335, 6914.688839002257, 7689.653965571562, 8015.839683206304, 8046.597670116471, 8076.232757887991, 7415.814604634711, 7698.499597526143, 7701.422393320636, 7717.0, 7733.226677332222, 7497.587632680255, 7502.287282708134, 7511.586862722603, 7529.247075292646, 7546.283103105416, 8001.639926203451, 8004.079530853794, 8045.195480451908, 8046.919530804851, 8058.959705201437, 4738.668293219442, 4745.738984355894, 4750.904981900274, 4751.121042607128, 4757.238841785298, 5835.278592815214, 6275.843103922439, 7447.813804654927, 7661.0, 7675.923240767745, 6042.90935635957, 7317.5609463432365, 7379.963100184465, 7382.6677799498075, 7405.074365704287, 6066.393360663898, 7322.157951835394, 7367.889481657672, 7378.413641067196, 7391.630418478947, 7159.284071592799, 7178.246284140299, 7198.136223653195, 7204.0, 7204.063471748639, 7091.184513780981, 7366.116066072105, 7369.889451658337, 7379.3358597726465, 7394.593297368697, 6883.449324053963, 7026.051483049927, 7144.428445724226, 7178.676959536938, 7189.784306470814], "unit": "score", "name": "prototype.html", "value": 5220.507774602546}, {"lowerIsBetter": false, "replicates": [668.6355936014875, 693.7259782385961, 714.4591266951065, 722.4184531452181, 727.7089164334267, 14631.048981816175, 14737.705245895102, 14813.333399996998, 14822.77765833512, 14846.257687115642, 13445.462181512728, 13477.0, 13586.728265434685, 13628.863711362883, 13634.795478067837, 842.9452085614415, 873.7247766953406, 882.7175303902753, 892.8258989497051, 893.7676204186894, 884.0275696733573, 884.9734507964771, 885.8361203177401, 886.2732559301376, 889.181952603603, 893.6425429828088, 932.2309094996621, 932.7714709896085, 934.2992755433424, 938.2353381993653, 876.2070326354659, 915.8397280475923, 920.4017388697333, 930.1303281431883, 930.6370515498961, 663.7875879718492, 689.5724650716538, 691.629977961788, 692.6779047742824, 693.2789898505548, 13034.022448316415, 13050.0, 13071.281079540622, 13116.606501804961, 13123.343832808321, 10822.24244302899, 10881.183911206612, 10937.015668589785, 11066.0, 11245.15661325404, 9528.380655257386, 9546.713598592054, 9559.522023898777, 9568.09103135201, 9910.801783964353, 3395.47370157626, 3399.2351720862857, 3421.606515250753, 3453.3783918894587, 3461.6365281645317, 70072.649636752, 74034.88947665843, 76679.84980225301, 78321.0, 87647.24705505918, 9325.300602454707, 9356.485393303297, 9394.765130871647, 9421.670241541513, 9883.11052005323, 17565.473035808947, 19788.70316945247, 19899.60200795976, 20028.799712002983, 20054.799452005293, 7111.573305601681, 7236.891446628305, 7282.0, 7427.591482468408, 7592.81017974555, 4100.65144462724, 4114.259433301974, 4119.8352065917625, 4130.772807495617, 4131.669466442678, 3488.284901595167, 3491.4064609016527, 3514.8594056237976, 3544.2379888324135, 3547.290541891632, 651.6025224612982, 652.083822229768, 665.4476784269045, 667.6594936582378, 669.9732010719614, 576.7577617400618, 581.4331027248398, 582.5601670738565, 612.6875293600295, 620.5283984172062, 8320.875186872201, 8420.78948026292, 8505.19568419789, 8535.95732021336, 8582.742517724479, 559.8208573256519, 587.7472686744655, 597.0626116996361, 621.8227805075622, 632.4560877645222, 3972.7219094663096, 3973.1259122992897, 4032.5564187939303, 4245.12974840157, 4336.262835318003, 79855.0, 80166.59916700496, 81283.59358203171, 85410.0, 89714.55142724376, 49570.752146239036, 59599.21202363936, 68583.65708171428, 71960.56078878498, 78876.0, 62276.37723622796, 63811.4047148825, 63895.0, 63979.72040559163, 65054.0, 8520.74437766868, 8631.309495240492, 8719.34604904622, 8841.970952082043, 8862.20240178387, 46249.76875115603, 48083.03833923372, 48104.759476202395, 48626.0, 50012.24981625351, 62547.6872615634, 64642.67678661577, 64686.676566616865, 65569.01646475402, 66498.33501664922, 10749.838752418564, 10928.78142437131, 10955.233133680566, 11252.381119038531, 11628.069754419457, 11834.289942603471, 12263.080268979684, 12270.263784172977, 12276.815847762113, 12514.812277815658, 11179.385133817717, 11261.493232804707, 11266.380349080879, 11647.6505704829, 11836.526538938346, 11067.335959842436, 11256.155788316073, 11759.118066145244, 11809.23239989398, 12295.815562766744, 11181.385023823768, 11231.26996745209, 11341.829872551752, 11379.601713939972, 11897.870734891863, 9502.144806967406, 9578.9042109578, 9598.0, 9688.176504996873, 9903.950480247553, 8778.824423511367, 9296.442213467213, 9806.460644664612, 9892.85160722604, 9911.45486998222], "unit": "score", "name": "yui.html", "value": 6742.122492009253}], "name": "dromaeo_css", "value": 7593.086019456974}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [158.0, 152.0, 159.0, 116.0, 117.0, 111.0, 154.0, 168.0, 169.0, 94.0], "unit": "score", "name": "ai-astar", "value": 139.8}, {"lowerIsBetter": true, "replicates": [189.0, 130.0, 149.0, 157.0, 123.0, 148.0, 134.0, 195.0, 173.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 151.9}, {"lowerIsBetter": true, "replicates": [196.0, 200.0, 206.0, 233.0, 196.0, 200.0, 201.0, 199.0, 204.0, 198.0], "unit": "score", "name": "audio-dft", "value": 203.3}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 71.0, 114.0, 57.0, 55.0, 65.0, 77.0, 113.0, 59.0], "unit": "score", "name": "audio-fft", "value": 75.7}, {"lowerIsBetter": true, "replicates": [83.0, 74.0, 125.0, 83.0, 82.0, 84.0, 119.0, 86.0, 99.0, 109.0], "unit": "score", "name": "audio-oscillator", "value": 94.4}, {"lowerIsBetter": true, "replicates": [106.0, 92.0, 85.0, 91.0, 104.0, 116.0, 86.0, 91.0, 86.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 99.0, 94.0, 95.0, 94.0, 95.0, 96.0, 94.0, 100.0], "unit": "score", "name": "imaging-darkroom", "value": 95.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 91.0, 93.0, 95.0, 93.0, 92.0, 96.0, 93.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 93.5}, {"lowerIsBetter": true, "replicates": [55.0, 57.0, 57.0, 54.0, 54.0, 56.0, 60.0, 88.0, 47.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 58.3}, {"lowerIsBetter": true, "replicates": [63.0, 68.0, 75.0, 85.0, 96.0, 101.0, 62.0, 93.0, 60.0, 78.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 78.1}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 86.0, 87.0, 87.0, 85.0, 86.0, 85.0, 86.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [131.0, 138.0, 138.0, 128.0, 125.0, 174.0, 113.0, 131.0, 135.0, 139.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 135.2}, {"lowerIsBetter": true, "replicates": [134.0, 144.0, 144.0, 148.0, 132.0, 165.0, 142.0, 139.0, 134.0, 182.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 67.0, 71.0, 69.0, 66.0, 70.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1522.4}]} 09:49:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1522.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7593.09"}}} 09:49:58 INFO - Return code: 0 09:49:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:49:58 ERROR - # TBPL SUCCESS # 09:49:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:49:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:49:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:49:58 INFO - 2016-02-24 09:49:58.985 screenresolution[1958:11624] starting screenresolution argv=screenresolution get 09:49:58 INFO - 2016-02-24 09:49:58.987 screenresolution[1958:11624] Display 0: 1600x1200x32@60 09:49:58 INFO - 2016-02-24 09:49:58.993 screenresolution[1959:11627] starting screenresolution argv=screenresolution list 09:49:58 INFO - Available Modes on Display 0 09:49:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:49:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:49:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:49:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:49:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:49:59 INFO - Intel Iris: 09:49:59 INFO - Chipset Model: Intel Iris 09:49:59 INFO - Type: GPU 09:49:59 INFO - Bus: Built-In 09:49:59 INFO - VRAM (Dynamic, Max): 1536 MB 09:49:59 INFO - Vendor: Intel (0x8086) 09:49:59 INFO - Device ID: 0x0a2e 09:49:59 INFO - Revision ID: 0x0009 09:49:59 INFO - Displays: 09:49:59 INFO - Display: 09:49:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:49:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:49:59 INFO - Display Serial Number: 1600x1200 60 09:49:59 INFO - Main Display: Yes 09:49:59 INFO - Mirror: Off 09:49:59 INFO - Online: Yes 09:49:59 INFO - Rotation: Supported 09:49:59 INFO - Return code: 0 09:49:59 INFO - Running post-action listener: _resource_record_post_action 09:49:59 INFO - Running post-run listener: _resource_record_post_run 09:50:00 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 4034560; Write bytes: 709419008; Read time: 53; Write time: 2266 09:50:00 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 384680448; Write bytes: 379941888; Read time: 28470; Write time: 696 09:50:00 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 4005888; Write bytes: 301972480; Read time: 52; Write time: 1510 09:50:00 INFO - Running post-run listener: _upload_blobber_files 09:50:00 INFO - Blob upload gear active. 09:50:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:50:00 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 09:50:00 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'] 09:50:00 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 09:50:00 INFO - (blobuploader) - INFO - Open directory for files ... 09:50:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:50:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:50:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:01 INFO - (blobuploader) - INFO - Done attempting. 09:50:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:50:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:50:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:50:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:50:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:50:03 INFO - (blobuploader) - INFO - Done attempting. 09:50:03 INFO - (blobuploader) - INFO - Iteration through files over. 09:50:03 INFO - Return code: 0 09:50:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:50:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:50:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a0b6d25c6daa48dfdcce42bd62f4f6f16cd2bdd13cdce2f46516c439bfebc5f39d1897d51046c3d1a679b7c9adfcb3d876feb30899aa6be72f8897ea9d39bdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bbcf4e5c1b27242d59e1210c888e9d7fac628c1d484d9354be3545da59314774b63e181c154b5d14803262cdd92d26672dc9448dc0fd4e1410205271014b8fc"} 09:50:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:50:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:50:03 INFO - Contents: 09:50:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a0b6d25c6daa48dfdcce42bd62f4f6f16cd2bdd13cdce2f46516c439bfebc5f39d1897d51046c3d1a679b7c9adfcb3d876feb30899aa6be72f8897ea9d39bdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bbcf4e5c1b27242d59e1210c888e9d7fac628c1d484d9354be3545da59314774b63e181c154b5d14803262cdd92d26672dc9448dc0fd4e1410205271014b8fc"} 09:50:03 INFO - Running post-run listener: copy_logs_to_upload_dir 09:50:03 INFO - Copying logs to upload dir... 09:50:03 INFO - mkdir: /builds/slave/test/build/upload/logs 09:50:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.044241 ========= master_lag: 7.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-02-24 09:50:10.196890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 09:50:10.205239) ========= 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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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/7a0b6d25c6daa48dfdcce42bd62f4f6f16cd2bdd13cdce2f46516c439bfebc5f39d1897d51046c3d1a679b7c9adfcb3d876feb30899aa6be72f8897ea9d39bdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bbcf4e5c1b27242d59e1210c888e9d7fac628c1d484d9354be3545da59314774b63e181c154b5d14803262cdd92d26672dc9448dc0fd4e1410205271014b8fc"} build_url:https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011561 build_url: 'https://queue.taskcluster.net/v1/task/XBrM-EotTMmpaZ1Rq6gRnw/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a0b6d25c6daa48dfdcce42bd62f4f6f16cd2bdd13cdce2f46516c439bfebc5f39d1897d51046c3d1a679b7c9adfcb3d876feb30899aa6be72f8897ea9d39bdf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1bbcf4e5c1b27242d59e1210c888e9d7fac628c1d484d9354be3545da59314774b63e181c154b5d14803262cdd92d26672dc9448dc0fd4e1410205271014b8fc"}' ========= master_lag: 0.88 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 09:50:11.099394) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:50:11.099729) ========= 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.eexlwtdmyk/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.Cg7G2wpcm7/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005288 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 09:50:11.154145) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 09:50:11.154428) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 09:50:11.155388) ========= ========= Total master_lag: 8.11 =========