builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0010 starttime: 1456352516.18 results: success (0) buildid: 20160224030246 builduid: 99e6cd1cafcc4dd688ddd3514d9312ab revision: 5b2baa5e9356644a7ed0b73e422eaff62e159ffb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 14:21:56.177428) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-24 14:21:56.177798) ========= ========= Started set props: basedir (results: 0, elapsed: 4 secs) (at 2016-02-24 14:21:56.178089) ========= 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.tarGM0WVR7/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.TKB2PuugOa/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.005657 basedir: '/builds/slave/test' ========= master_lag: 4.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 4 secs) (at 2016-02-24 14:22:00.194105) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:00.194527) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:00.216307) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:00.216678) ========= 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.tarGM0WVR7/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.TKB2PuugOa/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.005492 ========= master_lag: 0.25 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:00.472058) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:00.472406) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:00.472816) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:00.473158) ========= 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.tarGM0WVR7/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.TKB2PuugOa/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-02-24 14:22:00-- 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% 45.2M=0s 2016-02-24 14:22:00 (45.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137986 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:00.627386) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:00.627760) ========= 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.tarGM0WVR7/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.TKB2PuugOa/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.026142 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:00.676680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 14:22:00.677084) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5b2baa5e9356644a7ed0b73e422eaff62e159ffb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5b2baa5e9356644a7ed0b73e422eaff62e159ffb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tarGM0WVR7/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.TKB2PuugOa/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-02-24 14:22:00,750 truncating revision to first 12 chars 2016-02-24 14:22:00,751 Setting DEBUG logging. 2016-02-24 14:22:00,751 attempt 1/10 2016-02-24 14:22:00,751 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5b2baa5e9356?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-24 14:22:01,740 unpacking tar archive at: mozilla-central-5b2baa5e9356/testing/mozharness/ program finished with exit code 0 elapsedTime=1.237012 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-24 14:22:01.930958) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:01.931396) ========= echo 5b2baa5e9356644a7ed0b73e422eaff62e159ffb in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5b2baa5e9356644a7ed0b73e422eaff62e159ffb'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tarGM0WVR7/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.TKB2PuugOa/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 5b2baa5e9356644a7ed0b73e422eaff62e159ffb program finished with exit code 0 elapsedTime=0.005511 script_repo_revision: '5b2baa5e9356644a7ed0b73e422eaff62e159ffb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:01.983526) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:01.984061) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-24 14:22:02.004069) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-24 14:22:02.004782) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tarGM0WVR7/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.TKB2PuugOa/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 14:22:02 INFO - MultiFileLogger online at 20160224 14:22:02 in /builds/slave/test 14:22:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:22:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:22:02 INFO - {'append_to_log': False, 14:22:02 INFO - 'base_work_dir': '/builds/slave/test', 14:22:02 INFO - 'blob_upload_branch': 'Firefox', 14:22:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:22:02 INFO - 'branch': 'Firefox', 14:22:02 INFO - 'buildbot_json_path': 'buildprops.json', 14:22:02 INFO - 'config_files': ('talos/mac_config.py',), 14:22:02 INFO - 'default_actions': ('clobber', 14:22:02 INFO - 'read-buildbot-config', 14:22:02 INFO - 'download-and-extract', 14:22:02 INFO - 'populate-webroot', 14:22:02 INFO - 'create-virtualenv', 14:22:02 INFO - 'install', 14:22:02 INFO - 'run-tests'), 14:22:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:22:02 INFO - 'download_minidump_stackwalk': True, 14:22:02 INFO - 'download_symbols': 'ondemand', 14:22:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:22:02 INFO - 'tooltool.py': '/tools/tooltool.py', 14:22:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:22:02 INFO - '/tools/misc-python/virtualenv.py')}, 14:22:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:22:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:22:02 INFO - 'installer_path': 'installer.exe', 14:22:02 INFO - 'log_level': 'info', 14:22:02 INFO - 'log_name': 'talos', 14:22:02 INFO - 'log_to_console': True, 14:22:02 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:22:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:22:02 INFO - 'opt_config_files': (), 14:22:02 INFO - 'pip_index': False, 14:22:02 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:22:02 INFO - 'cmd': ('bash', 14:22:02 INFO - '-c', 14:22:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:22:02 INFO - 'enabled': True, 14:22:02 INFO - 'halt_on_failure': False, 14:22:02 INFO - 'name': 'check_screen_resolution'},), 14:22:02 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:22:02 INFO - 'cmd': ('bash', 14:22:02 INFO - '-c', 14:22:02 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:22:02 INFO - 'enabled': True, 14:22:02 INFO - 'halt_on_failure': False, 14:22:02 INFO - 'name': 'check_screen_resolution'},), 14:22:02 INFO - 'run_cmd_checks_enabled': True, 14:22:02 INFO - 'sps_profile': False, 14:22:02 INFO - 'sps_profile_interval': 0, 14:22:02 INFO - 'suite': 'dromaeojs', 14:22:02 INFO - 'system_bits': '32', 14:22:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:22:02 INFO - 'title': 't-yosemite-r7-0010', 14:22:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:22:02 INFO - 'use_talos_json': True, 14:22:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:22:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:22:02 INFO - 'work_dir': 'build'} 14:22:02 INFO - ##### 14:22:02 INFO - ##### Running clobber step. 14:22:02 INFO - ##### 14:22:02 INFO - Running pre-action listener: _resource_record_pre_action 14:22:02 INFO - Running main action method: clobber 14:22:02 INFO - rmtree: /builds/slave/test/build 14:22:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:22:04 INFO - Running post-action listener: _resource_record_post_action 14:22:04 INFO - ##### 14:22:04 INFO - ##### Running read-buildbot-config step. 14:22:04 INFO - ##### 14:22:04 INFO - Running pre-action listener: _resource_record_pre_action 14:22:04 INFO - Running main action method: read_buildbot_config 14:22:04 INFO - Using buildbot properties: 14:22:04 INFO - { 14:22:04 INFO - "project": "", 14:22:04 INFO - "product": "firefox", 14:22:04 INFO - "script_repo_revision": "production", 14:22:04 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 14:22:04 INFO - "repository": "", 14:22:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 14:22:04 INFO - "buildid": "20160224030246", 14:22:04 INFO - "stage_platform": "macosx64", 14:22:04 INFO - "basedir": "/builds/slave/test", 14:22:04 INFO - "nightly_build": "True", 14:22:04 INFO - "buildnumber": 133, 14:22:04 INFO - "slavename": "t-yosemite-r7-0010", 14:22:04 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:22:04 INFO - "platform": "yosemite_r7", 14:22:04 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:22:04 INFO - "branch": "mozilla-central", 14:22:04 INFO - "repo_path": "mozilla-central", 14:22:04 INFO - "revision": "5b2baa5e9356644a7ed0b73e422eaff62e159ffb", 14:22:04 INFO - "pgo_build": "False", 14:22:04 INFO - "builduid": "99e6cd1cafcc4dd688ddd3514d9312ab", 14:22:04 INFO - "slavebuilddir": "test" 14:22:04 INFO - } 14:22:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 14:22:04 INFO - Running post-action listener: _resource_record_post_action 14:22:04 INFO - ##### 14:22:04 INFO - ##### Running download-and-extract step. 14:22:04 INFO - ##### 14:22:04 INFO - Running pre-action listener: _resource_record_pre_action 14:22:04 INFO - Running main action method: download_and_extract 14:22:04 INFO - mkdir: /builds/slave/test/build/tests 14:22:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:04 INFO - https://queue.taskcluster.net/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:22:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/test_packages.json 14:22:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/test_packages.json 14:22:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 14:22:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 14:22:05 INFO - Downloaded 1277 bytes. 14:22:05 INFO - Reading from file /builds/slave/test/build/test_packages.json 14:22:05 INFO - Using the following test package requirements: 14:22:05 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:22:05 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:22:05 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 14:22:05 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:22:05 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 14:22:05 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:22:05 INFO - u'jsshell-mac.zip'], 14:22:05 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:22:05 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 14:22:05 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:22:05 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:22:05 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 14:22:05 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:22:05 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 14:22:05 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:22:05 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 14:22:05 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 14:22:05 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 14:22:05 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 14:22:05 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:22:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:05 INFO - https://queue.taskcluster.net/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:22:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:22:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:22:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/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 14:22:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/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 14:22:06 INFO - Downloaded 17826011 bytes. 14:22:06 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'] 14:22:06 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 14:22:09 INFO - Return code: 0 14:22:09 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 14:22:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:09 INFO - https://queue.taskcluster.net/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 14:22:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:22:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 14:22:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/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 14:22:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/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 14:22:10 INFO - Downloaded 17826011 bytes. 14:22:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:22:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 14:22:14 INFO - Return code: 0 14:22:14 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')]} 14:22:14 INFO - https://queue.taskcluster.net/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 14:22:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:22:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 14:22:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/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 14:22:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/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 14:22:15 INFO - Downloaded 10707015 bytes. 14:22:15 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'] 14:22:15 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 14:22:15 INFO - Return code: 0 14:22: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')]} 14:22:15 INFO - https://queue.taskcluster.net/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 14:22:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:22:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:22:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 14:22:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bcTU22iOT1aMrVlqF5NIbQ/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 14:22:18 INFO - Downloaded 111586073 bytes. 14:22:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:22:18 INFO - mkdir: /builds/slave/test/properties 14:22:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:22:18 INFO - Writing to file /builds/slave/test/properties/build_url 14:22:18 INFO - Contents: 14:22:18 INFO - build_url:https://queue.taskcluster.net/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 14:22:19 INFO - Running post-action listener: _resource_record_post_action 14:22:19 INFO - Running post-action listener: set_extra_try_arguments 14:22:19 INFO - ##### 14:22:19 INFO - ##### Running populate-webroot step. 14:22:19 INFO - ##### 14:22:19 INFO - Running pre-action listener: _resource_record_pre_action 14:22:19 INFO - Running main action method: populate_webroot 14:22:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:22:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:22:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:22:19 INFO - '--tppagecycles', 14:22:19 INFO - '7'], 14:22:19 INFO - 'tests': ['tsvgm']}}, 14:22:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:22:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:22:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:22:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 14:22:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:22:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:22:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:22:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:19 INFO - 'talos_options': ['--e10s'], 14:22:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:22:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:19 INFO - 'tests': ['damp', 'tps']}, 14:22:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:19 INFO - 'talos_options': ['--e10s'], 14:22:19 INFO - 'tests': ['damp', 'tps']}, 14:22:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:22:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:22:19 INFO - 'other': {'tests': ['a11yr', 14:22:19 INFO - 'ts_paint', 14:22:19 INFO - 'tpaint', 14:22:19 INFO - 'sessionrestore', 14:22:19 INFO - 'sessionrestore_no_auto_restore']}, 14:22:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:22:19 INFO - 'tests': ['a11yr', 14:22:19 INFO - 'ts_paint', 14:22:19 INFO - 'tpaint', 14:22:19 INFO - 'sessionrestore', 14:22:19 INFO - 'sessionrestore_no_auto_restore']}, 14:22:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:22:19 INFO - 'tests': ['a11yr', 14:22:19 INFO - 'ts_paint', 14:22:19 INFO - 'tpaint', 14:22:19 INFO - 'sessionrestore', 14:22:19 INFO - 'sessionrestore_no_auto_restore']}, 14:22:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:22:19 INFO - 'tests': ['a11yr', 14:22:19 INFO - 'ts_paint', 14:22:19 INFO - 'tpaint', 14:22:19 INFO - 'sessionrestore', 14:22:19 INFO - 'sessionrestore_no_auto_restore']}, 14:22:19 INFO - 'other_l64': {'tests': ['a11yr', 14:22:19 INFO - 'ts_paint', 14:22:19 INFO - 'tpaint', 14:22:19 INFO - 'sessionrestore', 14:22:19 INFO - 'sessionrestore_no_auto_restore']}, 14:22:19 INFO - 'other_nol64': {'tests': ['a11yr', 14:22:19 INFO - 'ts_paint', 14:22:19 INFO - 'tpaint', 14:22:19 INFO - 'sessionrestore', 14:22:19 INFO - 'sessionrestore_no_auto_restore']}, 14:22:19 INFO - 'svgr': {'tests': ['tsvgx', 14:22:19 INFO - 'tsvgr_opacity', 14:22:19 INFO - 'tart', 14:22:19 INFO - 'tscrollx', 14:22:19 INFO - 'cart']}, 14:22:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:22:19 INFO - 'tests': ['tsvgx', 14:22:19 INFO - 'tsvgr_opacity', 14:22:19 INFO - 'tart', 14:22:19 INFO - 'tscrollx', 14:22:19 INFO - 'cart']}, 14:22:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:19 INFO - 'tests': ['tp5o']}, 14:22:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:19 INFO - 'talos_options': ['--e10s'], 14:22:19 INFO - 'tests': ['tp5o']}, 14:22:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:19 INFO - 'talos_options': ['--xperf_path', 14:22:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:22:19 INFO - 'tests': ['tp5n']}, 14:22:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:22:19 INFO - 'talos_options': ['--e10s', 14:22:19 INFO - '--xperf_path', 14:22:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:22:19 INFO - 'tests': ['tp5n']}}, 14:22:19 INFO - 'talos.zip': {'path': '', 14:22:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:22:19 INFO - Running post-action listener: _resource_record_post_action 14:22:19 INFO - ##### 14:22:19 INFO - ##### Running create-virtualenv step. 14:22:19 INFO - ##### 14:22:19 INFO - Running pre-action listener: _resource_record_pre_action 14:22:19 INFO - Running main action method: create_virtualenv 14:22:19 INFO - Creating virtualenv /builds/slave/test/build/venv 14:22:19 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 14:22:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:22:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:22:19 INFO - Using real prefix '/tools/python27' 14:22:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:22:20 INFO - Installing distribute.............................................................................................................................................................................................done. 14:22:23 INFO - Installing pip.................done. 14:22:23 INFO - Return code: 0 14:22:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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')]} 14:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10faeea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5c8c61ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f992d30>, '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 0x10f7b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f989b20>, '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.tarGM0WVR7/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.TKB2PuugOa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 14:22: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', 'pip>=1.5'] in /builds/slave/test/build 14:22: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 pip>=1.5 14:22:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tarGM0WVR7/Render', 14:22:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:23 INFO - 'HOME': '/Users/cltbld', 14:22:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:23 INFO - 'LOGNAME': 'cltbld', 14:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:23 INFO - 'MOZ_NO_REMOTE': '1', 14:22:23 INFO - 'NO_EM_RESTART': '1', 14:22:23 INFO - 'PAGER': '/bin/cat', 14:22:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:23 INFO - 'PWD': '/builds/slave/test', 14:22:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:23 INFO - 'SHELL': '/bin/bash', 14:22:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TKB2PuugOa/Listeners', 14:22:23 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 14:22:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:23 INFO - 'USER': 'cltbld', 14:22:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:23 INFO - 'XPC_FLAGS': '0x0', 14:22:23 INFO - 'XPC_SERVICE_NAME': '0', 14:22:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:23 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 14:22:23 INFO - Cleaning up... 14:22:23 INFO - Return code: 0 14:22:23 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:22: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')]} 14:22:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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')]} 14:22:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22: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', '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 0x10faeea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5c8c61ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f992d30>, '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 0x10f7b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f989b20>, '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.tarGM0WVR7/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.TKB2PuugOa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 14:22: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', 'psutil>=0.7.1'] in /builds/slave/test/build 14:22: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 psutil>=0.7.1 14:22:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tarGM0WVR7/Render', 14:22:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:23 INFO - 'HOME': '/Users/cltbld', 14:22:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:23 INFO - 'LOGNAME': 'cltbld', 14:22:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:23 INFO - 'MOZ_NO_REMOTE': '1', 14:22:23 INFO - 'NO_EM_RESTART': '1', 14:22:23 INFO - 'PAGER': '/bin/cat', 14:22:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:23 INFO - 'PWD': '/builds/slave/test', 14:22:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:23 INFO - 'SHELL': '/bin/bash', 14:22:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TKB2PuugOa/Listeners', 14:22:23 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 14:22:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:23 INFO - 'USER': 'cltbld', 14:22:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:23 INFO - 'XPC_FLAGS': '0x0', 14:22:23 INFO - 'XPC_SERVICE_NAME': '0', 14:22:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:23 INFO - Downloading/unpacking psutil>=0.7.1 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22: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 14:22:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:22:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:26 INFO - Installing collected packages: psutil 14:22:26 INFO - Running setup.py install for psutil 14:22:26 INFO - building 'psutil._psutil_osx' extension 14:22:26 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 14:22:26 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 14:22:26 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 14:22:27 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 14:22:27 INFO - building 'psutil._psutil_posix' extension 14:22:27 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 14:22:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:22:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:22:27 INFO - ^ 14:22:27 INFO - 1 warning generated. 14:22:27 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 14:22:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:22:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:22:27 INFO - Successfully installed psutil 14:22:27 INFO - Cleaning up... 14:22:27 INFO - Return code: 0 14:22:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10faeea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5c8c61ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f992d30>, '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 0x10f7b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f989b20>, '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.tarGM0WVR7/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.TKB2PuugOa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 14:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:22:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tarGM0WVR7/Render', 14:22:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:27 INFO - 'HOME': '/Users/cltbld', 14:22:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:27 INFO - 'LOGNAME': 'cltbld', 14:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:27 INFO - 'MOZ_NO_REMOTE': '1', 14:22:27 INFO - 'NO_EM_RESTART': '1', 14:22:27 INFO - 'PAGER': '/bin/cat', 14:22:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:27 INFO - 'PWD': '/builds/slave/test', 14:22:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:27 INFO - 'SHELL': '/bin/bash', 14:22:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TKB2PuugOa/Listeners', 14:22:27 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 14:22:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:27 INFO - 'USER': 'cltbld', 14:22:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:27 INFO - 'XPC_FLAGS': '0x0', 14:22:27 INFO - 'XPC_SERVICE_NAME': '0', 14:22:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:22:27 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 14:22:27 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 14:22:27 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 14:22:27 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 14:22:27 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 14:22:27 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 14:22:30 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:22:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:22:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:22:30 INFO - Installing collected packages: mozsystemmonitor 14:22:30 INFO - Running setup.py install for mozsystemmonitor 14:22:30 INFO - Successfully installed mozsystemmonitor 14:22:30 INFO - Cleaning up... 14:22:30 INFO - Return code: 0 14:22:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:22:30 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')]} 14:22:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:30 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')]} 14:22:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:30 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 0x10faeea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5c8c61ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f992d30>, '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 0x10f7b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f989b20>, '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.tarGM0WVR7/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.TKB2PuugOa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 14:22:30 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 14:22:30 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 14:22:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tarGM0WVR7/Render', 14:22:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:30 INFO - 'HOME': '/Users/cltbld', 14:22:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:30 INFO - 'LOGNAME': 'cltbld', 14:22:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:30 INFO - 'MOZ_NO_REMOTE': '1', 14:22:30 INFO - 'NO_EM_RESTART': '1', 14:22:30 INFO - 'PAGER': '/bin/cat', 14:22:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:30 INFO - 'PWD': '/builds/slave/test', 14:22:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:30 INFO - 'SHELL': '/bin/bash', 14:22:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TKB2PuugOa/Listeners', 14:22:30 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 14:22:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:30 INFO - 'USER': 'cltbld', 14:22:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:30 INFO - 'XPC_FLAGS': '0x0', 14:22:30 INFO - 'XPC_SERVICE_NAME': '0', 14:22:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:30 INFO - Downloading/unpacking blobuploader==1.2.4 14:22:30 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 14:22:30 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 14:22:30 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 14:22:30 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 14:22:30 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 14:22:30 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 14:22:32 INFO - Downloading blobuploader-1.2.4.tar.gz 14:22:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:22:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:22:33 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 14:22:33 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 14:22:33 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 14:22:33 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 14:22:33 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 14:22:33 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 14:22:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:22:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:22:33 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 14:22:33 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 14:22:33 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 14:22:33 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 14:22:33 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 14:22:33 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 14:22:34 INFO - Downloading docopt-0.6.1.tar.gz 14:22:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:22:34 INFO - Installing collected packages: blobuploader, requests, docopt 14:22:34 INFO - Running setup.py install for blobuploader 14:22:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:22:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:22:34 INFO - Running setup.py install for requests 14:22:34 INFO - Running setup.py install for docopt 14:22:34 INFO - Successfully installed blobuploader requests docopt 14:22:34 INFO - Cleaning up... 14:22:35 INFO - Return code: 0 14:22:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:35 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')]} 14:22:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:35 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')]} 14:22:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:35 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 0x10faeea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5c8c61ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f992d30>, '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 0x10f7b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f989b20>, '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.tarGM0WVR7/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.TKB2PuugOa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 14:22:35 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 14:22:35 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 14:22:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tarGM0WVR7/Render', 14:22:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:35 INFO - 'HOME': '/Users/cltbld', 14:22:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:35 INFO - 'LOGNAME': 'cltbld', 14:22:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:35 INFO - 'MOZ_NO_REMOTE': '1', 14:22:35 INFO - 'NO_EM_RESTART': '1', 14:22:35 INFO - 'PAGER': '/bin/cat', 14:22:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:35 INFO - 'PWD': '/builds/slave/test', 14:22:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:35 INFO - 'SHELL': '/bin/bash', 14:22:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TKB2PuugOa/Listeners', 14:22:35 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 14:22:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:35 INFO - 'USER': 'cltbld', 14:22:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:35 INFO - 'XPC_FLAGS': '0x0', 14:22:35 INFO - 'XPC_SERVICE_NAME': '0', 14:22:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:35 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-5cXtsA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:35 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-ocmAWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:35 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-cssg0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:35 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-X_owau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:36 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-XjI4wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:36 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-W2eevv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:36 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-P_aYzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:36 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-_fJgPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:36 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-z7DMub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:36 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-nU58Hz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:36 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-JUzpvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:36 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-xnmLA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:36 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-KzTB7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:37 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-tUY6J8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:37 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-XddU7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:37 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-2Fvb9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:37 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Q4Otwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:22:37 INFO - Running setup.py install for manifestparser 14:22:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:22:37 INFO - Running setup.py install for mozcrash 14:22:37 INFO - Running setup.py install for mozdebug 14:22:37 INFO - Running setup.py install for mozdevice 14:22:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:22:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:22:38 INFO - Running setup.py install for mozfile 14:22:38 INFO - Running setup.py install for mozhttpd 14:22:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:22:38 INFO - Running setup.py install for mozinfo 14:22:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:22:38 INFO - Running setup.py install for mozInstall 14:22:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:22:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:22:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:22:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:22:38 INFO - Running setup.py install for mozleak 14:22:38 INFO - Running setup.py install for mozlog 14:22:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:22:38 INFO - Running setup.py install for moznetwork 14:22:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:22:39 INFO - Running setup.py install for mozprocess 14:22:39 INFO - Running setup.py install for mozprofile 14:22:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:22:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:22:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:22:39 INFO - Running setup.py install for mozrunner 14:22:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:22:39 INFO - Running setup.py install for mozscreenshot 14:22:39 INFO - Running setup.py install for moztest 14:22:39 INFO - Running setup.py install for mozversion 14:22:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:22:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:22:39 INFO - Cleaning up... 14:22:40 INFO - Return code: 0 14:22:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:40 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')]} 14:22:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:40 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')]} 14:22:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:40 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 0x10faeea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5c8c61ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f992d30>, '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 0x10f7b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f989b20>, '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.tarGM0WVR7/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.TKB2PuugOa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 14:22:40 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 14:22:40 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 14:22:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tarGM0WVR7/Render', 14:22:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:40 INFO - 'HOME': '/Users/cltbld', 14:22:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:40 INFO - 'LOGNAME': 'cltbld', 14:22:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:40 INFO - 'MOZ_NO_REMOTE': '1', 14:22:40 INFO - 'NO_EM_RESTART': '1', 14:22:40 INFO - 'PAGER': '/bin/cat', 14:22:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:40 INFO - 'PWD': '/builds/slave/test', 14:22:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:40 INFO - 'SHELL': '/bin/bash', 14:22:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TKB2PuugOa/Listeners', 14:22:40 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 14:22:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:40 INFO - 'USER': 'cltbld', 14:22:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:40 INFO - 'XPC_FLAGS': '0x0', 14:22:40 INFO - 'XPC_SERVICE_NAME': '0', 14:22:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:22:40 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-TzYiek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:22:40 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)) 14:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:22:40 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-FrNNYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:22:40 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)) 14:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:22:40 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-1HHLsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:22:40 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)) 14:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:22:40 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-Zy49a6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:22:40 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)) 14:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:22:40 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-jbAJv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:22:40 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)) 14:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:22:40 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-06Knws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:22:40 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)) 14:22:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:22:40 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-6BRtt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:22:41 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)) 14:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:22:41 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-ZgjMaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:22:41 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)) 14:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:22:41 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-JBeSOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:22:41 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)) 14:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:22:41 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-WZjZaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:22:41 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)) 14:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:22:41 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-OwXyMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:22:41 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)) 14:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:22:41 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-pXL_xa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:22:41 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)) 14:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:22:41 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-77CbPH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:22:41 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)) 14:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:22:41 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-lVUd4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:22:41 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)) 14:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:41 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-2fxtW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:22:41 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)) 14:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:22:41 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-vwW24N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:22:41 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)) 14:22:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:22:41 INFO - Running setup.py (path:/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/pip-nQMWms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:22:42 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)) 14:22:42 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)) 14:22:42 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)) 14:22:42 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)) 14:22:42 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)) 14:22:42 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)) 14:22:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:22:42 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 14:22:42 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 14:22:42 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 14:22:42 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 14:22:42 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 14:22:42 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 14:22:44 INFO - Downloading blessings-1.6.tar.gz 14:22:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:22:44 INFO - Installing collected packages: blessings 14:22:44 INFO - Running setup.py install for blessings 14:22:45 INFO - Successfully installed blessings 14:22:45 INFO - Cleaning up... 14:22:45 INFO - Return code: 0 14:22:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:22:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:45 INFO - Reading from file tmpfile_stdout 14:22:45 INFO - Current package versions: 14:22:45 INFO - blessings == 1.6 14:22:45 INFO - blobuploader == 1.2.4 14:22:45 INFO - docopt == 0.6.1 14:22:45 INFO - manifestparser == 1.1 14:22:45 INFO - mozInstall == 1.12 14:22:45 INFO - mozcrash == 0.16 14:22:45 INFO - mozdebug == 0.1 14:22:45 INFO - mozdevice == 0.48 14:22:45 INFO - mozfile == 1.2 14:22:45 INFO - mozhttpd == 0.7 14:22:45 INFO - mozinfo == 0.9 14:22:45 INFO - mozleak == 0.1 14:22:45 INFO - mozlog == 3.1 14:22:45 INFO - moznetwork == 0.27 14:22:45 INFO - mozprocess == 0.22 14:22:45 INFO - mozprofile == 0.28 14:22:45 INFO - mozrunner == 6.11 14:22:45 INFO - mozscreenshot == 0.1 14:22:45 INFO - mozsystemmonitor == 0.0 14:22:45 INFO - moztest == 0.7 14:22:45 INFO - mozversion == 1.4 14:22:45 INFO - psutil == 3.1.1 14:22:45 INFO - requests == 1.2.3 14:22:45 INFO - wsgiref == 0.1.2 14:22:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:45 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 0x10faeea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5c8c61ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f992d30>, '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 0x10f7b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f989b20>, '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.tarGM0WVR7/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.TKB2PuugOa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 14:22:45 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 14:22:45 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 14:22:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tarGM0WVR7/Render', 14:22:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:45 INFO - 'HOME': '/Users/cltbld', 14:22:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:45 INFO - 'LOGNAME': 'cltbld', 14:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:45 INFO - 'MOZ_NO_REMOTE': '1', 14:22:45 INFO - 'NO_EM_RESTART': '1', 14:22:45 INFO - 'PAGER': '/bin/cat', 14:22:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:45 INFO - 'PWD': '/builds/slave/test', 14:22:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:45 INFO - 'SHELL': '/bin/bash', 14:22:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TKB2PuugOa/Listeners', 14:22:45 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 14:22:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:45 INFO - 'USER': 'cltbld', 14:22:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:45 INFO - 'XPC_FLAGS': '0x0', 14:22:45 INFO - 'XPC_SERVICE_NAME': '0', 14:22:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:45 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)) 14:22:45 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)) 14:22:45 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)) 14:22:45 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)) 14:22:45 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)) 14:22:45 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)) 14:22:45 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)) 14:22:45 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)) 14:22:45 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)) 14:22:45 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)) 14:22:45 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)) 14:22:45 INFO - Cleaning up... 14:22:45 INFO - Return code: 0 14:22:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:45 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 0x10faeea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5c8c61ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f992d30>, '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 0x10f7b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f989b20>, '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.tarGM0WVR7/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.TKB2PuugOa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 14:22:45 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 14:22:45 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 14:22:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tarGM0WVR7/Render', 14:22:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:45 INFO - 'HOME': '/Users/cltbld', 14:22:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:45 INFO - 'LOGNAME': 'cltbld', 14:22:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:45 INFO - 'MOZ_NO_REMOTE': '1', 14:22:45 INFO - 'NO_EM_RESTART': '1', 14:22:45 INFO - 'PAGER': '/bin/cat', 14:22:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:45 INFO - 'PWD': '/builds/slave/test', 14:22:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:45 INFO - 'SHELL': '/bin/bash', 14:22:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TKB2PuugOa/Listeners', 14:22:45 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 14:22:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:45 INFO - 'USER': 'cltbld', 14:22:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:45 INFO - 'XPC_FLAGS': '0x0', 14:22:45 INFO - 'XPC_SERVICE_NAME': '0', 14:22:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:45 INFO - Downloading/unpacking jsonschema 14:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:22:48 INFO - Downloading/unpacking functools32 (from jsonschema) 14:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:48 INFO - Downloading functools32-3.2.3-2.tar.gz 14:22:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:22:48 INFO - warning: no files found matching '*.txt' 14:22:48 INFO - no previously-included directories found matching 'build' 14:22:48 INFO - no previously-included directories found matching 'dist' 14:22:48 INFO - no previously-included directories found matching '.git*' 14:22:48 INFO - Installing collected packages: jsonschema, functools32 14:22:48 INFO - Running setup.py install for functools32 14:22:48 INFO - warning: no files found matching '*.txt' 14:22:48 INFO - no previously-included directories found matching 'build' 14:22:48 INFO - no previously-included directories found matching 'dist' 14:22:48 INFO - no previously-included directories found matching '.git*' 14:22:48 INFO - Successfully installed jsonschema functools32 14:22:48 INFO - Cleaning up... 14:22:49 INFO - Return code: 0 14:22:49 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:22:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10faeea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10faf64c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd5c8c61ad0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f992d30>, '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 0x10f7b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f989b20>, '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.tarGM0WVR7/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.TKB2PuugOa/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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 14:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 14:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 14:22:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tarGM0WVR7/Render', 14:22:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:22:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:22:49 INFO - 'HOME': '/Users/cltbld', 14:22:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:22:49 INFO - 'LOGNAME': 'cltbld', 14:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:22:49 INFO - 'MOZ_NO_REMOTE': '1', 14:22:49 INFO - 'NO_EM_RESTART': '1', 14:22:49 INFO - 'PAGER': '/bin/cat', 14:22:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:22:49 INFO - 'PWD': '/builds/slave/test', 14:22:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:22:49 INFO - 'SHELL': '/bin/bash', 14:22:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TKB2PuugOa/Listeners', 14:22:49 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 14:22:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:22:49 INFO - 'USER': 'cltbld', 14:22:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:22:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:22:49 INFO - 'XPC_FLAGS': '0x0', 14:22:49 INFO - 'XPC_SERVICE_NAME': '0', 14:22:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:22:49 INFO - Downloading/unpacking flake8 14:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:22:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:22:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:22:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:22:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:22:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:22:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:22:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:22:52 INFO - no previously-included directories found matching 'docs/_build' 14:22:52 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:22:52 INFO - Running setup.py install for pep8 14:22:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:22:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:22:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:22:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:22:53 INFO - no previously-included directories found matching 'docs/_build' 14:22:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:22:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:22:53 INFO - Cleaning up... 14:22:53 INFO - Return code: 0 14:22:53 INFO - Running post-action listener: _resource_record_post_action 14:22:53 INFO - Running post-action listener: _start_resource_monitoring 14:22:53 INFO - Starting resource monitoring. 14:22:53 INFO - ##### 14:22:53 INFO - ##### Running install step. 14:22:53 INFO - ##### 14:22:53 INFO - Running pre-action listener: _resource_record_pre_action 14:22:53 INFO - Running main action method: install 14:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:22:53 INFO - Reading from file tmpfile_stdout 14:22:53 INFO - Detecting whether we're running mozinstall >=1.0... 14:22:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:22:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:22:53 INFO - Reading from file tmpfile_stdout 14:22:53 INFO - Output received: 14:22:53 INFO - Usage: mozinstall [options] installer 14:22:53 INFO - Options: 14:22:53 INFO - -h, --help show this help message and exit 14:22:53 INFO - -d DEST, --destination=DEST 14:22:53 INFO - Directory to install application into. [default: 14:22:53 INFO - "/builds/slave/test"] 14:22:53 INFO - --app=APP Application being installed. [default: firefox] 14:22:53 INFO - mkdir: /builds/slave/test/build/application 14:22:53 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'] 14:22:53 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 14:23:27 INFO - Reading from file tmpfile_stdout 14:23:27 INFO - Output received: 14:23:27 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 14:23:27 INFO - Running post-action listener: _resource_record_post_action 14:23:27 INFO - ##### 14:23:27 INFO - ##### Running run-tests step. 14:23:27 INFO - ##### 14:23:27 INFO - Running pre-action listener: _resource_record_pre_action 14:23:27 INFO - Running main action method: run_tests 14:23:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:23:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:23:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:23:27 INFO - 2016-02-24 14:23:27.544 screenresolution[1649:7599] starting screenresolution argv=screenresolution get 14:23:27 INFO - 2016-02-24 14:23:27.546 screenresolution[1649:7599] Display 0: 1600x1200x32@60 14:23:27 INFO - 2016-02-24 14:23:27.552 screenresolution[1650:7601] starting screenresolution argv=screenresolution list 14:23:27 INFO - Available Modes on Display 0 14:23:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:23:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:23:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:23:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:23:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:23:27 INFO - Intel Iris: 14:23:27 INFO - Chipset Model: Intel Iris 14:23:27 INFO - Type: GPU 14:23:27 INFO - Bus: Built-In 14:23:27 INFO - VRAM (Dynamic, Max): 1536 MB 14:23:27 INFO - Vendor: Intel (0x8086) 14:23:27 INFO - Device ID: 0x0a2e 14:23:27 INFO - Revision ID: 0x0009 14:23:27 INFO - Displays: 14:23:27 INFO - Display: 14:23:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:23:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:23:27 INFO - Display Serial Number: 1600x1200 60 14:23:27 INFO - Main Display: Yes 14:23:27 INFO - Mirror: Off 14:23:27 INFO - Online: Yes 14:23:27 INFO - Rotation: Supported 14:23:27 INFO - Return code: 0 14:23:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:23:27 INFO - Python 2.7.3 14:23:27 INFO - Return code: 0 14:23:27 INFO - grabbing minidump binary from tooltool 14:23:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:23:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f992d30>, '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 0x10f7b6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f989b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:23:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:23:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:23:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:23:27 INFO - Return code: 0 14:23:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:23:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:23:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:23:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:23:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:23:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:23:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:23:29 INFO - Return code: 0 14:23:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 14:23:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0010 --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 14:23:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tarGM0WVR7/Render', 14:23:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:23:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:23:29 INFO - 'HOME': '/Users/cltbld', 14:23:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:23:29 INFO - 'LOGNAME': 'cltbld', 14:23:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:23:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:23:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:23:29 INFO - 'MOZ_NO_REMOTE': '1', 14:23:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:23:29 INFO - 'NO_EM_RESTART': '1', 14:23:29 INFO - 'PAGER': '/bin/cat', 14:23:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:23:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:23:29 INFO - 'PWD': '/builds/slave/test', 14:23:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:23:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:23:29 INFO - 'SHELL': '/bin/bash', 14:23:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TKB2PuugOa/Listeners', 14:23:29 INFO - 'TMPDIR': '/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/', 14:23:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:23:29 INFO - 'USER': 'cltbld', 14:23:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:23:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:23:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:23:29 INFO - 'XPC_FLAGS': '0x0', 14:23:29 INFO - 'XPC_SERVICE_NAME': '0', 14:23:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:23:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0010', '--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 14:23:29 INFO - mozversion application_buildid: 20160224030246 14:23:29 INFO - mozversion application_changeset: 5b2baa5e9356644a7ed0b73e422eaff62e159ffb 14:23:29 INFO - mozversion application_display_name: Nightly 14:23:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:23:29 INFO - mozversion application_name: Firefox 14:23:29 INFO - mozversion application_remotingname: firefox 14:23:29 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:23:29 INFO - mozversion application_vendor: Mozilla 14:23:29 INFO - mozversion application_version: 47.0a1 14:23:29 INFO - mozversion platform_buildid: 20160224030246 14:23:29 INFO - mozversion platform_changeset: 5b2baa5e9356644a7ed0b73e422eaff62e159ffb 14:23:29 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:23:29 INFO - mozversion platform_version: 47.0a1 14:23:29 INFO - using testdate: 1456352609 14:23:29 INFO - actual date: 1456352609 14:23:29 INFO - starting webserver on 'localhost:49280' 14:23:29 INFO - SUITE-START | Running 2 tests 14:23:29 INFO - TEST-START | dromaeo_css 14:23:29 INFO - operating with platform_type : mac_ 14:23:29 INFO - Initialising browser for dromaeo_css test... 14:23:29 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpJtOa0b/profile http://localhost:49280/getInfo.html) 14:23:31 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 14:23:31 INFO - PROCESS | 1668 | colorDepth:24 14:23:31 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 14:23:31 INFO - PROCESS | 1668 | __metrics 14:23:32 INFO - PROCESS | 1668 | 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" 14:23:32 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:23:32 INFO - TEST-INFO | 1668: exit 0 14:23:32 INFO - Browser initialized. 14:23:32 INFO - Running cycle 1/1 for dromaeo_css test... 14:23:32 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpJtOa0b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:23:44 INFO - PROCESS | 1672 | RSS: Main: 244088832 14:23:44 INFO - PROCESS | 1672 | 14:24:35 INFO - PROCESS | 1672 | 1456352675825 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] 14:26:46 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49280/tests/dromaeo/cssquery-ext.html) 14:26:47 INFO - PROCESS | 1672 | RSS: Main: 344920064 14:26:47 INFO - PROCESS | 1672 | 14:29:49 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-ext.html (next: http://localhost:49280/tests/dromaeo/cssquery-jquery.html) 14:29:50 INFO - PROCESS | 1672 | RSS: Main: 376537088 14:29:50 INFO - PROCESS | 1672 | 14:32:52 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49280/tests/dromaeo/cssquery-mootools.html) 14:32:53 INFO - PROCESS | 1672 | RSS: Main: 377257984 14:32:53 INFO - PROCESS | 1672 | 14:35:55 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49280/tests/dromaeo/cssquery-prototype.html) 14:35:55 INFO - PROCESS | 1672 | RSS: Main: 334360576 14:35:55 INFO - PROCESS | 1672 | 14:38:59 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49280/tests/dromaeo/cssquery-yui.html) 14:38:59 INFO - PROCESS | 1672 | RSS: Main: 338911232 14:38:59 INFO - PROCESS | 1672 | 14:42:02 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49280/tests/dromaeo/cssquery-yui.html (next: http://localhost:49280/tests/dromaeo/cssquery-dojo.html) 14:42:02 INFO - PROCESS | 1672 | RSS: Main: 384397312 14:42:02 INFO - PROCESS | 1672 | 14:42:02 INFO - PROCESS | 1672 | __start_tp_report 14:42:02 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 14:42:02 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 14:42:02 INFO - PROCESS | 1672 | |i|pagename|runs| 14:42:02 INFO - PROCESS | 1672 | |0;dojo.html;2973.9405211895764;3451.3787518246722;3469.791812491249;3496;3511.3504001759675;5554.1946417769395;5591.384947655754;5596.776128954837;5608.130739735342;5617.691026993519;5383.515483606475;5621.297337832771;5654.971725141379;5831.7958871439505;5835.270591176103;5088.287639730441;5120.15517439622;5129.512696293846;5167.173252279636;5227.424983251858;4298.484181898161;4725.40932383452;5279.656822306557;5292.206169074631;5294.602904782138;5102.872428189288;5108.208227724708;5205.7136857473015;5217.087009773274;5230;5134.512221338967;5142.125838607446;5155.71643559604;5157.922631160535;5196.6881987080515;5063.139266324733;5103.668261563023;5145.871353216162;5175.249588809639;5186.481351864783;5509.862253443656;5521.503064724194;5643.548516118742;5680;5682.51698605619;6151.507879369639;6161.137440758297;6177.938220617782;6193.2877719062435;6196.256449226122;5412.269343638598;6137.570370074097;6153.661548614825;6158.599691020069;6160.045192995093;5676.914846277309;5764.048931926269;5782.595218334676;5793.102069179284;5804;5406.405295417501;6183.938160618426;6208.068789681493;6210.813675589739;6222.533310001768;6049.637021778707;6082.422169893853;6115.266168059861;6136.815895523141;6154.138420621117;5617;5897.76408943646;6106.45041946227;6134.386561343919;6150.862090513269;5359.812406565751;6152.615661476132;6181.876362472725;6182.350853160443;6192.752289908443;6213.96893015532;6216.285127210338;6229.4393504584805;6236.812895613139;6247.562670613013;4804.42346918365;4839.733814640229;4856.68431551948;4868.196747536687;4885.218365061573;4335.3713711511655;4342.696011279243;4374.103308821684;4383.539728328544;4397.054633253866;4900.754962251873;5722.971385143048;5784.305883293948;5808.506276966421;5814.825555233349;6101.542384321194;6108.068892179526;6116.694165291718;6132.78385080153;6135.324535308531;5679.716014199356;5766.308043034779;5772.769089236467;5780;5781.277340332458;4788.473267940523;5224.555912747383;5340.519353258148;5360.70516121617;5372.91940620891;6264.718087686065;6268.655223962634;6285.654289014056;6301.464375528131;6305.96847015762;6069.696515174312;6080.0575910733905;6129.509639228941;6134.969325153525;6147.508199344131;6217.409346112112;6257.874842503215;6314.242290925118;6331.810045698637;6348.841278968062;6120.60216085953;6121.510279177566;6136.20229370179;6136.570440069331;6139.6009259398;6091.847703807441;6163.859685958112;6207.16203312547;6223.439890409885;6225.035119556476;6038.969805150946;6102.458955353496;6106.969465152823;6111.8956224267595;6140.815775526741;6054.515638748978;6078.149059131813;6083.939160608337;6095.994160963569;6106.236720409949;4612.469565999819;5845.912311315248;5949.25634295713;5968.522518198621;5970.134330522137;5067.847964561069;6070.028795392716;6079.665618391031;6093.9085913712215;6118.296395914349;5870.383609720918;5915;5931.169636250842;5968.283805943314;5987.550933680079 14:42:02 INFO - PROCESS | 1672 | |1;ext.html;443.84909130895494;445.7682005357214;469.60553135366285;521.6400683528365;552.0697624502714;29458.96893608724;29775.553366699518;29902.700972990264;37746.43380349297;38540;40860.79569602155;41133;41302.793486032606;41340.379894301535;41379;9535.47554884481;9809;9809.362391444532;9818;9819.410835349867;9559.665411710592;9711.514424278794;9714.65998690046;9722.027797220293;9725.854112188323;9676.661316853912;9729.756756081119;9736.318457707963;9739.318247722662;9757.853632195523;9692.673758297993;9737.464439455827;9745.951270243675;9788.510574471247;9790.853137202948;9389.154976052188;9547.761305967337;9549.904500955041;9551.0926461986;9556.522173891277;39798.40302395466;40148.397774033416;40158.59444919443;40247;40261.59738402608;3202.711755941953;3240.789348692351;3243.1081452600724;3246.172226082334;3251.902442926716;28111.04736723949;28426.073131955443;28441.57337639937;28502.71497285021;28761.712382876114;2358.8469184890655;2786.9442611147665;2787.080263513036;2871.6410448693914;2965.569992351119;418439;482286.58856705844;484065;485264.1473585254;491449;43554.7822260893;61414.77170456566;61924.69037654873;61963;62004.109609587016;43563.564364356585;43654.78172609117;43842;43894.12211755747;43906.780466098106;13135.540256090992;15293;15450.922745386426;15456.768148477782;15529.844701553066;12356.38218089092;12417.379131043412;12420.254784712946;12424.627261182179;12430.627081187578;11997.340146292037;14307.570772876623;14330.713385732228;14407.207603581903;14444.422223110958;6038.550747820492;6057.909131363033;6073.271207455134;6085.421884920926;6101.481374083252;942.8915674697498;948.7770373962113;971.7658573611474;1061;1081.6160263106642;23232.76767232306;28680.139595812157;29126;29443.212675319668;29656.517174141205;970.3304719743354;994.3437331361267;1065.9520321585546;1121.327203677803;1200.5857978997233;12311.291515866495;14375.712485750435;14433.494827680981;14533.78199327011;14540.818877168298;549746;552615;552954;554175;554266;49199;55401.722991384784;56825.43174568284;56935.71532142313;57039.429605703415;1389.4095009621074;1411.287299913537;1421.0265967812081;1424.6295963049474;1426.0374247383184;23756.64365034491;24378.634320484853;27575.586366204923;28222.294442639097;28913;45046.549534505546;45401.545984539734;45431.31853022141;45557.544424556654;46633;348710;350930;351103;351855;353023;28051.438971220054;28094.71905280921;28811.830698622714;30136;32788.508172376954;34353.484697730055;40689;40960.1807963845;41487.58512414837;42322;29195.562066569444;34562.65437345695;35805.283894322485;36132.277354452235;36564.08589785277;34965.47551786674;35371.29257414786;35512.64487355093;35638.64361356353;35836;35515.28969420649;35976.460353094204;37435.812820935724;38276.42585361166;38363.23273534569;29772;31180.908668196505;31712.524312134876;31843.84078079595;32716.018519444453;20622.865742384314;24131.155409561285;24469.510609787347;24522.44816785178;25092.498150036532 14:42:02 INFO - PROCESS | 1672 | |2;jquery.html;354.5125452502808;360.5151071808418;361.86068363679976;366.3588719740454;368.434453114469;15579;16203.756943645854;19077.809221907777;19642;20345.49136271596;19086;19261.036948152607;19542.511437214078;19624.01879906006;19975.700364494543;4958.181899986498;5619.859503512404;5760.251167348239;5823.563232757539;5824.650520968734;4145.7098003139645;4363.214621368153;5535.335759708841;6164.691765411734;6419.422251997319;6345.333739957307;6381.521385896053;6384.297727249998;6385.680715964207;6387.776427825027;6244.3755624437645;6275.372462753711;6417.8395540111405;6425.871482570369;6430.16407866979;5500.862478438031;5537.169424586345;5537.750801213955;5550.69471179085;5550.750216240279;23944.760552394426;24912.501749965082;25111.874440627864;25154.371140721447;25155.37111572207;2186.202036256755;2310.145246258895;2310.4801419680607;2475.183189547445;2919.722626350493;14291.57125286243;14714.117152970748;14965.231432184972;15159.848401515954;15230.010049346756;1640.9015459072493;1745.3280487012464;1778.644271145776;1781.8574514038846;1820.3446759166688;79614;102592.48703756508;105297;105633.47183264034;106545.93454065437;10249.12882405004;10584.629537966135;10749.83875241872;10750;10856.78286434267;10995.395253260987;12866;12914.966802655765;12927.15973461722;12937.159084659466;7410.740624078131;8236.599778037747;8489.745307640656;8500.617472213766;8592.656293748305;8737.388382813142;8756.4308319959;8773.122687731176;8866.911330886609;8869.891263592051;5638.746256418471;6181.041938499539;6250.843728906722;6263.843403914848;6370.808875733643;1577.2113943028485;1670.816210216875;1747.100243374663;1796.2545543599522;1805.9187336569885;794.3168874767695;815.9347252219808;906.5331354352513;1017.6133069433567;1078.563181911327;19586.902065489583;20307;20377.796222037887;20723.171073156904;20776.75406102852;826.4297634632085;876.2201640539924;879.134052957836;936.424099179;999.5302207962392;9805.705828825146;10585.52365143555;10593.89406105929;10606.681799546026;10647.68056958277;529386.7061329337;534867;537960;652927;663451;115426;123014.38492807657;124905;124935;125590;993.2749093162032;1016.872890888639;1022.1771473963531;1056.9524371403152;1067.3755852826184;18004.819951800313;18327.450176494727;18365.63268734591;18435.078246087374;18559.44321670352;49963;50078.49921500738;52192;52441.475585245185;52683.73658131685;66686.99969500558;69972;71631.28368716454;72684.63657681677;73233.6338318305;8051.4766540174705;8060.556669383241;8077.27304542594;8097.919020809716;8361.581920904053;12334.074944379387;13111.409986550438;13212.867871321549;13499.32503374847;13537.1200871943;11354.26197297173;11402.372869492257;11407.657770266906;11455.885441145481;11468.598599048993;11213.887861121284;11282.575471885319;11312.264702794291;11337.319760814378;11692.47383867711;10763.784724305626;11438.885611143782;11531;11677.357745324089;11723.120765942418;5799.94200057994;6413.967930160506;7765.22347765219;7933.880991785243;8001.519908805491;8863.822723545622;11405.429728513707;11482.77034459323;11483.942580287045;11561.942190288995 14:42:02 INFO - PROCESS | 1672 | |3;mootools.html;1357.1992524410607;1525.748251538496;1567.8510541498558;1798.6672465593865;1939.2824654877697;7976.521408715474;8451.61967711453;8629.482231066133;8632.223099921006;8670.43642163259;7170.784876453702;8583.184597463247;8591.48451092935;8596.914030859689;8610;2060.1965233558926;2124.9787502125014;2436.305652888927;2453.914113006045;2454.5949918263464;2181.8000099945048;2391.1630929174826;2442.3039433761382;2454.472288457981;2459;2364.2788949370433;2438.792702620279;2440.5362981033545;2440.9511809763794;2442.206282958046;2381.988090059556;2418.3107814272935;2433.5741245282006;2437.171361737009;2438.475727718549;2398.4723360860585;2416.6979127609047;2433.634954756783;2435.135526887947;2438.9268321950194;8654.394192406535;8733.301335893113;8734.650613975433;8740.213380795696;8742.694005709833;5359.383670877821;5500.202470641734;5535.363433205192;5543.61194716366;5548.278723765925;3104.7205751482475;3569.428891377393;3653.671169594723;3685.649863262986;3695;1038.5170895533613;1059.6503153959175;1068.3109394440542;1088.7332603512111;1101.9944900275527;11834.171607987444;11912.285262884254;11970.521179152824;12003.279803211835;12209.511619535208;4900.26496025599;4913.992631510532;4921.557059864558;4959.355283813081;4962.379702537183;8498.872516912252;10159.949200253952;10224.795504089876;10234;10287.331323463952;4746.454157771831;4996.175631020841;5506.476884695948;5512.724363781795;5533.944660553423;4543.840965566189;4591.219492686251;4619.376384188092;4794.640401969867;4975.253711943237;3942.1327307992196;3942.1721438498234;3947.3289540778137;4006.5192176938954;4013.3979903014783;1297.8961683065331;1307.3920626908532;1314.6976195475095;1322.041519898066;1332.4070788499218;1090.5692251560747;1092.4756117063853;1093.2074246171621;1263.898888088969;1341.2958196946486;8211.850340952271;8370.79073023167;8376.036755773042;8398.370122240856;8420.53687047206;1182.3142577305143;1183.071289038101;1195.3067221011793;1205.5238180918489;1211.4911737070452;6309.463695585927;6314.116023756677;6370.076338930921;6381.266154392211;6386.521010924199;10333.896661033445;10589;10723.356598604109;10743.731406714895;10763.300385474919;8588.65645374178;10497.52761125736;10720.946395267974;10754.247202695893;10763.78472430547;8090.83818323642;8245.88680528133;8314.833703326021;8315.8336833263;8332.958335208285;7776.84446311082;7834.0990786058055;7865.252800983897;7888.17174196724;7922.168172341821;9351.251899848132;9611.855822162814;9672.468014259002;9721.756956076155;9739.75650608712;9911.10800028001;9920.206383489447;10041.899581004389;10047.899521004696;10086.445245511273;6407.167068281094;6432.581882177644;6795.694193761194;7043.964780176067;7156.928430715626;8161.183881612029;8161.714339998071;8202.958985205036;8235.876461852957;8255.628496717782;7193.280671932974;7304.5252058616015;7338.522996005456;7438.293362130589;7472.589007604634;7231.963840180765;7319.890201646873;7438;7474.551526908185;7701.807454813675;7638.236176382317;7657.234276572298;7697.268759467842;7697.345725613385;7697.692092316244;6918.204406493116;6941.305869413019;7002.089728335284;7014.088168538057;7065.57606543609;7123.893141602984;7132.322429369202;7198.352148306678;7208.098987626547;7257.165425975869 14:42:02 INFO - PROCESS | 1672 | |4;prototype.html;321.0721016263;325.9348130373926;327.79349010123616;329.8515667949422;330.6660273124145;6475;6508.6094834309915;6513.413792758657;6535.0850880876715;6548.607083574977;6407.199100112486;6419.871602567946;6419.871602567946;6433.8391540211405;6445.001024841145;4042.272390969624;4815.7110573365535;4826;4834.661573689843;4860.295257187706;4847.2971419144205;4849.321095046696;4854.393200849894;4857.878553036167;4869.659123861331;4424.97787511062;4562.954370456303;4677.228257337535;4801.4718380978065;4812.951870481285;4701.811927522929;4757.333973243749;4772.284157376386;4774.212254977924;4778.354922085508;3931.3120203964477;4075.4701888754566;4086.1010577672864;4106.178764247163;4107.158032603309;5225.529702326771;5907.172995780594;5998.880022399528;6072.301685306202;6086.11751296064;4603.9769801151115;5533.446655334475;5548.611597188158;5556.472135147154;5570.136628822539;6796.76211332601;6813.727450902007;6820.658967051628;6823.283555226729;6828.9317106829285;4569.9314510282375;4570.177368073745;4574;4578.679492435531;4580.839670611546;6348.174737284124;6386.744530218785;6450.903236451457;6985.371316581482;7176.892346614753;4518.118966801442;4572.839950601713;4578.175928332866;4581.79381927814;4583.381243532081;4710.9764451177525;4741.573258406691;4751.168545504523;4759.048190361941;4760.976195119002;5533.253010843485;5568.470995255444;5576.470235327637;5577.776888924398;5602.467765562265;5551.639143455663;6815.522913396015;6828.453723702191;6829.487788415889;6850.349216824394;1519.187234829361;1591.4191320168286;1595.0350038226707;1619.3846338391336;1636.2882146266413;1016.5577973581516;1023.9385636861663;1032.5147180825;1033.4367769565604;1044.4777611194402;6459.935400645933;6497.9350206498275;6497.967510162419;6517.185351831021;6534;7133.108361454818;7135.429165666734;7141.857162856713;7142.714291428389;7156;6489.1888513935755;6490.48076153916;6496.415322620986;6497.4477169441125;6501.349865013555;3748.175401411685;3779.4519794630173;3783.564890037626;3792.222594368148;3796.487474190949;7090.326418990187;7431.591262480507;7471.97385059052;7473.4021278297605;7487.737929172453;7239.312265334785;7303.452241081834;7320.524165929198;7329;7343.1555371131935;7279.636018199175;7432;7440.144383395978;7445.516041457288;7445.813854653568;6605.339466053356;6798.354156355336;7096.0420343253;7109.751158709627;7112.893306600508;6012.6392416455155;6907.240203577502;6950.096487456598;6968.895466568107;6988.825279367853;7400.555966642019;7418.36943859778;7425.294597013275;7430.4798664093;7529.510581812165;4322;4420.535843736361;4433.113377324484;4520.344550040291;4535.297028960516;6836.453083753388;6887.311268873073;6928.203256625351;6997.9503074539225;7019.6490175492045;6159.23009623797;6978.988046733094;6988.37104660583;6993.755218567326;7011.404030657452;6963.651817409211;6971.860562788817;6978.441724661913;6983.755568555076;6988.37104660583;5636.971815140898;6551.181102362205;6766.594004359754;6794.66026698673;6859.382655561023;6865.27914568983;6972;6972.372486476039;7013.263607321362;7032.824179395556;6824.181098268041;6832.282610326043;6837.931620683729;6863.656817159222;6867.519273650996 14:42:02 INFO - PROCESS | 1672 | |5;yui.html;680.1124532485106;685.561240805884;735.6285076036601;751.1887161865183;778.097407007871;14813.815569245231;14852.33164507597;14950.5514834555;14965.176915269656;15020.924895375536;13618.387172577233;14367.497137600187;14367.712645747079;14370.712585748279;14371.209583472932;712.8823744082221;726.785598248518;869.552180626976;886.898006729228;900.6172376739892;720.5784615999646;881.2377293641018;881.4534988307258;884.2395539835736;885.4244740918423;930.9208717259041;931.3061768982118;932.282142750082;932.282142750082;932.2914584915479;748.4424104042496;886.6807949138305;910.6858133943845;911.252772726358;924.3483344242327;689.9068625735512;690.1063123255396;690.4200471603876;691.0981169573704;691.1050190003957;14947.701045979129;14973.401063957428;14978.550643480714;14981.0262332948;14983.400663973427;12733.554325598652;12885.87114128856;12888.871111288861;12926.353682315847;12940;9894.20846332299;9969.307662176065;9974.601015959353;9986.600535978552;9991.500424978722;3498.2303893143467;3528.435450327935;3534.8762793302367;3539.9115022124397;3539.920324301087;74695;75935;76521.61739191324;78156.60921695469;82178;9372.90627093734;9374.296927730311;9374.484403357881;9401.57692903821;9615.471149086727;16589.83410165907;19945.401637950883;20018.299359522345;20031.799682002995;20037.799622003884;6702.798916032527;7188.029616001877;7191.424686025105;7410.962465254868;7498.775036748906;3537.2748586539697;4187.853425130106;4190.559991200941;4201.873943781691;4206.242876282237;3526.7354948378975;3528.558930133733;3537.7346698997676;3539.752217344761;3542.415501442233;630.8139098965817;635.9809205723835;643.5495153392644;645.2031740800109;656.3567703650353;480.9014152098811;530.3688610553429;583.5360888093976;594.5184400635499;597.3071237364636;8267.503949763033;8276.29651479619;8455.873161902577;8457.57712114404;8603.397762156714;594.337313895004;600.5255847880126;605.6063558686889;620.6369273974685;624.6533174088333;3365.3774051800006;3915.001674572966;3947.2500224957166;4050.3721923101966;4139.275626765304;96402.51798741102;97255.51372243236;97787;97882;97999.51000244953;69128.6543567289;78500.42999139985;81040.59479702682;82248;84178;73107.90338144932;73328.866979312;73624.26375736282;73720;74493.62753186199;8027.959860200662;8082.313003394777;8193.296212250063;8293.83412331738;8326.583670816313;42137;42226.788866055475;44338;47879.76060119816;48901.75549122231;69242.3075769256;69810;69989;70043.29956700368;70330.64834675999;9824.263180261367;9844.606215751577;9903;10030.749231269278;10120.949395252977;10710.62512812079;10910.61812836547;11060.22578419535;11146.275492092987;11802.291862488279;10361.585536578452;10496.370217786956;10499.422531760827;10592.152627789605;10605.151587872797;10554.525046372779;10584.682459526226;10589.099926506333;10637.840432393365;10711.57153713874;8708.259797917248;8740;10218.54016569271;10265.948670256601;10653.680389588324;8280.296174824967;8399.832003360021;8560.657573696983;8735.825283494421;8738.344624153087;8396.412251142361;8457.238848503419;8548.786280343042;8580.957095214733;8614.12422076172 14:42:02 INFO - PROCESS | 1672 | __end_tp_report 14:42:02 INFO - PROCESS | 1672 | __start_cc_report 14:42:02 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1003 14:42:02 INFO - PROCESS | 1672 | __end_cc_report 14:42:02 INFO - PROCESS | 1672 | __startTimestamp1456353722544__endTimestamp 14:42:02 INFO - PROCESS | 1672 | 14:42:02 INFO - PROCESS | 1672 | ------- Summary: start ------- 14:42:02 INFO - PROCESS | 1672 | Number of tests: 6 14:42:02 INFO - PROCESS | 1672 | 14:42:02 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5659.20 Median:5870.38 stddev:652.35 (11.1%) stddev-sans-first:619.41 14:42:02 INFO - PROCESS | 1672 | Values: 2973.9 3451.4 3469.8 3496.0 3511.4 5554.2 5591.4 5596.8 5608.1 5617.7 5383.5 5621.3 5655.0 5831.8 5835.3 5088.3 5120.2 5129.5 5167.2 5227.4 4298.5 4725.4 5279.7 5292.2 5294.6 5102.9 5108.2 5205.7 5217.1 5230.0 5134.5 5142.1 5155.7 5157.9 5196.7 5063.1 5103.7 5145.9 5175.2 5186.5 5509.9 5521.5 5643.5 5680.0 5682.5 6151.5 6161.1 6177.9 6193.3 6196.3 5412.3 6137.6 6153.7 6158.6 6160.0 5676.9 5764.0 5782.6 5793.1 5804.0 5406.4 6183.9 6208.1 6210.8 6222.5 6049.6 6082.4 6115.3 6136.8 6154.1 5617.0 5897.8 6106.5 6134.4 6150.9 5359.8 6152.6 6181.9 6182.4 6192.8 6214.0 6216.3 6229.4 6236.8 6247.6 4804.4 4839.7 4856.7 4868.2 4885.2 4335.4 4342.7 4374.1 4383.5 4397.1 4900.8 5723.0 5784.3 5808.5 5814.8 6101.5 6108.1 6116.7 6132.8 6135.3 5679.7 5766.3 5772.8 5780.0 5781.3 4788.5 5224.6 5340.5 5360.7 5372.9 6264.7 6268.7 6285.7 6301.5 6306.0 6069.7 6080.1 6129.5 6135.0 6147.5 6217.4 6257.9 6314.2 6331.8 6348.8 6120.6 6121.5 6136.2 6136.6 6139.6 6091.8 6163.9 6207.2 6223.4 6225.0 6039.0 6102.5 6107.0 6111.9 6140.8 6054.5 6078.1 6083.9 6096.0 6106.2 4612.5 5845.9 5949.3 5968.5 5970.1 5067.8 6070.0 6079.7 6093.9 6118.3 5870.4 5915.0 5931.2 5968.3 5987.6 14:42:02 INFO - PROCESS | 1672 | 14:42:02 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:59106.96 Median:36999.95 stddev:124312.34 (336.0%) stddev-sans-first:124583.04 14:42:02 INFO - PROCESS | 1672 | Values: 443.8 445.8 469.6 521.6 552.1 29459.0 29775.6 29902.7 37746.4 38540.0 40860.8 41133.0 41302.8 41340.4 41379.0 9535.5 9809.0 9809.4 9818.0 9819.4 9559.7 9711.5 9714.7 9722.0 9725.9 9676.7 9729.8 9736.3 9739.3 9757.9 9692.7 9737.5 9746.0 9788.5 9790.9 9389.2 9547.8 9549.9 9551.1 9556.5 39798.4 40148.4 40158.6 40247.0 40261.6 3202.7 3240.8 3243.1 3246.2 3251.9 28111.0 28426.1 28441.6 28502.7 28761.7 2358.8 2786.9 2787.1 2871.6 2965.6 418439.0 482286.6 484065.0 485264.1 491449.0 43554.8 61414.8 61924.7 61963.0 62004.1 43563.6 43654.8 43842.0 43894.1 43906.8 13135.5 15293.0 15450.9 15456.8 15529.8 12356.4 12417.4 12420.3 12424.6 12430.6 11997.3 14307.6 14330.7 14407.2 14444.4 6038.6 6057.9 6073.3 6085.4 6101.5 942.9 948.8 971.8 1061.0 1081.6 23232.8 28680.1 29126.0 29443.2 29656.5 970.3 994.3 1066.0 1121.3 1200.6 12311.3 14375.7 14433.5 14533.8 14540.8 549746.0 552615.0 552954.0 554175.0 554266.0 49199.0 55401.7 56825.4 56935.7 57039.4 1389.4 1411.3 1421.0 1424.6 1426.0 23756.6 24378.6 27575.6 28222.3 28913.0 45046.5 45401.5 45431.3 45557.5 46633.0 348710.0 350930.0 351103.0 351855.0 353023.0 28051.4 28094.7 28811.8 30136.0 32788.5 34353.5 40689.0 40960.2 41487.6 42322.0 29195.6 34562.7 35805.3 36132.3 36564.1 34965.5 35371.3 35512.6 35638.6 35836.0 35515.3 35976.5 37435.8 38276.4 38363.2 29772.0 31180.9 31712.5 31843.8 32716.0 20622.9 24131.2 24469.5 24522.4 25092.5 14:42:02 INFO - PROCESS | 1672 | 14:42:02 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:33710.65 Median:13127.62 stddev:97488.72 (742.6%) stddev-sans-first:97730.03 14:42:02 INFO - PROCESS | 1672 | Values: 354.5 360.5 361.9 366.4 368.4 15579.0 16203.8 19077.8 19642.0 20345.5 19086.0 19261.0 19542.5 19624.0 19975.7 4958.2 5619.9 5760.3 5823.6 5824.7 4145.7 4363.2 5535.3 6164.7 6419.4 6345.3 6381.5 6384.3 6385.7 6387.8 6244.4 6275.4 6417.8 6425.9 6430.2 5500.9 5537.2 5537.8 5550.7 5550.8 23944.8 24912.5 25111.9 25154.4 25155.4 2186.2 2310.1 2310.5 2475.2 2919.7 14291.6 14714.1 14965.2 15159.8 15230.0 1640.9 1745.3 1778.6 1781.9 1820.3 79614.0 102592.5 105297.0 105633.5 106545.9 10249.1 10584.6 10749.8 10750.0 10856.8 10995.4 12866.0 12915.0 12927.2 12937.2 7410.7 8236.6 8489.7 8500.6 8592.7 8737.4 8756.4 8773.1 8866.9 8869.9 5638.7 6181.0 6250.8 6263.8 6370.8 1577.2 1670.8 1747.1 1796.3 1805.9 794.3 815.9 906.5 1017.6 1078.6 19586.9 20307.0 20377.8 20723.2 20776.8 826.4 876.2 879.1 936.4 999.5 9805.7 10585.5 10593.9 10606.7 10647.7 529386.7 534867.0 537960.0 652927.0 663451.0 115426.0 123014.4 124905.0 124935.0 125590.0 993.3 1016.9 1022.2 1057.0 1067.4 18004.8 18327.5 18365.6 18435.1 18559.4 49963.0 50078.5 52192.0 52441.5 52683.7 66687.0 69972.0 71631.3 72684.6 73233.6 8051.5 8060.6 8077.3 8097.9 8361.6 12334.1 13111.4 13212.9 13499.3 13537.1 11354.3 11402.4 11407.7 11455.9 11468.6 11213.9 11282.6 11312.3 11337.3 11692.5 10763.8 11438.9 11531.0 11677.4 11723.1 5799.9 6414.0 7765.2 7933.9 8001.5 8863.8 11405.4 11482.8 11483.9 11561.9 14:42:02 INFO - PROCESS | 1672 | 14:42:02 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:6016.11 Median:4968.82 stddev:3170.19 (63.8%) stddev-sans-first:3159.74 14:42:02 INFO - PROCESS | 1672 | Values: 1357.2 1525.7 1567.9 1798.7 1939.3 7976.5 8451.6 8629.5 8632.2 8670.4 7170.8 8583.2 8591.5 8596.9 8610.0 2060.2 2125.0 2436.3 2453.9 2454.6 2181.8 2391.2 2442.3 2454.5 2459.0 2364.3 2438.8 2440.5 2441.0 2442.2 2382.0 2418.3 2433.6 2437.2 2438.5 2398.5 2416.7 2433.6 2435.1 2438.9 8654.4 8733.3 8734.7 8740.2 8742.7 5359.4 5500.2 5535.4 5543.6 5548.3 3104.7 3569.4 3653.7 3685.6 3695.0 1038.5 1059.7 1068.3 1088.7 1102.0 11834.2 11912.3 11970.5 12003.3 12209.5 4900.3 4914.0 4921.6 4959.4 4962.4 8498.9 10159.9 10224.8 10234.0 10287.3 4746.5 4996.2 5506.5 5512.7 5533.9 4543.8 4591.2 4619.4 4794.6 4975.3 3942.1 3942.2 3947.3 4006.5 4013.4 1297.9 1307.4 1314.7 1322.0 1332.4 1090.6 1092.5 1093.2 1263.9 1341.3 8211.9 8370.8 8376.0 8398.4 8420.5 1182.3 1183.1 1195.3 1205.5 1211.5 6309.5 6314.1 6370.1 6381.3 6386.5 10333.9 10589.0 10723.4 10743.7 10763.3 8588.7 10497.5 10720.9 10754.2 10763.8 8090.8 8245.9 8314.8 8315.8 8333.0 7776.8 7834.1 7865.3 7888.2 7922.2 9351.3 9611.9 9672.5 9721.8 9739.8 9911.1 9920.2 10041.9 10047.9 10086.4 6407.2 6432.6 6795.7 7044.0 7156.9 8161.2 8161.7 8203.0 8235.9 8255.6 7193.3 7304.5 7338.5 7438.3 7472.6 7232.0 7319.9 7438.0 7474.6 7701.8 7638.2 7657.2 7697.3 7697.3 7697.7 6918.2 6941.3 7002.1 7014.1 7065.6 7123.9 7132.3 7198.4 7208.1 7257.2 14:42:02 INFO - PROCESS | 1672 | 14:42:02 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5620.38 Median:6447.95 stddev:1780.81 (27.6%) stddev-sans-first:1740.82 14:42:02 INFO - PROCESS | 1672 | Values: 321.1 325.9 327.8 329.9 330.7 6475.0 6508.6 6513.4 6535.1 6548.6 6407.2 6419.9 6419.9 6433.8 6445.0 4042.3 4815.7 4826.0 4834.7 4860.3 4847.3 4849.3 4854.4 4857.9 4869.7 4425.0 4563.0 4677.2 4801.5 4813.0 4701.8 4757.3 4772.3 4774.2 4778.4 3931.3 4075.5 4086.1 4106.2 4107.2 5225.5 5907.2 5998.9 6072.3 6086.1 4604.0 5533.4 5548.6 5556.5 5570.1 6796.8 6813.7 6820.7 6823.3 6828.9 4569.9 4570.2 4574.0 4578.7 4580.8 6348.2 6386.7 6450.9 6985.4 7176.9 4518.1 4572.8 4578.2 4581.8 4583.4 4711.0 4741.6 4751.2 4759.0 4761.0 5533.3 5568.5 5576.5 5577.8 5602.5 5551.6 6815.5 6828.5 6829.5 6850.3 1519.2 1591.4 1595.0 1619.4 1636.3 1016.6 1023.9 1032.5 1033.4 1044.5 6459.9 6497.9 6498.0 6517.2 6534.0 7133.1 7135.4 7141.9 7142.7 7156.0 6489.2 6490.5 6496.4 6497.4 6501.3 3748.2 3779.5 3783.6 3792.2 3796.5 7090.3 7431.6 7472.0 7473.4 7487.7 7239.3 7303.5 7320.5 7329.0 7343.2 7279.6 7432.0 7440.1 7445.5 7445.8 6605.3 6798.4 7096.0 7109.8 7112.9 6012.6 6907.2 6950.1 6968.9 6988.8 7400.6 7418.4 7425.3 7430.5 7529.5 4322.0 4420.5 4433.1 4520.3 4535.3 6836.5 6887.3 6928.2 6998.0 7019.6 6159.2 6979.0 6988.4 6993.8 7011.4 6963.7 6971.9 6978.4 6983.8 6988.4 5637.0 6551.2 6766.6 6794.7 6859.4 6865.3 6972.0 6972.4 7013.3 7032.8 6824.2 6832.3 6837.9 6863.7 6867.5 14:42:02 INFO - PROCESS | 1672 | 14:42:02 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:18133.52 Median:690.76 stddev:26220.93 (3796.0%) stddev-sans-first:26261.74 14:42:02 INFO - PROCESS | 1672 | Values: 680.1 685.6 735.6 751.2 778.1 14813.8 14852.3 14950.6 14965.2 15020.9 13618.4 14367.5 14367.7 14370.7 14371.2 712.9 726.8 869.6 886.9 900.6 720.6 881.2 881.5 884.2 885.4 930.9 931.3 932.3 932.3 932.3 748.4 886.7 910.7 911.3 924.3 689.9 690.1 690.4 691.1 691.1 14947.7 14973.4 14978.6 14981.0 14983.4 12733.6 12885.9 12888.9 12926.4 12940.0 9894.2 9969.3 9974.6 9986.6 9991.5 3498.2 3528.4 3534.9 3539.9 3539.9 74695.0 75935.0 76521.6 78156.6 82178.0 9372.9 9374.3 9374.5 9401.6 9615.5 16589.8 19945.4 20018.3 20031.8 20037.8 6702.8 7188.0 7191.4 7411.0 7498.8 3537.3 4187.9 4190.6 4201.9 4206.2 3526.7 3528.6 3537.7 3539.8 3542.4 630.8 636.0 643.5 645.2 656.4 480.9 530.4 583.5 594.5 597.3 8267.5 8276.3 8455.9 8457.6 8603.4 594.3 600.5 605.6 620.6 624.7 3365.4 3915.0 3947.3 4050.4 4139.3 96402.5 97255.5 97787.0 97882.0 97999.5 69128.7 78500.4 81040.6 82248.0 84178.0 73107.9 73328.9 73624.3 73720.0 74493.6 8028.0 8082.3 8193.3 8293.8 8326.6 42137.0 42226.8 44338.0 47879.8 48901.8 69242.3 69810.0 69989.0 70043.3 70330.6 9824.3 9844.6 9903.0 10030.7 10120.9 10710.6 10910.6 11060.2 11146.3 11802.3 10361.6 10496.4 10499.4 10592.2 10605.2 10554.5 10584.7 10589.1 10637.8 10711.6 8708.3 8740.0 10218.5 10265.9 10653.7 8280.3 8399.8 8560.7 8735.8 8738.3 8396.4 8457.2 8548.8 8581.0 8614.1 14:42:02 INFO - PROCESS | 1672 | -------- Summary: end -------- 14:42:02 INFO - PROCESS | 1672 | 14:42:03 INFO - TEST-INFO | 1672: exit 0 14:42:03 INFO - TEST-OK | dromaeo_css | took 1113688ms 14:42:03 INFO - TEST-START | kraken 14:42:03 INFO - operating with platform_type : mac_ 14:42:03 INFO - Initialising browser for kraken test... 14:42:03 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpIG6XSP/profile http://localhost:49280/getInfo.html) 14:42:05 INFO - PROCESS | 1680 | __metrics Screen width/height:1600/1200 14:42:05 INFO - PROCESS | 1680 | colorDepth:24 14:42:05 INFO - PROCESS | 1680 | Browser inner width/height: 1024/689 14:42:05 INFO - PROCESS | 1680 | __metrics 14:42:05 INFO - PROCESS | 1680 | 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" 14:42:05 INFO - PROCESS | 1680 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:42:05 INFO - TEST-INFO | 1680: exit 0 14:42:05 INFO - Browser initialized. 14:42:05 INFO - Running cycle 1/1 for kraken test... 14:42:05 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/tmpIG6XSP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:42:18 INFO - PROCESS | 1683 | RSS: Main: 244293632 14:42:18 INFO - PROCESS | 1683 | 14:42:20 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection) 14:42:21 INFO - PROCESS | 1683 | RSS: Main: 290938880 14:42:21 INFO - PROCESS | 1683 | 14:42:23 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-dft) 14:42:24 INFO - PROCESS | 1683 | RSS: Main: 301162496 14:42:24 INFO - PROCESS | 1683 | 14:42:27 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-fft) 14:42:28 INFO - PROCESS | 1683 | RSS: Main: 285327360 14:42:28 INFO - PROCESS | 1683 | 14:42:30 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator) 14:42:30 INFO - PROCESS | 1683 | RSS: Main: 287870976 14:42:30 INFO - PROCESS | 1683 | 14:42:32 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:42:33 INFO - PROCESS | 1683 | RSS: Main: 288223232 14:42:33 INFO - PROCESS | 1683 | 14:42:36 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom) 14:42:36 INFO - PROCESS | 1683 | RSS: Main: 289894400 14:42:36 INFO - PROCESS | 1683 | 14:42:39 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate) 14:42:40 INFO - PROCESS | 1683 | RSS: Main: 291000320 14:42:40 INFO - PROCESS | 1683 | 14:42:42 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial) 14:42:43 INFO - PROCESS | 1683 | RSS: Main: 291500032 14:42:43 INFO - PROCESS | 1683 | 14:42:44 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:42:45 INFO - PROCESS | 1683 | RSS: Main: 325357568 14:42:45 INFO - PROCESS | 1683 | 14:42:47 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:42:47 INFO - PROCESS | 1683 | RSS: Main: 324022272 14:42:47 INFO - PROCESS | 1683 | 14:42:50 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:42:50 INFO - PROCESS | 1683 | RSS: Main: 332058624 14:42:50 INFO - PROCESS | 1683 | 14:42:53 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:42:53 INFO - PROCESS | 1683 | RSS: Main: 334082048 14:42:53 INFO - PROCESS | 1683 | 14:42:56 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:42:57 INFO - PROCESS | 1683 | RSS: Main: 333647872 14:42:57 INFO - PROCESS | 1683 | 14:42:58 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49280/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49280/tests/kraken/driver.html?testName=ai-astar) 14:42:59 INFO - PROCESS | 1683 | RSS: Main: 393580544 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | __start_tp_report 14:42:59 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 14:42:59 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 14:42:59 INFO - PROCESS | 1683 | |i|pagename|runs| 14:42:59 INFO - PROCESS | 1683 | |0;ai-astar;111;107;111;111;112;113;115;110;111;111 14:42:59 INFO - PROCESS | 1683 | |1;audio-beat-detection;161;119;148;158;123;150;143;109;180;142 14:42:59 INFO - PROCESS | 1683 | |2;audio-dft;179;184;188;184;187;185;185;193;253;183 14:42:59 INFO - PROCESS | 1683 | |3;audio-fft;72;76;88;82;56;57;56;81;77;54 14:42:59 INFO - PROCESS | 1683 | |4;audio-oscillator;93;99;125;79;80;84;111;78;78;115 14:42:59 INFO - PROCESS | 1683 | |5;imaging-gaussian-blur;84;89;84;91;84;89;84;90;84;91 14:42:59 INFO - PROCESS | 1683 | |6;imaging-darkroom;93;93;95;93;95;93;93;93;94;93 14:42:59 INFO - PROCESS | 1683 | |7;imaging-desaturate;86;85;87;88;84;85;85;85;85;90 14:42:59 INFO - PROCESS | 1683 | |8;json-parse-financial;53;53;55;52;55;54;53;63;52;52 14:42:59 INFO - PROCESS | 1683 | |9;json-stringify-tinderbox;65;63;79;73;70;65;64;65;66;65 14:42:59 INFO - PROCESS | 1683 | |10;stanford-crypto-aes;84;104;104;105;78;81;82;84;84;84 14:42:59 INFO - PROCESS | 1683 | |11;stanford-crypto-ccm;127;129;125;125;127;124;126;124;129;120 14:42:59 INFO - PROCESS | 1683 | |12;stanford-crypto-pbkdf2;138;122;144;136;139;122;141;166;166;161 14:42:59 INFO - PROCESS | 1683 | |13;stanford-crypto-sha256-iterative;67;66;84;73;67;66;68;68;66;66 14:42:59 INFO - PROCESS | 1683 | __end_tp_report 14:42:59 INFO - PROCESS | 1683 | __start_cc_report 14:42:59 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,1106 14:42:59 INFO - PROCESS | 1683 | __end_cc_report 14:42:59 INFO - PROCESS | 1683 | __startTimestamp1456353779019__endTimestamp 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | ------- Summary: start ------- 14:42:59 INFO - PROCESS | 1683 | Number of tests: 14 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:2.04 (1.8%) stddev-sans-first:2.17 14:42:59 INFO - PROCESS | 1683 | Values: 111.0 107.0 111.0 111.0 112.0 113.0 115.0 110.0 111.0 111.0 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#1] audio-beat-detection Cycles:10 Average:143.30 Median:149.00 stddev:21.41 (14.4%) stddev-sans-first:21.73 14:42:59 INFO - PROCESS | 1683 | Values: 161.0 119.0 148.0 158.0 123.0 150.0 143.0 109.0 180.0 142.0 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#2] audio-dft Cycles:10 Average:192.10 Median:186.00 stddev:21.70 (11.7%) stddev-sans-first:22.50 14:42:59 INFO - PROCESS | 1683 | Values: 179.0 184.0 188.0 184.0 187.0 185.0 185.0 193.0 253.0 183.0 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#3] audio-fft Cycles:10 Average:69.90 Median:76.50 stddev:12.89 (16.8%) stddev-sans-first:13.65 14:42:59 INFO - PROCESS | 1683 | Values: 72.0 76.0 88.0 82.0 56.0 57.0 56.0 81.0 77.0 54.0 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#4] audio-oscillator Cycles:10 Average:94.20 Median:79.50 stddev:17.48 (22.0%) stddev-sans-first:18.53 14:42:59 INFO - PROCESS | 1683 | Values: 93.0 99.0 125.0 79.0 80.0 84.0 111.0 78.0 78.0 115.0 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:89.00 stddev:3.23 (3.6%) stddev-sans-first:3.24 14:42:59 INFO - PROCESS | 1683 | Values: 84.0 89.0 84.0 91.0 84.0 89.0 84.0 90.0 84.0 91.0 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#6] imaging-darkroom Cycles:10 Average:93.50 Median:93.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 14:42:59 INFO - PROCESS | 1683 | Values: 93.0 93.0 95.0 93.0 95.0 93.0 93.0 93.0 94.0 93.0 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:85.50 stddev:1.83 (2.1%) stddev-sans-first:1.94 14:42:59 INFO - PROCESS | 1683 | Values: 86.0 85.0 87.0 88.0 84.0 85.0 85.0 85.0 85.0 90.0 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:53.50 stddev:3.29 (6.2%) stddev-sans-first:3.46 14:42:59 INFO - PROCESS | 1683 | Values: 53.0 53.0 55.0 52.0 55.0 54.0 53.0 63.0 52.0 52.0 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#9] json-stringify-tinderbox Cycles:10 Average:67.50 Median:65.50 stddev:5.04 (7.7%) stddev-sans-first:5.26 14:42:59 INFO - PROCESS | 1683 | Values: 65.0 63.0 79.0 73.0 70.0 65.0 64.0 65.0 66.0 65.0 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#10] stanford-crypto-aes Cycles:10 Average:89.00 Median:83.00 stddev:10.75 (13.0%) stddev-sans-first:11.25 14:42:59 INFO - PROCESS | 1683 | Values: 84.0 104.0 104.0 105.0 78.0 81.0 82.0 84.0 84.0 84.0 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:126.50 stddev:2.67 (2.1%) stddev-sans-first:2.79 14:42:59 INFO - PROCESS | 1683 | Values: 127.0 129.0 125.0 125.0 127.0 124.0 126.0 124.0 129.0 120.0 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:142.50 stddev:16.18 (11.4%) stddev-sans-first:17.04 14:42:59 INFO - PROCESS | 1683 | Values: 138.0 122.0 144.0 136.0 139.0 122.0 141.0 166.0 166.0 161.0 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - PROCESS | 1683 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:67.50 stddev:5.65 (8.4%) stddev-sans-first:5.94 14:42:59 INFO - PROCESS | 1683 | Values: 67.0 66.0 84.0 73.0 67.0 66.0 68.0 68.0 66.0 66.0 14:42:59 INFO - PROCESS | 1683 | -------- Summary: end -------- 14:42:59 INFO - PROCESS | 1683 | 14:42:59 INFO - TEST-INFO | 1683: exit 0 14:42:59 INFO - TEST-OK | kraken | took 56726ms 14:42:59 INFO - SUITE-END | took 1170s 14:43:00 INFO - Completed test suite (00:19:30) 14:43:00 INFO - Working with test: dromaeo_css 14:43:00 INFO - Generating results file: dromaeo_css 14:43:00 INFO - Working with test: kraken 14:43:00 INFO - Generating results file: kraken 14:43:00 INFO - javascript benchmark 14:43:00 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:43:00 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,59]] 14:43:00 INFO - process_Request line: dromaeo_css 7384.00 graph.html#tests=[[72,1,59]] 14:43:00 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:43:00 INFO - process_Request line: kraken 1426.10 graph.html#tests=[[232,1,59]] 14:43:00 INFO - RETURN: dromaeo_css: 7384.00 14:43:00 INFO - RETURN: kraken: 1426.10 14:43:00 INFO - javascript benchmark 14:43:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2973.9405211895764, 3451.3787518246722, 3469.791812491249, 3496.0, 3511.3504001759675, 5554.1946417769395, 5591.384947655754, 5596.776128954837, 5608.130739735342, 5617.691026993519, 5383.515483606475, 5621.297337832771, 5654.971725141379, 5831.7958871439505, 5835.270591176103, 5088.287639730441, 5120.15517439622, 5129.512696293846, 5167.173252279636, 5227.424983251858, 4298.484181898161, 4725.40932383452, 5279.656822306557, 5292.206169074631, 5294.602904782138, 5102.872428189288, 5108.208227724708, 5205.7136857473015, 5217.087009773274, 5230.0, 5134.512221338967, 5142.125838607446, 5155.71643559604, 5157.922631160535, 5196.6881987080515, 5063.139266324733, 5103.668261563023, 5145.871353216162, 5175.249588809639, 5186.481351864783, 5509.862253443656, 5521.503064724194, 5643.548516118742, 5680.0, 5682.51698605619, 6151.507879369639, 6161.137440758297, 6177.938220617782, 6193.2877719062435, 6196.256449226122, 5412.269343638598, 6137.570370074097, 6153.661548614825, 6158.599691020069, 6160.045192995093, 5676.914846277309, 5764.048931926269, 5782.595218334676, 5793.102069179284, 5804.0, 5406.405295417501, 6183.938160618426, 6208.068789681493, 6210.813675589739, 6222.533310001768, 6049.637021778707, 6082.422169893853, 6115.266168059861, 6136.815895523141, 6154.138420621117, 5617.0, 5897.76408943646, 6106.45041946227, 6134.386561343919, 6150.862090513269, 5359.812406565751, 6152.615661476132, 6181.876362472725, 6182.350853160443, 6192.752289908443, 6213.96893015532, 6216.285127210338, 6229.4393504584805, 6236.812895613139, 6247.562670613013, 4804.42346918365, 4839.733814640229, 4856.68431551948, 4868.196747536687, 4885.218365061573, 4335.3713711511655, 4342.696011279243, 4374.103308821684, 4383.539728328544, 4397.054633253866, 4900.754962251873, 5722.971385143048, 5784.305883293948, 5808.506276966421, 5814.825555233349, 6101.542384321194, 6108.068892179526, 6116.694165291718, 6132.78385080153, 6135.324535308531, 5679.716014199356, 5766.308043034779, 5772.769089236467, 5780.0, 5781.277340332458, 4788.473267940523, 5224.555912747383, 5340.519353258148, 5360.70516121617, 5372.91940620891, 6264.718087686065, 6268.655223962634, 6285.654289014056, 6301.464375528131, 6305.96847015762, 6069.696515174312, 6080.0575910733905, 6129.509639228941, 6134.969325153525, 6147.508199344131, 6217.409346112112, 6257.874842503215, 6314.242290925118, 6331.810045698637, 6348.841278968062, 6120.60216085953, 6121.510279177566, 6136.20229370179, 6136.570440069331, 6139.6009259398, 6091.847703807441, 6163.859685958112, 6207.16203312547, 6223.439890409885, 6225.035119556476, 6038.969805150946, 6102.458955353496, 6106.969465152823, 6111.8956224267595, 6140.815775526741, 6054.515638748978, 6078.149059131813, 6083.939160608337, 6095.994160963569, 6106.236720409949, 4612.469565999819, 5845.912311315248, 5949.25634295713, 5968.522518198621, 5970.134330522137, 5067.847964561069, 6070.028795392716, 6079.665618391031, 6093.9085913712215, 6118.296395914349, 5870.383609720918, 5915.0, 5931.169636250842, 5968.283805943314, 5987.550933680079], "unit": "score", "name": "dojo.html", "value": 5619.039645262209}, {"lowerIsBetter": false, "replicates": [443.84909130895494, 445.7682005357214, 469.60553135366285, 521.6400683528365, 552.0697624502714, 29458.96893608724, 29775.553366699518, 29902.700972990264, 37746.43380349297, 38540.0, 40860.79569602155, 41133.0, 41302.793486032606, 41340.379894301535, 41379.0, 9535.47554884481, 9809.0, 9809.362391444532, 9818.0, 9819.410835349867, 9559.665411710592, 9711.514424278794, 9714.65998690046, 9722.027797220293, 9725.854112188323, 9676.661316853912, 9729.756756081119, 9736.318457707963, 9739.318247722662, 9757.853632195523, 9692.673758297993, 9737.464439455827, 9745.951270243675, 9788.510574471247, 9790.853137202948, 9389.154976052188, 9547.761305967337, 9549.904500955041, 9551.0926461986, 9556.522173891277, 39798.40302395466, 40148.397774033416, 40158.59444919443, 40247.0, 40261.59738402608, 3202.711755941953, 3240.789348692351, 3243.1081452600724, 3246.172226082334, 3251.902442926716, 28111.04736723949, 28426.073131955443, 28441.57337639937, 28502.71497285021, 28761.712382876114, 2358.8469184890655, 2786.9442611147665, 2787.080263513036, 2871.6410448693914, 2965.569992351119, 418439.0, 482286.58856705844, 484065.0, 485264.1473585254, 491449.0, 43554.7822260893, 61414.77170456566, 61924.69037654873, 61963.0, 62004.109609587016, 43563.564364356585, 43654.78172609117, 43842.0, 43894.12211755747, 43906.780466098106, 13135.540256090992, 15293.0, 15450.922745386426, 15456.768148477782, 15529.844701553066, 12356.38218089092, 12417.379131043412, 12420.254784712946, 12424.627261182179, 12430.627081187578, 11997.340146292037, 14307.570772876623, 14330.713385732228, 14407.207603581903, 14444.422223110958, 6038.550747820492, 6057.909131363033, 6073.271207455134, 6085.421884920926, 6101.481374083252, 942.8915674697498, 948.7770373962113, 971.7658573611474, 1061.0, 1081.6160263106642, 23232.76767232306, 28680.139595812157, 29126.0, 29443.212675319668, 29656.517174141205, 970.3304719743354, 994.3437331361267, 1065.9520321585546, 1121.327203677803, 1200.5857978997233, 12311.291515866495, 14375.712485750435, 14433.494827680981, 14533.78199327011, 14540.818877168298, 549746.0, 552615.0, 552954.0, 554175.0, 554266.0, 49199.0, 55401.722991384784, 56825.43174568284, 56935.71532142313, 57039.429605703415, 1389.4095009621074, 1411.287299913537, 1421.0265967812081, 1424.6295963049474, 1426.0374247383184, 23756.64365034491, 24378.634320484853, 27575.586366204923, 28222.294442639097, 28913.0, 45046.549534505546, 45401.545984539734, 45431.31853022141, 45557.544424556654, 46633.0, 348710.0, 350930.0, 351103.0, 351855.0, 353023.0, 28051.438971220054, 28094.71905280921, 28811.830698622714, 30136.0, 32788.508172376954, 34353.484697730055, 40689.0, 40960.1807963845, 41487.58512414837, 42322.0, 29195.562066569444, 34562.65437345695, 35805.283894322485, 36132.277354452235, 36564.08589785277, 34965.47551786674, 35371.29257414786, 35512.64487355093, 35638.64361356353, 35836.0, 35515.28969420649, 35976.460353094204, 37435.812820935724, 38276.42585361166, 38363.23273534569, 29772.0, 31180.908668196505, 31712.524312134876, 31843.84078079595, 32716.018519444453, 20622.865742384314, 24131.155409561285, 24469.510609787347, 24522.44816785178, 25092.498150036532], "unit": "score", "name": "ext.html", "value": 18394.553969869714}, {"lowerIsBetter": false, "replicates": [354.5125452502808, 360.5151071808418, 361.86068363679976, 366.3588719740454, 368.434453114469, 15579.0, 16203.756943645854, 19077.809221907777, 19642.0, 20345.49136271596, 19086.0, 19261.036948152607, 19542.511437214078, 19624.01879906006, 19975.700364494543, 4958.181899986498, 5619.859503512404, 5760.251167348239, 5823.563232757539, 5824.650520968734, 4145.7098003139645, 4363.214621368153, 5535.335759708841, 6164.691765411734, 6419.422251997319, 6345.333739957307, 6381.521385896053, 6384.297727249998, 6385.680715964207, 6387.776427825027, 6244.3755624437645, 6275.372462753711, 6417.8395540111405, 6425.871482570369, 6430.16407866979, 5500.862478438031, 5537.169424586345, 5537.750801213955, 5550.69471179085, 5550.750216240279, 23944.760552394426, 24912.501749965082, 25111.874440627864, 25154.371140721447, 25155.37111572207, 2186.202036256755, 2310.145246258895, 2310.4801419680607, 2475.183189547445, 2919.722626350493, 14291.57125286243, 14714.117152970748, 14965.231432184972, 15159.848401515954, 15230.010049346756, 1640.9015459072493, 1745.3280487012464, 1778.644271145776, 1781.8574514038846, 1820.3446759166688, 79614.0, 102592.48703756508, 105297.0, 105633.47183264034, 106545.93454065437, 10249.12882405004, 10584.629537966135, 10749.83875241872, 10750.0, 10856.78286434267, 10995.395253260987, 12866.0, 12914.966802655765, 12927.15973461722, 12937.159084659466, 7410.740624078131, 8236.599778037747, 8489.745307640656, 8500.617472213766, 8592.656293748305, 8737.388382813142, 8756.4308319959, 8773.122687731176, 8866.911330886609, 8869.891263592051, 5638.746256418471, 6181.041938499539, 6250.843728906722, 6263.843403914848, 6370.808875733643, 1577.2113943028485, 1670.816210216875, 1747.100243374663, 1796.2545543599522, 1805.9187336569885, 794.3168874767695, 815.9347252219808, 906.5331354352513, 1017.6133069433567, 1078.563181911327, 19586.902065489583, 20307.0, 20377.796222037887, 20723.171073156904, 20776.75406102852, 826.4297634632085, 876.2201640539924, 879.134052957836, 936.424099179, 999.5302207962392, 9805.705828825146, 10585.52365143555, 10593.89406105929, 10606.681799546026, 10647.68056958277, 529386.7061329337, 534867.0, 537960.0, 652927.0, 663451.0, 115426.0, 123014.38492807657, 124905.0, 124935.0, 125590.0, 993.2749093162032, 1016.872890888639, 1022.1771473963531, 1056.9524371403152, 1067.3755852826184, 18004.819951800313, 18327.450176494727, 18365.63268734591, 18435.078246087374, 18559.44321670352, 49963.0, 50078.49921500738, 52192.0, 52441.475585245185, 52683.73658131685, 66686.99969500558, 69972.0, 71631.28368716454, 72684.63657681677, 73233.6338318305, 8051.4766540174705, 8060.556669383241, 8077.27304542594, 8097.919020809716, 8361.581920904053, 12334.074944379387, 13111.409986550438, 13212.867871321549, 13499.32503374847, 13537.1200871943, 11354.26197297173, 11402.372869492257, 11407.657770266906, 11455.885441145481, 11468.598599048993, 11213.887861121284, 11282.575471885319, 11312.264702794291, 11337.319760814378, 11692.47383867711, 10763.784724305626, 11438.885611143782, 11531.0, 11677.357745324089, 11723.120765942418, 5799.94200057994, 6413.967930160506, 7765.22347765219, 7933.880991785243, 8001.519908805491, 8863.822723545622, 11405.429728513707, 11482.77034459323, 11483.942580287045, 11561.942190288995], "unit": "score", "name": "jquery.html", "value": 9490.955673964387}, {"lowerIsBetter": false, "replicates": [1357.1992524410607, 1525.748251538496, 1567.8510541498558, 1798.6672465593865, 1939.2824654877697, 7976.521408715474, 8451.61967711453, 8629.482231066133, 8632.223099921006, 8670.43642163259, 7170.784876453702, 8583.184597463247, 8591.48451092935, 8596.914030859689, 8610.0, 2060.1965233558926, 2124.9787502125014, 2436.305652888927, 2453.914113006045, 2454.5949918263464, 2181.8000099945048, 2391.1630929174826, 2442.3039433761382, 2454.472288457981, 2459.0, 2364.2788949370433, 2438.792702620279, 2440.5362981033545, 2440.9511809763794, 2442.206282958046, 2381.988090059556, 2418.3107814272935, 2433.5741245282006, 2437.171361737009, 2438.475727718549, 2398.4723360860585, 2416.6979127609047, 2433.634954756783, 2435.135526887947, 2438.9268321950194, 8654.394192406535, 8733.301335893113, 8734.650613975433, 8740.213380795696, 8742.694005709833, 5359.383670877821, 5500.202470641734, 5535.363433205192, 5543.61194716366, 5548.278723765925, 3104.7205751482475, 3569.428891377393, 3653.671169594723, 3685.649863262986, 3695.0, 1038.5170895533613, 1059.6503153959175, 1068.3109394440542, 1088.7332603512111, 1101.9944900275527, 11834.171607987444, 11912.285262884254, 11970.521179152824, 12003.279803211835, 12209.511619535208, 4900.26496025599, 4913.992631510532, 4921.557059864558, 4959.355283813081, 4962.379702537183, 8498.872516912252, 10159.949200253952, 10224.795504089876, 10234.0, 10287.331323463952, 4746.454157771831, 4996.175631020841, 5506.476884695948, 5512.724363781795, 5533.944660553423, 4543.840965566189, 4591.219492686251, 4619.376384188092, 4794.640401969867, 4975.253711943237, 3942.1327307992196, 3942.1721438498234, 3947.3289540778137, 4006.5192176938954, 4013.3979903014783, 1297.8961683065331, 1307.3920626908532, 1314.6976195475095, 1322.041519898066, 1332.4070788499218, 1090.5692251560747, 1092.4756117063853, 1093.2074246171621, 1263.898888088969, 1341.2958196946486, 8211.850340952271, 8370.79073023167, 8376.036755773042, 8398.370122240856, 8420.53687047206, 1182.3142577305143, 1183.071289038101, 1195.3067221011793, 1205.5238180918489, 1211.4911737070452, 6309.463695585927, 6314.116023756677, 6370.076338930921, 6381.266154392211, 6386.521010924199, 10333.896661033445, 10589.0, 10723.356598604109, 10743.731406714895, 10763.300385474919, 8588.65645374178, 10497.52761125736, 10720.946395267974, 10754.247202695893, 10763.78472430547, 8090.83818323642, 8245.88680528133, 8314.833703326021, 8315.8336833263, 8332.958335208285, 7776.84446311082, 7834.0990786058055, 7865.252800983897, 7888.17174196724, 7922.168172341821, 9351.251899848132, 9611.855822162814, 9672.468014259002, 9721.756956076155, 9739.75650608712, 9911.10800028001, 9920.206383489447, 10041.899581004389, 10047.899521004696, 10086.445245511273, 6407.167068281094, 6432.581882177644, 6795.694193761194, 7043.964780176067, 7156.928430715626, 8161.183881612029, 8161.714339998071, 8202.958985205036, 8235.876461852957, 8255.628496717782, 7193.280671932974, 7304.5252058616015, 7338.522996005456, 7438.293362130589, 7472.589007604634, 7231.963840180765, 7319.890201646873, 7438.0, 7474.551526908185, 7701.807454813675, 7638.236176382317, 7657.234276572298, 7697.268759467842, 7697.345725613385, 7697.692092316244, 6918.204406493116, 6941.305869413019, 7002.089728335284, 7014.088168538057, 7065.57606543609, 7123.893141602984, 7132.322429369202, 7198.352148306678, 7208.098987626547, 7257.165425975869], "unit": "score", "name": "mootools.html", "value": 4906.785483050103}, {"lowerIsBetter": false, "replicates": [321.0721016263, 325.9348130373926, 327.79349010123616, 329.8515667949422, 330.6660273124145, 6475.0, 6508.6094834309915, 6513.413792758657, 6535.0850880876715, 6548.607083574977, 6407.199100112486, 6419.871602567946, 6419.871602567946, 6433.8391540211405, 6445.001024841145, 4042.272390969624, 4815.7110573365535, 4826.0, 4834.661573689843, 4860.295257187706, 4847.2971419144205, 4849.321095046696, 4854.393200849894, 4857.878553036167, 4869.659123861331, 4424.97787511062, 4562.954370456303, 4677.228257337535, 4801.4718380978065, 4812.951870481285, 4701.811927522929, 4757.333973243749, 4772.284157376386, 4774.212254977924, 4778.354922085508, 3931.3120203964477, 4075.4701888754566, 4086.1010577672864, 4106.178764247163, 4107.158032603309, 5225.529702326771, 5907.172995780594, 5998.880022399528, 6072.301685306202, 6086.11751296064, 4603.9769801151115, 5533.446655334475, 5548.611597188158, 5556.472135147154, 5570.136628822539, 6796.76211332601, 6813.727450902007, 6820.658967051628, 6823.283555226729, 6828.9317106829285, 4569.9314510282375, 4570.177368073745, 4574.0, 4578.679492435531, 4580.839670611546, 6348.174737284124, 6386.744530218785, 6450.903236451457, 6985.371316581482, 7176.892346614753, 4518.118966801442, 4572.839950601713, 4578.175928332866, 4581.79381927814, 4583.381243532081, 4710.9764451177525, 4741.573258406691, 4751.168545504523, 4759.048190361941, 4760.976195119002, 5533.253010843485, 5568.470995255444, 5576.470235327637, 5577.776888924398, 5602.467765562265, 5551.639143455663, 6815.522913396015, 6828.453723702191, 6829.487788415889, 6850.349216824394, 1519.187234829361, 1591.4191320168286, 1595.0350038226707, 1619.3846338391336, 1636.2882146266413, 1016.5577973581516, 1023.9385636861663, 1032.5147180825, 1033.4367769565604, 1044.4777611194402, 6459.935400645933, 6497.9350206498275, 6497.967510162419, 6517.185351831021, 6534.0, 7133.108361454818, 7135.429165666734, 7141.857162856713, 7142.714291428389, 7156.0, 6489.1888513935755, 6490.48076153916, 6496.415322620986, 6497.4477169441125, 6501.349865013555, 3748.175401411685, 3779.4519794630173, 3783.564890037626, 3792.222594368148, 3796.487474190949, 7090.326418990187, 7431.591262480507, 7471.97385059052, 7473.4021278297605, 7487.737929172453, 7239.312265334785, 7303.452241081834, 7320.524165929198, 7329.0, 7343.1555371131935, 7279.636018199175, 7432.0, 7440.144383395978, 7445.516041457288, 7445.813854653568, 6605.339466053356, 6798.354156355336, 7096.0420343253, 7109.751158709627, 7112.893306600508, 6012.6392416455155, 6907.240203577502, 6950.096487456598, 6968.895466568107, 6988.825279367853, 7400.555966642019, 7418.36943859778, 7425.294597013275, 7430.4798664093, 7529.510581812165, 4322.0, 4420.535843736361, 4433.113377324484, 4520.344550040291, 4535.297028960516, 6836.453083753388, 6887.311268873073, 6928.203256625351, 6997.9503074539225, 7019.6490175492045, 6159.23009623797, 6978.988046733094, 6988.37104660583, 6993.755218567326, 7011.404030657452, 6963.651817409211, 6971.860562788817, 6978.441724661913, 6983.755568555076, 6988.37104660583, 5636.971815140898, 6551.181102362205, 6766.594004359754, 6794.66026698673, 6859.382655561023, 6865.27914568983, 6972.0, 6972.372486476039, 7013.263607321362, 7032.824179395556, 6824.181098268041, 6832.282610326043, 6837.931620683729, 6863.656817159222, 6867.519273650996], "unit": "score", "name": "prototype.html", "value": 5024.808440328657}, {"lowerIsBetter": false, "replicates": [680.1124532485106, 685.561240805884, 735.6285076036601, 751.1887161865183, 778.097407007871, 14813.815569245231, 14852.33164507597, 14950.5514834555, 14965.176915269656, 15020.924895375536, 13618.387172577233, 14367.497137600187, 14367.712645747079, 14370.712585748279, 14371.209583472932, 712.8823744082221, 726.785598248518, 869.552180626976, 886.898006729228, 900.6172376739892, 720.5784615999646, 881.2377293641018, 881.4534988307258, 884.2395539835736, 885.4244740918423, 930.9208717259041, 931.3061768982118, 932.282142750082, 932.282142750082, 932.2914584915479, 748.4424104042496, 886.6807949138305, 910.6858133943845, 911.252772726358, 924.3483344242327, 689.9068625735512, 690.1063123255396, 690.4200471603876, 691.0981169573704, 691.1050190003957, 14947.701045979129, 14973.401063957428, 14978.550643480714, 14981.0262332948, 14983.400663973427, 12733.554325598652, 12885.87114128856, 12888.871111288861, 12926.353682315847, 12940.0, 9894.20846332299, 9969.307662176065, 9974.601015959353, 9986.600535978552, 9991.500424978722, 3498.2303893143467, 3528.435450327935, 3534.8762793302367, 3539.9115022124397, 3539.920324301087, 74695.0, 75935.0, 76521.61739191324, 78156.60921695469, 82178.0, 9372.90627093734, 9374.296927730311, 9374.484403357881, 9401.57692903821, 9615.471149086727, 16589.83410165907, 19945.401637950883, 20018.299359522345, 20031.799682002995, 20037.799622003884, 6702.798916032527, 7188.029616001877, 7191.424686025105, 7410.962465254868, 7498.775036748906, 3537.2748586539697, 4187.853425130106, 4190.559991200941, 4201.873943781691, 4206.242876282237, 3526.7354948378975, 3528.558930133733, 3537.7346698997676, 3539.752217344761, 3542.415501442233, 630.8139098965817, 635.9809205723835, 643.5495153392644, 645.2031740800109, 656.3567703650353, 480.9014152098811, 530.3688610553429, 583.5360888093976, 594.5184400635499, 597.3071237364636, 8267.503949763033, 8276.29651479619, 8455.873161902577, 8457.57712114404, 8603.397762156714, 594.337313895004, 600.5255847880126, 605.6063558686889, 620.6369273974685, 624.6533174088333, 3365.3774051800006, 3915.001674572966, 3947.2500224957166, 4050.3721923101966, 4139.275626765304, 96402.51798741102, 97255.51372243236, 97787.0, 97882.0, 97999.51000244953, 69128.6543567289, 78500.42999139985, 81040.59479702682, 82248.0, 84178.0, 73107.90338144932, 73328.866979312, 73624.26375736282, 73720.0, 74493.62753186199, 8027.959860200662, 8082.313003394777, 8193.296212250063, 8293.83412331738, 8326.583670816313, 42137.0, 42226.788866055475, 44338.0, 47879.76060119816, 48901.75549122231, 69242.3075769256, 69810.0, 69989.0, 70043.29956700368, 70330.64834675999, 9824.263180261367, 9844.606215751577, 9903.0, 10030.749231269278, 10120.949395252977, 10710.62512812079, 10910.61812836547, 11060.22578419535, 11146.275492092987, 11802.291862488279, 10361.585536578452, 10496.370217786956, 10499.422531760827, 10592.152627789605, 10605.151587872797, 10554.525046372779, 10584.682459526226, 10589.099926506333, 10637.840432393365, 10711.57153713874, 8708.259797917248, 8740.0, 10218.54016569271, 10265.948670256601, 10653.680389588324, 8280.296174824967, 8399.832003360021, 8560.657573696983, 8735.825283494421, 8738.344624153087, 8396.412251142361, 8457.238848503419, 8548.786280343042, 8580.957095214733, 8614.12422076172], "unit": "score", "name": "yui.html", "value": 6700.94867696343}], "name": "dromaeo_css", "value": 7383.993068844784}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 111.0, 111.0, 112.0, 113.0, 115.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.2}, {"lowerIsBetter": true, "replicates": [161.0, 119.0, 148.0, 158.0, 123.0, 150.0, 143.0, 109.0, 180.0, 142.0], "unit": "score", "name": "audio-beat-detection", "value": 143.3}, {"lowerIsBetter": true, "replicates": [179.0, 184.0, 188.0, 184.0, 187.0, 185.0, 185.0, 193.0, 253.0, 183.0], "unit": "score", "name": "audio-dft", "value": 192.1}, {"lowerIsBetter": true, "replicates": [72.0, 76.0, 88.0, 82.0, 56.0, 57.0, 56.0, 81.0, 77.0, 54.0], "unit": "score", "name": "audio-fft", "value": 69.9}, {"lowerIsBetter": true, "replicates": [93.0, 99.0, 125.0, 79.0, 80.0, 84.0, 111.0, 78.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 94.2}, {"lowerIsBetter": true, "replicates": [84.0, 89.0, 84.0, 91.0, 84.0, 89.0, 84.0, 90.0, 84.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 95.0, 93.0, 95.0, 93.0, 93.0, 93.0, 94.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.5}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 87.0, 88.0, 84.0, 85.0, 85.0, 85.0, 85.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 86.0}, {"lowerIsBetter": true, "replicates": [53.0, 53.0, 55.0, 52.0, 55.0, 54.0, 53.0, 63.0, 52.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.2}, {"lowerIsBetter": true, "replicates": [65.0, 63.0, 79.0, 73.0, 70.0, 65.0, 64.0, 65.0, 66.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.5}, {"lowerIsBetter": true, "replicates": [84.0, 104.0, 104.0, 105.0, 78.0, 81.0, 82.0, 84.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 89.0}, {"lowerIsBetter": true, "replicates": [127.0, 129.0, 125.0, 125.0, 127.0, 124.0, 126.0, 124.0, 129.0, 120.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [138.0, 122.0, 144.0, 136.0, 139.0, 122.0, 141.0, 166.0, 166.0, 161.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 84.0, 73.0, 67.0, 66.0, 68.0, 68.0, 66.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken", "value": 1426.1}]} 14:43:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,59]]", "result": "1426.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,59]]", "result": "7384.00"}}} 14:43:00 INFO - Return code: 0 14:43:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 14:43:00 INFO - # TBPL SUCCESS # 14:43:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:43:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:43:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:43:00 INFO - 2016-02-24 14:43:00.749 screenresolution[1687:9723] starting screenresolution argv=screenresolution get 14:43:00 INFO - 2016-02-24 14:43:00.752 screenresolution[1687:9723] Display 0: 1600x1200x32@60 14:43:00 INFO - 2016-02-24 14:43:00.758 screenresolution[1688:9726] starting screenresolution argv=screenresolution list 14:43:00 INFO - Available Modes on Display 0 14:43:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:43:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:43:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:43:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:43:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:43:00 INFO - Intel Iris: 14:43:00 INFO - Chipset Model: Intel Iris 14:43:00 INFO - Type: GPU 14:43:00 INFO - Bus: Built-In 14:43:00 INFO - VRAM (Dynamic, Max): 1536 MB 14:43:00 INFO - Vendor: Intel (0x8086) 14:43:00 INFO - Device ID: 0x0a2e 14:43:00 INFO - Revision ID: 0x0009 14:43:00 INFO - Displays: 14:43:00 INFO - Display: 14:43:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:43:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:43:00 INFO - Display Serial Number: 1600x1200 60 14:43:00 INFO - Main Display: Yes 14:43:00 INFO - Mirror: Off 14:43:00 INFO - Online: Yes 14:43:00 INFO - Rotation: Supported 14:43:00 INFO - Return code: 0 14:43:00 INFO - Running post-action listener: _resource_record_post_action 14:43:00 INFO - Running post-run listener: _resource_record_post_run 14:43:02 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 39462400; Write bytes: 708322304; Read time: 428; Write time: 1936 14:43:02 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 407007744; Write bytes: 395101696; Read time: 29903; Write time: 724 14:43:02 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 32316928; Write bytes: 301657600; Read time: 341; Write time: 1178 14:43:02 INFO - Running post-run listener: _upload_blobber_files 14:43:02 INFO - Blob upload gear active. 14:43:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:43:02 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 14:43:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:43:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:43:02 INFO - (blobuploader) - INFO - Open directory for files ... 14:43:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:43:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:43:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:03 INFO - (blobuploader) - INFO - Done attempting. 14:43:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:43:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:43:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:43:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:43:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:43:04 INFO - (blobuploader) - INFO - Done attempting. 14:43:04 INFO - (blobuploader) - INFO - Iteration through files over. 14:43:04 INFO - Return code: 0 14:43:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:43:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:43:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d9da6600e91c0e1ab3f37c747515ba4351106cb281d123098e746ca2bb5c1375ec0728a21882cc67cdbfb48ac30629d72e4312bc790ecd82a917830454275f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/783406e3f31d3705fd8a4d13d90ffddc6c044fe830551b8a07947f072da1df6b90e610addcbc0fbcbea5ccae9184c766a0ca12a02c18f4bb6c85eaa42e4a74e0"} 14:43:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:43:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:43:04 INFO - Contents: 14:43:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d9da6600e91c0e1ab3f37c747515ba4351106cb281d123098e746ca2bb5c1375ec0728a21882cc67cdbfb48ac30629d72e4312bc790ecd82a917830454275f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/783406e3f31d3705fd8a4d13d90ffddc6c044fe830551b8a07947f072da1df6b90e610addcbc0fbcbea5ccae9184c766a0ca12a02c18f4bb6c85eaa42e4a74e0"} 14:43:04 INFO - Running post-run listener: copy_logs_to_upload_dir 14:43:04 INFO - Copying logs to upload dir... 14:43:04 INFO - mkdir: /builds/slave/test/build/upload/logs 14:43:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.639644 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-24 14:43:04.688217) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 14:43:04.691259) ========= 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.tarGM0WVR7/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.TKB2PuugOa/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d9da6600e91c0e1ab3f37c747515ba4351106cb281d123098e746ca2bb5c1375ec0728a21882cc67cdbfb48ac30629d72e4312bc790ecd82a917830454275f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/783406e3f31d3705fd8a4d13d90ffddc6c044fe830551b8a07947f072da1df6b90e610addcbc0fbcbea5ccae9184c766a0ca12a02c18f4bb6c85eaa42e4a74e0"} build_url:https://queue.taskcluster.net/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010738 build_url: 'https://queue.taskcluster.net/v1/task/bcTU22iOT1aMrVlqF5NIbQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d9da6600e91c0e1ab3f37c747515ba4351106cb281d123098e746ca2bb5c1375ec0728a21882cc67cdbfb48ac30629d72e4312bc790ecd82a917830454275f0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/783406e3f31d3705fd8a4d13d90ffddc6c044fe830551b8a07947f072da1df6b90e610addcbc0fbcbea5ccae9184c766a0ca12a02c18f4bb6c85eaa42e4a74e0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-24 14:43:04.718386) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 14:43:04.718863) ========= 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.tarGM0WVR7/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.TKB2PuugOa/Listeners TMPDIR=/var/folders/_q/ws1b_mf156sfthc66fnphd6r00000w/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.005096 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-24 14:43:04.768242) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 14:43:04.768566) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-24 14:43:04.768963) ========= ========= Total master_lag: 4.47 =========