builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0094 starttime: 1455305211.12 results: success (0) buildid: 20160212092224 builduid: 5dd27caccf65462c9829d9f25862548d revision: 20c7c84490ed0e3b4d0826b4e0a06d9ca5d53824 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.121537) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.121950) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.122248) ========= 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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.005648 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.146825) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.147167) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.164097) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.164375) ========= 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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.005477 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.216125) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.216411) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.217090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.217521) ========= 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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-12 11:26:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-02-12 11:26:52 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.465378 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.701376) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.701952) ========= 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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.026422 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:51.750522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 11:26:51.750936) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 20c7c84490ed0e3b4d0826b4e0a06d9ca5d53824 --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 20c7c84490ed0e3b4d0826b4e0a06d9ca5d53824 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-12 11:26:52,334 truncating revision to first 12 chars 2016-02-12 11:26:52,334 Setting DEBUG logging. 2016-02-12 11:26:52,334 attempt 1/10 2016-02-12 11:26:52,334 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/20c7c84490ed?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-12 11:26:52,984 unpacking tar archive at: fx-team-20c7c84490ed/testing/mozharness/ program finished with exit code 0 elapsedTime=1.075029 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-12 11:26:52.842656) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:52.843120) ========= echo 20c7c84490ed0e3b4d0826b4e0a06d9ca5d53824 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'20c7c84490ed0e3b4d0826b4e0a06d9ca5d53824'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 20c7c84490ed0e3b4d0826b4e0a06d9ca5d53824 program finished with exit code 0 elapsedTime=0.005432 script_repo_revision: '20c7c84490ed0e3b4d0826b4e0a06d9ca5d53824' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:52.895383) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:52.895668) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-12 11:26:52.914171) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-12 11:26:52.914539) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:26:53 INFO - MultiFileLogger online at 20160212 11:26:53 in /builds/slave/test 11:26:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:26:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:26:53 INFO - {'append_to_log': False, 11:26:53 INFO - 'base_work_dir': '/builds/slave/test', 11:26:53 INFO - 'blob_upload_branch': 'Fx-Team', 11:26:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:26:53 INFO - 'branch': 'Fx-Team', 11:26:53 INFO - 'buildbot_json_path': 'buildprops.json', 11:26:53 INFO - 'config_files': ('talos/mac_config.py',), 11:26:53 INFO - 'default_actions': ('clobber', 11:26:53 INFO - 'read-buildbot-config', 11:26:53 INFO - 'download-and-extract', 11:26:53 INFO - 'populate-webroot', 11:26:53 INFO - 'create-virtualenv', 11:26:53 INFO - 'install', 11:26:53 INFO - 'run-tests'), 11:26:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:26:53 INFO - 'download_minidump_stackwalk': True, 11:26:53 INFO - 'download_symbols': 'ondemand', 11:26:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:26:53 INFO - 'tooltool.py': '/tools/tooltool.py', 11:26:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:26:53 INFO - '/tools/misc-python/virtualenv.py')}, 11:26:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:26:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:26:53 INFO - 'installer_path': 'installer.exe', 11:26:53 INFO - 'log_level': 'info', 11:26:53 INFO - 'log_name': 'talos', 11:26:53 INFO - 'log_to_console': True, 11:26:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 11:26:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 11:26:53 INFO - 'opt_config_files': (), 11:26:53 INFO - 'pip_index': False, 11:26:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:26:53 INFO - 'cmd': ('bash', 11:26:53 INFO - '-c', 11:26:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:26:53 INFO - 'enabled': True, 11:26:53 INFO - 'halt_on_failure': False, 11:26:53 INFO - 'name': 'check_screen_resolution'},), 11:26:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 11:26:53 INFO - 'cmd': ('bash', 11:26:53 INFO - '-c', 11:26:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 11:26:53 INFO - 'enabled': True, 11:26:53 INFO - 'halt_on_failure': False, 11:26:53 INFO - 'name': 'check_screen_resolution'},), 11:26:53 INFO - 'run_cmd_checks_enabled': True, 11:26:53 INFO - 'sps_profile': False, 11:26:53 INFO - 'sps_profile_interval': 0, 11:26:53 INFO - 'suite': 'dromaeojs', 11:26:53 INFO - 'system_bits': '32', 11:26:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:26:53 INFO - 'title': 't-yosemite-r7-0094', 11:26:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:26:53 INFO - 'use_talos_json': True, 11:26:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:26:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:26:53 INFO - 'work_dir': 'build'} 11:26:53 INFO - ##### 11:26:53 INFO - ##### Running clobber step. 11:26:53 INFO - ##### 11:26:53 INFO - Running pre-action listener: _resource_record_pre_action 11:26:53 INFO - Running main action method: clobber 11:26:53 INFO - rmtree: /builds/slave/test/build 11:26:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:26:55 INFO - Running post-action listener: _resource_record_post_action 11:26:55 INFO - ##### 11:26:55 INFO - ##### Running read-buildbot-config step. 11:26:55 INFO - ##### 11:26:55 INFO - Running pre-action listener: _resource_record_pre_action 11:26:55 INFO - Running main action method: read_buildbot_config 11:26:55 INFO - Using buildbot properties: 11:26:55 INFO - { 11:26:55 INFO - "project": "", 11:26:55 INFO - "product": "firefox", 11:26:55 INFO - "script_repo_revision": "production", 11:26:55 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 11:26:55 INFO - "repository": "", 11:26:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 11:26:55 INFO - "buildid": "20160212092224", 11:26:55 INFO - "pgo_build": "False", 11:26:55 INFO - "basedir": "/builds/slave/test", 11:26:55 INFO - "buildnumber": 368, 11:26:55 INFO - "slavename": "t-yosemite-r7-0094", 11:26:55 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 11:26:55 INFO - "platform": "yosemite_r7", 11:26:55 INFO - "scheduler": "tests-fx-team-macosx64-talos", 11:26:55 INFO - "branch": "fx-team", 11:26:55 INFO - "repo_path": "integration/fx-team", 11:26:55 INFO - "revision": "20c7c84490ed0e3b4d0826b4e0a06d9ca5d53824", 11:26:55 INFO - "stage_platform": "macosx64", 11:26:55 INFO - "builduid": "5dd27caccf65462c9829d9f25862548d", 11:26:55 INFO - "slavebuilddir": "test" 11:26:55 INFO - } 11:26:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 11:26:55 INFO - Running post-action listener: _resource_record_post_action 11:26:55 INFO - ##### 11:26:55 INFO - ##### Running download-and-extract step. 11:26:55 INFO - ##### 11:26:55 INFO - Running pre-action listener: _resource_record_pre_action 11:26:55 INFO - Running main action method: download_and_extract 11:26:55 INFO - mkdir: /builds/slave/test/build/tests 11:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:55 INFO - https://queue.taskcluster.net/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:26:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/test_packages.json 11:26:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/test_packages.json 11:26:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:26:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:26:56 INFO - Downloaded 1277 bytes. 11:26:56 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:26:56 INFO - Using the following test package requirements: 11:26:56 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:26:56 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:26:56 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 11:26:56 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:26:56 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 11:26:56 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:26:56 INFO - u'jsshell-mac.zip'], 11:26:56 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:26:56 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 11:26:56 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:26:56 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:26:56 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 11:26:56 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:26:56 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 11:26:56 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:26:56 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 11:26:56 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 11:26:56 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 11:26:56 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 11:26:56 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 11:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:26:56 INFO - https://queue.taskcluster.net/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:26:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:26:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:26:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/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:26:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/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:26:57 INFO - Downloaded 17756646 bytes. 11:26:57 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:26:57 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:27:01 INFO - Return code: 0 11:27:01 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:27:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:01 INFO - https://queue.taskcluster.net/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 11:27:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:27:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 11:27:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/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:27:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/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:27:02 INFO - Downloaded 17756646 bytes. 11:27:02 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:27:02 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:27:06 INFO - Return code: 0 11:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:06 INFO - https://queue.taskcluster.net/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 11:27:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 11:27:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 11:27:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/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:27:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/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:27:07 INFO - Downloaded 10707070 bytes. 11:27:07 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:27:07 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:27:07 INFO - Return code: 0 11:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:07 INFO - https://queue.taskcluster.net/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 11:27:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:27:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:27:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 11:27:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fxQvWAU_TOGzHwnrxTfMmg/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:27:10 INFO - Downloaded 111080777 bytes. 11:27:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:27:10 INFO - mkdir: /builds/slave/test/properties 11:27:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:27:10 INFO - Writing to file /builds/slave/test/properties/build_url 11:27:10 INFO - Contents: 11:27:10 INFO - build_url:https://queue.taskcluster.net/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 11:27:11 INFO - Running post-action listener: _resource_record_post_action 11:27:11 INFO - Running post-action listener: set_extra_try_arguments 11:27:11 INFO - ##### 11:27:11 INFO - ##### Running populate-webroot step. 11:27:11 INFO - ##### 11:27:11 INFO - Running pre-action listener: _resource_record_pre_action 11:27:11 INFO - Running main action method: populate_webroot 11:27:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:27:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:27:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:27:11 INFO - '--tppagecycles', 11:27:11 INFO - '7'], 11:27:11 INFO - 'tests': ['tsvgm']}}, 11:27:11 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:27:11 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:27:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:27:11 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 11:27:11 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:27:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:27:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:27:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:11 INFO - 'talos_options': ['--e10s'], 11:27:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:27:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:11 INFO - 'tests': ['damp', 'tps']}, 11:27:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:11 INFO - 'talos_options': ['--e10s'], 11:27:11 INFO - 'tests': ['damp', 'tps']}, 11:27:11 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:27:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:27:11 INFO - 'other': {'tests': ['a11yr', 11:27:11 INFO - 'ts_paint', 11:27:11 INFO - 'tpaint', 11:27:11 INFO - 'sessionrestore', 11:27:11 INFO - 'sessionrestore_no_auto_restore']}, 11:27:11 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:27:11 INFO - 'tests': ['a11yr', 11:27:11 INFO - 'ts_paint', 11:27:11 INFO - 'tpaint', 11:27:11 INFO - 'sessionrestore', 11:27:11 INFO - 'sessionrestore_no_auto_restore']}, 11:27:11 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:27:11 INFO - 'tests': ['a11yr', 11:27:11 INFO - 'ts_paint', 11:27:11 INFO - 'tpaint', 11:27:11 INFO - 'sessionrestore', 11:27:11 INFO - 'sessionrestore_no_auto_restore']}, 11:27:11 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:27:11 INFO - 'tests': ['a11yr', 11:27:11 INFO - 'ts_paint', 11:27:11 INFO - 'tpaint', 11:27:11 INFO - 'sessionrestore', 11:27:11 INFO - 'sessionrestore_no_auto_restore']}, 11:27:11 INFO - 'other_l64': {'tests': ['a11yr', 11:27:11 INFO - 'ts_paint', 11:27:11 INFO - 'tpaint', 11:27:11 INFO - 'sessionrestore', 11:27:11 INFO - 'sessionrestore_no_auto_restore']}, 11:27:11 INFO - 'other_nol64': {'tests': ['a11yr', 11:27:11 INFO - 'ts_paint', 11:27:11 INFO - 'tpaint', 11:27:11 INFO - 'sessionrestore', 11:27:11 INFO - 'sessionrestore_no_auto_restore']}, 11:27:11 INFO - 'svgr': {'tests': ['tsvgx', 11:27:11 INFO - 'tsvgr_opacity', 11:27:11 INFO - 'tart', 11:27:11 INFO - 'tscrollx', 11:27:11 INFO - 'cart']}, 11:27:11 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:27:11 INFO - 'tests': ['tsvgx', 11:27:11 INFO - 'tsvgr_opacity', 11:27:11 INFO - 'tart', 11:27:11 INFO - 'tscrollx', 11:27:11 INFO - 'cart']}, 11:27:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:11 INFO - 'tests': ['tp5o']}, 11:27:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:11 INFO - 'talos_options': ['--e10s'], 11:27:11 INFO - 'tests': ['tp5o']}, 11:27:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:11 INFO - 'talos_options': ['--xperf_path', 11:27:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:27:11 INFO - 'tests': ['tp5n']}, 11:27:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:27:11 INFO - 'talos_options': ['--e10s', 11:27:11 INFO - '--xperf_path', 11:27:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:27:11 INFO - 'tests': ['tp5n']}}, 11:27:11 INFO - 'talos.zip': {'path': '', 11:27:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:27:11 INFO - Running post-action listener: _resource_record_post_action 11:27:11 INFO - ##### 11:27:11 INFO - ##### Running create-virtualenv step. 11:27:11 INFO - ##### 11:27:11 INFO - Running pre-action listener: _resource_record_pre_action 11:27:11 INFO - Running main action method: create_virtualenv 11:27:11 INFO - Creating virtualenv /builds/slave/test/build/venv 11:27:11 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:27:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:27:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:27:12 INFO - Using real prefix '/tools/python27' 11:27:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:27:12 INFO - Installing distribute.............................................................................................................................................................................................done. 11:27:15 INFO - Installing pip.................done. 11:27:15 INFO - Return code: 0 11:27:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:15 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 0x109545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feed946c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093e9d30>, '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 0x10920ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093e0b20>, '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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:27:15 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:27:15 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:27:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXNAZ8Q3m7/Render', 11:27:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:15 INFO - 'HOME': '/Users/cltbld', 11:27:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:15 INFO - 'LOGNAME': 'cltbld', 11:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:15 INFO - 'MOZ_NO_REMOTE': '1', 11:27:15 INFO - 'NO_EM_RESTART': '1', 11:27:15 INFO - 'PAGER': '/bin/cat', 11:27:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:15 INFO - 'PWD': '/builds/slave/test', 11:27:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:15 INFO - 'SHELL': '/bin/bash', 11:27:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWR7nC0sQG/Listeners', 11:27:15 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:27:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:15 INFO - 'USER': 'cltbld', 11:27:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:15 INFO - 'XPC_FLAGS': '0x0', 11:27:15 INFO - 'XPC_SERVICE_NAME': '0', 11:27:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:15 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:27:15 INFO - Cleaning up... 11:27:15 INFO - Return code: 0 11:27:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:15 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 0x109545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feed946c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093e9d30>, '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 0x10920ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093e0b20>, '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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:27:15 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:27:15 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:27:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXNAZ8Q3m7/Render', 11:27:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:15 INFO - 'HOME': '/Users/cltbld', 11:27:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:15 INFO - 'LOGNAME': 'cltbld', 11:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:15 INFO - 'MOZ_NO_REMOTE': '1', 11:27:15 INFO - 'NO_EM_RESTART': '1', 11:27:15 INFO - 'PAGER': '/bin/cat', 11:27:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:15 INFO - 'PWD': '/builds/slave/test', 11:27:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:15 INFO - 'SHELL': '/bin/bash', 11:27:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWR7nC0sQG/Listeners', 11:27:15 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:27:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:15 INFO - 'USER': 'cltbld', 11:27:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:15 INFO - 'XPC_FLAGS': '0x0', 11:27:15 INFO - 'XPC_SERVICE_NAME': '0', 11:27:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:16 INFO - Downloading/unpacking psutil>=0.7.1 11:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:27:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:27:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:27:19 INFO - Installing collected packages: psutil 11:27:19 INFO - Running setup.py install for psutil 11:27:19 INFO - building 'psutil._psutil_osx' extension 11:27:19 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:27:20 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:27:20 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:27:20 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:27:20 INFO - building 'psutil._psutil_posix' extension 11:27:20 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:27:20 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 11:27:20 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 11:27:20 INFO - ^ 11:27:20 INFO - 1 warning generated. 11:27:20 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:27:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:27:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:27:20 INFO - Successfully installed psutil 11:27:20 INFO - Cleaning up... 11:27:20 INFO - Return code: 0 11:27:20 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:20 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 0x109545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feed946c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093e9d30>, '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 0x10920ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093e0b20>, '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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:27:20 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:27:20 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:27:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXNAZ8Q3m7/Render', 11:27:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:20 INFO - 'HOME': '/Users/cltbld', 11:27:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:20 INFO - 'LOGNAME': 'cltbld', 11:27:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:20 INFO - 'MOZ_NO_REMOTE': '1', 11:27:20 INFO - 'NO_EM_RESTART': '1', 11:27:20 INFO - 'PAGER': '/bin/cat', 11:27:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:20 INFO - 'PWD': '/builds/slave/test', 11:27:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:20 INFO - 'SHELL': '/bin/bash', 11:27:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWR7nC0sQG/Listeners', 11:27:20 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:27:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:20 INFO - 'USER': 'cltbld', 11:27:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:20 INFO - 'XPC_FLAGS': '0x0', 11:27:20 INFO - 'XPC_SERVICE_NAME': '0', 11:27:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:20 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:27:23 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:27:23 INFO - Installing collected packages: mozsystemmonitor 11:27:23 INFO - Running setup.py install for mozsystemmonitor 11:27:23 INFO - Successfully installed mozsystemmonitor 11:27:23 INFO - Cleaning up... 11:27:23 INFO - Return code: 0 11:27:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:23 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 0x109545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feed946c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093e9d30>, '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 0x10920ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093e0b20>, '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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:27:23 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:27:23 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:27:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXNAZ8Q3m7/Render', 11:27:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:23 INFO - 'HOME': '/Users/cltbld', 11:27:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:23 INFO - 'LOGNAME': 'cltbld', 11:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:23 INFO - 'MOZ_NO_REMOTE': '1', 11:27:23 INFO - 'NO_EM_RESTART': '1', 11:27:23 INFO - 'PAGER': '/bin/cat', 11:27:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:23 INFO - 'PWD': '/builds/slave/test', 11:27:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:23 INFO - 'SHELL': '/bin/bash', 11:27:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWR7nC0sQG/Listeners', 11:27:23 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:27:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:23 INFO - 'USER': 'cltbld', 11:27:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:23 INFO - 'XPC_FLAGS': '0x0', 11:27:23 INFO - 'XPC_SERVICE_NAME': '0', 11:27:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:23 INFO - Downloading/unpacking blobuploader==1.2.4 11:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:26 INFO - Downloading blobuploader-1.2.4.tar.gz 11:27:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:27:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:27:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:27 INFO - Downloading docopt-0.6.1.tar.gz 11:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:27:27 INFO - Installing collected packages: blobuploader, requests, docopt 11:27:27 INFO - Running setup.py install for blobuploader 11:27:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:27:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:27:27 INFO - Running setup.py install for requests 11:27:27 INFO - Running setup.py install for docopt 11:27:28 INFO - Successfully installed blobuploader requests docopt 11:27:28 INFO - Cleaning up... 11:27:28 INFO - Return code: 0 11:27:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:28 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 0x109545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feed946c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093e9d30>, '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 0x10920ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093e0b20>, '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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:27:28 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:27:28 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:27:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXNAZ8Q3m7/Render', 11:27:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:28 INFO - 'HOME': '/Users/cltbld', 11:27:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:28 INFO - 'LOGNAME': 'cltbld', 11:27:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:28 INFO - 'MOZ_NO_REMOTE': '1', 11:27:28 INFO - 'NO_EM_RESTART': '1', 11:27:28 INFO - 'PAGER': '/bin/cat', 11:27:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:28 INFO - 'PWD': '/builds/slave/test', 11:27:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:28 INFO - 'SHELL': '/bin/bash', 11:27:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWR7nC0sQG/Listeners', 11:27:28 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:27:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:28 INFO - 'USER': 'cltbld', 11:27:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:28 INFO - 'XPC_FLAGS': '0x0', 11:27:28 INFO - 'XPC_SERVICE_NAME': '0', 11:27:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:27:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-ZZGggy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:27:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Y5D4Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:27:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-46D7e3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:27:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-L3Sl4w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:27:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-pRgylA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:27:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:27:28 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-RtW1tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:27:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-G1BbWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:27:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-at0X3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:27:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-awHZH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:27:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-G1sIrP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:27:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-wxqyyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:27:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-NihMH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:27:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-slpwls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:27:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-q5ZLUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-r3_S2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:27:29 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-VlfHYD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:27:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:27:30 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-NvkZTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:27:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:27:30 INFO - Running setup.py install for manifestparser 11:27:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:27:30 INFO - Running setup.py install for mozcrash 11:27:30 INFO - Running setup.py install for mozdebug 11:27:30 INFO - Running setup.py install for mozdevice 11:27:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:27:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:27:30 INFO - Running setup.py install for mozfile 11:27:30 INFO - Running setup.py install for mozhttpd 11:27:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:27:31 INFO - Running setup.py install for mozinfo 11:27:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:27:31 INFO - Running setup.py install for mozInstall 11:27:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:27:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:27:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:27:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:27:31 INFO - Running setup.py install for mozleak 11:27:31 INFO - Running setup.py install for mozlog 11:27:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:27:31 INFO - Running setup.py install for moznetwork 11:27:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:27:31 INFO - Running setup.py install for mozprocess 11:27:31 INFO - Running setup.py install for mozprofile 11:27:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:27:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:27:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:27:32 INFO - Running setup.py install for mozrunner 11:27:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:27:32 INFO - Running setup.py install for mozscreenshot 11:27:32 INFO - Running setup.py install for moztest 11:27:32 INFO - Running setup.py install for mozversion 11:27:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:27:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:27:32 INFO - Cleaning up... 11:27:32 INFO - Return code: 0 11:27:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:32 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:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:32 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:27:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:32 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 0x109545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feed946c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093e9d30>, '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 0x10920ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093e0b20>, '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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:27:32 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:27:32 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:27:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXNAZ8Q3m7/Render', 11:27:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:32 INFO - 'HOME': '/Users/cltbld', 11:27:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:32 INFO - 'LOGNAME': 'cltbld', 11:27:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:32 INFO - 'MOZ_NO_REMOTE': '1', 11:27:32 INFO - 'NO_EM_RESTART': '1', 11:27:32 INFO - 'PAGER': '/bin/cat', 11:27:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:32 INFO - 'PWD': '/builds/slave/test', 11:27:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:32 INFO - 'SHELL': '/bin/bash', 11:27:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWR7nC0sQG/Listeners', 11:27:32 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:27:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:32 INFO - 'USER': 'cltbld', 11:27:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:32 INFO - 'XPC_FLAGS': '0x0', 11:27:32 INFO - 'XPC_SERVICE_NAME': '0', 11:27:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:27:33 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-FVO0BD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:27:33 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:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:27:33 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-2V8T5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:27:33 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:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:27:33 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-mO2dcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:27:33 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:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:27:33 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-9547GK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:27:33 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:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:27:33 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-F_QCtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:27:33 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:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:27:33 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-0EiZjX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:27:33 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:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:27:33 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-Hqa7nK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:27:33 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:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:27:33 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-4HQheT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:27:33 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:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:27:33 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-9IeXlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:27:33 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:27:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:27:33 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-fDi4X_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:27:34 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:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:27:34 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-spMedg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:27:34 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:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:27:34 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-1XGBU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:27:34 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:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:27:34 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-GaiB3r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:27:34 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:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:27:34 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-XlK1Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:27:34 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:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:34 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-S_M6W8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:27:34 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:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:27:34 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-zVydw2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:27:34 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:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:27:34 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-faJu5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:27:34 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:27:34 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:27:34 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:27:34 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:27:34 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:27:34 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:27:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:27: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:27: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:27: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:27: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:27: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:27: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:27:37 INFO - Downloading blessings-1.6.tar.gz 11:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:27:37 INFO - Installing collected packages: blessings 11:27:37 INFO - Running setup.py install for blessings 11:27:37 INFO - Successfully installed blessings 11:27:37 INFO - Cleaning up... 11:27:37 INFO - Return code: 0 11:27:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:27:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:37 INFO - Reading from file tmpfile_stdout 11:27:37 INFO - Current package versions: 11:27:37 INFO - blessings == 1.6 11:27:37 INFO - blobuploader == 1.2.4 11:27:37 INFO - docopt == 0.6.1 11:27:37 INFO - manifestparser == 1.1 11:27:37 INFO - mozInstall == 1.12 11:27:37 INFO - mozcrash == 0.16 11:27:37 INFO - mozdebug == 0.1 11:27:37 INFO - mozdevice == 0.48 11:27:37 INFO - mozfile == 1.2 11:27:37 INFO - mozhttpd == 0.7 11:27:37 INFO - mozinfo == 0.9 11:27:37 INFO - mozleak == 0.1 11:27:37 INFO - mozlog == 3.1 11:27:37 INFO - moznetwork == 0.27 11:27:37 INFO - mozprocess == 0.22 11:27:37 INFO - mozprofile == 0.28 11:27:37 INFO - mozrunner == 6.11 11:27:37 INFO - mozscreenshot == 0.1 11:27:37 INFO - mozsystemmonitor == 0.0 11:27:37 INFO - moztest == 0.7 11:27:37 INFO - mozversion == 1.4 11:27:37 INFO - psutil == 3.1.1 11:27:37 INFO - requests == 1.2.3 11:27:37 INFO - wsgiref == 0.1.2 11:27:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:37 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 0x109545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feed946c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093e9d30>, '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 0x10920ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093e0b20>, '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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:27:37 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:27:37 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:27:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXNAZ8Q3m7/Render', 11:27:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:37 INFO - 'HOME': '/Users/cltbld', 11:27:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:37 INFO - 'LOGNAME': 'cltbld', 11:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:37 INFO - 'MOZ_NO_REMOTE': '1', 11:27:37 INFO - 'NO_EM_RESTART': '1', 11:27:37 INFO - 'PAGER': '/bin/cat', 11:27:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:37 INFO - 'PWD': '/builds/slave/test', 11:27:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:37 INFO - 'SHELL': '/bin/bash', 11:27:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWR7nC0sQG/Listeners', 11:27:37 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:27:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:37 INFO - 'USER': 'cltbld', 11:27:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:37 INFO - 'XPC_FLAGS': '0x0', 11:27:37 INFO - 'XPC_SERVICE_NAME': '0', 11:27:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:37 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:27:37 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:27:37 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:27:37 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:27:37 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:27:37 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:27:37 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:27:37 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:27:37 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:27:37 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:27:37 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:27:37 INFO - Cleaning up... 11:27:37 INFO - Return code: 0 11:27:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feed946c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093e9d30>, '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 0x10920ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093e0b20>, '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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:27:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:27:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:27:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXNAZ8Q3m7/Render', 11:27:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:37 INFO - 'HOME': '/Users/cltbld', 11:27:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:37 INFO - 'LOGNAME': 'cltbld', 11:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:37 INFO - 'MOZ_NO_REMOTE': '1', 11:27:37 INFO - 'NO_EM_RESTART': '1', 11:27:37 INFO - 'PAGER': '/bin/cat', 11:27:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:37 INFO - 'PWD': '/builds/slave/test', 11:27:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:37 INFO - 'SHELL': '/bin/bash', 11:27:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWR7nC0sQG/Listeners', 11:27:37 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:27:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:37 INFO - 'USER': 'cltbld', 11:27:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:37 INFO - 'XPC_FLAGS': '0x0', 11:27:37 INFO - 'XPC_SERVICE_NAME': '0', 11:27:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:38 INFO - Downloading/unpacking jsonschema 11:27:38 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:27:38 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:27:38 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:27:38 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:27:38 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:27:38 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:27:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:27:40 INFO - Downloading/unpacking functools32 (from jsonschema) 11:27:40 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:27:40 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:27:40 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:27:40 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:27:40 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:27:40 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:27:40 INFO - Downloading functools32-3.2.3-2.tar.gz 11:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:27:40 INFO - warning: no files found matching '*.txt' 11:27:40 INFO - no previously-included directories found matching 'build' 11:27:40 INFO - no previously-included directories found matching 'dist' 11:27:40 INFO - no previously-included directories found matching '.git*' 11:27:40 INFO - Installing collected packages: jsonschema, functools32 11:27:41 INFO - Running setup.py install for functools32 11:27:41 INFO - warning: no files found matching '*.txt' 11:27:41 INFO - no previously-included directories found matching 'build' 11:27:41 INFO - no previously-included directories found matching 'dist' 11:27:41 INFO - no previously-included directories found matching '.git*' 11:27:41 INFO - Successfully installed jsonschema functools32 11:27:41 INFO - Cleaning up... 11:27:41 INFO - Return code: 0 11:27:41 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:27:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109545a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10954d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feed946c670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1093e9d30>, '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 0x10920ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093e0b20>, '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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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:27:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 11:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 11:27:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXNAZ8Q3m7/Render', 11:27:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:27:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:27:41 INFO - 'HOME': '/Users/cltbld', 11:27:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:27:41 INFO - 'LOGNAME': 'cltbld', 11:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:27:41 INFO - 'MOZ_NO_REMOTE': '1', 11:27:41 INFO - 'NO_EM_RESTART': '1', 11:27:41 INFO - 'PAGER': '/bin/cat', 11:27:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:27:41 INFO - 'PWD': '/builds/slave/test', 11:27:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:27:41 INFO - 'SHELL': '/bin/bash', 11:27:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWR7nC0sQG/Listeners', 11:27:41 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:27:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:27:41 INFO - 'USER': 'cltbld', 11:27:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:27:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:27:41 INFO - 'XPC_FLAGS': '0x0', 11:27:41 INFO - 'XPC_SERVICE_NAME': '0', 11:27:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:27:41 INFO - Downloading/unpacking flake8 11:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:27:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:27:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:27:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:27:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:27:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:27:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:27:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:27:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:27:44 INFO - no previously-included directories found matching 'docs/_build' 11:27:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:27:45 INFO - Running setup.py install for pep8 11:27:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:27:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:27:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:27:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:27:45 INFO - no previously-included directories found matching 'docs/_build' 11:27:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:27:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:27:45 INFO - Cleaning up... 11:27:45 INFO - Return code: 0 11:27:45 INFO - Running post-action listener: _resource_record_post_action 11:27:45 INFO - Running post-action listener: _start_resource_monitoring 11:27:45 INFO - Starting resource monitoring. 11:27:45 INFO - ##### 11:27:45 INFO - ##### Running install step. 11:27:45 INFO - ##### 11:27:45 INFO - Running pre-action listener: _resource_record_pre_action 11:27:45 INFO - Running main action method: install 11:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:27:45 INFO - Reading from file tmpfile_stdout 11:27:45 INFO - Detecting whether we're running mozinstall >=1.0... 11:27:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:27:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:27:45 INFO - Reading from file tmpfile_stdout 11:27:45 INFO - Output received: 11:27:45 INFO - Usage: mozinstall [options] installer 11:27:45 INFO - Options: 11:27:45 INFO - -h, --help show this help message and exit 11:27:45 INFO - -d DEST, --destination=DEST 11:27:45 INFO - Directory to install application into. [default: 11:27:45 INFO - "/builds/slave/test"] 11:27:45 INFO - --app=APP Application being installed. [default: firefox] 11:27:45 INFO - mkdir: /builds/slave/test/build/application 11:27:45 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:27:45 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:28:19 INFO - Reading from file tmpfile_stdout 11:28:19 INFO - Output received: 11:28:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 11:28:19 INFO - Running post-action listener: _resource_record_post_action 11:28:19 INFO - ##### 11:28:19 INFO - ##### Running run-tests step. 11:28:19 INFO - ##### 11:28:19 INFO - Running pre-action listener: _resource_record_pre_action 11:28:19 INFO - Running main action method: run_tests 11:28:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:28:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:28:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:28:19 INFO - 2016-02-12 11:28:19.899 screenresolution[1653:7929] starting screenresolution argv=screenresolution get 11:28:19 INFO - 2016-02-12 11:28:19.901 screenresolution[1653:7929] Display 0: 1600x1200x32@60 11:28:19 INFO - 2016-02-12 11:28:19.907 screenresolution[1654:7931] starting screenresolution argv=screenresolution list 11:28:19 INFO - Available Modes on Display 0 11:28:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:28:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:28:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:28:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:28:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:28:20 INFO - Intel Iris: 11:28:20 INFO - Chipset Model: Intel Iris 11:28:20 INFO - Type: GPU 11:28:20 INFO - Bus: Built-In 11:28:20 INFO - VRAM (Dynamic, Max): 1536 MB 11:28:20 INFO - Vendor: Intel (0x8086) 11:28:20 INFO - Device ID: 0x0a2e 11:28:20 INFO - Revision ID: 0x0009 11:28:20 INFO - Displays: 11:28:20 INFO - Display: 11:28:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:28:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:28:20 INFO - Display Serial Number: 1600x1200 60 11:28:20 INFO - Main Display: Yes 11:28:20 INFO - Mirror: Off 11:28:20 INFO - Online: Yes 11:28:20 INFO - Rotation: Supported 11:28:20 INFO - Return code: 0 11:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:28:20 INFO - Python 2.7.3 11:28:20 INFO - Return code: 0 11:28:20 INFO - grabbing minidump binary from tooltool 11:28:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:28:20 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 0x1093e9d30>, '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 0x10920ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1093e0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:28:20 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:28:20 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:28:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:28:20 INFO - Return code: 0 11:28:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 11:28:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:28:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:28:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 11:28:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:28:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:28:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:28:21 INFO - Return code: 0 11:28:21 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', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 11:28:21 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 --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0094 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 11:28:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fXNAZ8Q3m7/Render', 11:28:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 11:28:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 11:28:21 INFO - 'HOME': '/Users/cltbld', 11:28:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 11:28:21 INFO - 'LOGNAME': 'cltbld', 11:28:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:28:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 11:28:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:28:21 INFO - 'MOZ_NO_REMOTE': '1', 11:28:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:28:21 INFO - 'NO_EM_RESTART': '1', 11:28:21 INFO - 'PAGER': '/bin/cat', 11:28:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 11:28:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:28:21 INFO - 'PWD': '/builds/slave/test', 11:28:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:28:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 11:28:21 INFO - 'SHELL': '/bin/bash', 11:28:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.pWR7nC0sQG/Listeners', 11:28:21 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 11:28:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 11:28:21 INFO - 'USER': 'cltbld', 11:28:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 11:28:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 11:28:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:28:21 INFO - 'XPC_FLAGS': '0x0', 11:28:21 INFO - 'XPC_SERVICE_NAME': '0', 11:28:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 11:28:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 11:28:21 INFO - mozversion application_buildid: 20160212092224 11:28:21 INFO - mozversion application_changeset: 20c7c84490ed0e3b4d0826b4e0a06d9ca5d53824 11:28:21 INFO - mozversion application_display_name: Nightly 11:28:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:28:21 INFO - mozversion application_name: Firefox 11:28:21 INFO - mozversion application_remotingname: firefox 11:28:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:28:21 INFO - mozversion application_vendor: Mozilla 11:28:21 INFO - mozversion application_version: 47.0a1 11:28:21 INFO - mozversion platform_buildid: 20160212092224 11:28:21 INFO - mozversion platform_changeset: 20c7c84490ed0e3b4d0826b4e0a06d9ca5d53824 11:28:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:28:21 INFO - mozversion platform_version: 47.0a1 11:28:21 INFO - using testdate: 1455305301 11:28:21 INFO - actual date: 1455305301 11:28:21 INFO - starting webserver on 'localhost:49274' 11:28:21 INFO - SUITE-START | Running 2 tests 11:28:21 INFO - TEST-START | dromaeo_css 11:28:21 INFO - operating with platform_type : mac_ 11:28:21 INFO - Initialising browser for dromaeo_css test... 11:28:21 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpedHvs6/profile http://localhost:49274/getInfo.html) 11:28:24 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 11:28:24 INFO - PROCESS | 1672 | colorDepth:24 11:28:24 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 11:28:24 INFO - PROCESS | 1672 | __metrics 11:28:24 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:28:24 INFO - PROCESS | 1672 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:28:24 INFO - TEST-INFO | 1672: exit 0 11:28:24 INFO - Browser initialized. 11:28:24 INFO - Running cycle 1/1 for dromaeo_css test... 11:28:24 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpedHvs6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:28:36 INFO - PROCESS | 1676 | RSS: Main: 247222272 11:28:36 INFO - PROCESS | 1676 | 11:29:27 INFO - PROCESS | 1676 | 1455305367936 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:31:38 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 11:31:39 INFO - PROCESS | 1676 | RSS: Main: 376958976 11:31:39 INFO - PROCESS | 1676 | 11:34:42 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 11:34:43 INFO - PROCESS | 1676 | RSS: Main: 387280896 11:34:43 INFO - PROCESS | 1676 | 11:37:45 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 11:37:46 INFO - PROCESS | 1676 | RSS: Main: 387842048 11:37:46 INFO - PROCESS | 1676 | 11:40:48 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 11:40:48 INFO - PROCESS | 1676 | RSS: Main: 346333184 11:40:48 INFO - PROCESS | 1676 | 11:43:51 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 11:43:52 INFO - PROCESS | 1676 | RSS: Main: 348631040 11:43:52 INFO - PROCESS | 1676 | 11:46:55 INFO - PROCESS | 1676 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 11:46:55 INFO - PROCESS | 1676 | RSS: Main: 383852544 11:46:55 INFO - PROCESS | 1676 | 11:46:55 INFO - PROCESS | 1676 | __start_tp_report 11:46:55 INFO - PROCESS | 1676 | _x_x_mozilla_page_load 11:46:55 INFO - PROCESS | 1676 | _x_x_mozilla_page_load_details 11:46:55 INFO - PROCESS | 1676 | |i|pagename|runs| 11:46:55 INFO - PROCESS | 1676 | |0;dojo.html;3449.034270404287;3483.8258087095655;3510.087377281909;3535.6464353564647;3576.4992900993866;5578.693171875545;5596.580256480765;5603.943960560393;5646.181303710964;5662.546996240301;5651.434856514346;5659.462351076651;5668.461496157869;5771.711414429283;5779.913301300473;5056.519630635102;5087.694738315713;5106.9489305106845;5107.923381149286;5225.712585807779;5191.117510023286;5191.247269145972;5210.192420174879;5248.921266180992;5272.894542109156;5066.316047333618;5069.974650126763;5144.948550514484;5177.197534382177;5182.119039763212;5150.922736158961;5157.432682404932;5171.456997015334;5195.454477279869;5201.7919283229;5095.286659867622;5140.537351638371;5142.280080788692;5161.045206636784;5167.147420675584;5479.205515200274;5544.0575102232315;5596.356419011784;5600.747966341524;5653;6183.505319574423;6197.752089916398;6205.81382558524;6221.004639257742;6229.6573688447115;6105.633661980295;6198.2252218472695;6246.3753624637175;6277.309495955441;6297.149884765589;5697.145428185805;5709.885802283972;5741.511971482387;5762.2509073820975;5820.592558520905;6350.936490635127;6366.745330186741;6367.713452894631;6374.681265936684;6393.680315984182;5878.735456904449;6066.45401913821;6097.237845269341;6098.939010609926;6100.267967843798;6152.3540028297275;6216.378362163748;6254.15568898202;6259.843503912348;6272.717727702265;6151.384861513813;6159.568830181934;6175.84560385985;6188.783392581238;6189.164462797555;5993.190919225936;6099.695015249308;6099.908501372394;6180.598261113013;6191.318954914956;4765.571098601143;4811.615070794328;4814.15752243356;4818.445878723922;4826.686265392738;4335.458067741532;4374.803133858984;4418.094290670405;4421.911561768747;4433.334999749999;5589.776408943597;5654.46282603152;5657.632253903483;5659.462351076641;5684.573656975661;6055.303640081359;6238.1266622672865;6244.094606282155;6262.812115636538;6276.968615156895;5572;5659.660420374791;5667.036603777367;5669;5669.262995810518;5347.759350829222;5373.785048598091;5378.2470454136455;5380.031594312983;5384.515393614515;6257.937420625826;6310.116583678288;6332.271788744261;6353.36466353361;6357.809265722036;6196.721147548461;6253.593516421418;6255.218097737783;6263.74945002213;6280.497560195265;6328.6519241442165;6328.683565821782;6328.810135695937;6334.113224148531;6343.651099189589;6009.54928380382;6070.696465176812;6114.021756518936;6137.96931015342;6140.508759299156;6162.722677479434;6168.414000669929;6172.321044684992;6189.876202475835;6190.845228869134;5970.31341395745;5970.4765417086755;5977.521798256216;5989.910151347821;6030.974734295092;5920.674362910081;5983.700814959322;5993.790217342372;6005.6396616203165;6092.847678808065;4744.952550474451;5804.448577385142;5835.56233282514;5837.0368889132815;5858.94141058584;6019.247594050744;6019.307779605401;6027.21646185993;6040.305364883095;6078.57449978515;5763.077907534775;5842.795502157404;5855.882882342244;5875.618084824473;5943.405659434195 11:46:55 INFO - PROCESS | 1676 | |1;ext.html;446.9843555475559;461.2067244339734;509.5439581574491;519.7037688517545;539.895912858205;29854;30433.087007389786;30461;30463.543046854316;30508.54237186444;31356.529652055182;31775;39747.807565773;40702.59297407025;40826.79586602063;9584.233261339075;9775.169110625606;9776;9786.951065244664;9812.558434870412;9695.90304096957;9850.310478266525;9862.013798620152;9869.01309869011;9874.210063194927;9779.511024448784;9861.21110311177;9861.408315501058;9862.654807081753;9894.950525247365;9911;9982.301238913278;10004.849927251096;10010.64962726301;10019.949900250525;9715.659951901649;9835.557399917021;9860.556274967643;9899.950500247525;9914.25643076765;40399.7980010098;40764.592354076376;40806.38790418146;40892;41009.179816403805;3137.952930706041;3360.4455264881267;3435.793852368866;3437.74216933731;3655.3603119454256;24831.379215519577;28936.855315723285;29340.413191736046;29522.852385738148;30807;2261.4911644879935;2713.1724823928694;2729.044834307996;2792.5897421802065;2827.519321715293;419352;422696.9999999969;422853;422988;423302;56783;58147.4185258142;63688;64112.717745644826;64258;68792.65603671949;69336;70218;70263;70467.23831904243;16103.27535260916;16323.510294691177;16323.836761632469;16375.426860060079;16378.935369200964;10802.783944321227;10961.397123158144;12370.505179792888;12450.377481125908;12648;20337.389878303675;20793.06431210599;21198.894005529874;21217.363479095653;21293.574128517343;9020.097990200928;9290.205574322652;9304.767380815534;9341.532923353805;9393.624255029723;917.1149840403909;988.8022395520925;1043.7110168941351;1054.5570860238718;1086.4947799273375;29820.85089574538;30112.096637100924;30819;31494;31610.525842112387;1030.4229631406436;1032.9991375055477;1053.6628278950816;1140.6178930058522;1178.8467499225046;13896.791548126786;14256.144631322153;14375.921805864393;14452.277386130652;14645.780313295309;579001;665313.774898007;671622;672409;674212;57274.7136264316;57791.13313300304;57823.421765782645;57847;57884.42115578875;1441.8990670652954;1447.9638009049647;1465.369890946903;1468.3539242733164;1470.9632259193393;26136.215913522625;30839.537406939362;30905;30983.535246970863;31673.5248971261;52644;53329.733351332994;53331.46668533265;53460.73269633627;53485.19772203342;424657;429187;631134.6886531076;634791;635481;42465.5753442474;43288.35067474053;43292.35061474144;43980.56019439764;44135.77932110319;38544.03639908913;46009;46492.767536163454;46617.06765864731;47471.76264118657;35992.64007359893;37607.059823503536;38533;38765.83702488817;38798.4180237291;29058.779853978467;37299;38506.229875401776;38681.6131838678;40243;36546.08634784045;37262.6249114412;37361.81319093496;37695.49218031248;37902.8104859474;29364.85317573484;31426.685733142374;33370.66629333773;33431.665683343825;33658.49512257269;19014.14436350395;24293.75706242915;24977.625335619618;25029.374265643506;25506.489870202862 11:46:55 INFO - PROCESS | 1676 | |2;jquery.html;340.8909149072297;367.15554225281863;373.4659437005083;374.67029014467266;378.7405627145407;14988.10071395717;15504.302306396212;18600;18953.71569426458;19369.934653594064;11327.830082548768;11916.225445346046;11932.82100768487;12347.691307717312;19188.75273107247;4653.8603841884715;5388.622796404254;5402.297701298845;5406.324209473816;5414.83755487336;3852.9422058669143;4077.898052548695;5643.238162848004;5889.705514724268;5893.823185304448;5247.160454327309;5532.806351777688;5781.739821708013;5894.6168499047635;6005.459508644221;5885.205497257858;5943.465088142067;5951.553633477485;5954.047352423591;5956.404359564009;5514.531264842493;5677.630953987978;5691.573132015115;5701.945140149086;5702.344230413472;23401.648975265383;23767.692776897264;24624.015039398582;24676.876615616988;24685.382865428328;2067.0388269454625;2178.302943058222;2253.3803204119;2331.160782118436;2464.913728019511;9800.95099524505;10127.189824813997;11235.831462527987;12096.153269271155;13771.311434428238;1628.5684293662189;1709.837565431282;1758.2088060372882;1801.2164708351909;1815.0652414006797;90284.54857725734;96715.0328496713;97259;97925.51037244839;99066.5046674762;10540.631077912236;10901.127909767358;10927.907209279008;11011.394373309546;11041.503132359063;13135.605931822061;13149;13269.203847768971;13282.800757988638;13291.933540332237;8211.507309561446;8219.260266575917;8230.42387032902;8298.294644955246;8378.329733621296;6766.458683305324;8303.501789892625;8315.875261871077;8368.832623347498;8376.288015518627;4063.918721625551;4218.683598730107;4305.160493703697;4394.934075988863;4442.48911375196;1753.8070812210647;1768.5578605348662;1819.6889555538003;1828.5816338173597;1831.2161242405166;919.3610440743619;922.5377776224625;927.8144371125802;938.1697197979837;994.4083270454068;20127;20760;20826.37520874346;20981.370558883256;21016.89491552563;871.7646235516502;915.5513798238948;935.5976929920064;969.7575606098476;1013.3767732844248;10562.337501547605;10976.957189067025;10996.319912916186;11006.449677516252;11008.889911100947;732884;734182;737545;751890;752017;114630.82953363711;123060.38469807773;125707;126015;126888;1114.331401159298;1130.1410927694847;1145.53605789657;1149.2759561476216;1150.0626989003936;18594.349197778014;18704.251829926652;18710.97089660082;18753.437396878115;18829.90585047066;33126.33747325088;50278.49721502738;53198;54180;54601;78751;79185;79215.415691687;79875;79904.60047699956;7482.551046937201;7748.263914928073;7777.766666999999;7790.454668173174;7808.921910781047;7514.8413121240355;9336.53317334117;9612.327137100336;11875.940620296844;12113.546374435124;9699.806003880023;10171.28800983924;10545;10557.73605659834;10579.576816927236;9972.800543988935;10296.382217067;10348.913364096963;10496;10507;10453.68638940833;10612.261194178667;10827.729306767395;10834.404107774148;10911.236213464981;7729.995100637107;7828.45200835936;7838.216178382117;7840.764777056697;7860.528368297921;6218.755150250089;9784.364016338915;10648.467576621293;10728.73178170552;10892.509837057192 11:46:55 INFO - PROCESS | 1676 | |3;mootools.html;1413.7172565486906;1524.4588171199223;1556.1518972160172;1794.147779804593;1951.0829909942322;7832.686692532299;8479.91520084799;8611.009733880606;8626.008009078958;8650.610722517486;8472.449290796108;8729;8746.037935827055;8748.475091494514;8750.737477875675;1996.7903370146144;2107.915683372671;2163.2212403534713;2226.64373700208;2469.2468797016904;2501.837380570257;2507.6238564215423;2509.874506274688;2510.949781004379;2512.296556964053;2087;2410.9758902411013;2488.5147396257735;2491.725910149882;2492.0405643827075;2446.143849652616;2476.2571228631427;2489.5892177790643;2498.375406148463;2500.587403078508;2444.6577479152934;2483.788877945377;2491.2152671908293;2492.700875894886;2494.3514686181543;8709.172628600272;8779.253763430052;8781.517016564087;8792.692255771017;8798.604062817189;5018.824341148079;5482.150266708666;5490.011797876381;5493.505584497414;5553.055980483327;3107.7203051725455;3580.5703315602036;3617.0595645132194;3679.0802299425145;3685.3182161300247;975.4391225045628;994.6419289055934;1000.5097502223858;1010.4695035106554;1058.9523471443804;11881.940590296994;11938.403079846059;11968.461419236155;12125.211861228992;12130.393480326036;4878.707277563358;4884.755762211875;4946.5053494650965;4968.378952630921;4973.8010479581135;10217.080462758388;10255.538500767483;10257.94871025655;10278.434686092336;10293.691189264335;5490.835274941758;5501.889962200734;5515.172724091419;5516.972415137979;5519.365272993577;4926.211806111005;5001.824936127218;5003.2995380646735;5006.924896126561;5014.874628134253;3943.38877473992;3974.105826189142;3987.92024159521;4000.0599859033105;4027.778472184058;1296.5332480307081;1302.1145620977636;1302.3097758188176;1308.7971364438527;1317.4861803896488;963.8409662405764;1143.2911594811271;1217.1662411248324;1376.3393571085935;1381.254122773711;8044.074931382849;8174;8189.50862948225;8191.508509489449;8217.506949583045;433.41705406228573;497.9925301120486;506.3695698854949;515.3712470785636;519.4727351737989;5211.5049070338255;6261.436470717566;6287.717052732638;6289.433950944345;6294.118823364733;10054.849177262347;10332.535035923402;10336;10495.632652857113;10521.631742888962;9915.603375865028;10191;10336.17310615149;10345.431001295;10368;7986.640601172961;8227.712030079038;8229.629666665014;8239.340852731768;8240.464369815943;7750.651220695195;7973.883656288008;8018.639161237642;8077.151899050515;8114.675412983651;9292.057498476564;9359.15767580921;9376.859347109663;9527.38072025316;9528.094830991045;9466.905330946878;9642;9820.705378838646;9915.405075695482;9920.553575088994;6255.530835187288;6338.492920566436;7149.85700285981;7362.852742945004;7383;8035.758927232192;8046.316063134699;8065.637046332812;8069.636866340911;8113.3509319253135;6415.711292991733;7348.485606007528;7579.924200758142;7599.620018998918;7684.731034413992;7362.153352364332;7442.1441534222095;7443.81390465221;7585.393168546393;7594.31651151399;7598.164201937672;7628.122765881994;7639.236076392316;7664.233576642291;7691.308042185414;6957.304269573002;6960.79117626472;7019.4735394844565;7035.155781306072;7039.331263529956;7034.2965703429245;7054.25930277334;7054.329838665319;7078.646067696697;7084.36240738336 11:46:55 INFO - PROCESS | 1676 | |4;prototype.html;318.62084119897327;325.52148341937345;330.3393213572854;330.8957678331325;334.8526648274759;6449.90325145122;6499.512536559765;6530.575512591684;6580.532300387355;6621.966890165542;6396.648184349859;6565.27781943987;6579.440747536453;6585.407313341799;6619.536632435731;4938.629602779797;4943.480934501879;4944.579710724593;4965.230389289666;4974.577160941324;4699.459562150362;4810.591099756525;4827.324174615556;4911.263310503417;4924.28597853311;4830.178869592178;4834.685745426554;4926.2364333528185;4961.156603377434;4981.750912454381;4907.631927605408;4924.285978533093;4924.433690125646;4924.4583095859425;4926.5566099051075;4202;4209.789510524462;4210.663146948237;4216.831326746927;4218.535961044283;5480.588955828329;6091.786787462462;6208.72060757267;6329.525285603552;6451.096846441502;5736.053551164053;5736.7992120276;5737.856553586152;5742.942570574282;5748.8850222995725;6676;6821.761238356634;7021.052157958661;7026.227115017344;7042.225355210922;3858.903527411809;4582.404287442611;4666.556677115703;4667.206574882278;4670;7285.635718214121;7357.632118394113;7422.406207503387;7447.962760186273;7460.0301960744755;4601.234623171349;4786.928196077061;4791.425028996473;4797.40032495938;4798.664093513421;4895.045466134141;4907.607391408679;4909.140900342426;4919;4920.950790492121;5706.629069110494;5731.828045158652;5736.713164341766;5737.799177028784;5747.6838773867;7014.088168538057;7017.964910175417;7020.543664661781;7026.789196324118;7041.725597597142;1660.968732063964;1687.3166367621134;1691.577105723569;1702.5998890260778;1706.8634509239232;1100.4937728644752;1110.5335758981248;1111.4387234446715;1116.7598966222301;1125.9211855170224;6686.531942764057;6694.129763130762;6696.531242812956;6702.798916032527;6718.798436046829;7321.487495875344;7325.926740732631;7328.560286382834;7349.669264883093;7356.043714317211;6430.967845160838;6652;6660.933390666129;6670.39966403026;6694.364035416627;3859.1895701902354;3861.2663593917628;3869.3228684980018;3889.2999260132883;3896.7661940283674;7636.50362726421;7653.808654783564;7659.731909383145;7667.1949445308555;7669.5398276103615;6335.461485773669;6710.027046078291;7519.924800752032;7525.795872660348;7532.945387645734;6167.568270221221;6197.225346831646;7647.426443016796;7649.885251721229;7651.120121186135;6105.9694701526205;7041.190263119602;7190.81351576984;7200.71197152108;7588.886166707393;7210.96394518024;7263.673134709056;7294.635268236673;7301;7305.379042781211;7517.210692877169;7775.300222979959;7778.105517865291;7784.338331241908;7789.493682910593;4804.639652026042;4813;4818.180909245367;4820.807167713252;4822.469528351949;7338.633068346669;7362.300581444754;7369.889451658122;7375.704971801282;7380.114386273682;5741.655500669973;6337.683115844097;6942.826429339307;7092.468064895051;7136.000959865727;7082;7124.643767811693;7132.251113632994;7133.536320139175;7142.178649455379;6567.704453299709;6951.930480695129;6964.373206411447;6965.47758918073;6974;6875.931240687729;7118.074650295428;7119.572825630479;7122.109736282965;7141.642917853983;6962.268961758942;6963.338482844122;6966.268541803241;6966.5471744336455;6968.23349431552 11:46:55 INFO - PROCESS | 1676 | |5;yui.html;742.220668298287;748.6930358552993;751.0836779129463;760.5132715062359;760.7831767946136;14954.252287385629;15083.472078477256;15199.696006079872;15200.619984500394;15227.92386038071;13519.594412167651;13595.980301477379;13613.795793063113;13635.386407611657;13637.863621363807;690.2028157478121;700.9509334346598;701.03607539633;844.7803571071535;865.6667183134475;840.7898025493627;861.4615865084322;872.9694460693877;874.9868751968726;876.0801158783283;916.8578870275085;917.7246825952187;918.545320066568;919.3977944446365;922.3958307308724;725.6154238253707;738.9778306650809;889.2619126125301;913.2237598041645;914.2503147419119;674.2953613473932;674.5379415100623;676.6921050921819;678.372505432473;678.6776281266408;13419.261940593264;13673.794893076612;14313.928430357886;14749.115053096848;14787.556373308818;12551.497940082385;12694.80957785634;12886.484540618365;12920.80906744389;12985.7069603269;9988.95005524975;10093.545790439448;10124.139448146916;10167.23745719074;10811.675649730521;3516.331896939573;3549.94675079874;3559.7330200235087;3566.641181201654;3572.8749493767855;78716.21283787204;78797.60601197014;78912.60543697244;78915.6054219731;79172.60413697895;8001.357515746171;9574.47340396285;9673.081057299545;9767.218622510181;9793.020697930293;20814.271500497714;21109.894450527958;21446;21522.56954860894;21530.677039844413;7613.467057306047;7735.381169506426;7809.726659566888;7888.605569721491;7912.683492660344;4094.9181016380103;4126.154138401621;4150.045489537423;4168.3955826405;4168.854090106832;3538.929221415557;3603.4594810778067;3604.9279014419567;3606.711463082947;3610.2959922815326;640.2828831708516;641.7689631732572;647.2556559955995;664.7374287156546;673.9082686048534;564.9887002259932;588.3586890289605;612.1674522649193;612.6905912514152;620.5035971223003;8480.194381533744;8587.871181932276;8761.474311541328;8863.911360886437;8957.910420895838;510.25502765962113;576.9538436925036;613.9907901381483;618.4113875047161;648.3451713769127;3396.6603339665835;3712.5730540987593;3883.514560679915;4035;4079;83667.16332836715;84077;85718.57140714256;85920;92320;73854.63072684602;73886;74923;75144.62427687936;75988.24011759812;67245;67892;68230;69004.89477973603;69045.65477172582;7864.4888082274465;9044.231240344645;9051.818963620559;9108.98806787517;9271.814563708824;47051.52948470471;47638.80902977453;48194.27708584444;48863;48906;63672.04491932717;65948.67025664842;66185.66907165434;67367.98948015882;68185.65907170433;10608.681739547827;10723.463826808473;10814.837777433188;11192.944035279772;11728.237664551776;11885.702857428634;12165.45255463524;12261.75476490483;12530.74938501243;12692.619221423003;11402.543898244308;11491.367974761468;11755.412229388667;11758.11814113962;11814.763704726029;11366;11463.598774042868;11759;11781.882181178422;12041;8109.59452027408;9555.522223888638;10536.367817930948;10702.892971070502;11560.826587601361;8636.983777647101;8857.689980850897;8896.2882969361;9212.078792120734;9577.616895324109;8448.788780280296;8732.646439801842;9918.702438926844;9963.153131983863;9994.450305233282 11:46:55 INFO - PROCESS | 1676 | __end_tp_report 11:46:55 INFO - PROCESS | 1676 | __start_cc_report 11:46:55 INFO - PROCESS | 1676 | _x_x_mozilla_cycle_collect,1133 11:46:55 INFO - PROCESS | 1676 | __end_cc_report 11:46:55 INFO - PROCESS | 1676 | __startTimestamp1455306415718__endTimestamp 11:46:55 INFO - PROCESS | 1676 | 11:46:55 INFO - PROCESS | 1676 | ------- Summary: start ------- 11:46:55 INFO - PROCESS | 1676 | Number of tests: 6 11:46:55 INFO - PROCESS | 1676 | 11:46:55 INFO - PROCESS | 1676 | [#0] dojo.html Cycles:165 Average:5699.11 Median:5858.94 stddev:629.45 (10.7%) stddev-sans-first:606.12 11:46:55 INFO - PROCESS | 1676 | Values: 3449.0 3483.8 3510.1 3535.6 3576.5 5578.7 5596.6 5603.9 5646.2 5662.5 5651.4 5659.5 5668.5 5771.7 5779.9 5056.5 5087.7 5106.9 5107.9 5225.7 5191.1 5191.2 5210.2 5248.9 5272.9 5066.3 5070.0 5144.9 5177.2 5182.1 5150.9 5157.4 5171.5 5195.5 5201.8 5095.3 5140.5 5142.3 5161.0 5167.1 5479.2 5544.1 5596.4 5600.7 5653.0 6183.5 6197.8 6205.8 6221.0 6229.7 6105.6 6198.2 6246.4 6277.3 6297.1 5697.1 5709.9 5741.5 5762.3 5820.6 6350.9 6366.7 6367.7 6374.7 6393.7 5878.7 6066.5 6097.2 6098.9 6100.3 6152.4 6216.4 6254.2 6259.8 6272.7 6151.4 6159.6 6175.8 6188.8 6189.2 5993.2 6099.7 6099.9 6180.6 6191.3 4765.6 4811.6 4814.2 4818.4 4826.7 4335.5 4374.8 4418.1 4421.9 4433.3 5589.8 5654.5 5657.6 5659.5 5684.6 6055.3 6238.1 6244.1 6262.8 6277.0 5572.0 5659.7 5667.0 5669.0 5669.3 5347.8 5373.8 5378.2 5380.0 5384.5 6257.9 6310.1 6332.3 6353.4 6357.8 6196.7 6253.6 6255.2 6263.7 6280.5 6328.7 6328.7 6328.8 6334.1 6343.7 6009.5 6070.7 6114.0 6138.0 6140.5 6162.7 6168.4 6172.3 6189.9 6190.8 5970.3 5970.5 5977.5 5989.9 6031.0 5920.7 5983.7 5993.8 6005.6 6092.8 4745.0 5804.4 5835.6 5837.0 5858.9 6019.2 6019.3 6027.2 6040.3 6078.6 5763.1 5842.8 5855.9 5875.6 5943.4 11:46:55 INFO - PROCESS | 1676 | 11:46:55 INFO - PROCESS | 1676 | [#1] ext.html Cycles:180 Average:68171.69 Median:38723.73 stddev:148069.82 (382.4%) stddev-sans-first:148397.88 11:46:55 INFO - PROCESS | 1676 | Values: 447.0 461.2 509.5 519.7 539.9 29854.0 30433.1 30461.0 30463.5 30508.5 31356.5 31775.0 39747.8 40702.6 40826.8 9584.2 9775.2 9776.0 9787.0 9812.6 9695.9 9850.3 9862.0 9869.0 9874.2 9779.5 9861.2 9861.4 9862.7 9895.0 9911.0 9982.3 10004.8 10010.6 10019.9 9715.7 9835.6 9860.6 9900.0 9914.3 40399.8 40764.6 40806.4 40892.0 41009.2 3138.0 3360.4 3435.8 3437.7 3655.4 24831.4 28936.9 29340.4 29522.9 30807.0 2261.5 2713.2 2729.0 2792.6 2827.5 419352.0 422697.0 422853.0 422988.0 423302.0 56783.0 58147.4 63688.0 64112.7 64258.0 68792.7 69336.0 70218.0 70263.0 70467.2 16103.3 16323.5 16323.8 16375.4 16378.9 10802.8 10961.4 12370.5 12450.4 12648.0 20337.4 20793.1 21198.9 21217.4 21293.6 9020.1 9290.2 9304.8 9341.5 9393.6 917.1 988.8 1043.7 1054.6 1086.5 29820.9 30112.1 30819.0 31494.0 31610.5 1030.4 1033.0 1053.7 1140.6 1178.8 13896.8 14256.1 14375.9 14452.3 14645.8 579001.0 665313.8 671622.0 672409.0 674212.0 57274.7 57791.1 57823.4 57847.0 57884.4 1441.9 1448.0 1465.4 1468.4 1471.0 26136.2 30839.5 30905.0 30983.5 31673.5 52644.0 53329.7 53331.5 53460.7 53485.2 424657.0 429187.0 631134.7 634791.0 635481.0 42465.6 43288.4 43292.4 43980.6 44135.8 38544.0 46009.0 46492.8 46617.1 47471.8 35992.6 37607.1 38533.0 38765.8 38798.4 29058.8 37299.0 38506.2 38681.6 40243.0 36546.1 37262.6 37361.8 37695.5 37902.8 29364.9 31426.7 33370.7 33431.7 33658.5 19014.1 24293.8 24977.6 25029.4 25506.5 11:46:55 INFO - PROCESS | 1676 | 11:46:55 INFO - PROCESS | 1676 | [#2] jquery.html Cycles:180 Average:37629.19 Median:370.31 stddev:122344.95 (33038.5%) stddev-sans-first:122656.12 11:46:55 INFO - PROCESS | 1676 | Values: 340.9 367.2 373.5 374.7 378.7 14988.1 15504.3 18600.0 18953.7 19369.9 11327.8 11916.2 11932.8 12347.7 19188.8 4653.9 5388.6 5402.3 5406.3 5414.8 3852.9 4077.9 5643.2 5889.7 5893.8 5247.2 5532.8 5781.7 5894.6 6005.5 5885.2 5943.5 5951.6 5954.0 5956.4 5514.5 5677.6 5691.6 5701.9 5702.3 23401.6 23767.7 24624.0 24676.9 24685.4 2067.0 2178.3 2253.4 2331.2 2464.9 9801.0 10127.2 11235.8 12096.2 13771.3 1628.6 1709.8 1758.2 1801.2 1815.1 90284.5 96715.0 97259.0 97925.5 99066.5 10540.6 10901.1 10927.9 11011.4 11041.5 13135.6 13149.0 13269.2 13282.8 13291.9 8211.5 8219.3 8230.4 8298.3 8378.3 6766.5 8303.5 8315.9 8368.8 8376.3 4063.9 4218.7 4305.2 4394.9 4442.5 1753.8 1768.6 1819.7 1828.6 1831.2 919.4 922.5 927.8 938.2 994.4 20127.0 20760.0 20826.4 20981.4 21016.9 871.8 915.6 935.6 969.8 1013.4 10562.3 10977.0 10996.3 11006.4 11008.9 732884.0 734182.0 737545.0 751890.0 752017.0 114630.8 123060.4 125707.0 126015.0 126888.0 1114.3 1130.1 1145.5 1149.3 1150.1 18594.3 18704.3 18711.0 18753.4 18829.9 33126.3 50278.5 53198.0 54180.0 54601.0 78751.0 79185.0 79215.4 79875.0 79904.6 7482.6 7748.3 7777.8 7790.5 7808.9 7514.8 9336.5 9612.3 11875.9 12113.5 9699.8 10171.3 10545.0 10557.7 10579.6 9972.8 10296.4 10348.9 10496.0 10507.0 10453.7 10612.3 10827.7 10834.4 10911.2 7730.0 7828.5 7838.2 7840.8 7860.5 6218.8 9784.4 10648.5 10728.7 10892.5 11:46:55 INFO - PROCESS | 1676 | 11:46:55 INFO - PROCESS | 1676 | [#3] mootools.html Cycles:180 Average:5997.12 Median:5492.17 stddev:3182.17 (57.9%) stddev-sans-first:3172.45 11:46:55 INFO - PROCESS | 1676 | Values: 1413.7 1524.5 1556.2 1794.1 1951.1 7832.7 8479.9 8611.0 8626.0 8650.6 8472.4 8729.0 8746.0 8748.5 8750.7 1996.8 2107.9 2163.2 2226.6 2469.2 2501.8 2507.6 2509.9 2510.9 2512.3 2087.0 2411.0 2488.5 2491.7 2492.0 2446.1 2476.3 2489.6 2498.4 2500.6 2444.7 2483.8 2491.2 2492.7 2494.4 8709.2 8779.3 8781.5 8792.7 8798.6 5018.8 5482.2 5490.0 5493.5 5553.1 3107.7 3580.6 3617.1 3679.1 3685.3 975.4 994.6 1000.5 1010.5 1059.0 11881.9 11938.4 11968.5 12125.2 12130.4 4878.7 4884.8 4946.5 4968.4 4973.8 10217.1 10255.5 10257.9 10278.4 10293.7 5490.8 5501.9 5515.2 5517.0 5519.4 4926.2 5001.8 5003.3 5006.9 5014.9 3943.4 3974.1 3987.9 4000.1 4027.8 1296.5 1302.1 1302.3 1308.8 1317.5 963.8 1143.3 1217.2 1376.3 1381.3 8044.1 8174.0 8189.5 8191.5 8217.5 433.4 498.0 506.4 515.4 519.5 5211.5 6261.4 6287.7 6289.4 6294.1 10054.8 10332.5 10336.0 10495.6 10521.6 9915.6 10191.0 10336.2 10345.4 10368.0 7986.6 8227.7 8229.6 8239.3 8240.5 7750.7 7973.9 8018.6 8077.2 8114.7 9292.1 9359.2 9376.9 9527.4 9528.1 9466.9 9642.0 9820.7 9915.4 9920.6 6255.5 6338.5 7149.9 7362.9 7383.0 8035.8 8046.3 8065.6 8069.6 8113.4 6415.7 7348.5 7579.9 7599.6 7684.7 7362.2 7442.1 7443.8 7585.4 7594.3 7598.2 7628.1 7639.2 7664.2 7691.3 6957.3 6960.8 7019.5 7035.2 7039.3 7034.3 7054.3 7054.3 7078.6 7084.4 11:46:55 INFO - PROCESS | 1676 | 11:46:55 INFO - PROCESS | 1676 | [#4] prototype.html Cycles:180 Average:5789.09 Median:6547.93 stddev:1816.08 (27.7%) stddev-sans-first:1774.15 11:46:55 INFO - PROCESS | 1676 | Values: 318.6 325.5 330.3 330.9 334.9 6449.9 6499.5 6530.6 6580.5 6622.0 6396.6 6565.3 6579.4 6585.4 6619.5 4938.6 4943.5 4944.6 4965.2 4974.6 4699.5 4810.6 4827.3 4911.3 4924.3 4830.2 4834.7 4926.2 4961.2 4981.8 4907.6 4924.3 4924.4 4924.5 4926.6 4202.0 4209.8 4210.7 4216.8 4218.5 5480.6 6091.8 6208.7 6329.5 6451.1 5736.1 5736.8 5737.9 5742.9 5748.9 6676.0 6821.8 7021.1 7026.2 7042.2 3858.9 4582.4 4666.6 4667.2 4670.0 7285.6 7357.6 7422.4 7448.0 7460.0 4601.2 4786.9 4791.4 4797.4 4798.7 4895.0 4907.6 4909.1 4919.0 4921.0 5706.6 5731.8 5736.7 5737.8 5747.7 7014.1 7018.0 7020.5 7026.8 7041.7 1661.0 1687.3 1691.6 1702.6 1706.9 1100.5 1110.5 1111.4 1116.8 1125.9 6686.5 6694.1 6696.5 6702.8 6718.8 7321.5 7325.9 7328.6 7349.7 7356.0 6431.0 6652.0 6660.9 6670.4 6694.4 3859.2 3861.3 3869.3 3889.3 3896.8 7636.5 7653.8 7659.7 7667.2 7669.5 6335.5 6710.0 7519.9 7525.8 7532.9 6167.6 6197.2 7647.4 7649.9 7651.1 6106.0 7041.2 7190.8 7200.7 7588.9 7211.0 7263.7 7294.6 7301.0 7305.4 7517.2 7775.3 7778.1 7784.3 7789.5 4804.6 4813.0 4818.2 4820.8 4822.5 7338.6 7362.3 7369.9 7375.7 7380.1 5741.7 6337.7 6942.8 7092.5 7136.0 7082.0 7124.6 7132.3 7133.5 7142.2 6567.7 6951.9 6964.4 6965.5 6974.0 6875.9 7118.1 7119.6 7122.1 7141.6 6962.3 6963.3 6966.3 6966.5 6968.2 11:46:55 INFO - PROCESS | 1676 | 11:46:55 INFO - PROCESS | 1676 | [#5] yui.html Cycles:180 Average:17823.55 Median:33298.51 stddev:24643.31 (74.0%) stddev-sans-first:24679.07 11:46:55 INFO - PROCESS | 1676 | Values: 742.2 748.7 751.1 760.5 760.8 14954.3 15083.5 15199.7 15200.6 15227.9 13519.6 13596.0 13613.8 13635.4 13637.9 690.2 701.0 701.0 844.8 865.7 840.8 861.5 873.0 875.0 876.1 916.9 917.7 918.5 919.4 922.4 725.6 739.0 889.3 913.2 914.3 674.3 674.5 676.7 678.4 678.7 13419.3 13673.8 14313.9 14749.1 14787.6 12551.5 12694.8 12886.5 12920.8 12985.7 9989.0 10093.5 10124.1 10167.2 10811.7 3516.3 3549.9 3559.7 3566.6 3572.9 78716.2 78797.6 78912.6 78915.6 79172.6 8001.4 9574.5 9673.1 9767.2 9793.0 20814.3 21109.9 21446.0 21522.6 21530.7 7613.5 7735.4 7809.7 7888.6 7912.7 4094.9 4126.2 4150.0 4168.4 4168.9 3538.9 3603.5 3604.9 3606.7 3610.3 640.3 641.8 647.3 664.7 673.9 565.0 588.4 612.2 612.7 620.5 8480.2 8587.9 8761.5 8863.9 8957.9 510.3 577.0 614.0 618.4 648.3 3396.7 3712.6 3883.5 4035.0 4079.0 83667.2 84077.0 85718.6 85920.0 92320.0 73854.6 73886.0 74923.0 75144.6 75988.2 67245.0 67892.0 68230.0 69004.9 69045.7 7864.5 9044.2 9051.8 9109.0 9271.8 47051.5 47638.8 48194.3 48863.0 48906.0 63672.0 65948.7 66185.7 67368.0 68185.7 10608.7 10723.5 10814.8 11192.9 11728.2 11885.7 12165.5 12261.8 12530.7 12692.6 11402.5 11491.4 11755.4 11758.1 11814.8 11366.0 11463.6 11759.0 11781.9 12041.0 8109.6 9555.5 10536.4 10702.9 11560.8 8637.0 8857.7 8896.3 9212.1 9577.6 8448.8 8732.6 9918.7 9963.2 9994.5 11:46:55 INFO - PROCESS | 1676 | -------- Summary: end -------- 11:46:55 INFO - PROCESS | 1676 | 11:46:56 INFO - TEST-INFO | 1676: exit 0 11:46:56 INFO - TEST-OK | dromaeo_css | took 1114557ms 11:46:56 INFO - TEST-START | kraken 11:46:56 INFO - operating with platform_type : mac_ 11:46:56 INFO - Initialising browser for kraken test... 11:46:56 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpdi4Xid/profile http://localhost:49274/getInfo.html) 11:46:58 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 11:46:58 INFO - PROCESS | 1682 | colorDepth:24 11:46:58 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 11:46:58 INFO - PROCESS | 1682 | __metrics 11:46:58 INFO - PROCESS | 1682 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 668: Error: Phase "quit-application-granted is finished, it is too late to register completion condition "SessionStore: flushing all windows" 11:46:58 INFO - PROCESS | 1682 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:46:59 INFO - TEST-INFO | 1682: exit 0 11:46:59 INFO - Browser initialized. 11:46:59 INFO - Running cycle 1/1 for kraken test... 11:46:59 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpdi4Xid/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:47:10 INFO - PROCESS | 1684 | RSS: Main: 247246848 11:47:10 INFO - PROCESS | 1684 | 11:47:13 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 11:47:14 INFO - PROCESS | 1684 | RSS: Main: 292872192 11:47:14 INFO - PROCESS | 1684 | 11:47:16 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 11:47:17 INFO - PROCESS | 1684 | RSS: Main: 302272512 11:47:17 INFO - PROCESS | 1684 | 11:47:20 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 11:47:21 INFO - PROCESS | 1684 | RSS: Main: 287064064 11:47:21 INFO - PROCESS | 1684 | 11:47:23 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 11:47:23 INFO - PROCESS | 1684 | RSS: Main: 290443264 11:47:23 INFO - PROCESS | 1684 | 11:47:25 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:47:26 INFO - PROCESS | 1684 | RSS: Main: 289755136 11:47:26 INFO - PROCESS | 1684 | 11:47:29 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 11:47:29 INFO - PROCESS | 1684 | RSS: Main: 291037184 11:47:29 INFO - PROCESS | 1684 | 11:47:32 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 11:47:33 INFO - PROCESS | 1684 | RSS: Main: 292233216 11:47:33 INFO - PROCESS | 1684 | 11:47:36 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 11:47:36 INFO - PROCESS | 1684 | RSS: Main: 292298752 11:47:36 INFO - PROCESS | 1684 | 11:47:38 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:47:38 INFO - PROCESS | 1684 | RSS: Main: 327344128 11:47:38 INFO - PROCESS | 1684 | 11:47:40 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:47:41 INFO - PROCESS | 1684 | RSS: Main: 326602752 11:47:41 INFO - PROCESS | 1684 | 11:47:43 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:47:43 INFO - PROCESS | 1684 | RSS: Main: 334614528 11:47:43 INFO - PROCESS | 1684 | 11:47:46 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:47:47 INFO - PROCESS | 1684 | RSS: Main: 335650816 11:47:47 INFO - PROCESS | 1684 | 11:47:49 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:47:50 INFO - PROCESS | 1684 | RSS: Main: 335519744 11:47:50 INFO - PROCESS | 1684 | 11:47:51 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 11:47:52 INFO - PROCESS | 1684 | RSS: Main: 395390976 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | __start_tp_report 11:47:52 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 11:47:52 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 11:47:52 INFO - PROCESS | 1684 | |i|pagename|runs| 11:47:52 INFO - PROCESS | 1684 | |0;ai-astar;110;108;109;110;111;108;115;111;111;110 11:47:52 INFO - PROCESS | 1684 | |1;audio-beat-detection;178;146;174;159;106;158;168;147;170;119 11:47:52 INFO - PROCESS | 1684 | |2;audio-dft;185;186;185;186;185;183;186;184;179;182 11:47:52 INFO - PROCESS | 1684 | |3;audio-fft;72;78;106;79;56;48;56;79;77;72 11:47:52 INFO - PROCESS | 1684 | |4;audio-oscillator;94;93;122;77;80;83;110;75;77;111 11:47:52 INFO - PROCESS | 1684 | |5;imaging-gaussian-blur;85;89;83;89;84;89;84;89;83;89 11:47:52 INFO - PROCESS | 1684 | |6;imaging-darkroom;101;149;131;94;94;94;94;93;137;94 11:47:52 INFO - PROCESS | 1684 | |7;imaging-desaturate;84;84;84;98;142;144;87;85;87;85 11:47:52 INFO - PROCESS | 1684 | |8;json-parse-financial;56;53;54;54;55;54;54;64;52;53 11:47:52 INFO - PROCESS | 1684 | |9;json-stringify-tinderbox;62;68;72;69;71;66;65;66;67;67 11:47:52 INFO - PROCESS | 1684 | |10;stanford-crypto-aes;84;83;84;78;82;82;84;83;82;84 11:47:52 INFO - PROCESS | 1684 | |11;stanford-crypto-ccm;126;127;117;125;121;127;123;123;126;132 11:47:52 INFO - PROCESS | 1684 | |12;stanford-crypto-pbkdf2;140;127;138;136;136;138;139;137;135;132 11:47:52 INFO - PROCESS | 1684 | |13;stanford-crypto-sha256-iterative;66;67;65;67;67;68;86;71;67;67 11:47:52 INFO - PROCESS | 1684 | __end_tp_report 11:47:52 INFO - PROCESS | 1684 | __start_cc_report 11:47:52 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1211 11:47:52 INFO - PROCESS | 1684 | __end_cc_report 11:47:52 INFO - PROCESS | 1684 | __startTimestamp1455306472108__endTimestamp 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | ------- Summary: start ------- 11:47:52 INFO - PROCESS | 1684 | Number of tests: 14 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:2.00 (1.8%) stddev-sans-first:2.12 11:47:52 INFO - PROCESS | 1684 | Values: 110.0 108.0 109.0 110.0 111.0 108.0 115.0 111.0 111.0 110.0 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:163.50 stddev:23.78 (14.5%) stddev-sans-first:23.36 11:47:52 INFO - PROCESS | 1684 | Values: 178.0 146.0 174.0 159.0 106.0 158.0 168.0 147.0 170.0 119.0 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#2] audio-dft Cycles:10 Average:184.10 Median:185.00 stddev:2.23 (1.2%) stddev-sans-first:2.35 11:47:52 INFO - PROCESS | 1684 | Values: 185.0 186.0 185.0 186.0 185.0 183.0 186.0 184.0 179.0 182.0 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#3] audio-fft Cycles:10 Average:72.30 Median:74.50 stddev:16.34 (21.9%) stddev-sans-first:17.33 11:47:52 INFO - PROCESS | 1684 | Values: 72.0 78.0 106.0 79.0 56.0 48.0 56.0 79.0 77.0 72.0 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:78.50 stddev:16.84 (21.5%) stddev-sans-first:17.85 11:47:52 INFO - PROCESS | 1684 | Values: 94.0 93.0 122.0 77.0 80.0 83.0 110.0 75.0 77.0 111.0 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:89.00 stddev:2.80 (3.1%) stddev-sans-first:2.92 11:47:52 INFO - PROCESS | 1684 | Values: 85.0 89.0 83.0 89.0 84.0 89.0 84.0 89.0 83.0 89.0 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#6] imaging-darkroom Cycles:10 Average:108.10 Median:94.00 stddev:21.87 (23.3%) stddev-sans-first:23.05 11:47:52 INFO - PROCESS | 1684 | Values: 101.0 149.0 131.0 94.0 94.0 94.0 94.0 93.0 137.0 94.0 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#7] imaging-desaturate Cycles:10 Average:98.00 Median:85.00 stddev:24.08 (28.3%) stddev-sans-first:25.01 11:47:52 INFO - PROCESS | 1684 | Values: 84.0 84.0 84.0 98.0 142.0 144.0 87.0 85.0 87.0 85.0 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:54.00 stddev:3.38 (6.3%) stddev-sans-first:3.56 11:47:52 INFO - PROCESS | 1684 | Values: 56.0 53.0 54.0 54.0 55.0 54.0 54.0 64.0 52.0 53.0 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#9] json-stringify-tinderbox Cycles:10 Average:67.30 Median:67.50 stddev:2.91 (4.3%) stddev-sans-first:2.37 11:47:52 INFO - PROCESS | 1684 | Values: 62.0 68.0 72.0 69.0 71.0 66.0 65.0 66.0 67.0 67.0 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.50 stddev:1.84 (2.2%) stddev-sans-first:1.88 11:47:52 INFO - PROCESS | 1684 | Values: 84.0 83.0 84.0 78.0 82.0 82.0 84.0 83.0 82.0 84.0 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:126.00 stddev:4.03 (3.2%) stddev-sans-first:4.25 11:47:52 INFO - PROCESS | 1684 | Values: 126.0 127.0 117.0 125.0 121.0 127.0 123.0 123.0 126.0 132.0 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.80 Median:137.50 stddev:3.82 (2.8%) stddev-sans-first:3.74 11:47:52 INFO - PROCESS | 1684 | Values: 140.0 127.0 138.0 136.0 136.0 138.0 139.0 137.0 135.0 132.0 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - PROCESS | 1684 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:67.00 stddev:6.14 (9.2%) stddev-sans-first:6.41 11:47:52 INFO - PROCESS | 1684 | Values: 66.0 67.0 65.0 67.0 67.0 68.0 86.0 71.0 67.0 67.0 11:47:52 INFO - PROCESS | 1684 | -------- Summary: end -------- 11:47:52 INFO - PROCESS | 1684 | 11:47:52 INFO - TEST-INFO | 1684: exit 0 11:47:52 INFO - TEST-OK | kraken | took 56477ms 11:47:52 INFO - SUITE-END | took 1171s 11:47:53 INFO - Completed test suite (00:19:31) 11:47:53 INFO - Working with test: dromaeo_css 11:47:53 INFO - Generating results file: dromaeo_css 11:47:53 INFO - Working with test: kraken 11:47:53 INFO - Generating results file: kraken 11:47:53 INFO - javascript benchmark 11:47:53 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:47:53 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,59]] 11:47:53 INFO - process_Request line: dromaeo_css 7475.18 graph.html#tests=[[72,64,59]] 11:47:53 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:47:53 INFO - process_Request line: kraken 1438.30 graph.html#tests=[[232,64,59]] 11:47:53 INFO - RETURN: dromaeo_css: 7475.18 11:47:53 INFO - RETURN: kraken: 1438.30 11:47:53 INFO - javascript benchmark 11:47:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3449.034270404287, 3483.8258087095655, 3510.087377281909, 3535.6464353564647, 3576.4992900993866, 5578.693171875545, 5596.580256480765, 5603.943960560393, 5646.181303710964, 5662.546996240301, 5651.434856514346, 5659.462351076651, 5668.461496157869, 5771.711414429283, 5779.913301300473, 5056.519630635102, 5087.694738315713, 5106.9489305106845, 5107.923381149286, 5225.712585807779, 5191.117510023286, 5191.247269145972, 5210.192420174879, 5248.921266180992, 5272.894542109156, 5066.316047333618, 5069.974650126763, 5144.948550514484, 5177.197534382177, 5182.119039763212, 5150.922736158961, 5157.432682404932, 5171.456997015334, 5195.454477279869, 5201.7919283229, 5095.286659867622, 5140.537351638371, 5142.280080788692, 5161.045206636784, 5167.147420675584, 5479.205515200274, 5544.0575102232315, 5596.356419011784, 5600.747966341524, 5653.0, 6183.505319574423, 6197.752089916398, 6205.81382558524, 6221.004639257742, 6229.6573688447115, 6105.633661980295, 6198.2252218472695, 6246.3753624637175, 6277.309495955441, 6297.149884765589, 5697.145428185805, 5709.885802283972, 5741.511971482387, 5762.2509073820975, 5820.592558520905, 6350.936490635127, 6366.745330186741, 6367.713452894631, 6374.681265936684, 6393.680315984182, 5878.735456904449, 6066.45401913821, 6097.237845269341, 6098.939010609926, 6100.267967843798, 6152.3540028297275, 6216.378362163748, 6254.15568898202, 6259.843503912348, 6272.717727702265, 6151.384861513813, 6159.568830181934, 6175.84560385985, 6188.783392581238, 6189.164462797555, 5993.190919225936, 6099.695015249308, 6099.908501372394, 6180.598261113013, 6191.318954914956, 4765.571098601143, 4811.615070794328, 4814.15752243356, 4818.445878723922, 4826.686265392738, 4335.458067741532, 4374.803133858984, 4418.094290670405, 4421.911561768747, 4433.334999749999, 5589.776408943597, 5654.46282603152, 5657.632253903483, 5659.462351076641, 5684.573656975661, 6055.303640081359, 6238.1266622672865, 6244.094606282155, 6262.812115636538, 6276.968615156895, 5572.0, 5659.660420374791, 5667.036603777367, 5669.0, 5669.262995810518, 5347.759350829222, 5373.785048598091, 5378.2470454136455, 5380.031594312983, 5384.515393614515, 6257.937420625826, 6310.116583678288, 6332.271788744261, 6353.36466353361, 6357.809265722036, 6196.721147548461, 6253.593516421418, 6255.218097737783, 6263.74945002213, 6280.497560195265, 6328.6519241442165, 6328.683565821782, 6328.810135695937, 6334.113224148531, 6343.651099189589, 6009.54928380382, 6070.696465176812, 6114.021756518936, 6137.96931015342, 6140.508759299156, 6162.722677479434, 6168.414000669929, 6172.321044684992, 6189.876202475835, 6190.845228869134, 5970.31341395745, 5970.4765417086755, 5977.521798256216, 5989.910151347821, 6030.974734295092, 5920.674362910081, 5983.700814959322, 5993.790217342372, 6005.6396616203165, 6092.847678808065, 4744.952550474451, 5804.448577385142, 5835.56233282514, 5837.0368889132815, 5858.94141058584, 6019.247594050744, 6019.307779605401, 6027.21646185993, 6040.305364883095, 6078.57449978515, 5763.077907534775, 5842.795502157404, 5855.882882342244, 5875.618084824473, 5943.405659434195], "unit": "score", "name": "dojo.html", "value": 5659.974719847322}, {"lowerIsBetter": false, "replicates": [446.9843555475559, 461.2067244339734, 509.5439581574491, 519.7037688517545, 539.895912858205, 29854.0, 30433.087007389786, 30461.0, 30463.543046854316, 30508.54237186444, 31356.529652055182, 31775.0, 39747.807565773, 40702.59297407025, 40826.79586602063, 9584.233261339075, 9775.169110625606, 9776.0, 9786.951065244664, 9812.558434870412, 9695.90304096957, 9850.310478266525, 9862.013798620152, 9869.01309869011, 9874.210063194927, 9779.511024448784, 9861.21110311177, 9861.408315501058, 9862.654807081753, 9894.950525247365, 9911.0, 9982.301238913278, 10004.849927251096, 10010.64962726301, 10019.949900250525, 9715.659951901649, 9835.557399917021, 9860.556274967643, 9899.950500247525, 9914.25643076765, 40399.7980010098, 40764.592354076376, 40806.38790418146, 40892.0, 41009.179816403805, 3137.952930706041, 3360.4455264881267, 3435.793852368866, 3437.74216933731, 3655.3603119454256, 24831.379215519577, 28936.855315723285, 29340.413191736046, 29522.852385738148, 30807.0, 2261.4911644879935, 2713.1724823928694, 2729.044834307996, 2792.5897421802065, 2827.519321715293, 419352.0, 422696.9999999969, 422853.0, 422988.0, 423302.0, 56783.0, 58147.4185258142, 63688.0, 64112.717745644826, 64258.0, 68792.65603671949, 69336.0, 70218.0, 70263.0, 70467.23831904243, 16103.27535260916, 16323.510294691177, 16323.836761632469, 16375.426860060079, 16378.935369200964, 10802.783944321227, 10961.397123158144, 12370.505179792888, 12450.377481125908, 12648.0, 20337.389878303675, 20793.06431210599, 21198.894005529874, 21217.363479095653, 21293.574128517343, 9020.097990200928, 9290.205574322652, 9304.767380815534, 9341.532923353805, 9393.624255029723, 917.1149840403909, 988.8022395520925, 1043.7110168941351, 1054.5570860238718, 1086.4947799273375, 29820.85089574538, 30112.096637100924, 30819.0, 31494.0, 31610.525842112387, 1030.4229631406436, 1032.9991375055477, 1053.6628278950816, 1140.6178930058522, 1178.8467499225046, 13896.791548126786, 14256.144631322153, 14375.921805864393, 14452.277386130652, 14645.780313295309, 579001.0, 665313.774898007, 671622.0, 672409.0, 674212.0, 57274.7136264316, 57791.13313300304, 57823.421765782645, 57847.0, 57884.42115578875, 1441.8990670652954, 1447.9638009049647, 1465.369890946903, 1468.3539242733164, 1470.9632259193393, 26136.215913522625, 30839.537406939362, 30905.0, 30983.535246970863, 31673.5248971261, 52644.0, 53329.733351332994, 53331.46668533265, 53460.73269633627, 53485.19772203342, 424657.0, 429187.0, 631134.6886531076, 634791.0, 635481.0, 42465.5753442474, 43288.35067474053, 43292.35061474144, 43980.56019439764, 44135.77932110319, 38544.03639908913, 46009.0, 46492.767536163454, 46617.06765864731, 47471.76264118657, 35992.64007359893, 37607.059823503536, 38533.0, 38765.83702488817, 38798.4180237291, 29058.779853978467, 37299.0, 38506.229875401776, 38681.6131838678, 40243.0, 36546.08634784045, 37262.6249114412, 37361.81319093496, 37695.49218031248, 37902.8104859474, 29364.85317573484, 31426.685733142374, 33370.66629333773, 33431.665683343825, 33658.49512257269, 19014.14436350395, 24293.75706242915, 24977.625335619618, 25029.374265643506, 25506.489870202862], "unit": "score", "name": "ext.html", "value": 20002.038395654658}, {"lowerIsBetter": false, "replicates": [340.8909149072297, 367.15554225281863, 373.4659437005083, 374.67029014467266, 378.7405627145407, 14988.10071395717, 15504.302306396212, 18600.0, 18953.71569426458, 19369.934653594064, 11327.830082548768, 11916.225445346046, 11932.82100768487, 12347.691307717312, 19188.75273107247, 4653.8603841884715, 5388.622796404254, 5402.297701298845, 5406.324209473816, 5414.83755487336, 3852.9422058669143, 4077.898052548695, 5643.238162848004, 5889.705514724268, 5893.823185304448, 5247.160454327309, 5532.806351777688, 5781.739821708013, 5894.6168499047635, 6005.459508644221, 5885.205497257858, 5943.465088142067, 5951.553633477485, 5954.047352423591, 5956.404359564009, 5514.531264842493, 5677.630953987978, 5691.573132015115, 5701.945140149086, 5702.344230413472, 23401.648975265383, 23767.692776897264, 24624.015039398582, 24676.876615616988, 24685.382865428328, 2067.0388269454625, 2178.302943058222, 2253.3803204119, 2331.160782118436, 2464.913728019511, 9800.95099524505, 10127.189824813997, 11235.831462527987, 12096.153269271155, 13771.311434428238, 1628.5684293662189, 1709.837565431282, 1758.2088060372882, 1801.2164708351909, 1815.0652414006797, 90284.54857725734, 96715.0328496713, 97259.0, 97925.51037244839, 99066.5046674762, 10540.631077912236, 10901.127909767358, 10927.907209279008, 11011.394373309546, 11041.503132359063, 13135.605931822061, 13149.0, 13269.203847768971, 13282.800757988638, 13291.933540332237, 8211.507309561446, 8219.260266575917, 8230.42387032902, 8298.294644955246, 8378.329733621296, 6766.458683305324, 8303.501789892625, 8315.875261871077, 8368.832623347498, 8376.288015518627, 4063.918721625551, 4218.683598730107, 4305.160493703697, 4394.934075988863, 4442.48911375196, 1753.8070812210647, 1768.5578605348662, 1819.6889555538003, 1828.5816338173597, 1831.2161242405166, 919.3610440743619, 922.5377776224625, 927.8144371125802, 938.1697197979837, 994.4083270454068, 20127.0, 20760.0, 20826.37520874346, 20981.370558883256, 21016.89491552563, 871.7646235516502, 915.5513798238948, 935.5976929920064, 969.7575606098476, 1013.3767732844248, 10562.337501547605, 10976.957189067025, 10996.319912916186, 11006.449677516252, 11008.889911100947, 732884.0, 734182.0, 737545.0, 751890.0, 752017.0, 114630.82953363711, 123060.38469807773, 125707.0, 126015.0, 126888.0, 1114.331401159298, 1130.1410927694847, 1145.53605789657, 1149.2759561476216, 1150.0626989003936, 18594.349197778014, 18704.251829926652, 18710.97089660082, 18753.437396878115, 18829.90585047066, 33126.33747325088, 50278.49721502738, 53198.0, 54180.0, 54601.0, 78751.0, 79185.0, 79215.415691687, 79875.0, 79904.60047699956, 7482.551046937201, 7748.263914928073, 7777.766666999999, 7790.454668173174, 7808.921910781047, 7514.8413121240355, 9336.53317334117, 9612.327137100336, 11875.940620296844, 12113.546374435124, 9699.806003880023, 10171.28800983924, 10545.0, 10557.73605659834, 10579.576816927236, 9972.800543988935, 10296.382217067, 10348.913364096963, 10496.0, 10507.0, 10453.68638940833, 10612.261194178667, 10827.729306767395, 10834.404107774148, 10911.236213464981, 7729.995100637107, 7828.45200835936, 7838.216178382117, 7840.764777056697, 7860.528368297921, 6218.755150250089, 9784.364016338915, 10648.467576621293, 10728.73178170552, 10892.509837057192], "unit": "score", "name": "jquery.html", "value": 9107.707504615533}, {"lowerIsBetter": false, "replicates": [1413.7172565486906, 1524.4588171199223, 1556.1518972160172, 1794.147779804593, 1951.0829909942322, 7832.686692532299, 8479.91520084799, 8611.009733880606, 8626.008009078958, 8650.610722517486, 8472.449290796108, 8729.0, 8746.037935827055, 8748.475091494514, 8750.737477875675, 1996.7903370146144, 2107.915683372671, 2163.2212403534713, 2226.64373700208, 2469.2468797016904, 2501.837380570257, 2507.6238564215423, 2509.874506274688, 2510.949781004379, 2512.296556964053, 2087.0, 2410.9758902411013, 2488.5147396257735, 2491.725910149882, 2492.0405643827075, 2446.143849652616, 2476.2571228631427, 2489.5892177790643, 2498.375406148463, 2500.587403078508, 2444.6577479152934, 2483.788877945377, 2491.2152671908293, 2492.700875894886, 2494.3514686181543, 8709.172628600272, 8779.253763430052, 8781.517016564087, 8792.692255771017, 8798.604062817189, 5018.824341148079, 5482.150266708666, 5490.011797876381, 5493.505584497414, 5553.055980483327, 3107.7203051725455, 3580.5703315602036, 3617.0595645132194, 3679.0802299425145, 3685.3182161300247, 975.4391225045628, 994.6419289055934, 1000.5097502223858, 1010.4695035106554, 1058.9523471443804, 11881.940590296994, 11938.403079846059, 11968.461419236155, 12125.211861228992, 12130.393480326036, 4878.707277563358, 4884.755762211875, 4946.5053494650965, 4968.378952630921, 4973.8010479581135, 10217.080462758388, 10255.538500767483, 10257.94871025655, 10278.434686092336, 10293.691189264335, 5490.835274941758, 5501.889962200734, 5515.172724091419, 5516.972415137979, 5519.365272993577, 4926.211806111005, 5001.824936127218, 5003.2995380646735, 5006.924896126561, 5014.874628134253, 3943.38877473992, 3974.105826189142, 3987.92024159521, 4000.0599859033105, 4027.778472184058, 1296.5332480307081, 1302.1145620977636, 1302.3097758188176, 1308.7971364438527, 1317.4861803896488, 963.8409662405764, 1143.2911594811271, 1217.1662411248324, 1376.3393571085935, 1381.254122773711, 8044.074931382849, 8174.0, 8189.50862948225, 8191.508509489449, 8217.506949583045, 433.41705406228573, 497.9925301120486, 506.3695698854949, 515.3712470785636, 519.4727351737989, 5211.5049070338255, 6261.436470717566, 6287.717052732638, 6289.433950944345, 6294.118823364733, 10054.849177262347, 10332.535035923402, 10336.0, 10495.632652857113, 10521.631742888962, 9915.603375865028, 10191.0, 10336.17310615149, 10345.431001295, 10368.0, 7986.640601172961, 8227.712030079038, 8229.629666665014, 8239.340852731768, 8240.464369815943, 7750.651220695195, 7973.883656288008, 8018.639161237642, 8077.151899050515, 8114.675412983651, 9292.057498476564, 9359.15767580921, 9376.859347109663, 9527.38072025316, 9528.094830991045, 9466.905330946878, 9642.0, 9820.705378838646, 9915.405075695482, 9920.553575088994, 6255.530835187288, 6338.492920566436, 7149.85700285981, 7362.852742945004, 7383.0, 8035.758927232192, 8046.316063134699, 8065.637046332812, 8069.636866340911, 8113.3509319253135, 6415.711292991733, 7348.485606007528, 7579.924200758142, 7599.620018998918, 7684.731034413992, 7362.153352364332, 7442.1441534222095, 7443.81390465221, 7585.393168546393, 7594.31651151399, 7598.164201937672, 7628.122765881994, 7639.236076392316, 7664.233576642291, 7691.308042185414, 6957.304269573002, 6960.79117626472, 7019.4735394844565, 7035.155781306072, 7039.331263529956, 7034.2965703429245, 7054.25930277334, 7054.329838665319, 7078.646067696697, 7084.36240738336], "unit": "score", "name": "mootools.html", "value": 4792.178411032108}, {"lowerIsBetter": false, "replicates": [318.62084119897327, 325.52148341937345, 330.3393213572854, 330.8957678331325, 334.8526648274759, 6449.90325145122, 6499.512536559765, 6530.575512591684, 6580.532300387355, 6621.966890165542, 6396.648184349859, 6565.27781943987, 6579.440747536453, 6585.407313341799, 6619.536632435731, 4938.629602779797, 4943.480934501879, 4944.579710724593, 4965.230389289666, 4974.577160941324, 4699.459562150362, 4810.591099756525, 4827.324174615556, 4911.263310503417, 4924.28597853311, 4830.178869592178, 4834.685745426554, 4926.2364333528185, 4961.156603377434, 4981.750912454381, 4907.631927605408, 4924.285978533093, 4924.433690125646, 4924.4583095859425, 4926.5566099051075, 4202.0, 4209.789510524462, 4210.663146948237, 4216.831326746927, 4218.535961044283, 5480.588955828329, 6091.786787462462, 6208.72060757267, 6329.525285603552, 6451.096846441502, 5736.053551164053, 5736.7992120276, 5737.856553586152, 5742.942570574282, 5748.8850222995725, 6676.0, 6821.761238356634, 7021.052157958661, 7026.227115017344, 7042.225355210922, 3858.903527411809, 4582.404287442611, 4666.556677115703, 4667.206574882278, 4670.0, 7285.635718214121, 7357.632118394113, 7422.406207503387, 7447.962760186273, 7460.0301960744755, 4601.234623171349, 4786.928196077061, 4791.425028996473, 4797.40032495938, 4798.664093513421, 4895.045466134141, 4907.607391408679, 4909.140900342426, 4919.0, 4920.950790492121, 5706.629069110494, 5731.828045158652, 5736.713164341766, 5737.799177028784, 5747.6838773867, 7014.088168538057, 7017.964910175417, 7020.543664661781, 7026.789196324118, 7041.725597597142, 1660.968732063964, 1687.3166367621134, 1691.577105723569, 1702.5998890260778, 1706.8634509239232, 1100.4937728644752, 1110.5335758981248, 1111.4387234446715, 1116.7598966222301, 1125.9211855170224, 6686.531942764057, 6694.129763130762, 6696.531242812956, 6702.798916032527, 6718.798436046829, 7321.487495875344, 7325.926740732631, 7328.560286382834, 7349.669264883093, 7356.043714317211, 6430.967845160838, 6652.0, 6660.933390666129, 6670.39966403026, 6694.364035416627, 3859.1895701902354, 3861.2663593917628, 3869.3228684980018, 3889.2999260132883, 3896.7661940283674, 7636.50362726421, 7653.808654783564, 7659.731909383145, 7667.1949445308555, 7669.5398276103615, 6335.461485773669, 6710.027046078291, 7519.924800752032, 7525.795872660348, 7532.945387645734, 6167.568270221221, 6197.225346831646, 7647.426443016796, 7649.885251721229, 7651.120121186135, 6105.9694701526205, 7041.190263119602, 7190.81351576984, 7200.71197152108, 7588.886166707393, 7210.96394518024, 7263.673134709056, 7294.635268236673, 7301.0, 7305.379042781211, 7517.210692877169, 7775.300222979959, 7778.105517865291, 7784.338331241908, 7789.493682910593, 4804.639652026042, 4813.0, 4818.180909245367, 4820.807167713252, 4822.469528351949, 7338.633068346669, 7362.300581444754, 7369.889451658122, 7375.704971801282, 7380.114386273682, 5741.655500669973, 6337.683115844097, 6942.826429339307, 7092.468064895051, 7136.000959865727, 7082.0, 7124.643767811693, 7132.251113632994, 7133.536320139175, 7142.178649455379, 6567.704453299709, 6951.930480695129, 6964.373206411447, 6965.47758918073, 6974.0, 6875.931240687729, 7118.074650295428, 7119.572825630479, 7122.109736282965, 7141.642917853983, 6962.268961758942, 6963.338482844122, 6966.268541803241, 6966.5471744336455, 6968.23349431552], "unit": "score", "name": "prototype.html", "value": 5184.1276110726585}, {"lowerIsBetter": false, "replicates": [742.220668298287, 748.6930358552993, 751.0836779129463, 760.5132715062359, 760.7831767946136, 14954.252287385629, 15083.472078477256, 15199.696006079872, 15200.619984500394, 15227.92386038071, 13519.594412167651, 13595.980301477379, 13613.795793063113, 13635.386407611657, 13637.863621363807, 690.2028157478121, 700.9509334346598, 701.03607539633, 844.7803571071535, 865.6667183134475, 840.7898025493627, 861.4615865084322, 872.9694460693877, 874.9868751968726, 876.0801158783283, 916.8578870275085, 917.7246825952187, 918.545320066568, 919.3977944446365, 922.3958307308724, 725.6154238253707, 738.9778306650809, 889.2619126125301, 913.2237598041645, 914.2503147419119, 674.2953613473932, 674.5379415100623, 676.6921050921819, 678.372505432473, 678.6776281266408, 13419.261940593264, 13673.794893076612, 14313.928430357886, 14749.115053096848, 14787.556373308818, 12551.497940082385, 12694.80957785634, 12886.484540618365, 12920.80906744389, 12985.7069603269, 9988.95005524975, 10093.545790439448, 10124.139448146916, 10167.23745719074, 10811.675649730521, 3516.331896939573, 3549.94675079874, 3559.7330200235087, 3566.641181201654, 3572.8749493767855, 78716.21283787204, 78797.60601197014, 78912.60543697244, 78915.6054219731, 79172.60413697895, 8001.357515746171, 9574.47340396285, 9673.081057299545, 9767.218622510181, 9793.020697930293, 20814.271500497714, 21109.894450527958, 21446.0, 21522.56954860894, 21530.677039844413, 7613.467057306047, 7735.381169506426, 7809.726659566888, 7888.605569721491, 7912.683492660344, 4094.9181016380103, 4126.154138401621, 4150.045489537423, 4168.3955826405, 4168.854090106832, 3538.929221415557, 3603.4594810778067, 3604.9279014419567, 3606.711463082947, 3610.2959922815326, 640.2828831708516, 641.7689631732572, 647.2556559955995, 664.7374287156546, 673.9082686048534, 564.9887002259932, 588.3586890289605, 612.1674522649193, 612.6905912514152, 620.5035971223003, 8480.194381533744, 8587.871181932276, 8761.474311541328, 8863.911360886437, 8957.910420895838, 510.25502765962113, 576.9538436925036, 613.9907901381483, 618.4113875047161, 648.3451713769127, 3396.6603339665835, 3712.5730540987593, 3883.514560679915, 4035.0, 4079.0, 83667.16332836715, 84077.0, 85718.57140714256, 85920.0, 92320.0, 73854.63072684602, 73886.0, 74923.0, 75144.62427687936, 75988.24011759812, 67245.0, 67892.0, 68230.0, 69004.89477973603, 69045.65477172582, 7864.4888082274465, 9044.231240344645, 9051.818963620559, 9108.98806787517, 9271.814563708824, 47051.52948470471, 47638.80902977453, 48194.27708584444, 48863.0, 48906.0, 63672.04491932717, 65948.67025664842, 66185.66907165434, 67367.98948015882, 68185.65907170433, 10608.681739547827, 10723.463826808473, 10814.837777433188, 11192.944035279772, 11728.237664551776, 11885.702857428634, 12165.45255463524, 12261.75476490483, 12530.74938501243, 12692.619221423003, 11402.543898244308, 11491.367974761468, 11755.412229388667, 11758.11814113962, 11814.763704726029, 11366.0, 11463.598774042868, 11759.0, 11781.882181178422, 12041.0, 8109.59452027408, 9555.522223888638, 10536.367817930948, 10702.892971070502, 11560.826587601361, 8636.983777647101, 8857.689980850897, 8896.2882969361, 9212.078792120734, 9577.616895324109, 8448.788780280296, 8732.646439801842, 9918.702438926844, 9963.153131983863, 9994.450305233282], "unit": "score", "name": "yui.html", "value": 6810.628554918422}], "name": "dromaeo_css", "value": 7475.178413417071}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 108.0, 109.0, 110.0, 111.0, 108.0, 115.0, 111.0, 111.0, 110.0], "unit": "score", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [178.0, 146.0, 174.0, 159.0, 106.0, 158.0, 168.0, 147.0, 170.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 152.5}, {"lowerIsBetter": true, "replicates": [185.0, 186.0, 185.0, 186.0, 185.0, 183.0, 186.0, 184.0, 179.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.1}, {"lowerIsBetter": true, "replicates": [72.0, 78.0, 106.0, 79.0, 56.0, 48.0, 56.0, 79.0, 77.0, 72.0], "unit": "score", "name": "audio-fft", "value": 72.3}, {"lowerIsBetter": true, "replicates": [94.0, 93.0, 122.0, 77.0, 80.0, 83.0, 110.0, 75.0, 77.0, 111.0], "unit": "score", "name": "audio-oscillator", "value": 92.2}, {"lowerIsBetter": true, "replicates": [85.0, 89.0, 83.0, 89.0, 84.0, 89.0, 84.0, 89.0, 83.0, 89.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.4}, {"lowerIsBetter": true, "replicates": [101.0, 149.0, 131.0, 94.0, 94.0, 94.0, 94.0, 93.0, 137.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 108.1}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 84.0, 98.0, 142.0, 144.0, 87.0, 85.0, 87.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 98.0}, {"lowerIsBetter": true, "replicates": [56.0, 53.0, 54.0, 54.0, 55.0, 54.0, 54.0, 64.0, 52.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.9}, {"lowerIsBetter": true, "replicates": [62.0, 68.0, 72.0, 69.0, 71.0, 66.0, 65.0, 66.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.3}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 78.0, 82.0, 82.0, 84.0, 83.0, 82.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [126.0, 127.0, 117.0, 125.0, 121.0, 127.0, 123.0, 123.0, 126.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.7}, {"lowerIsBetter": true, "replicates": [140.0, 127.0, 138.0, 136.0, 136.0, 138.0, 139.0, 137.0, 135.0, 132.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.8}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 67.0, 67.0, 68.0, 86.0, 71.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1438.2999999999997}]} 11:47:53 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,59]]", "result": "1438.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,59]]", "result": "7475.18"}}} 11:47:53 INFO - Return code: 0 11:47:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:47:53 INFO - # TBPL SUCCESS # 11:47:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:47:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:47:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:47:53 INFO - 2016-02-12 11:47:53.486 screenresolution[1688:10069] starting screenresolution argv=screenresolution get 11:47:53 INFO - 2016-02-12 11:47:53.488 screenresolution[1688:10069] Display 0: 1600x1200x32@60 11:47:53 INFO - 2016-02-12 11:47:53.494 screenresolution[1689:10072] starting screenresolution argv=screenresolution list 11:47:53 INFO - Available Modes on Display 0 11:47:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:47:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:47:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:47:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:47:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:47:53 INFO - Intel Iris: 11:47:53 INFO - Chipset Model: Intel Iris 11:47:53 INFO - Type: GPU 11:47:53 INFO - Bus: Built-In 11:47:53 INFO - VRAM (Dynamic, Max): 1536 MB 11:47:53 INFO - Vendor: Intel (0x8086) 11:47:53 INFO - Device ID: 0x0a2e 11:47:53 INFO - Revision ID: 0x0009 11:47:53 INFO - Displays: 11:47:53 INFO - Display: 11:47:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:47:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:47:53 INFO - Display Serial Number: 1600x1200 60 11:47:53 INFO - Main Display: Yes 11:47:53 INFO - Mirror: Off 11:47:53 INFO - Online: Yes 11:47:53 INFO - Rotation: Supported 11:47:53 INFO - Return code: 0 11:47:53 INFO - Running post-action listener: _resource_record_post_action 11:47:53 INFO - Running post-run listener: _resource_record_post_run 11:47:54 INFO - Total resource usage - Wall time: 1207s; CPU: 52.0%; Read bytes: 33746432; Write bytes: 708914176; Read time: 353; Write time: 1905 11:47:54 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 395043328; Write bytes: 389765120; Read time: 29832; Write time: 693 11:47:54 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 31960576; Write bytes: 301306880; Read time: 334; Write time: 1176 11:47:54 INFO - Running post-run listener: _upload_blobber_files 11:47:54 INFO - Blob upload gear active. 11:47:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:47:54 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:47:54 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:47:54 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:47:55 INFO - (blobuploader) - INFO - Open directory for files ... 11:47:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:47:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:47:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:56 INFO - (blobuploader) - INFO - Done attempting. 11:47:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:47:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:47:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:47:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:47:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:47:57 INFO - (blobuploader) - INFO - Done attempting. 11:47:57 INFO - (blobuploader) - INFO - Iteration through files over. 11:47:57 INFO - Return code: 0 11:47:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:47:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:47:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a3232cb3d0bf9718a9e23395f2339626e827e785f1c91300d66dadf7e02f22d87e718115153bfb82cd41e03bad22b0c8812a158d662206b96c909f749019087", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ac87fb4500c0e508212ab8a0c6e4259dfa81dd5d2a76ec61e57f1bcfd252b644d7c97d5129fbf6e77b6f1178704767415b241415d1e21f1b8833022adc97d1c"} 11:47:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:47:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:47:57 INFO - Contents: 11:47:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a3232cb3d0bf9718a9e23395f2339626e827e785f1c91300d66dadf7e02f22d87e718115153bfb82cd41e03bad22b0c8812a158d662206b96c909f749019087", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ac87fb4500c0e508212ab8a0c6e4259dfa81dd5d2a76ec61e57f1bcfd252b644d7c97d5129fbf6e77b6f1178704767415b241415d1e21f1b8833022adc97d1c"} 11:47:57 INFO - Running post-run listener: copy_logs_to_upload_dir 11:47:57 INFO - Copying logs to upload dir... 11:47:57 INFO - mkdir: /builds/slave/test/build/upload/logs 11:47:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.857592 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-12 11:47:56.813263) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 11:47:56.816609) ========= 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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a3232cb3d0bf9718a9e23395f2339626e827e785f1c91300d66dadf7e02f22d87e718115153bfb82cd41e03bad22b0c8812a158d662206b96c909f749019087", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ac87fb4500c0e508212ab8a0c6e4259dfa81dd5d2a76ec61e57f1bcfd252b644d7c97d5129fbf6e77b6f1178704767415b241415d1e21f1b8833022adc97d1c"} build_url:https://queue.taskcluster.net/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011035 build_url: 'https://queue.taskcluster.net/v1/task/fxQvWAU_TOGzHwnrxTfMmg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/7a3232cb3d0bf9718a9e23395f2339626e827e785f1c91300d66dadf7e02f22d87e718115153bfb82cd41e03bad22b0c8812a158d662206b96c909f749019087", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9ac87fb4500c0e508212ab8a0c6e4259dfa81dd5d2a76ec61e57f1bcfd252b644d7c97d5129fbf6e77b6f1178704767415b241415d1e21f1b8833022adc97d1c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-12 11:47:56.843392) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 11:47:56.843802) ========= 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.fXNAZ8Q3m7/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.pWR7nC0sQG/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.004940 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-12 11:47:56.893283) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 11:47:56.893656) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-12 11:47:56.894123) ========= ========= Total master_lag: 0.27 =========