builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0162 starttime: 1457032684.68 results: success (0) buildid: 20160303092333 builduid: fbd0d6d18bac4a1fb87a3ecb3e535eb3 revision: 217b441ef860497f6770a27fa2ba988060ae00ed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.682908) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.683345) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.683641) ========= 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.CQTyaw1JdT/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.fCm4dH6v72/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005854 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.708718) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.712029) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.727404) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.727670) ========= 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.CQTyaw1JdT/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.fCm4dH6v72/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005494 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.775598) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.778953) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.779316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.779624) ========= 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.CQTyaw1JdT/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.fCm4dH6v72/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-03-03 11:18:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.7M=0.001s 2016-03-03 11:18:04 (15.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.146941 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.941828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.945175) ========= 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.CQTyaw1JdT/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.fCm4dH6v72/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.020033 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:04.997314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 11:18:04.997635) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 217b441ef860497f6770a27fa2ba988060ae00ed --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 217b441ef860497f6770a27fa2ba988060ae00ed --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CQTyaw1JdT/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.fCm4dH6v72/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-03-03 11:18:05,046 truncating revision to first 12 chars 2016-03-03 11:18:05,046 Setting DEBUG logging. 2016-03-03 11:18:05,046 attempt 1/10 2016-03-03 11:18:05,046 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/217b441ef860?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-03 11:18:06,460 unpacking tar archive at: fx-team-217b441ef860/testing/mozharness/ program finished with exit code 0 elapsedTime=1.663541 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-03 11:18:06.677193) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:06.677559) ========= echo 217b441ef860497f6770a27fa2ba988060ae00ed in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'217b441ef860497f6770a27fa2ba988060ae00ed'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CQTyaw1JdT/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.fCm4dH6v72/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 217b441ef860497f6770a27fa2ba988060ae00ed program finished with exit code 0 elapsedTime=0.005246 script_repo_revision: '217b441ef860497f6770a27fa2ba988060ae00ed' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:06.727236) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:06.727520) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-03 11:18:06.740720) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-03 11:18:06.741008) ========= /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.CQTyaw1JdT/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.fCm4dH6v72/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:18:06 INFO - MultiFileLogger online at 20160303 11:18:06 in /builds/slave/test 11:18:06 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 11:18:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:18:06 INFO - {'append_to_log': False, 11:18:06 INFO - 'base_work_dir': '/builds/slave/test', 11:18:06 INFO - 'blob_upload_branch': 'Fx-Team', 11:18:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:18:06 INFO - 'branch': 'Fx-Team', 11:18:06 INFO - 'buildbot_json_path': 'buildprops.json', 11:18:06 INFO - 'config_files': ('talos/mac_config.py',), 11:18:06 INFO - 'default_actions': ('clobber', 11:18:06 INFO - 'read-buildbot-config', 11:18:06 INFO - 'download-and-extract', 11:18:06 INFO - 'populate-webroot', 11:18:06 INFO - 'create-virtualenv', 11:18:06 INFO - 'install', 11:18:06 INFO - 'run-tests'), 11:18:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:18:06 INFO - 'download_minidump_stackwalk': True, 11:18:06 INFO - 'download_symbols': 'ondemand', 11:18:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:18:06 INFO - 'tooltool.py': '/tools/tooltool.py', 11:18:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:18:06 INFO - '/tools/misc-python/virtualenv.py')}, 11:18:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:18:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:18:06 INFO - 'installer_path': 'installer.exe', 11:18:06 INFO - 'log_level': 'info', 11:18:06 INFO - 'log_name': 'talos', 11:18:06 INFO - 'log_to_console': True, 11:18:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:18:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:18:06 INFO - 'opt_config_files': (), 11:18:06 INFO - 'pip_index': False, 11:18:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:18:06 INFO - 'cmd': ('bash', 11:18:06 INFO - '-c', 11:18:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:18:06 INFO - 'enabled': True, 11:18:06 INFO - 'halt_on_failure': False, 11:18:06 INFO - 'name': 'check_screen_resolution'},), 11:18:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:18:06 INFO - 'cmd': ('bash', 11:18:06 INFO - '-c', 11:18:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:18:06 INFO - 'enabled': True, 11:18:06 INFO - 'halt_on_failure': False, 11:18:06 INFO - 'name': 'check_screen_resolution'},), 11:18:06 INFO - 'run_cmd_checks_enabled': True, 11:18:06 INFO - 'sps_profile': False, 11:18:06 INFO - 'sps_profile_interval': 0, 11:18:06 INFO - 'suite': 'dromaeojs-e10s', 11:18:06 INFO - 'system_bits': '32', 11:18:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:18:06 INFO - 'title': 't-yosemite-r7-0162', 11:18:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:18:06 INFO - 'use_talos_json': True, 11:18:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:18:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:18:06 INFO - 'work_dir': 'build'} 11:18:06 INFO - ##### 11:18:06 INFO - ##### Running clobber step. 11:18:06 INFO - ##### 11:18:06 INFO - Running pre-action listener: _resource_record_pre_action 11:18:06 INFO - Running main action method: clobber 11:18:06 INFO - rmtree: /builds/slave/test/build 11:18:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:18:08 INFO - Running post-action listener: _resource_record_post_action 11:18:08 INFO - ##### 11:18:08 INFO - ##### Running read-buildbot-config step. 11:18:08 INFO - ##### 11:18:08 INFO - Running pre-action listener: _resource_record_pre_action 11:18:08 INFO - Running main action method: read_buildbot_config 11:18:08 INFO - Using buildbot properties: 11:18:08 INFO - { 11:18:08 INFO - "project": "", 11:18:08 INFO - "product": "firefox", 11:18:08 INFO - "script_repo_revision": "production", 11:18:08 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 11:18:08 INFO - "repository": "", 11:18:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 11:18:08 INFO - "buildid": "20160303092333", 11:18:08 INFO - "pgo_build": "False", 11:18:08 INFO - "basedir": "/builds/slave/test", 11:18:08 INFO - "buildnumber": 488, 11:18:08 INFO - "slavename": "t-yosemite-r7-0162", 11:18:08 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:18:08 INFO - "platform": "yosemite_r7", 11:18:08 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:18:08 INFO - "branch": "fx-team", 11:18:08 INFO - "repo_path": "integration/fx-team", 11:18:08 INFO - "revision": "217b441ef860497f6770a27fa2ba988060ae00ed", 11:18:08 INFO - "stage_platform": "macosx64", 11:18:08 INFO - "builduid": "fbd0d6d18bac4a1fb87a3ecb3e535eb3", 11:18:08 INFO - "slavebuilddir": "test" 11:18:08 INFO - } 11:18:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 11:18:08 INFO - Running post-action listener: _resource_record_post_action 11:18:08 INFO - ##### 11:18:08 INFO - ##### Running download-and-extract step. 11:18:08 INFO - ##### 11:18:08 INFO - Running pre-action listener: _resource_record_pre_action 11:18:08 INFO - Running main action method: download_and_extract 11:18:08 INFO - mkdir: /builds/slave/test/build/tests 11:18:08 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')]} 11:18:08 INFO - https://queue.taskcluster.net/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 11:18:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 11:18:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 11:18:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 11:18:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 11:18:09 INFO - Downloaded 1277 bytes. 11:18:09 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 11:18:09 INFO - Using the following test package requirements: 11:18:09 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:18:09 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:18:09 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 11:18:09 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:18:09 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 11:18:09 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:18:09 INFO - u'jsshell-mac.zip'], 11:18:09 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:18:09 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 11:18:09 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:18:09 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:18:09 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 11:18:09 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:18:09 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 11:18:09 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:18:09 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 11:18:09 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:18:09 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:18:09 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 11:18:09 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:18:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:09 INFO - https://queue.taskcluster.net/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:18:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:18:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:18:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/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 11:18:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/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 11:18:10 INFO - Downloaded 17855112 bytes. 11:18:10 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'] 11:18:10 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 11:18:13 INFO - Return code: 0 11:18:13 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 11:18:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:13 INFO - https://queue.taskcluster.net/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:18:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:18:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:18:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/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 11:18:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/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 11:18:14 INFO - Downloaded 17855112 bytes. 11:18:14 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'] 11:18:14 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 11:18:18 INFO - Return code: 0 11:18:18 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')]} 11:18:18 INFO - https://queue.taskcluster.net/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:18:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 11:18:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 11:18:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/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 11:18:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/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 11:18:19 INFO - Downloaded 10808282 bytes. 11:18:19 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'] 11:18:19 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 11:18:19 INFO - Return code: 0 11:18:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:19 INFO - https://queue.taskcluster.net/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:18:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:18:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:18:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 11:18:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfs7pxxPS9Sx6zsr1YMezg/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 11:18:22 INFO - Downloaded 110953269 bytes. 11:18:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:18:22 INFO - mkdir: /builds/slave/test/properties 11:18:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:18:22 INFO - Writing to file /builds/slave/test/properties/build_url 11:18:22 INFO - Contents: 11:18:22 INFO - build_url:https://queue.taskcluster.net/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:18:23 INFO - Running post-action listener: _resource_record_post_action 11:18:23 INFO - Running post-action listener: set_extra_try_arguments 11:18:23 INFO - ##### 11:18:23 INFO - ##### Running populate-webroot step. 11:18:23 INFO - ##### 11:18:23 INFO - Running pre-action listener: _resource_record_pre_action 11:18:23 INFO - Running main action method: populate_webroot 11:18:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:18:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:18:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:18:23 INFO - '--tppagecycles', 11:18:23 INFO - '7'], 11:18:23 INFO - 'tests': ['tsvgm']}}, 11:18:23 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:18:23 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:18:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:18:23 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:18:23 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:18:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:18:23 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:23 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:23 INFO - 'talos_options': ['--e10s'], 11:18:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:18:23 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:23 INFO - 'tests': ['damp', 'tps']}, 11:18:23 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:23 INFO - 'talos_options': ['--e10s'], 11:18:23 INFO - 'tests': ['damp', 'tps']}, 11:18:23 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:18:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:18:23 INFO - 'other': {'tests': ['a11yr', 11:18:23 INFO - 'ts_paint', 11:18:23 INFO - 'tpaint', 11:18:23 INFO - 'sessionrestore', 11:18:23 INFO - 'sessionrestore_no_auto_restore']}, 11:18:23 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:18:23 INFO - 'tests': ['a11yr', 11:18:23 INFO - 'ts_paint', 11:18:23 INFO - 'tpaint', 11:18:23 INFO - 'sessionrestore', 11:18:23 INFO - 'sessionrestore_no_auto_restore']}, 11:18:23 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:18:23 INFO - 'tests': ['a11yr', 11:18:23 INFO - 'ts_paint', 11:18:23 INFO - 'tpaint', 11:18:23 INFO - 'sessionrestore', 11:18:23 INFO - 'sessionrestore_no_auto_restore']}, 11:18:23 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:18:23 INFO - 'tests': ['a11yr', 11:18:23 INFO - 'ts_paint', 11:18:23 INFO - 'tpaint', 11:18:23 INFO - 'sessionrestore', 11:18:23 INFO - 'sessionrestore_no_auto_restore']}, 11:18:23 INFO - 'other_l64': {'tests': ['a11yr', 11:18:23 INFO - 'ts_paint', 11:18:23 INFO - 'tpaint', 11:18:23 INFO - 'sessionrestore', 11:18:23 INFO - 'sessionrestore_no_auto_restore']}, 11:18:23 INFO - 'other_nol64': {'tests': ['a11yr', 11:18:23 INFO - 'ts_paint', 11:18:23 INFO - 'tpaint', 11:18:23 INFO - 'sessionrestore', 11:18:23 INFO - 'sessionrestore_no_auto_restore']}, 11:18:23 INFO - 'svgr': {'tests': ['tsvgx', 11:18:23 INFO - 'tsvgr_opacity', 11:18:23 INFO - 'tart', 11:18:23 INFO - 'tscrollx', 11:18:23 INFO - 'cart']}, 11:18:23 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:18:23 INFO - 'tests': ['tsvgx', 11:18:23 INFO - 'tsvgr_opacity', 11:18:23 INFO - 'tart', 11:18:23 INFO - 'tscrollx', 11:18:23 INFO - 'cart']}, 11:18:23 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:23 INFO - 'tests': ['tp5o']}, 11:18:23 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:23 INFO - 'talos_options': ['--e10s'], 11:18:23 INFO - 'tests': ['tp5o']}, 11:18:23 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:23 INFO - 'talos_options': ['--xperf_path', 11:18:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:23 INFO - 'tests': ['tp5n']}, 11:18:23 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:18:23 INFO - 'talos_options': ['--e10s', 11:18:23 INFO - '--xperf_path', 11:18:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:18:23 INFO - 'tests': ['tp5n']}}, 11:18:23 INFO - 'talos.zip': {'path': '', 11:18:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:18:23 INFO - Running post-action listener: _resource_record_post_action 11:18:23 INFO - ##### 11:18:23 INFO - ##### Running create-virtualenv step. 11:18:23 INFO - ##### 11:18:23 INFO - Running pre-action listener: _resource_record_pre_action 11:18:23 INFO - Running main action method: create_virtualenv 11:18:23 INFO - Creating virtualenv /builds/slave/test/build/venv 11:18:23 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 11:18:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:18:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:18:24 INFO - Using real prefix '/tools/python27' 11:18:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:18:24 INFO - Installing distribute.............................................................................................................................................................................................done. 11:18:27 INFO - Installing pip.................done. 11:18:27 INFO - Return code: 0 11:18:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:27 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 0x109274a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10927b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62949be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109118d30>, '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 0x108f3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10910fb20>, '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.CQTyaw1JdT/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.fCm4dH6v72/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:18:27 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 11:18:27 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 11:18:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CQTyaw1JdT/Render', 11:18:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:27 INFO - 'HOME': '/Users/cltbld', 11:18:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:27 INFO - 'LOGNAME': 'cltbld', 11:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:27 INFO - 'MOZ_NO_REMOTE': '1', 11:18:27 INFO - 'NO_EM_RESTART': '1', 11:18:27 INFO - 'PAGER': '/bin/cat', 11:18:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:27 INFO - 'PWD': '/builds/slave/test', 11:18:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:27 INFO - 'SHELL': '/bin/bash', 11:18:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fCm4dH6v72/Listeners', 11:18:27 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:18:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:27 INFO - 'USER': 'cltbld', 11:18:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:27 INFO - 'XPC_FLAGS': '0x0', 11:18:27 INFO - 'XPC_SERVICE_NAME': '0', 11:18:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:27 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 11:18:27 INFO - Cleaning up... 11:18:27 INFO - Return code: 0 11:18:27 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:27 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 0x109274a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10927b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62949be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109118d30>, '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 0x108f3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10910fb20>, '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.CQTyaw1JdT/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.fCm4dH6v72/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:18:27 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 11:18:27 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 11:18:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CQTyaw1JdT/Render', 11:18:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:27 INFO - 'HOME': '/Users/cltbld', 11:18:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:27 INFO - 'LOGNAME': 'cltbld', 11:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:27 INFO - 'MOZ_NO_REMOTE': '1', 11:18:27 INFO - 'NO_EM_RESTART': '1', 11:18:27 INFO - 'PAGER': '/bin/cat', 11:18:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:27 INFO - 'PWD': '/builds/slave/test', 11:18:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:27 INFO - 'SHELL': '/bin/bash', 11:18:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fCm4dH6v72/Listeners', 11:18:27 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:18:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:27 INFO - 'USER': 'cltbld', 11:18:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:27 INFO - 'XPC_FLAGS': '0x0', 11:18:27 INFO - 'XPC_SERVICE_NAME': '0', 11:18:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:28 INFO - Downloading/unpacking psutil>=0.7.1 11:18:28 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 11:18:28 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 11:18:28 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 11:18:28 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 11:18:28 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 11:18:28 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 11:18:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:18:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:30 INFO - Installing collected packages: psutil 11:18:30 INFO - Running setup.py install for psutil 11:18:30 INFO - building 'psutil._psutil_osx' extension 11:18:30 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 11:18:31 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 11:18:31 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 11:18:31 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 11:18:31 INFO - building 'psutil._psutil_posix' extension 11:18:31 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 11:18:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:18:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:18:31 INFO - ^ 11:18:31 INFO - 1 warning generated. 11:18:31 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 11:18:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:18:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:18:31 INFO - Successfully installed psutil 11:18:31 INFO - Cleaning up... 11:18:31 INFO - Return code: 0 11:18:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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', '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 0x109274a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10927b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62949be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109118d30>, '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 0x108f3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10910fb20>, '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.CQTyaw1JdT/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.fCm4dH6v72/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:18: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 11:18: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 mozsystemmonitor==0.0.0 11:18:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CQTyaw1JdT/Render', 11:18:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:31 INFO - 'HOME': '/Users/cltbld', 11:18:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:31 INFO - 'LOGNAME': 'cltbld', 11:18:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:31 INFO - 'MOZ_NO_REMOTE': '1', 11:18:31 INFO - 'NO_EM_RESTART': '1', 11:18:31 INFO - 'PAGER': '/bin/cat', 11:18:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:31 INFO - 'PWD': '/builds/slave/test', 11:18:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:31 INFO - 'SHELL': '/bin/bash', 11:18:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fCm4dH6v72/Listeners', 11:18:31 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:18:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:31 INFO - 'USER': 'cltbld', 11:18:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:31 INFO - 'XPC_FLAGS': '0x0', 11:18:31 INFO - 'XPC_SERVICE_NAME': '0', 11:18:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:18:31 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 11:18:31 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 11:18:31 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 11:18:31 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 11:18:31 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 11:18:31 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 11:18:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:18:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:18:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:18:34 INFO - Installing collected packages: mozsystemmonitor 11:18:34 INFO - Running setup.py install for mozsystemmonitor 11:18:34 INFO - Successfully installed mozsystemmonitor 11:18:34 INFO - Cleaning up... 11:18:34 INFO - Return code: 0 11:18:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:34 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 0x109274a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10927b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62949be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109118d30>, '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 0x108f3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10910fb20>, '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.CQTyaw1JdT/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.fCm4dH6v72/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:18:34 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 11:18:34 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 11:18:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CQTyaw1JdT/Render', 11:18:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:34 INFO - 'HOME': '/Users/cltbld', 11:18:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:34 INFO - 'LOGNAME': 'cltbld', 11:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:34 INFO - 'MOZ_NO_REMOTE': '1', 11:18:34 INFO - 'NO_EM_RESTART': '1', 11:18:34 INFO - 'PAGER': '/bin/cat', 11:18:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:34 INFO - 'PWD': '/builds/slave/test', 11:18:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:34 INFO - 'SHELL': '/bin/bash', 11:18:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fCm4dH6v72/Listeners', 11:18:34 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:18:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:34 INFO - 'USER': 'cltbld', 11:18:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:34 INFO - 'XPC_FLAGS': '0x0', 11:18:34 INFO - 'XPC_SERVICE_NAME': '0', 11:18:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:34 INFO - Downloading/unpacking blobuploader==1.2.4 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:37 INFO - Downloading blobuploader-1.2.4.tar.gz 11:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:18:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:18:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:38 INFO - Downloading docopt-0.6.1.tar.gz 11:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:18:38 INFO - Installing collected packages: blobuploader, requests, docopt 11:18:38 INFO - Running setup.py install for blobuploader 11:18:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:18:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:18:38 INFO - Running setup.py install for requests 11:18:38 INFO - Running setup.py install for docopt 11:18:39 INFO - Successfully installed blobuploader requests docopt 11:18:39 INFO - Cleaning up... 11:18:39 INFO - Return code: 0 11:18:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:39 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 0x109274a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10927b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62949be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109118d30>, '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 0x108f3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10910fb20>, '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.CQTyaw1JdT/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.fCm4dH6v72/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:18:39 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 11:18:39 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 11:18:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CQTyaw1JdT/Render', 11:18:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:39 INFO - 'HOME': '/Users/cltbld', 11:18:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:39 INFO - 'LOGNAME': 'cltbld', 11:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:39 INFO - 'MOZ_NO_REMOTE': '1', 11:18:39 INFO - 'NO_EM_RESTART': '1', 11:18:39 INFO - 'PAGER': '/bin/cat', 11:18:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:39 INFO - 'PWD': '/builds/slave/test', 11:18:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:39 INFO - 'SHELL': '/bin/bash', 11:18:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fCm4dH6v72/Listeners', 11:18:39 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:18:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:39 INFO - 'USER': 'cltbld', 11:18:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:39 INFO - 'XPC_FLAGS': '0x0', 11:18:39 INFO - 'XPC_SERVICE_NAME': '0', 11:18:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:39 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-9ZXJCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:39 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Kt2qvh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:39 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-pQde_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:39 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-XhIK4x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:39 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-cQQQGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:39 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-GP6je6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:40 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-3eWwTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:40 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-JVNAc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:40 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-R9bRbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:40 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-nacWdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:40 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-_s8u18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:40 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-d46SXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:40 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-M3r1BY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:40 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-qUhRYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:40 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Sfv3Hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:40 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-xGfyN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:41 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-yPtkWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:18:41 INFO - Running setup.py install for manifestparser 11:18:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:18:41 INFO - Running setup.py install for mozcrash 11:18:41 INFO - Running setup.py install for mozdebug 11:18:41 INFO - Running setup.py install for mozdevice 11:18:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:18:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:18:41 INFO - Running setup.py install for mozfile 11:18:41 INFO - Running setup.py install for mozhttpd 11:18:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:18:42 INFO - Running setup.py install for mozinfo 11:18:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:18:42 INFO - Running setup.py install for mozInstall 11:18:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:18:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:18:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:18:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:18:42 INFO - Running setup.py install for mozleak 11:18:42 INFO - Running setup.py install for mozlog 11:18:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:18:42 INFO - Running setup.py install for moznetwork 11:18:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:18:42 INFO - Running setup.py install for mozprocess 11:18:42 INFO - Running setup.py install for mozprofile 11:18:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:18:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:18:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:18:43 INFO - Running setup.py install for mozrunner 11:18:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:18:43 INFO - Running setup.py install for mozscreenshot 11:18:43 INFO - Running setup.py install for moztest 11:18:43 INFO - Running setup.py install for mozversion 11:18:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:18:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:18:43 INFO - Cleaning up... 11:18:43 INFO - Return code: 0 11:18:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:43 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')]} 11:18:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:43 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')]} 11:18:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:43 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 0x109274a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10927b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62949be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109118d30>, '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 0x108f3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10910fb20>, '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.CQTyaw1JdT/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.fCm4dH6v72/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:18:43 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 11:18:43 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 11:18:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CQTyaw1JdT/Render', 11:18:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:43 INFO - 'HOME': '/Users/cltbld', 11:18:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:43 INFO - 'LOGNAME': 'cltbld', 11:18:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:43 INFO - 'MOZ_NO_REMOTE': '1', 11:18:43 INFO - 'NO_EM_RESTART': '1', 11:18:43 INFO - 'PAGER': '/bin/cat', 11:18:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:43 INFO - 'PWD': '/builds/slave/test', 11:18:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:43 INFO - 'SHELL': '/bin/bash', 11:18:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fCm4dH6v72/Listeners', 11:18:43 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:18:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:43 INFO - 'USER': 'cltbld', 11:18:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:43 INFO - 'XPC_FLAGS': '0x0', 11:18:43 INFO - 'XPC_SERVICE_NAME': '0', 11:18:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:18:44 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Bvl4Dj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:18:44 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)) 11:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:18:44 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-fge9AC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:18:44 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)) 11:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:18:44 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-dBSHOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:18:44 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)) 11:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:18:44 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-M_s44I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:18:44 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)) 11:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:18:44 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-v3AaQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:18:44 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)) 11:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:18:44 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-PKokFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:18:44 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)) 11:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:18:44 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-XDPhVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:18:44 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)) 11:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:18:44 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-hB5ZDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:18:44 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)) 11:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:18:44 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Pr529g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:18:44 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)) 11:18:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:18:44 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-xpOrfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:18:45 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)) 11:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:18:45 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-QhRsPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:18:45 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)) 11:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:18:45 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-pVUkCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:18:45 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)) 11:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:18:45 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-BeNDYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:18:45 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)) 11:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:18:45 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-R9TXLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:18:45 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)) 11:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:45 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-c1ByRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:18:45 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)) 11:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:18:45 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ISWguR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:18:45 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)) 11:18:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:18:45 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-INCGvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:18:45 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)) 11:18:45 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)) 11:18:45 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)) 11:18:45 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)) 11:18:45 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)) 11:18:45 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)) 11:18:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:48 INFO - Downloading blessings-1.6.tar.gz 11:18:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:18:48 INFO - Installing collected packages: blessings 11:18:48 INFO - Running setup.py install for blessings 11:18:48 INFO - Successfully installed blessings 11:18:48 INFO - Cleaning up... 11:18:48 INFO - Return code: 0 11:18:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:18:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:48 INFO - Reading from file tmpfile_stdout 11:18:48 INFO - Current package versions: 11:18:48 INFO - blessings == 1.6 11:18:48 INFO - blobuploader == 1.2.4 11:18:48 INFO - docopt == 0.6.1 11:18:48 INFO - manifestparser == 1.1 11:18:48 INFO - mozInstall == 1.12 11:18:48 INFO - mozcrash == 0.16 11:18:48 INFO - mozdebug == 0.1 11:18:48 INFO - mozdevice == 0.48 11:18:48 INFO - mozfile == 1.2 11:18:48 INFO - mozhttpd == 0.7 11:18:48 INFO - mozinfo == 0.9 11:18:48 INFO - mozleak == 0.1 11:18:48 INFO - mozlog == 3.1 11:18:48 INFO - moznetwork == 0.27 11:18:48 INFO - mozprocess == 0.22 11:18:48 INFO - mozprofile == 0.28 11:18:48 INFO - mozrunner == 6.11 11:18:48 INFO - mozscreenshot == 0.1 11:18:48 INFO - mozsystemmonitor == 0.0 11:18:48 INFO - moztest == 0.7 11:18:48 INFO - mozversion == 1.4 11:18:48 INFO - psutil == 3.1.1 11:18:48 INFO - requests == 1.2.3 11:18:48 INFO - wsgiref == 0.1.2 11:18:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:18:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:48 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 0x109274a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10927b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62949be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109118d30>, '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 0x108f3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10910fb20>, '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.CQTyaw1JdT/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.fCm4dH6v72/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:18:48 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 11:18:48 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 11:18:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CQTyaw1JdT/Render', 11:18:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:48 INFO - 'HOME': '/Users/cltbld', 11:18:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:48 INFO - 'LOGNAME': 'cltbld', 11:18:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:48 INFO - 'MOZ_NO_REMOTE': '1', 11:18:48 INFO - 'NO_EM_RESTART': '1', 11:18:48 INFO - 'PAGER': '/bin/cat', 11:18:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:48 INFO - 'PWD': '/builds/slave/test', 11:18:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:48 INFO - 'SHELL': '/bin/bash', 11:18:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fCm4dH6v72/Listeners', 11:18:48 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:18:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:48 INFO - 'USER': 'cltbld', 11:18:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:48 INFO - 'XPC_FLAGS': '0x0', 11:18:48 INFO - 'XPC_SERVICE_NAME': '0', 11:18:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:49 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)) 11:18:49 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)) 11:18:49 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)) 11:18:49 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)) 11:18:49 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)) 11:18:49 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)) 11:18:49 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)) 11:18:49 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)) 11:18:49 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)) 11:18:49 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)) 11:18:49 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)) 11:18:49 INFO - Cleaning up... 11:18:49 INFO - Return code: 0 11:18:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:18: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')]} 11:18:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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')]} 11:18:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109274a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10927b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62949be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109118d30>, '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 0x108f3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10910fb20>, '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.CQTyaw1JdT/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.fCm4dH6v72/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:18: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', 'jsonschema'] in /builds/slave/test/build 11:18: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 jsonschema 11:18:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CQTyaw1JdT/Render', 11:18:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:49 INFO - 'HOME': '/Users/cltbld', 11:18:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:49 INFO - 'LOGNAME': 'cltbld', 11:18:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:49 INFO - 'MOZ_NO_REMOTE': '1', 11:18:49 INFO - 'NO_EM_RESTART': '1', 11:18:49 INFO - 'PAGER': '/bin/cat', 11:18:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:49 INFO - 'PWD': '/builds/slave/test', 11:18:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:49 INFO - 'SHELL': '/bin/bash', 11:18:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fCm4dH6v72/Listeners', 11:18:49 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:18:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:49 INFO - 'USER': 'cltbld', 11:18:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:49 INFO - 'XPC_FLAGS': '0x0', 11:18:49 INFO - 'XPC_SERVICE_NAME': '0', 11:18:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:49 INFO - Downloading/unpacking jsonschema 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:18:51 INFO - Downloading/unpacking functools32 (from jsonschema) 11:18:51 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 11:18:51 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 11:18:51 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 11:18:51 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 11:18:51 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 11:18:51 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 11:18:52 INFO - Downloading functools32-3.2.3-2.tar.gz 11:18:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:18:52 INFO - warning: no files found matching '*.txt' 11:18:52 INFO - no previously-included directories found matching 'build' 11:18:52 INFO - no previously-included directories found matching 'dist' 11:18:52 INFO - no previously-included directories found matching '.git*' 11:18:52 INFO - Installing collected packages: jsonschema, functools32 11:18:52 INFO - Running setup.py install for functools32 11:18:52 INFO - warning: no files found matching '*.txt' 11:18:52 INFO - no previously-included directories found matching 'build' 11:18:52 INFO - no previously-included directories found matching 'dist' 11:18:52 INFO - no previously-included directories found matching '.git*' 11:18:52 INFO - Successfully installed jsonschema functools32 11:18:52 INFO - Cleaning up... 11:18:52 INFO - Return code: 0 11:18:52 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:18:52 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')]} 11:18:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:18:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:52 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')]} 11:18:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:18:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:18:52 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 0x109274a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10927b4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff62949be30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109118d30>, '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 0x108f3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10910fb20>, '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.CQTyaw1JdT/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.fCm4dH6v72/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 11:18:52 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 11:18:52 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 11:18:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CQTyaw1JdT/Render', 11:18:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:18:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:18:52 INFO - 'HOME': '/Users/cltbld', 11:18:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:18:52 INFO - 'LOGNAME': 'cltbld', 11:18:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:18:52 INFO - 'MOZ_NO_REMOTE': '1', 11:18:52 INFO - 'NO_EM_RESTART': '1', 11:18:52 INFO - 'PAGER': '/bin/cat', 11:18:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:18:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:18:52 INFO - 'PWD': '/builds/slave/test', 11:18:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:18:52 INFO - 'SHELL': '/bin/bash', 11:18:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fCm4dH6v72/Listeners', 11:18:52 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:18:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:18:52 INFO - 'USER': 'cltbld', 11:18:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:18:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:18:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:18:52 INFO - 'XPC_FLAGS': '0x0', 11:18:52 INFO - 'XPC_SERVICE_NAME': '0', 11:18:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:18:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:18:52 INFO - Downloading/unpacking flake8 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18: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 11:18:55 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:18:55 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:55 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:18:55 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:55 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:18:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:18:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:18:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:18:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:56 INFO - no previously-included directories found matching 'docs/_build' 11:18:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:18:56 INFO - Running setup.py install for pep8 11:18:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:18:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:18:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:18:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:18:56 INFO - no previously-included directories found matching 'docs/_build' 11:18:56 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:18:56 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:18:56 INFO - Cleaning up... 11:18:56 INFO - Return code: 0 11:18:56 INFO - Running post-action listener: _resource_record_post_action 11:18:56 INFO - Running post-action listener: _start_resource_monitoring 11:18:56 INFO - Starting resource monitoring. 11:18:56 INFO - ##### 11:18:56 INFO - ##### Running install step. 11:18:56 INFO - ##### 11:18:56 INFO - Running pre-action listener: _resource_record_pre_action 11:18:56 INFO - Running main action method: install 11:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:18:56 INFO - Reading from file tmpfile_stdout 11:18:56 INFO - Detecting whether we're running mozinstall >=1.0... 11:18:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:18:57 INFO - Reading from file tmpfile_stdout 11:18:57 INFO - Output received: 11:18:57 INFO - Usage: mozinstall [options] installer 11:18:57 INFO - Options: 11:18:57 INFO - -h, --help show this help message and exit 11:18:57 INFO - -d DEST, --destination=DEST 11:18:57 INFO - Directory to install application into. [default: 11:18:57 INFO - "/builds/slave/test"] 11:18:57 INFO - --app=APP Application being installed. [default: firefox] 11:18:57 INFO - mkdir: /builds/slave/test/build/application 11:18:57 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'] 11:18:57 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 11:19:30 INFO - Reading from file tmpfile_stdout 11:19:30 INFO - Output received: 11:19:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:19:30 INFO - Running post-action listener: _resource_record_post_action 11:19:30 INFO - ##### 11:19:30 INFO - ##### Running run-tests step. 11:19:30 INFO - ##### 11:19:30 INFO - Running pre-action listener: _resource_record_pre_action 11:19:30 INFO - Running main action method: run_tests 11:19:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:19:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:19:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:19:30 INFO - 2016-03-03 11:19:30.872 screenresolution[2210:20128] starting screenresolution argv=screenresolution get 11:19:30 INFO - 2016-03-03 11:19:30.875 screenresolution[2210:20128] Display 0: 1600x1200x32@60 11:19:30 INFO - 2016-03-03 11:19:30.881 screenresolution[2211:20131] starting screenresolution argv=screenresolution list 11:19:30 INFO - Available Modes on Display 0 11:19:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:19:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:19:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:19:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:19:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:19:31 INFO - Intel Iris: 11:19:31 INFO - Chipset Model: Intel Iris 11:19:31 INFO - Type: GPU 11:19:31 INFO - Bus: Built-In 11:19:31 INFO - VRAM (Dynamic, Max): 1536 MB 11:19:31 INFO - Vendor: Intel (0x8086) 11:19:31 INFO - Device ID: 0x0a2e 11:19:31 INFO - Revision ID: 0x0009 11:19:31 INFO - Displays: 11:19:31 INFO - Display: 11:19:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:19:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:19:31 INFO - Display Serial Number: 1600x1200 60 11:19:31 INFO - Main Display: Yes 11:19:31 INFO - Mirror: Off 11:19:31 INFO - Online: Yes 11:19:31 INFO - Rotation: Supported 11:19:31 INFO - Return code: 0 11:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:19:31 INFO - Python 2.7.3 11:19:31 INFO - Return code: 0 11:19:31 INFO - grabbing minidump binary from tooltool 11:19: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')]} 11:19:31 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 0x109118d30>, '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 0x108f3cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10910fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:19:31 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 11:19:31 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 11:19:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:19:31 INFO - Return code: 0 11:19:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:19:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:19:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:19:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:19:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:19:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:19:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:19:32 INFO - Return code: 0 11:19:32 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/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--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 11:19:32 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/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0162 --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 11:19:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CQTyaw1JdT/Render', 11:19:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:19:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:19:32 INFO - 'HOME': '/Users/cltbld', 11:19:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:19:32 INFO - 'LOGNAME': 'cltbld', 11:19:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:19:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:19:32 INFO - 'MOZ_NO_REMOTE': '1', 11:19:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:19:32 INFO - 'NO_EM_RESTART': '1', 11:19:32 INFO - 'PAGER': '/bin/cat', 11:19:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:19:32 INFO - 'PWD': '/builds/slave/test', 11:19:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:19:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:19:32 INFO - 'SHELL': '/bin/bash', 11:19:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fCm4dH6v72/Listeners', 11:19:32 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 11:19:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:19:32 INFO - 'USER': 'cltbld', 11:19:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:19:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:19:32 INFO - 'XPC_FLAGS': '0x0', 11:19:32 INFO - 'XPC_SERVICE_NAME': '0', 11:19:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:19:32 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/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0162', '--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 11:19:32 INFO - mozversion application_buildid: 20160303092333 11:19:32 INFO - mozversion application_changeset: 217b441ef860497f6770a27fa2ba988060ae00ed 11:19:32 INFO - mozversion application_display_name: Nightly 11:19:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:19:32 INFO - mozversion application_name: Firefox 11:19:32 INFO - mozversion application_remotingname: firefox 11:19:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:19:32 INFO - mozversion application_vendor: Mozilla 11:19:32 INFO - mozversion application_version: 47.0a1 11:19:32 INFO - mozversion platform_buildid: 20160303092333 11:19:32 INFO - mozversion platform_changeset: 217b441ef860497f6770a27fa2ba988060ae00ed 11:19:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:19:32 INFO - mozversion platform_version: 47.0a1 11:19:32 INFO - using testdate: 1457032772 11:19:32 INFO - actual date: 1457032772 11:19:33 INFO - starting webserver on 'localhost:51140' 11:19:33 INFO - SUITE-START | Running 2 tests 11:19:33 INFO - TEST-START | dromaeo_css 11:19:33 INFO - operating with platform_type : mac_ 11:19:33 INFO - Initialising browser for dromaeo_css test... 11:19:33 INFO - TEST-INFO | started process 2229 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpsjBfnE/profile http://localhost:51140/getInfo.html) 11:19:35 INFO - PROCESS | 2229 | __metrics Screen width/height:1600/1200 11:19:35 INFO - PROCESS | 2229 | colorDepth:24 11:19:35 INFO - PROCESS | 2229 | Browser inner width/height: 1024/689 11:19:35 INFO - PROCESS | 2229 | __metrics 11:19:35 ERROR - PROCESS | 2229 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 11:19:36 INFO - TEST-INFO | 2229: exit 0 11:19:36 INFO - Browser initialized. 11:19:36 INFO - Running cycle 1/1 for dromaeo_css test... 11:19:36 INFO - TEST-INFO | started process 2233 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpsjBfnE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:19:48 INFO - PROCESS | 2233 | RSS: Main: 254365696 11:19:48 INFO - PROCESS | 2233 | 11:20:38 INFO - PROCESS | 2233 | 1457032838321 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] 11:22:49 INFO - PROCESS | 2233 | Cycle 1(1): loaded http://localhost:51140/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51140/tests/dromaeo/cssquery-ext.html) 11:22:50 INFO - PROCESS | 2233 | RSS: Main: 268890112 11:22:50 INFO - PROCESS | 2233 | 11:25:52 INFO - PROCESS | 2233 | Cycle 1(1): loaded http://localhost:51140/tests/dromaeo/cssquery-ext.html (next: http://localhost:51140/tests/dromaeo/cssquery-jquery.html) 11:25:53 INFO - PROCESS | 2233 | RSS: Main: 281579520 11:25:53 INFO - PROCESS | 2233 | 11:28:54 INFO - PROCESS | 2233 | Cycle 1(1): loaded http://localhost:51140/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51140/tests/dromaeo/cssquery-mootools.html) 11:28:55 INFO - PROCESS | 2233 | RSS: Main: 282075136 11:28:55 INFO - PROCESS | 2233 | 11:31:57 INFO - PROCESS | 2233 | Cycle 1(1): loaded http://localhost:51140/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51140/tests/dromaeo/cssquery-prototype.html) 11:31:57 INFO - PROCESS | 2233 | RSS: Main: 284401664 11:31:57 INFO - PROCESS | 2233 | 11:35:00 INFO - PROCESS | 2233 | Cycle 1(1): loaded http://localhost:51140/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51140/tests/dromaeo/cssquery-yui.html) 11:35:00 INFO - PROCESS | 2233 | RSS: Main: 286040064 11:35:00 INFO - PROCESS | 2233 | 11:38:03 INFO - PROCESS | 2233 | Cycle 1(1): loaded http://localhost:51140/tests/dromaeo/cssquery-yui.html (next: http://localhost:51140/tests/dromaeo/cssquery-dojo.html) 11:38:03 INFO - PROCESS | 2233 | RSS: Main: 288284672 11:38:03 INFO - PROCESS | 2233 | 11:38:03 INFO - PROCESS | 2233 | __start_tp_report 11:38:03 INFO - PROCESS | 2233 | _x_x_mozilla_page_load 11:38:03 INFO - PROCESS | 2233 | _x_x_mozilla_page_load_details 11:38:03 INFO - PROCESS | 2233 | |i|pagename|runs| 11:38:03 INFO - PROCESS | 2233 | |0;dojo.html;3413.266147778227;3453.9309213815723;3486.1458942559075;3512.701420379268;3518.4018716818136;5632.77468901244;5671.262735844334;5680.772769089242;5688;5711.571632127591;4811.59101476375;5523.558115350772;5637.492625663689;5640.182173584838;5709.486146246837;5081.491850814926;5180.015796998577;5185.870353241162;5195.376554813428;5241.947580524203;893.9558619788871;5074.13739664258;5111.386633603955;5194.506521880434;5271.841844744664;5138.897222055538;5146.665466744649;5162.070827251093;5197.818076367347;5216.00895829793;5177.430482646906;5199.6360254782185;5217.973910130463;5224.608154388398;5258.237555554423;5070.2141168119;5096.082705113078;5183.870403239912;5204.4535323791215;5212.29633999409;4573.153966516172;4892.339534162878;5106.15748401517;5543.722813859291;5577.69322687252;6057.575969682124;6216.036514340284;6223.097650840648;6230.345813689588;6241.750329986795;6148.739508400812;6180.783672571483;6239.220097487814;6240.968795156041;6250.43746062852;4277.315629499265;5729.169270455761;5740.856478588027;5746.88506229873;5766.308043034863;6125.93755450893;6166.7224974876235;6237.844053898598;6248.31268560458;6270.811875643738;4975;6012.849678758066;6020.909686354708;6031.7587296507645;6089.391060893964;6144.56988010835;6172.166757487771;6180;6184.690765461709;6185.969070154621;4816.277558366203;5992;6031.9396806032255;6116.0010150213275;6136.570440069152;6121.087175196994;6184.81445556634;6208.596441231305;6228.875422491525;6267.561270711007;4870.780814863339;4886.65793394459;4887.413510378778;4900.166971614763;4903.828366007173;4254.149170165979;4335.869923902288;4352.129574085196;4390.956090439118;4423.977880110579;5567.638103523258;5651.9826431241945;5677.801276955287;5699.800506982318;5701;6188.566800324024;6247.2815626202655;6255.186825712628;6256.374362563798;6265.8746825063245;5552;5609.49514543693;5657.094864821609;5710.314762228559;5731.742071606787;5317.7872885084935;5325.520703136736;5335.946640533545;5340.893182136336;5359.678419294854;6295.055741638699;6299.590526615663;6305.464035556937;6315.810525684236;6316.210473690789;6136.355682653257;6147.754089836357;6226.377362263737;6249.78125765596;6251.218597675291;6280;6291.779787707408;6304.148939893055;6308.873822523432;6342.619442833445;6104.938950610437;6151.753929842756;6156.938430615636;6165.691715414122;6174.475169610633;6124.081387791867;6128.075379514812;6200.379962003944;6241.875162496815;6261.8747625046335;6028.930471931341;6039.909401359071;6082.60463069899;6090.573659843769;6140.140380346666;5876.1773351731645;5988.951933411723;6034.306054803754;6043.516518678407;6129.877402452015;4826.734529600765;4945.4312754033745;5553.444655534414;5890.175375447355;6003;6059.33347331802;6062.787802426894;6068.575199735976;6071.301800292847;6098.969505152446;5814.360420353673;5918.615290006136;5942.64344139353;5957.136215248678;5972.432618901197 11:38:03 INFO - PROCESS | 2233 | |1;ext.html;441.8210624696999;448.79804088160313;481.6508031677035;514.776072408502;525.3197109742883;33358.833205833966;34236.97289081332;37083.443748343794;38265.80867095664;38345.04137396563;38893.611063889424;39473;39483.60516394835;39504.407433888446;39606.405903911465;9519.857202141957;9767.16979056781;9767.316287859852;9795.216382689403;9800.41197528147;9600.663976760814;9730.221582273436;9732.708018759413;9751.90248097517;9803.264755143357;9693.418394896293;9737.415755054684;9746.805063898753;9761.267904907161;9770.120689137977;8039.999999999971;9678.128968392843;9707.757306067335;9732.562034708455;9738.172255358302;9419.058094190596;9735.41587504752;9747.951260243653;9759.072888075621;9769.267304952156;37372.81313593442;37483.4377484338;38022.61977380219;38022.859314220615;38226.61773382286;2830.4763618730394;3081.6610172880964;3208.374366998436;3324.983375083133;3382.8477718502727;26780.866095669397;26962;27681.446371072667;27682.892684292605;28388.29029274264;2742.9725702743117;2829.4906916754976;2851.344190836119;2853.671827739795;2854.2864283929016;351600;352117;353366.99999999744;354924;355008;44960.77519612381;45707.08585828265;58566.4143358561;60032.49918752066;60043;44446.888827778916;44771.77614111909;44946.55053449489;44954.775226124315;45171.32243016357;14795.704085918436;14818.555443336718;14835.258237088103;14940;15009.924950375396;11608.187426880206;11705.941470292764;11770.529178832921;11875.465604047666;11915.225510341974;14334.99655024159;14357.78463323051;14377.856221437652;14432.134071955506;14583.489577864724;5577.386487486373;6063.727132279058;6236.376362363818;6298.307186209513;6344.143540622049;876;950.2682934140673;978.5400861595039;1098.7857367813199;1159.62891874601;29478.852605736833;29536.704632953395;29752.404951901273;29868.850655747017;30022.79908803667;1007.5214273220162;1080.783843231357;1137.1357768096307;1161.0769438296575;1164.5632887667125;11734.647960561197;12701.491940322283;14322.997390182796;14413.711725765635;14653.413863445556;427976;430777;436153;440301;441410;58382.12426813601;58692.70653646704;59589;59611.105833412534;59826.70086649539;1394.4352537222442;1400.2706657278254;1414.2504472629523;1416.0583212163797;1428.114568967247;29193.416131676822;29248.707512924597;29623.407531849673;29920.401591967602;29922.401551969273;52486.21270680866;52791;52909.94180116299;53192.46807531875;53246.20130697965;468466;488956;490687.5465622649;491209;493301;33288.50067248945;33773.83113084419;33778.49332260067;34276.828615856764;34307;44840.77579612081;44962;45159.774201128785;46297.6110716679;46472.53527464682;36578.902632921054;37016.6298337024;37574.81212594029;38009.61990380061;38176;36986.965716884755;37107.814460927526;37397.43903841499;37451.81274093612;37592;32577.67422325841;36241.63758362383;37039;37154.07114822043;37229.62770372262;30573.388532228786;31515.84242078775;31619.20951976219;31793;31934;23974.40063998414;24060.39849003789;24164.637530436707;24240.909159087532;24382.51234975326 11:38:03 INFO - PROCESS | 2233 | |2;jquery.html;302.81528267756676;346.6723945871151;356.308761003653;357.89442114576195;362.0207339147606;18601.7209741854;18681.066176470587;20701.68947465789;21137.943102844874;21158.682619760715;19635.90182049088;19788.109535070922;20082.598348033032;20100.296489622866;20201.696974545357;5538.529225015878;5782.53739700825;5837.24115864937;5856.736446859902;5856.824295271127;4155.979220103895;5106.4382917879;5655.830325090254;6331.050342448623;6353.459955903731;6276.466500347476;6303.401176888188;6303.9369606304035;6305.0542418637115;6314.7158377872875;5816.563757718188;6015.218021657179;6195.597286176384;6207.28616209135;6208.2239720034995;5336.226247194174;5354.571634269288;5358.678479291255;5362.946370536284;5372.059889519358;16620.916895415445;22061.45569810114;25249.873750631312;25378.619320710204;25379.984800607952;1767.9027653479054;2030.0966070098812;2439.9756002439926;2490.713567939692;2759.903403380872;14191.858081419157;14406.927965360212;14556.344964476624;14711.705765884622;14759;1524.3902439024369;1684.1410880450935;1762.3919747687028;1783.4203883737837;1795.649848279586;76757.61621191914;93553.53223233909;95819.9999999993;95829.52085239599;97010.57473563147;9532.856057273033;9690.70927872165;10295.3822770634;10706.678799636024;10796.028357447867;12699.936500317439;12743.426545805462;12783.424745886457;12834.743305133845;12847.421866016051;8209.958950205211;8362.45644033136;8407.537585432738;8486.363522735819;8514.318854491627;8511;8553.230209281195;8582;8650.264727498106;8705.434146780439;6048;6156;6156.876862462816;6171.938280617136;6219.720112594944;1701.438525286677;1753.6755700195504;1806.7380229866858;1808.63827234551;1823.4985379020875;874.2612492443875;933.8739270198572;961.423146112327;975.7267964969819;1041.57295508841;19589.60820783605;19630.901845490967;19755.40733777989;20056.598868022556;20320.491987700425;932.5477143585356;995.581855620641;1009.5557954500143;1018.5772904244656;1041.578160844844;11020.889791102147;11090.833637495443;11229;11336.144739515446;11432.828507572392;591228.043859778;611749;626921;643419;652827.3586320665;121019;122180;123646.38176809058;124705.99999999818;126111;451.28921947931485;471.72639868875285;474.0731869195714;1025.4975062219607;1068.8289873620183;10528;10659.307145035547;11061.004509594175;11170.603674540682;11516.94241528787;48954.75522622364;49721.75139124281;50984.74507627438;51485.71285717737;52377;67558.66220668865;69837.60324793577;71508;72610;72639;7933.325667318342;7978.659752692322;8043.839123217386;8099.716509922125;8143.918560814316;9057.320700947586;11009.394483303175;12683.42924568415;12817.23096614206;12910.935445322713;8036.754303083031;8261.297789687704;8670.523121228392;10685.57257709683;11270.098392128773;9367.782188315748;10701.732456688645;10711.196660250669;10991;11118.332900026024;10714.410707411167;10956.835647465454;11371.715707107389;11600;11746.58886938953;6878.209005964378;6956.339147780953;7986.480878742863;7997.520148790858;8212.753617391489;9708;10684.519196636325;11222.382768947786;11335.093192544742;11347.829782553103 11:38:03 INFO - PROCESS | 2233 | |3;mootools.html;1396.951106711265;1427.8357988831283;1626.4470080172753;1773.556610847288;1958.0992743338054;7748.186440423745;8330.58347082645;8623.223909848113;8732.91267087329;8788.560571971408;6800.693968771405;8024.398170137234;8074.708046712512;8562.74311770648;8586.184312490319;2337.602607556711;2351.0948284910305;2361.657559653849;2386.3079706884982;2387.415083304593;2378.4053986503372;2389.7610238976135;2414.1550457339877;2434.3670645632087;2457.2259738182415;2438.036975394718;2443.535728211643;2457.6682147909983;2463.224084413413;2466.506698660266;2402.2913240593894;2425.854448733082;2435.866027368485;2443.30365845734;2453.325335532725;2009.4172689919906;2389.223502361722;2423.4426082001064;2425.7938075263623;2430.2709187243754;8716.259117974916;8717.651293948235;8743;8744.825103497895;8757.386982911199;4325.935110973338;5428.647137936022;5452.991196628636;5458.9454105458835;5463.399026107125;3537.0626783902285;3595.2449985503076;3662.981685091584;3693.0398096494837;3742.120601658608;1030.8969103089705;1039.0569634783003;1043.1081425381265;1047.5862034496408;1047.9109275711573;11860.28838269698;11938.582149624808;12019.21875078126;12026.759464810742;12062.939685301604;4197.895052623709;4270.893227669271;4814.735189564608;4865.294532292798;4881.8535443936735;10102.39385636864;10116.08955194036;10142.695719128438;10153.94923025395;10163.034511721375;5409.891802163935;5431.565474762009;5434.70109143993;5492.945070549244;5498.367687715884;4389.736615803062;4753.904921901542;4891.975540122347;4898.681585696918;4927.704337739747;3328.6671332866517;3863.34323165057;3898.785566793797;3938.665213456888;3987.1626958338493;1288.6134159752037;1301.3688361144837;1302.4139137388024;1303.1073714505594;1306.562301628946;1292.6639073840681;1310.3775706539318;1313.1333320008748;1337.6923307639297;1350.8716671916152;7215.639218039077;8023.318017968538;8054.637541310655;8130.512169269863;8242.958785206036;423.860126158367;497.2069549069229;508.21227097997956;509.4930544108636;515.3455112007729;6222.439980401786;6261.655608941552;6278.340774218641;6289.7484100636375;6311.27420346666;10194.643187488402;10365.963403659574;10406.167506599453;10496.580136794442;10532.631357902437;9967.451790151466;10303.278770486144;10323.741906452398;10356.896431035744;10376.636817711344;8046.557439340892;8185.95907020473;8222.13667564909;8229.917700823034;8282.378821588405;7760.767176984474;7893.881591776013;8074.232947869943;8092.069412017693;8101.716439924574;7777.338926191337;8784;8977.955110224408;9513.714588562354;9531.523423828643;9184.586693598938;9350.064993500868;9419.434833909987;9429.481378524248;9430.387024843363;6748.898766518604;7257.346838784535;7807.336376408069;8064.032316122103;8150.510969341858;8086.6361013755695;8101.797455063671;8116.797080073045;8156.184381561797;8175.795605109682;6818.93181068183;7127.037849890198;7310.268973102648;7430.814229644302;7480.588567628615;7167.641617919187;7246.021787058679;7285.979962805318;7316.195218526064;7339.339459448675;7608.353289970193;7608.8478230433975;7719.112302085107;7730.458867879194;7743.9545661335;6893.276205998298;6909.170899492093;6990.545614535039;7007.544509606859;7028.613426261605;7050.189228238818;7093.042439270633;7132.179799322937;7132.8930066048015;7146.213916469288 11:38:03 INFO - PROCESS | 2233 | |4;prototype.html;260.60778528314887;321.7040322902929;329.1540740297436;329.85321531918305;331.4944709318291;6685.130932978712;6812.693428795704;6869.48478864086;6893.241743408221;6914.412274956635;5783.074708046714;6799.69401376938;6801.523893327469;6804.115464989544;6810;4700.670953033272;4814.422269327668;4887.828925987591;4913.852584422455;5002.574781143598;3632.4369722693023;4027.8520621622843;4146.481689788777;4462.776861156945;4625.560571745679;4906.1168989581865;4916.852494425173;4920.0159968006365;4936.555709986101;4940.08608407444;4000.4799376081214;4242.575742425733;4760.762201827532;4928.827491037814;4939.234418665113;4189.895252618679;4198.202341555095;4203.747775133502;4212.4523811904255;4220.3036498977635;6275.811725648192;6562.114114594564;6576.342365763433;6602.042703807969;6605.669716514203;4423.248047831877;5782.421757824226;5797.768089276424;5805.564582656318;5809.157672137559;7300.707971681127;7310.770215084397;7336.523125996793;7338.2388226825715;7353.323338330834;4627.930581041253;4629.189891768927;4630.421197350332;4639.280911458729;4650.511696271877;7708.229177082303;7782.610869456505;7789.766307010798;7798.064232292105;7798.103218129931;4431.268840641258;4502.212112880233;4577.359169716243;4660.883477913011;4690.882727931829;4721.716696998191;4744.051189761993;4801.303810947393;4803.3995750531185;4805.711657300573;5665.830025099253;5755.1367294906095;5760.3951585083805;5770.16332631766;5799.739011744482;7312.378447831888;7321;7334;7336.156342020629;7336.486445948839;1634.4524584264404;1650.2656317938402;1652.900825950447;1654.8924319919167;1658.278648787781;1022.156720705421;1047.1936608811325;1050.2595670052594;1050.3435352904435;1067.0290036067142;6821.69302381394;6851.177858656993;6873.243943166248;6873.553219040847;6873.965630171817;6465.321141280192;7619.580923049175;7620.085589729268;7628.160902300742;7638.656260468292;6836.931630683729;6863.828404289933;6888.827779305458;6895.896561551581;6920.031195632616;3873.96126038736;4011.8796436106963;4029.576894426043;4052.169305292467;4056.9391459128137;7137.179224389158;7933.841323173504;7963.685991811286;7970.123286438487;7973.20267973198;6946.0622815920215;7824.178461261599;7855.921440785519;7862.410319226081;7878.803029924297;7934.2859142677435;7944.880826787718;7948.721794737156;7965.601719913865;7981.800454988555;7295.562266264041;7605.429592780453;7609.201033891583;7624.771256862303;7650.6174691264105;7006.9649651751415;7419.332260096618;7444.702211911463;7449.478536502393;7458.701651933862;6369.522285828674;6939.826504337432;7967.043954725238;7994.880076798969;8003.5197888126895;4719.59883409914;4720.409948756405;4727.834525791581;4737.0052289019695;4740.5733483986605;7216.639168041682;7335.449841262033;7517.361024312994;7579.924200757921;7600.125985511516;5933.970330148321;6666.366695163952;6812.965935170292;7341.972123902551;7452.627368631655;7372;7418.629068546659;7424.923386108876;7427.7771666850085;7629.2752188542;7221.350078492961;7229.240929702306;7231.987521746854;7241.312075352833;7302.2697730226555;6049.909251361145;7157.677904494414;7344.853102938018;7414.295641914009;7417.184109748031;7239.4932354734665;7254.347108760237;7274.4907856449545;7275.454340924346;7286.162091359562 11:38:03 INFO - PROCESS | 2233 | |5;yui.html;659.9473839226434;699.3461113858542;723.2822047636862;729.2197348836745;733.853229354129;14476.493322733706;14644.487442939499;14721.926390368046;14820;14838.332275047622;13485.460581576725;13708.657283567916;13853.930730346334;13864.584062478116;13902.582922512342;699.5697645947731;844.0673056272792;854.7905763088052;860.6127242740761;880.3177537408527;877.8727084572733;884.3411658314533;884.8407286688393;886.8581027035675;887.9112088791134;931.4318265857821;931.6180366049921;934.0752654871662;934.9953250233739;942.180303136269;904.1184844776357;907.9682211122645;914.8581969794626;921.8525035994243;927.5130556457846;664.9933500665028;673.3300366135677;679.1985457160548;680.404645934807;680.7038938061959;14386.568402947823;14635.487757928528;14658.19379934114;14662.486812961602;14711.337989790485;12422.254664720056;12518.81221781674;12524.81212781809;12691;12766.170198937132;9774.071463210983;9866.556004979793;10010.59957601695;10038.14675752562;10244.795104097877;3454.516367708523;3478.4086705260165;3494.9301013979834;3499.510068590374;3501.38725723;64670.35329646691;68349.31650683479;72677.78359380852;73667.26332736711;74114.62942685252;7835.412344074217;9218.663293822492;9227.26181905446;9260.7684807879;9454.101860323395;20336.796632033787;20864.956752162332;20926.162953481995;20927.05828237733;20946.266880659103;7339.339459448675;7441.404687624977;7467.141278753013;7498.700051997859;7650.273224043818;4103.281925662997;4171.645410140172;4174.791260436966;4175.498940127204;4179.331306990867;3321.80069195849;3348.162959260185;3365.5456513370873;3371.005553361764;3371.3088816792497;611.3947192279611;622.0078974036404;625.1591609285504;629.1475051305507;663.2902794010363;447.93728877957113;538.4615384615385;564.1622191046293;566.0999011571621;575.9222504961776;7903.525788452711;7951.721689740832;8071.717489887826;8079;8251.917480825115;562.2522045679236;564.8333741546171;578.727997841014;579.5800289291253;582.3884920833108;2921.342697892957;3568.2685049564775;3796.0889386547583;3813.580506144322;3868.903277418031;81914.59042704749;87202.56398717966;88541.3593980454;89521;89792.10207897967;56396.87206255934;69541.65229173923;69901.65049174824;72891.90662140072;75898.62050689712;53504.46495534995;66991;68130.31869681239;68486.31513684799;69475.30524694688;7990.960045199737;8067.959660201662;8256.25693687571;8257.339412847077;8345.41582089248;46507.30239046349;47114.05771884612;47216.527834721215;48179.79550511125;48407;57996.71001645133;60233.39766602453;64612.030819536805;64643;67369;10185.592576296865;10244.948775256375;10279.94860025695;10361.689149325532;10418.374897506174;11440.084793216689;11458.598949036743;11526.366049867338;11533.884661153617;11908.821367679318;10647.201459890694;10746.677599672023;10833.783324333626;11047.281926674741;11306.547738090385;10783.352998820095;11012.339259644446;11044.33733975964;11927.224730392496;11967.461464233957;10668.83996740065;10971.780564388828;11234.887651123385;11349.4892729829;11551.537938482366;9045.683401081194;9134.22359099484;9357.57890894925;9397.530123493934;9464.763380915532;9023.323250756088;9413.52932353366;9450.385724927857;9531.761705957406;9556.85664715016 11:38:03 INFO - PROCESS | 2233 | __end_tp_report 11:38:03 INFO - PROCESS | 2233 | __start_cc_report 11:38:03 INFO - PROCESS | 2233 | _x_x_mozilla_cycle_collect,337 11:38:03 INFO - PROCESS | 2233 | __end_cc_report 11:38:03 INFO - PROCESS | 2233 | __startTimestamp1457033883429__endTimestamp 11:38:03 INFO - PROCESS | 2233 | 11:38:03 INFO - PROCESS | 2233 | ------- Summary: start ------- 11:38:03 INFO - PROCESS | 2233 | Number of tests: 6 11:38:03 INFO - PROCESS | 2233 | 11:38:03 INFO - PROCESS | 2233 | [#0] dojo.html Cycles:165 Average:5626.91 Median:5918.62 stddev:752.30 (12.7%) stddev-sans-first:734.29 11:38:03 INFO - PROCESS | 2233 | Values: 3413.3 3453.9 3486.1 3512.7 3518.4 5632.8 5671.3 5680.8 5688.0 5711.6 4811.6 5523.6 5637.5 5640.2 5709.5 5081.5 5180.0 5185.9 5195.4 5241.9 894.0 5074.1 5111.4 5194.5 5271.8 5138.9 5146.7 5162.1 5197.8 5216.0 5177.4 5199.6 5218.0 5224.6 5258.2 5070.2 5096.1 5183.9 5204.5 5212.3 4573.2 4892.3 5106.2 5543.7 5577.7 6057.6 6216.0 6223.1 6230.3 6241.8 6148.7 6180.8 6239.2 6241.0 6250.4 4277.3 5729.2 5740.9 5746.9 5766.3 6125.9 6166.7 6237.8 6248.3 6270.8 4975.0 6012.8 6020.9 6031.8 6089.4 6144.6 6172.2 6180.0 6184.7 6186.0 4816.3 5992.0 6031.9 6116.0 6136.6 6121.1 6184.8 6208.6 6228.9 6267.6 4870.8 4886.7 4887.4 4900.2 4903.8 4254.1 4335.9 4352.1 4391.0 4424.0 5567.6 5652.0 5677.8 5699.8 5701.0 6188.6 6247.3 6255.2 6256.4 6265.9 5552.0 5609.5 5657.1 5710.3 5731.7 5317.8 5325.5 5335.9 5340.9 5359.7 6295.1 6299.6 6305.5 6315.8 6316.2 6136.4 6147.8 6226.4 6249.8 6251.2 6280.0 6291.8 6304.1 6308.9 6342.6 6104.9 6151.8 6156.9 6165.7 6174.5 6124.1 6128.1 6200.4 6241.9 6261.9 6028.9 6039.9 6082.6 6090.6 6140.1 5876.2 5989.0 6034.3 6043.5 6129.9 4826.7 4945.4 5553.4 5890.2 6003.0 6059.3 6062.8 6068.6 6071.3 6099.0 5814.4 5918.6 5942.6 5957.1 5972.4 11:38:03 INFO - PROCESS | 2233 | 11:38:03 INFO - PROCESS | 2233 | [#1] ext.html Cycles:180 Average:56981.26 Median:37424.63 stddev:113673.69 (303.7%) stddev-sans-first:113913.31 11:38:03 INFO - PROCESS | 2233 | Values: 441.8 448.8 481.7 514.8 525.3 33358.8 34237.0 37083.4 38265.8 38345.0 38893.6 39473.0 39483.6 39504.4 39606.4 9519.9 9767.2 9767.3 9795.2 9800.4 9600.7 9730.2 9732.7 9751.9 9803.3 9693.4 9737.4 9746.8 9761.3 9770.1 8040.0 9678.1 9707.8 9732.6 9738.2 9419.1 9735.4 9748.0 9759.1 9769.3 37372.8 37483.4 38022.6 38022.9 38226.6 2830.5 3081.7 3208.4 3325.0 3382.8 26780.9 26962.0 27681.4 27682.9 28388.3 2743.0 2829.5 2851.3 2853.7 2854.3 351600.0 352117.0 353367.0 354924.0 355008.0 44960.8 45707.1 58566.4 60032.5 60043.0 44446.9 44771.8 44946.6 44954.8 45171.3 14795.7 14818.6 14835.3 14940.0 15009.9 11608.2 11705.9 11770.5 11875.5 11915.2 14335.0 14357.8 14377.9 14432.1 14583.5 5577.4 6063.7 6236.4 6298.3 6344.1 876.0 950.3 978.5 1098.8 1159.6 29478.9 29536.7 29752.4 29868.9 30022.8 1007.5 1080.8 1137.1 1161.1 1164.6 11734.6 12701.5 14323.0 14413.7 14653.4 427976.0 430777.0 436153.0 440301.0 441410.0 58382.1 58692.7 59589.0 59611.1 59826.7 1394.4 1400.3 1414.3 1416.1 1428.1 29193.4 29248.7 29623.4 29920.4 29922.4 52486.2 52791.0 52909.9 53192.5 53246.2 468466.0 488956.0 490687.5 491209.0 493301.0 33288.5 33773.8 33778.5 34276.8 34307.0 44840.8 44962.0 45159.8 46297.6 46472.5 36578.9 37016.6 37574.8 38009.6 38176.0 36987.0 37107.8 37397.4 37451.8 37592.0 32577.7 36241.6 37039.0 37154.1 37229.6 30573.4 31515.8 31619.2 31793.0 31934.0 23974.4 24060.4 24164.6 24240.9 24382.5 11:38:03 INFO - PROCESS | 2233 | 11:38:03 INFO - PROCESS | 2233 | [#2] jquery.html Cycles:180 Average:34307.09 Median:357.10 stddev:103554.66 (28998.7%) stddev-sans-first:103813.68 11:38:03 INFO - PROCESS | 2233 | Values: 302.8 346.7 356.3 357.9 362.0 18601.7 18681.1 20701.7 21137.9 21158.7 19635.9 19788.1 20082.6 20100.3 20201.7 5538.5 5782.5 5837.2 5856.7 5856.8 4156.0 5106.4 5655.8 6331.1 6353.5 6276.5 6303.4 6303.9 6305.1 6314.7 5816.6 6015.2 6195.6 6207.3 6208.2 5336.2 5354.6 5358.7 5362.9 5372.1 16620.9 22061.5 25249.9 25378.6 25380.0 1767.9 2030.1 2440.0 2490.7 2759.9 14191.9 14406.9 14556.3 14711.7 14759.0 1524.4 1684.1 1762.4 1783.4 1795.6 76757.6 93553.5 95820.0 95829.5 97010.6 9532.9 9690.7 10295.4 10706.7 10796.0 12699.9 12743.4 12783.4 12834.7 12847.4 8210.0 8362.5 8407.5 8486.4 8514.3 8511.0 8553.2 8582.0 8650.3 8705.4 6048.0 6156.0 6156.9 6171.9 6219.7 1701.4 1753.7 1806.7 1808.6 1823.5 874.3 933.9 961.4 975.7 1041.6 19589.6 19630.9 19755.4 20056.6 20320.5 932.5 995.6 1009.6 1018.6 1041.6 11020.9 11090.8 11229.0 11336.1 11432.8 591228.0 611749.0 626921.0 643419.0 652827.4 121019.0 122180.0 123646.4 124706.0 126111.0 451.3 471.7 474.1 1025.5 1068.8 10528.0 10659.3 11061.0 11170.6 11516.9 48954.8 49721.8 50984.7 51485.7 52377.0 67558.7 69837.6 71508.0 72610.0 72639.0 7933.3 7978.7 8043.8 8099.7 8143.9 9057.3 11009.4 12683.4 12817.2 12910.9 8036.8 8261.3 8670.5 10685.6 11270.1 9367.8 10701.7 10711.2 10991.0 11118.3 10714.4 10956.8 11371.7 11600.0 11746.6 6878.2 6956.3 7986.5 7997.5 8212.8 9708.0 10684.5 11222.4 11335.1 11347.8 11:38:03 INFO - PROCESS | 2233 | 11:38:03 INFO - PROCESS | 2233 | [#3] mootools.html Cycles:180 Average:5942.54 Median:5419.27 stddev:3148.62 (58.1%) stddev-sans-first:3138.91 11:38:03 INFO - PROCESS | 2233 | Values: 1397.0 1427.8 1626.4 1773.6 1958.1 7748.2 8330.6 8623.2 8732.9 8788.6 6800.7 8024.4 8074.7 8562.7 8586.2 2337.6 2351.1 2361.7 2386.3 2387.4 2378.4 2389.8 2414.2 2434.4 2457.2 2438.0 2443.5 2457.7 2463.2 2466.5 2402.3 2425.9 2435.9 2443.3 2453.3 2009.4 2389.2 2423.4 2425.8 2430.3 8716.3 8717.7 8743.0 8744.8 8757.4 4325.9 5428.6 5453.0 5458.9 5463.4 3537.1 3595.2 3663.0 3693.0 3742.1 1030.9 1039.1 1043.1 1047.6 1047.9 11860.3 11938.6 12019.2 12026.8 12062.9 4197.9 4270.9 4814.7 4865.3 4881.9 10102.4 10116.1 10142.7 10153.9 10163.0 5409.9 5431.6 5434.7 5492.9 5498.4 4389.7 4753.9 4892.0 4898.7 4927.7 3328.7 3863.3 3898.8 3938.7 3987.2 1288.6 1301.4 1302.4 1303.1 1306.6 1292.7 1310.4 1313.1 1337.7 1350.9 7215.6 8023.3 8054.6 8130.5 8243.0 423.9 497.2 508.2 509.5 515.3 6222.4 6261.7 6278.3 6289.7 6311.3 10194.6 10366.0 10406.2 10496.6 10532.6 9967.5 10303.3 10323.7 10356.9 10376.6 8046.6 8186.0 8222.1 8229.9 8282.4 7760.8 7893.9 8074.2 8092.1 8101.7 7777.3 8784.0 8978.0 9513.7 9531.5 9184.6 9350.1 9419.4 9429.5 9430.4 6748.9 7257.3 7807.3 8064.0 8150.5 8086.6 8101.8 8116.8 8156.2 8175.8 6818.9 7127.0 7310.3 7430.8 7480.6 7167.6 7246.0 7286.0 7316.2 7339.3 7608.4 7608.8 7719.1 7730.5 7744.0 6893.3 6909.2 6990.5 7007.5 7028.6 7050.2 7093.0 7132.2 7132.9 7146.2 11:38:03 INFO - PROCESS | 2233 | 11:38:03 INFO - PROCESS | 2233 | [#4] prototype.html Cycles:180 Average:5900.00 Median:6811.35 stddev:1956.28 (28.7%) stddev-sans-first:1915.43 11:38:03 INFO - PROCESS | 2233 | Values: 260.6 321.7 329.2 329.9 331.5 6685.1 6812.7 6869.5 6893.2 6914.4 5783.1 6799.7 6801.5 6804.1 6810.0 4700.7 4814.4 4887.8 4913.9 5002.6 3632.4 4027.9 4146.5 4462.8 4625.6 4906.1 4916.9 4920.0 4936.6 4940.1 4000.5 4242.6 4760.8 4928.8 4939.2 4189.9 4198.2 4203.7 4212.5 4220.3 6275.8 6562.1 6576.3 6602.0 6605.7 4423.2 5782.4 5797.8 5805.6 5809.2 7300.7 7310.8 7336.5 7338.2 7353.3 4627.9 4629.2 4630.4 4639.3 4650.5 7708.2 7782.6 7789.8 7798.1 7798.1 4431.3 4502.2 4577.4 4660.9 4690.9 4721.7 4744.1 4801.3 4803.4 4805.7 5665.8 5755.1 5760.4 5770.2 5799.7 7312.4 7321.0 7334.0 7336.2 7336.5 1634.5 1650.3 1652.9 1654.9 1658.3 1022.2 1047.2 1050.3 1050.3 1067.0 6821.7 6851.2 6873.2 6873.6 6874.0 6465.3 7619.6 7620.1 7628.2 7638.7 6836.9 6863.8 6888.8 6895.9 6920.0 3874.0 4011.9 4029.6 4052.2 4056.9 7137.2 7933.8 7963.7 7970.1 7973.2 6946.1 7824.2 7855.9 7862.4 7878.8 7934.3 7944.9 7948.7 7965.6 7981.8 7295.6 7605.4 7609.2 7624.8 7650.6 7007.0 7419.3 7444.7 7449.5 7458.7 6369.5 6939.8 7967.0 7994.9 8003.5 4719.6 4720.4 4727.8 4737.0 4740.6 7216.6 7335.4 7517.4 7579.9 7600.1 5934.0 6666.4 6813.0 7342.0 7452.6 7372.0 7418.6 7424.9 7427.8 7629.3 7221.4 7229.2 7232.0 7241.3 7302.3 6049.9 7157.7 7344.9 7414.3 7417.2 7239.5 7254.3 7274.5 7275.5 7286.2 11:38:03 INFO - PROCESS | 2233 | 11:38:03 INFO - PROCESS | 2233 | [#5] yui.html Cycles:180 Average:17144.44 Median:30407.89 stddev:23535.42 (77.4%) stddev-sans-first:23568.89 11:38:03 INFO - PROCESS | 2233 | Values: 659.9 699.3 723.3 729.2 733.9 14476.5 14644.5 14721.9 14820.0 14838.3 13485.5 13708.7 13853.9 13864.6 13902.6 699.6 844.1 854.8 860.6 880.3 877.9 884.3 884.8 886.9 887.9 931.4 931.6 934.1 935.0 942.2 904.1 908.0 914.9 921.9 927.5 665.0 673.3 679.2 680.4 680.7 14386.6 14635.5 14658.2 14662.5 14711.3 12422.3 12518.8 12524.8 12691.0 12766.2 9774.1 9866.6 10010.6 10038.1 10244.8 3454.5 3478.4 3494.9 3499.5 3501.4 64670.4 68349.3 72677.8 73667.3 74114.6 7835.4 9218.7 9227.3 9260.8 9454.1 20336.8 20865.0 20926.2 20927.1 20946.3 7339.3 7441.4 7467.1 7498.7 7650.3 4103.3 4171.6 4174.8 4175.5 4179.3 3321.8 3348.2 3365.5 3371.0 3371.3 611.4 622.0 625.2 629.1 663.3 447.9 538.5 564.2 566.1 575.9 7903.5 7951.7 8071.7 8079.0 8251.9 562.3 564.8 578.7 579.6 582.4 2921.3 3568.3 3796.1 3813.6 3868.9 81914.6 87202.6 88541.4 89521.0 89792.1 56396.9 69541.7 69901.7 72891.9 75898.6 53504.5 66991.0 68130.3 68486.3 69475.3 7991.0 8068.0 8256.3 8257.3 8345.4 46507.3 47114.1 47216.5 48179.8 48407.0 57996.7 60233.4 64612.0 64643.0 67369.0 10185.6 10244.9 10279.9 10361.7 10418.4 11440.1 11458.6 11526.4 11533.9 11908.8 10647.2 10746.7 10833.8 11047.3 11306.5 10783.4 11012.3 11044.3 11927.2 11967.5 10668.8 10971.8 11234.9 11349.5 11551.5 9045.7 9134.2 9357.6 9397.5 9464.8 9023.3 9413.5 9450.4 9531.8 9556.9 11:38:03 INFO - PROCESS | 2233 | -------- Summary: end -------- 11:38:03 INFO - PROCESS | 2233 | 11:38:03 INFO - TEST-INFO | 2233: exit 0 11:38:03 INFO - TEST-OK | dromaeo_css | took 1110844ms 11:38:03 INFO - TEST-START | kraken 11:38:03 INFO - operating with platform_type : mac_ 11:38:03 INFO - Initialising browser for kraken test... 11:38:03 INFO - TEST-INFO | started process 2240 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmp1XeNAl/profile http://localhost:51140/getInfo.html) 11:38:06 INFO - PROCESS | 2240 | __metrics Screen width/height:1600/1200 11:38:06 INFO - PROCESS | 2240 | colorDepth:24 11:38:06 INFO - PROCESS | 2240 | Browser inner width/height: 1024/689 11:38:06 INFO - PROCESS | 2240 | __metrics 11:38:06 ERROR - PROCESS | 2240 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 11:38:07 INFO - TEST-INFO | 2240: exit 0 11:38:07 INFO - Browser initialized. 11:38:07 INFO - Running cycle 1/1 for kraken test... 11:38:07 INFO - TEST-INFO | started process 2243 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmp1XeNAl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:38:19 INFO - PROCESS | 2243 | RSS: Main: 253956096 11:38:19 INFO - PROCESS | 2243 | 11:38:22 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51140/tests/kraken/driver.html?testName=audio-beat-detection) 11:38:22 INFO - PROCESS | 2243 | RSS: Main: 268414976 11:38:22 INFO - PROCESS | 2243 | 11:38:25 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51140/tests/kraken/driver.html?testName=audio-dft) 11:38:26 INFO - PROCESS | 2243 | RSS: Main: 276443136 11:38:26 INFO - PROCESS | 2243 | 11:38:29 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51140/tests/kraken/driver.html?testName=audio-fft) 11:38:30 INFO - PROCESS | 2243 | RSS: Main: 280981504 11:38:30 INFO - PROCESS | 2243 | 11:38:31 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51140/tests/kraken/driver.html?testName=audio-oscillator) 11:38:32 INFO - PROCESS | 2243 | RSS: Main: 279818240 11:38:32 INFO - PROCESS | 2243 | 11:38:34 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51140/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:38:35 INFO - PROCESS | 2243 | RSS: Main: 280399872 11:38:35 INFO - PROCESS | 2243 | 11:38:38 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51140/tests/kraken/driver.html?testName=imaging-darkroom) 11:38:38 INFO - PROCESS | 2243 | RSS: Main: 283226112 11:38:38 INFO - PROCESS | 2243 | 11:38:41 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51140/tests/kraken/driver.html?testName=imaging-desaturate) 11:38:42 INFO - PROCESS | 2243 | RSS: Main: 283148288 11:38:42 INFO - PROCESS | 2243 | 11:38:45 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51140/tests/kraken/driver.html?testName=json-parse-financial) 11:38:46 INFO - PROCESS | 2243 | RSS: Main: 283316224 11:38:46 INFO - PROCESS | 2243 | 11:38:47 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51140/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:38:48 INFO - PROCESS | 2243 | RSS: Main: 282136576 11:38:48 INFO - PROCESS | 2243 | 11:38:50 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51140/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:38:50 INFO - PROCESS | 2243 | RSS: Main: 281698304 11:38:50 INFO - PROCESS | 2243 | 11:38:53 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51140/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:38:53 INFO - PROCESS | 2243 | RSS: Main: 282849280 11:38:53 INFO - PROCESS | 2243 | 11:38:56 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:38:57 INFO - PROCESS | 2243 | RSS: Main: 281989120 11:38:57 INFO - PROCESS | 2243 | 11:38:59 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:39:00 INFO - PROCESS | 2243 | RSS: Main: 282701824 11:39:00 INFO - PROCESS | 2243 | 11:39:01 INFO - PROCESS | 2243 | Cycle 1(1): loaded http://localhost:51140/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51140/tests/kraken/driver.html?testName=ai-astar) 11:39:02 INFO - PROCESS | 2243 | RSS: Main: 283693056 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | __start_tp_report 11:39:02 INFO - PROCESS | 2243 | _x_x_mozilla_page_load 11:39:02 INFO - PROCESS | 2243 | _x_x_mozilla_page_load_details 11:39:02 INFO - PROCESS | 2243 | |i|pagename|runs| 11:39:02 INFO - PROCESS | 2243 | |0;ai-astar;114;110;114;114;114;125;113;113;115;113 11:39:02 INFO - PROCESS | 2243 | |1;audio-beat-detection;179;141;149;162;113;149;162;156;194;121 11:39:02 INFO - PROCESS | 2243 | |2;audio-dft;197;195;202;249;269;201;200;199;206;200 11:39:02 INFO - PROCESS | 2243 | |3;audio-fft;74;71;72;119;75;49;52;75;146;69 11:39:02 INFO - PROCESS | 2243 | |4;audio-oscillator;86;104;165;117;80;90;124;86;117;156 11:39:02 INFO - PROCESS | 2243 | |5;imaging-gaussian-blur;88;115;126;85;88;88;88;86;121;83 11:39:02 INFO - PROCESS | 2243 | |6;imaging-darkroom;95;94;95;97;152;150;94;95;93;94 11:39:02 INFO - PROCESS | 2243 | |7;imaging-desaturate;91;93;92;99;141;132;90;105;146;142 11:39:02 INFO - PROCESS | 2243 | |8;json-parse-financial;58;68;69;70;58;57;55;66;59;56 11:39:02 INFO - PROCESS | 2243 | |9;json-stringify-tinderbox;66;64;76;92;117;67;103;99;101;84 11:39:02 INFO - PROCESS | 2243 | |10;stanford-crypto-aes;105;75;89;81;108;112;116;109;86;87 11:39:02 INFO - PROCESS | 2243 | |11;stanford-crypto-ccm;118;128;135;122;123;129;122;138;135;132 11:39:02 INFO - PROCESS | 2243 | |12;stanford-crypto-pbkdf2;132;159;145;145;143;129;140;141;143;144 11:39:02 INFO - PROCESS | 2243 | |13;stanford-crypto-sha256-iterative;66;68;65;74;82;100;95;95;97;102 11:39:02 INFO - PROCESS | 2243 | __end_tp_report 11:39:02 INFO - PROCESS | 2243 | __start_cc_report 11:39:02 INFO - PROCESS | 2243 | _x_x_mozilla_cycle_collect,917 11:39:02 INFO - PROCESS | 2243 | __end_cc_report 11:39:02 INFO - PROCESS | 2243 | __startTimestamp1457033942250__endTimestamp 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | ------- Summary: start ------- 11:39:02 INFO - PROCESS | 2243 | Number of tests: 14 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#0] ai-astar Cycles:10 Average:114.50 Median:114.00 stddev:3.92 (3.4%) stddev-sans-first:4.16 11:39:02 INFO - PROCESS | 2243 | Values: 114.0 110.0 114.0 114.0 114.0 125.0 113.0 113.0 115.0 113.0 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#1] audio-beat-detection Cycles:10 Average:152.60 Median:159.00 stddev:24.33 (15.3%) stddev-sans-first:23.85 11:39:02 INFO - PROCESS | 2243 | Values: 179.0 141.0 149.0 162.0 113.0 149.0 162.0 156.0 194.0 121.0 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#2] audio-dft Cycles:10 Average:211.80 Median:201.50 stddev:25.49 (12.6%) stddev-sans-first:26.46 11:39:02 INFO - PROCESS | 2243 | Values: 197.0 195.0 202.0 249.0 269.0 201.0 200.0 199.0 206.0 200.0 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#3] audio-fft Cycles:10 Average:80.20 Median:71.50 stddev:29.77 (41.6%) stddev-sans-first:31.49 11:39:02 INFO - PROCESS | 2243 | Values: 74.0 71.0 72.0 119.0 75.0 49.0 52.0 75.0 146.0 69.0 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#4] audio-oscillator Cycles:10 Average:112.50 Median:122.50 stddev:29.55 (24.1%) stddev-sans-first:29.75 11:39:02 INFO - PROCESS | 2243 | Values: 86.0 104.0 165.0 117.0 80.0 90.0 124.0 86.0 117.0 156.0 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#5] imaging-gaussian-blur Cycles:10 Average:96.80 Median:87.00 stddev:16.75 (19.3%) stddev-sans-first:17.46 11:39:02 INFO - PROCESS | 2243 | Values: 88.0 115.0 126.0 85.0 88.0 88.0 88.0 86.0 121.0 83.0 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#6] imaging-darkroom Cycles:10 Average:105.90 Median:94.50 stddev:23.80 (25.2%) stddev-sans-first:24.91 11:39:02 INFO - PROCESS | 2243 | Values: 95.0 94.0 95.0 97.0 152.0 150.0 94.0 95.0 93.0 94.0 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#7] imaging-desaturate Cycles:10 Average:113.10 Median:90.50 stddev:24.01 (26.5%) stddev-sans-first:24.10 11:39:02 INFO - PROCESS | 2243 | Values: 91.0 93.0 92.0 99.0 141.0 132.0 90.0 105.0 146.0 142.0 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:62.50 stddev:5.91 (9.5%) stddev-sans-first:6.12 11:39:02 INFO - PROCESS | 2243 | Values: 58.0 68.0 69.0 70.0 58.0 57.0 55.0 66.0 59.0 56.0 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#9] json-stringify-tinderbox Cycles:10 Average:86.90 Median:71.50 stddev:18.32 (25.6%) stddev-sans-first:17.80 11:39:02 INFO - PROCESS | 2243 | Values: 66.0 64.0 76.0 92.0 117.0 67.0 103.0 99.0 101.0 84.0 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#10] stanford-crypto-aes Cycles:10 Average:96.80 Median:78.00 stddev:14.68 (18.8%) stddev-sans-first:15.27 11:39:02 INFO - PROCESS | 2243 | Values: 105.0 75.0 89.0 81.0 108.0 112.0 116.0 109.0 86.0 87.0 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#11] stanford-crypto-ccm Cycles:10 Average:128.20 Median:130.50 stddev:6.76 (5.2%) stddev-sans-first:6.08 11:39:02 INFO - PROCESS | 2243 | Values: 118.0 128.0 135.0 122.0 123.0 129.0 122.0 138.0 135.0 132.0 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.10 Median:143.50 stddev:8.08 (5.6%) stddev-sans-first:7.69 11:39:02 INFO - PROCESS | 2243 | Values: 132.0 159.0 145.0 145.0 143.0 129.0 140.0 141.0 143.0 144.0 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - PROCESS | 2243 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:84.40 Median:78.00 stddev:15.03 (19.3%) stddev-sans-first:14.40 11:39:02 INFO - PROCESS | 2243 | Values: 66.0 68.0 65.0 74.0 82.0 100.0 95.0 95.0 97.0 102.0 11:39:02 INFO - PROCESS | 2243 | -------- Summary: end -------- 11:39:02 INFO - PROCESS | 2243 | 11:39:02 INFO - TEST-INFO | 2243: exit 0 11:39:02 INFO - TEST-OK | kraken | took 59033ms 11:39:02 INFO - SUITE-END | took 1169s 11:39:03 INFO - Completed test suite (00:19:30) 11:39:03 INFO - Working with test: dromaeo_css 11:39:03 INFO - Generating results file: dromaeo_css 11:39:03 INFO - Working with test: kraken 11:39:03 INFO - Generating results file: kraken 11:39:03 INFO - javascript benchmark 11:39:03 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:39:03 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 11:39:03 INFO - process_Request line: dromaeo_css 7354.78 graph.html#tests=[[72,64,61]] 11:39:03 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:39:03 INFO - process_Request line: kraken 1587.40 graph.html#tests=[[232,64,61]] 11:39:03 INFO - RETURN: dromaeo_css: 7354.78 11:39:03 INFO - RETURN: kraken: 1587.40 11:39:03 INFO - javascript benchmark 11:39:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3413.266147778227, 3453.9309213815723, 3486.1458942559075, 3512.701420379268, 3518.4018716818136, 5632.77468901244, 5671.262735844334, 5680.772769089242, 5688.0, 5711.571632127591, 4811.59101476375, 5523.558115350772, 5637.492625663689, 5640.182173584838, 5709.486146246837, 5081.491850814926, 5180.015796998577, 5185.870353241162, 5195.376554813428, 5241.947580524203, 893.9558619788871, 5074.13739664258, 5111.386633603955, 5194.506521880434, 5271.841844744664, 5138.897222055538, 5146.665466744649, 5162.070827251093, 5197.818076367347, 5216.00895829793, 5177.430482646906, 5199.6360254782185, 5217.973910130463, 5224.608154388398, 5258.237555554423, 5070.2141168119, 5096.082705113078, 5183.870403239912, 5204.4535323791215, 5212.29633999409, 4573.153966516172, 4892.339534162878, 5106.15748401517, 5543.722813859291, 5577.69322687252, 6057.575969682124, 6216.036514340284, 6223.097650840648, 6230.345813689588, 6241.750329986795, 6148.739508400812, 6180.783672571483, 6239.220097487814, 6240.968795156041, 6250.43746062852, 4277.315629499265, 5729.169270455761, 5740.856478588027, 5746.88506229873, 5766.308043034863, 6125.93755450893, 6166.7224974876235, 6237.844053898598, 6248.31268560458, 6270.811875643738, 4975.0, 6012.849678758066, 6020.909686354708, 6031.7587296507645, 6089.391060893964, 6144.56988010835, 6172.166757487771, 6180.0, 6184.690765461709, 6185.969070154621, 4816.277558366203, 5992.0, 6031.9396806032255, 6116.0010150213275, 6136.570440069152, 6121.087175196994, 6184.81445556634, 6208.596441231305, 6228.875422491525, 6267.561270711007, 4870.780814863339, 4886.65793394459, 4887.413510378778, 4900.166971614763, 4903.828366007173, 4254.149170165979, 4335.869923902288, 4352.129574085196, 4390.956090439118, 4423.977880110579, 5567.638103523258, 5651.9826431241945, 5677.801276955287, 5699.800506982318, 5701.0, 6188.566800324024, 6247.2815626202655, 6255.186825712628, 6256.374362563798, 6265.8746825063245, 5552.0, 5609.49514543693, 5657.094864821609, 5710.314762228559, 5731.742071606787, 5317.7872885084935, 5325.520703136736, 5335.946640533545, 5340.893182136336, 5359.678419294854, 6295.055741638699, 6299.590526615663, 6305.464035556937, 6315.810525684236, 6316.210473690789, 6136.355682653257, 6147.754089836357, 6226.377362263737, 6249.78125765596, 6251.218597675291, 6280.0, 6291.779787707408, 6304.148939893055, 6308.873822523432, 6342.619442833445, 6104.938950610437, 6151.753929842756, 6156.938430615636, 6165.691715414122, 6174.475169610633, 6124.081387791867, 6128.075379514812, 6200.379962003944, 6241.875162496815, 6261.8747625046335, 6028.930471931341, 6039.909401359071, 6082.60463069899, 6090.573659843769, 6140.140380346666, 5876.1773351731645, 5988.951933411723, 6034.306054803754, 6043.516518678407, 6129.877402452015, 4826.734529600765, 4945.4312754033745, 5553.444655534414, 5890.175375447355, 6003.0, 6059.33347331802, 6062.787802426894, 6068.575199735976, 6071.301800292847, 6098.969505152446, 5814.360420353673, 5918.615290006136, 5942.64344139353, 5957.136215248678, 5972.432618901197], "unit": "score", "name": "dojo.html", "value": 5582.800429684438}, {"lowerIsBetter": false, "replicates": [441.8210624696999, 448.79804088160313, 481.6508031677035, 514.776072408502, 525.3197109742883, 33358.833205833966, 34236.97289081332, 37083.443748343794, 38265.80867095664, 38345.04137396563, 38893.611063889424, 39473.0, 39483.60516394835, 39504.407433888446, 39606.405903911465, 9519.857202141957, 9767.16979056781, 9767.316287859852, 9795.216382689403, 9800.41197528147, 9600.663976760814, 9730.221582273436, 9732.708018759413, 9751.90248097517, 9803.264755143357, 9693.418394896293, 9737.415755054684, 9746.805063898753, 9761.267904907161, 9770.120689137977, 8039.999999999971, 9678.128968392843, 9707.757306067335, 9732.562034708455, 9738.172255358302, 9419.058094190596, 9735.41587504752, 9747.951260243653, 9759.072888075621, 9769.267304952156, 37372.81313593442, 37483.4377484338, 38022.61977380219, 38022.859314220615, 38226.61773382286, 2830.4763618730394, 3081.6610172880964, 3208.374366998436, 3324.983375083133, 3382.8477718502727, 26780.866095669397, 26962.0, 27681.446371072667, 27682.892684292605, 28388.29029274264, 2742.9725702743117, 2829.4906916754976, 2851.344190836119, 2853.671827739795, 2854.2864283929016, 351600.0, 352117.0, 353366.99999999744, 354924.0, 355008.0, 44960.77519612381, 45707.08585828265, 58566.4143358561, 60032.49918752066, 60043.0, 44446.888827778916, 44771.77614111909, 44946.55053449489, 44954.775226124315, 45171.32243016357, 14795.704085918436, 14818.555443336718, 14835.258237088103, 14940.0, 15009.924950375396, 11608.187426880206, 11705.941470292764, 11770.529178832921, 11875.465604047666, 11915.225510341974, 14334.99655024159, 14357.78463323051, 14377.856221437652, 14432.134071955506, 14583.489577864724, 5577.386487486373, 6063.727132279058, 6236.376362363818, 6298.307186209513, 6344.143540622049, 876.0, 950.2682934140673, 978.5400861595039, 1098.7857367813199, 1159.62891874601, 29478.852605736833, 29536.704632953395, 29752.404951901273, 29868.850655747017, 30022.79908803667, 1007.5214273220162, 1080.783843231357, 1137.1357768096307, 1161.0769438296575, 1164.5632887667125, 11734.647960561197, 12701.491940322283, 14322.997390182796, 14413.711725765635, 14653.413863445556, 427976.0, 430777.0, 436153.0, 440301.0, 441410.0, 58382.12426813601, 58692.70653646704, 59589.0, 59611.105833412534, 59826.70086649539, 1394.4352537222442, 1400.2706657278254, 1414.2504472629523, 1416.0583212163797, 1428.114568967247, 29193.416131676822, 29248.707512924597, 29623.407531849673, 29920.401591967602, 29922.401551969273, 52486.21270680866, 52791.0, 52909.94180116299, 53192.46807531875, 53246.20130697965, 468466.0, 488956.0, 490687.5465622649, 491209.0, 493301.0, 33288.50067248945, 33773.83113084419, 33778.49332260067, 34276.828615856764, 34307.0, 44840.77579612081, 44962.0, 45159.774201128785, 46297.6110716679, 46472.53527464682, 36578.902632921054, 37016.6298337024, 37574.81212594029, 38009.61990380061, 38176.0, 36986.965716884755, 37107.814460927526, 37397.43903841499, 37451.81274093612, 37592.0, 32577.67422325841, 36241.63758362383, 37039.0, 37154.07114822043, 37229.62770372262, 30573.388532228786, 31515.84242078775, 31619.20951976219, 31793.0, 31934.0, 23974.40063998414, 24060.39849003789, 24164.637530436707, 24240.909159087532, 24382.51234975326], "unit": "score", "name": "ext.html", "value": 18624.092631730775}, {"lowerIsBetter": false, "replicates": [302.81528267756676, 346.6723945871151, 356.308761003653, 357.89442114576195, 362.0207339147606, 18601.7209741854, 18681.066176470587, 20701.68947465789, 21137.943102844874, 21158.682619760715, 19635.90182049088, 19788.109535070922, 20082.598348033032, 20100.296489622866, 20201.696974545357, 5538.529225015878, 5782.53739700825, 5837.24115864937, 5856.736446859902, 5856.824295271127, 4155.979220103895, 5106.4382917879, 5655.830325090254, 6331.050342448623, 6353.459955903731, 6276.466500347476, 6303.401176888188, 6303.9369606304035, 6305.0542418637115, 6314.7158377872875, 5816.563757718188, 6015.218021657179, 6195.597286176384, 6207.28616209135, 6208.2239720034995, 5336.226247194174, 5354.571634269288, 5358.678479291255, 5362.946370536284, 5372.059889519358, 16620.916895415445, 22061.45569810114, 25249.873750631312, 25378.619320710204, 25379.984800607952, 1767.9027653479054, 2030.0966070098812, 2439.9756002439926, 2490.713567939692, 2759.903403380872, 14191.858081419157, 14406.927965360212, 14556.344964476624, 14711.705765884622, 14759.0, 1524.3902439024369, 1684.1410880450935, 1762.3919747687028, 1783.4203883737837, 1795.649848279586, 76757.61621191914, 93553.53223233909, 95819.9999999993, 95829.52085239599, 97010.57473563147, 9532.856057273033, 9690.70927872165, 10295.3822770634, 10706.678799636024, 10796.028357447867, 12699.936500317439, 12743.426545805462, 12783.424745886457, 12834.743305133845, 12847.421866016051, 8209.958950205211, 8362.45644033136, 8407.537585432738, 8486.363522735819, 8514.318854491627, 8511.0, 8553.230209281195, 8582.0, 8650.264727498106, 8705.434146780439, 6048.0, 6156.0, 6156.876862462816, 6171.938280617136, 6219.720112594944, 1701.438525286677, 1753.6755700195504, 1806.7380229866858, 1808.63827234551, 1823.4985379020875, 874.2612492443875, 933.8739270198572, 961.423146112327, 975.7267964969819, 1041.57295508841, 19589.60820783605, 19630.901845490967, 19755.40733777989, 20056.598868022556, 20320.491987700425, 932.5477143585356, 995.581855620641, 1009.5557954500143, 1018.5772904244656, 1041.578160844844, 11020.889791102147, 11090.833637495443, 11229.0, 11336.144739515446, 11432.828507572392, 591228.043859778, 611749.0, 626921.0, 643419.0, 652827.3586320665, 121019.0, 122180.0, 123646.38176809058, 124705.99999999818, 126111.0, 451.28921947931485, 471.72639868875285, 474.0731869195714, 1025.4975062219607, 1068.8289873620183, 10528.0, 10659.307145035547, 11061.004509594175, 11170.603674540682, 11516.94241528787, 48954.75522622364, 49721.75139124281, 50984.74507627438, 51485.71285717737, 52377.0, 67558.66220668865, 69837.60324793577, 71508.0, 72610.0, 72639.0, 7933.325667318342, 7978.659752692322, 8043.839123217386, 8099.716509922125, 8143.918560814316, 9057.320700947586, 11009.394483303175, 12683.42924568415, 12817.23096614206, 12910.935445322713, 8036.754303083031, 8261.297789687704, 8670.523121228392, 10685.57257709683, 11270.098392128773, 9367.782188315748, 10701.732456688645, 10711.196660250669, 10991.0, 11118.332900026024, 10714.410707411167, 10956.835647465454, 11371.715707107389, 11600.0, 11746.58886938953, 6878.209005964378, 6956.339147780953, 7986.480878742863, 7997.520148790858, 8212.753617391489, 9708.0, 10684.519196636325, 11222.382768947786, 11335.093192544742, 11347.829782553103], "unit": "score", "name": "jquery.html", "value": 9172.144025539761}, {"lowerIsBetter": false, "replicates": [1396.951106711265, 1427.8357988831283, 1626.4470080172753, 1773.556610847288, 1958.0992743338054, 7748.186440423745, 8330.58347082645, 8623.223909848113, 8732.91267087329, 8788.560571971408, 6800.693968771405, 8024.398170137234, 8074.708046712512, 8562.74311770648, 8586.184312490319, 2337.602607556711, 2351.0948284910305, 2361.657559653849, 2386.3079706884982, 2387.415083304593, 2378.4053986503372, 2389.7610238976135, 2414.1550457339877, 2434.3670645632087, 2457.2259738182415, 2438.036975394718, 2443.535728211643, 2457.6682147909983, 2463.224084413413, 2466.506698660266, 2402.2913240593894, 2425.854448733082, 2435.866027368485, 2443.30365845734, 2453.325335532725, 2009.4172689919906, 2389.223502361722, 2423.4426082001064, 2425.7938075263623, 2430.2709187243754, 8716.259117974916, 8717.651293948235, 8743.0, 8744.825103497895, 8757.386982911199, 4325.935110973338, 5428.647137936022, 5452.991196628636, 5458.9454105458835, 5463.399026107125, 3537.0626783902285, 3595.2449985503076, 3662.981685091584, 3693.0398096494837, 3742.120601658608, 1030.8969103089705, 1039.0569634783003, 1043.1081425381265, 1047.5862034496408, 1047.9109275711573, 11860.28838269698, 11938.582149624808, 12019.21875078126, 12026.759464810742, 12062.939685301604, 4197.895052623709, 4270.893227669271, 4814.735189564608, 4865.294532292798, 4881.8535443936735, 10102.39385636864, 10116.08955194036, 10142.695719128438, 10153.94923025395, 10163.034511721375, 5409.891802163935, 5431.565474762009, 5434.70109143993, 5492.945070549244, 5498.367687715884, 4389.736615803062, 4753.904921901542, 4891.975540122347, 4898.681585696918, 4927.704337739747, 3328.6671332866517, 3863.34323165057, 3898.785566793797, 3938.665213456888, 3987.1626958338493, 1288.6134159752037, 1301.3688361144837, 1302.4139137388024, 1303.1073714505594, 1306.562301628946, 1292.6639073840681, 1310.3775706539318, 1313.1333320008748, 1337.6923307639297, 1350.8716671916152, 7215.639218039077, 8023.318017968538, 8054.637541310655, 8130.512169269863, 8242.958785206036, 423.860126158367, 497.2069549069229, 508.21227097997956, 509.4930544108636, 515.3455112007729, 6222.439980401786, 6261.655608941552, 6278.340774218641, 6289.7484100636375, 6311.27420346666, 10194.643187488402, 10365.963403659574, 10406.167506599453, 10496.580136794442, 10532.631357902437, 9967.451790151466, 10303.278770486144, 10323.741906452398, 10356.896431035744, 10376.636817711344, 8046.557439340892, 8185.95907020473, 8222.13667564909, 8229.917700823034, 8282.378821588405, 7760.767176984474, 7893.881591776013, 8074.232947869943, 8092.069412017693, 8101.716439924574, 7777.338926191337, 8784.0, 8977.955110224408, 9513.714588562354, 9531.523423828643, 9184.586693598938, 9350.064993500868, 9419.434833909987, 9429.481378524248, 9430.387024843363, 6748.898766518604, 7257.346838784535, 7807.336376408069, 8064.032316122103, 8150.510969341858, 8086.6361013755695, 8101.797455063671, 8116.797080073045, 8156.184381561797, 8175.795605109682, 6818.93181068183, 7127.037849890198, 7310.268973102648, 7430.814229644302, 7480.588567628615, 7167.641617919187, 7246.021787058679, 7285.979962805318, 7316.195218526064, 7339.339459448675, 7608.353289970193, 7608.8478230433975, 7719.112302085107, 7730.458867879194, 7743.9545661335, 6893.276205998298, 6909.170899492093, 6990.545614535039, 7007.544509606859, 7028.613426261605, 7050.189228238818, 7093.042439270633, 7132.179799322937, 7132.8930066048015, 7146.213916469288], "unit": "score", "name": "mootools.html", "value": 4764.8564780045535}, {"lowerIsBetter": false, "replicates": [260.60778528314887, 321.7040322902929, 329.1540740297436, 329.85321531918305, 331.4944709318291, 6685.130932978712, 6812.693428795704, 6869.48478864086, 6893.241743408221, 6914.412274956635, 5783.074708046714, 6799.69401376938, 6801.523893327469, 6804.115464989544, 6810.0, 4700.670953033272, 4814.422269327668, 4887.828925987591, 4913.852584422455, 5002.574781143598, 3632.4369722693023, 4027.8520621622843, 4146.481689788777, 4462.776861156945, 4625.560571745679, 4906.1168989581865, 4916.852494425173, 4920.0159968006365, 4936.555709986101, 4940.08608407444, 4000.4799376081214, 4242.575742425733, 4760.762201827532, 4928.827491037814, 4939.234418665113, 4189.895252618679, 4198.202341555095, 4203.747775133502, 4212.4523811904255, 4220.3036498977635, 6275.811725648192, 6562.114114594564, 6576.342365763433, 6602.042703807969, 6605.669716514203, 4423.248047831877, 5782.421757824226, 5797.768089276424, 5805.564582656318, 5809.157672137559, 7300.707971681127, 7310.770215084397, 7336.523125996793, 7338.2388226825715, 7353.323338330834, 4627.930581041253, 4629.189891768927, 4630.421197350332, 4639.280911458729, 4650.511696271877, 7708.229177082303, 7782.610869456505, 7789.766307010798, 7798.064232292105, 7798.103218129931, 4431.268840641258, 4502.212112880233, 4577.359169716243, 4660.883477913011, 4690.882727931829, 4721.716696998191, 4744.051189761993, 4801.303810947393, 4803.3995750531185, 4805.711657300573, 5665.830025099253, 5755.1367294906095, 5760.3951585083805, 5770.16332631766, 5799.739011744482, 7312.378447831888, 7321.0, 7334.0, 7336.156342020629, 7336.486445948839, 1634.4524584264404, 1650.2656317938402, 1652.900825950447, 1654.8924319919167, 1658.278648787781, 1022.156720705421, 1047.1936608811325, 1050.2595670052594, 1050.3435352904435, 1067.0290036067142, 6821.69302381394, 6851.177858656993, 6873.243943166248, 6873.553219040847, 6873.965630171817, 6465.321141280192, 7619.580923049175, 7620.085589729268, 7628.160902300742, 7638.656260468292, 6836.931630683729, 6863.828404289933, 6888.827779305458, 6895.896561551581, 6920.031195632616, 3873.96126038736, 4011.8796436106963, 4029.576894426043, 4052.169305292467, 4056.9391459128137, 7137.179224389158, 7933.841323173504, 7963.685991811286, 7970.123286438487, 7973.20267973198, 6946.0622815920215, 7824.178461261599, 7855.921440785519, 7862.410319226081, 7878.803029924297, 7934.2859142677435, 7944.880826787718, 7948.721794737156, 7965.601719913865, 7981.800454988555, 7295.562266264041, 7605.429592780453, 7609.201033891583, 7624.771256862303, 7650.6174691264105, 7006.9649651751415, 7419.332260096618, 7444.702211911463, 7449.478536502393, 7458.701651933862, 6369.522285828674, 6939.826504337432, 7967.043954725238, 7994.880076798969, 8003.5197888126895, 4719.59883409914, 4720.409948756405, 4727.834525791581, 4737.0052289019695, 4740.5733483986605, 7216.639168041682, 7335.449841262033, 7517.361024312994, 7579.924200757921, 7600.125985511516, 5933.970330148321, 6666.366695163952, 6812.965935170292, 7341.972123902551, 7452.627368631655, 7372.0, 7418.629068546659, 7424.923386108876, 7427.7771666850085, 7629.2752188542, 7221.350078492961, 7229.240929702306, 7231.987521746854, 7241.312075352833, 7302.2697730226555, 6049.909251361145, 7157.677904494414, 7344.853102938018, 7414.295641914009, 7417.184109748031, 7239.4932354734665, 7254.347108760237, 7274.4907856449545, 7275.454340924346, 7286.162091359562], "unit": "score", "name": "prototype.html", "value": 5235.966448832538}, {"lowerIsBetter": false, "replicates": [659.9473839226434, 699.3461113858542, 723.2822047636862, 729.2197348836745, 733.853229354129, 14476.493322733706, 14644.487442939499, 14721.926390368046, 14820.0, 14838.332275047622, 13485.460581576725, 13708.657283567916, 13853.930730346334, 13864.584062478116, 13902.582922512342, 699.5697645947731, 844.0673056272792, 854.7905763088052, 860.6127242740761, 880.3177537408527, 877.8727084572733, 884.3411658314533, 884.8407286688393, 886.8581027035675, 887.9112088791134, 931.4318265857821, 931.6180366049921, 934.0752654871662, 934.9953250233739, 942.180303136269, 904.1184844776357, 907.9682211122645, 914.8581969794626, 921.8525035994243, 927.5130556457846, 664.9933500665028, 673.3300366135677, 679.1985457160548, 680.404645934807, 680.7038938061959, 14386.568402947823, 14635.487757928528, 14658.19379934114, 14662.486812961602, 14711.337989790485, 12422.254664720056, 12518.81221781674, 12524.81212781809, 12691.0, 12766.170198937132, 9774.071463210983, 9866.556004979793, 10010.59957601695, 10038.14675752562, 10244.795104097877, 3454.516367708523, 3478.4086705260165, 3494.9301013979834, 3499.510068590374, 3501.38725723, 64670.35329646691, 68349.31650683479, 72677.78359380852, 73667.26332736711, 74114.62942685252, 7835.412344074217, 9218.663293822492, 9227.26181905446, 9260.7684807879, 9454.101860323395, 20336.796632033787, 20864.956752162332, 20926.162953481995, 20927.05828237733, 20946.266880659103, 7339.339459448675, 7441.404687624977, 7467.141278753013, 7498.700051997859, 7650.273224043818, 4103.281925662997, 4171.645410140172, 4174.791260436966, 4175.498940127204, 4179.331306990867, 3321.80069195849, 3348.162959260185, 3365.5456513370873, 3371.005553361764, 3371.3088816792497, 611.3947192279611, 622.0078974036404, 625.1591609285504, 629.1475051305507, 663.2902794010363, 447.93728877957113, 538.4615384615385, 564.1622191046293, 566.0999011571621, 575.9222504961776, 7903.525788452711, 7951.721689740832, 8071.717489887826, 8079.0, 8251.917480825115, 562.2522045679236, 564.8333741546171, 578.727997841014, 579.5800289291253, 582.3884920833108, 2921.342697892957, 3568.2685049564775, 3796.0889386547583, 3813.580506144322, 3868.903277418031, 81914.59042704749, 87202.56398717966, 88541.3593980454, 89521.0, 89792.10207897967, 56396.87206255934, 69541.65229173923, 69901.65049174824, 72891.90662140072, 75898.62050689712, 53504.46495534995, 66991.0, 68130.31869681239, 68486.31513684799, 69475.30524694688, 7990.960045199737, 8067.959660201662, 8256.25693687571, 8257.339412847077, 8345.41582089248, 46507.30239046349, 47114.05771884612, 47216.527834721215, 48179.79550511125, 48407.0, 57996.71001645133, 60233.39766602453, 64612.030819536805, 64643.0, 67369.0, 10185.592576296865, 10244.948775256375, 10279.94860025695, 10361.689149325532, 10418.374897506174, 11440.084793216689, 11458.598949036743, 11526.366049867338, 11533.884661153617, 11908.821367679318, 10647.201459890694, 10746.677599672023, 10833.783324333626, 11047.281926674741, 11306.547738090385, 10783.352998820095, 11012.339259644446, 11044.33733975964, 11927.224730392496, 11967.461464233957, 10668.83996740065, 10971.780564388828, 11234.887651123385, 11349.4892729829, 11551.537938482366, 9045.683401081194, 9134.22359099484, 9357.57890894925, 9397.530123493934, 9464.763380915532, 9023.323250756088, 9413.52932353366, 9450.385724927857, 9531.761705957406, 9556.85664715016], "unit": "score", "name": "yui.html", "value": 6651.788357562707}], "name": "dromaeo_css", "value": 7354.776076705629}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 114.0, 114.0, 114.0, 125.0, 113.0, 113.0, 115.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.5}, {"lowerIsBetter": true, "replicates": [179.0, 141.0, 149.0, 162.0, 113.0, 149.0, 162.0, 156.0, 194.0, 121.0], "unit": "score", "name": "audio-beat-detection", "value": 152.6}, {"lowerIsBetter": true, "replicates": [197.0, 195.0, 202.0, 249.0, 269.0, 201.0, 200.0, 199.0, 206.0, 200.0], "unit": "score", "name": "audio-dft", "value": 211.8}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 72.0, 119.0, 75.0, 49.0, 52.0, 75.0, 146.0, 69.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [86.0, 104.0, 165.0, 117.0, 80.0, 90.0, 124.0, 86.0, 117.0, 156.0], "unit": "score", "name": "audio-oscillator", "value": 112.5}, {"lowerIsBetter": true, "replicates": [88.0, 115.0, 126.0, 85.0, 88.0, 88.0, 88.0, 86.0, 121.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 96.8}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 97.0, 152.0, 150.0, 94.0, 95.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 105.9}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 92.0, 99.0, 141.0, 132.0, 90.0, 105.0, 146.0, 142.0], "unit": "score", "name": "imaging-desaturate", "value": 113.1}, {"lowerIsBetter": true, "replicates": [58.0, 68.0, 69.0, 70.0, 58.0, 57.0, 55.0, 66.0, 59.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 61.6}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 76.0, 92.0, 117.0, 67.0, 103.0, 99.0, 101.0, 84.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 86.9}, {"lowerIsBetter": true, "replicates": [105.0, 75.0, 89.0, 81.0, 108.0, 112.0, 116.0, 109.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 96.8}, {"lowerIsBetter": true, "replicates": [118.0, 128.0, 135.0, 122.0, 123.0, 129.0, 122.0, 138.0, 135.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 128.2}, {"lowerIsBetter": true, "replicates": [132.0, 159.0, 145.0, 145.0, 143.0, 129.0, 140.0, 141.0, 143.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.1}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 65.0, 74.0, 82.0, 100.0, 95.0, 95.0, 97.0, 102.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 84.4}], "name": "kraken", "value": 1587.4}]} 11:39:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1587.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7354.78"}}} 11:39:04 INFO - Return code: 0 11:39:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:39:04 ERROR - # TBPL SUCCESS # 11:39:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:39:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:39:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:39:04 INFO - 2016-03-03 11:39:04.090 screenresolution[2248:22663] starting screenresolution argv=screenresolution get 11:39:04 INFO - 2016-03-03 11:39:04.092 screenresolution[2248:22663] Display 0: 1600x1200x32@60 11:39:04 INFO - 2016-03-03 11:39:04.098 screenresolution[2249:22666] starting screenresolution argv=screenresolution list 11:39:04 INFO - Available Modes on Display 0 11:39:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:39:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:39:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:39:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:39:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:39:04 INFO - Intel Iris: 11:39:04 INFO - Chipset Model: Intel Iris 11:39:04 INFO - Type: GPU 11:39:04 INFO - Bus: Built-In 11:39:04 INFO - VRAM (Dynamic, Max): 1536 MB 11:39:04 INFO - Vendor: Intel (0x8086) 11:39:04 INFO - Device ID: 0x0a2e 11:39:04 INFO - Revision ID: 0x0009 11:39:04 INFO - Displays: 11:39:04 INFO - Display: 11:39:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:39:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:39:04 INFO - Display Serial Number: 1600x1200 60 11:39:04 INFO - Main Display: Yes 11:39:04 INFO - Mirror: Off 11:39:04 INFO - Online: Yes 11:39:04 INFO - Rotation: Supported 11:39:04 INFO - Return code: 0 11:39:04 INFO - Running post-action listener: _resource_record_post_action 11:39:04 INFO - Running post-run listener: _resource_record_post_run 11:39:05 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 2371584; Write bytes: 705418752; Read time: 42; Write time: 2013 11:39:05 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401340928; Write bytes: 403088896; Read time: 30237; Write time: 730 11:39:05 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 2371584; Write bytes: 301039616; Read time: 42; Write time: 1279 11:39:05 INFO - Running post-run listener: _upload_blobber_files 11:39:05 INFO - Blob upload gear active. 11:39:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:39:05 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 11:39:05 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'] 11:39:05 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 11:39:05 INFO - (blobuploader) - INFO - Open directory for files ... 11:39:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:39:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:39:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:06 INFO - (blobuploader) - INFO - Done attempting. 11:39:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:39:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:39:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:39:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:39:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:39:07 INFO - (blobuploader) - INFO - Done attempting. 11:39:07 INFO - (blobuploader) - INFO - Iteration through files over. 11:39:07 INFO - Return code: 0 11:39:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:39:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:39:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fa8ce214c4404193e18be7ed523b0b23a9c8f133c4bad9c22b67b6917c084eaf17c41a0894b7591f9028d1c3f1bdca60daa450e8c6ff6ce14f991bac52799ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee406175f6362cb96ccbc10cac66d70ca204d859bf9925f0a3d735d48e94c980b916d74b467237297302388b6d4f995d33bb41b30eb17a6fb7b49e287bb2bb6c"} 11:39:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:39:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:39:07 INFO - Contents: 11:39:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7fa8ce214c4404193e18be7ed523b0b23a9c8f133c4bad9c22b67b6917c084eaf17c41a0894b7591f9028d1c3f1bdca60daa450e8c6ff6ce14f991bac52799ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee406175f6362cb96ccbc10cac66d70ca204d859bf9925f0a3d735d48e94c980b916d74b467237297302388b6d4f995d33bb41b30eb17a6fb7b49e287bb2bb6c"} 11:39:07 INFO - Running post-run listener: copy_logs_to_upload_dir 11:39:07 INFO - Copying logs to upload dir... 11:39:07 INFO - mkdir: /builds/slave/test/build/upload/logs 11:39:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.903974 ========= master_lag: 2.26 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-03-03 11:39:09.908151) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 11:39:09.911287) ========= 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.CQTyaw1JdT/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.fCm4dH6v72/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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/7fa8ce214c4404193e18be7ed523b0b23a9c8f133c4bad9c22b67b6917c084eaf17c41a0894b7591f9028d1c3f1bdca60daa450e8c6ff6ce14f991bac52799ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee406175f6362cb96ccbc10cac66d70ca204d859bf9925f0a3d735d48e94c980b916d74b467237297302388b6d4f995d33bb41b30eb17a6fb7b49e287bb2bb6c"} build_url:https://queue.taskcluster.net/v1/task/bfs7pxxPS9Sx6zsr1YMezg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011562 build_url: 'https://queue.taskcluster.net/v1/task/bfs7pxxPS9Sx6zsr1YMezg/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/7fa8ce214c4404193e18be7ed523b0b23a9c8f133c4bad9c22b67b6917c084eaf17c41a0894b7591f9028d1c3f1bdca60daa450e8c6ff6ce14f991bac52799ff", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ee406175f6362cb96ccbc10cac66d70ca204d859bf9925f0a3d735d48e94c980b916d74b467237297302388b6d4f995d33bb41b30eb17a6fb7b49e287bb2bb6c"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-03 11:39:09.959892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 11:39:09.960256) ========= 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.CQTyaw1JdT/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.fCm4dH6v72/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005258 ========= master_lag: 0.34 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-03 11:39:10.309650) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 11:39:10.310022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-03 11:39:10.312014) ========= ========= Total master_lag: 2.81 =========