builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0134 starttime: 1454732985.54 results: success (0) buildid: 20160205184242 builduid: b81e17307b524502a4d5965ed72b6c98 revision: 0885625045f0d07ab8ce6d46d8b354939aa3b617 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:45.540373) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:45.540809) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:45.541102) ========= 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.udTnQUDdPb/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.JdOvlkOwcW/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005491 basedir: '/builds/slave/test' ========= master_lag: 0.18 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:45.723444) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:45.723897) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:45.854265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:45.854841) ========= 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.udTnQUDdPb/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.JdOvlkOwcW/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005424 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:45.945615) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:45.945900) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:45.946305) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:45.946610) ========= 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.udTnQUDdPb/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.JdOvlkOwcW/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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-05 20:29:45-- 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% 68.1M=0s 2016-02-05 20:29:46 (68.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.563907 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:46.593626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:46.594024) ========= 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.udTnQUDdPb/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.JdOvlkOwcW/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.026355 ========= master_lag: 0.15 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:46.771054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-05 20:29:46.771430) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0885625045f0d07ab8ce6d46d8b354939aa3b617 --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 0885625045f0d07ab8ce6d46d8b354939aa3b617 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.udTnQUDdPb/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.JdOvlkOwcW/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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-05 20:29:46,893 truncating revision to first 12 chars 2016-02-05 20:29:46,894 Setting DEBUG logging. 2016-02-05 20:29:46,894 attempt 1/10 2016-02-05 20:29:46,894 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0885625045f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-05 20:29:47,953 unpacking tar archive at: mozilla-central-0885625045f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.310767 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-05 20:29:48.159014) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:48.159317) ========= echo 0885625045f0d07ab8ce6d46d8b354939aa3b617 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'0885625045f0d07ab8ce6d46d8b354939aa3b617'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.udTnQUDdPb/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.JdOvlkOwcW/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 0885625045f0d07ab8ce6d46d8b354939aa3b617 program finished with exit code 0 elapsedTime=0.007736 script_repo_revision: '0885625045f0d07ab8ce6d46d8b354939aa3b617' ========= master_lag: 0.08 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:48.251785) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:48.252100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-05 20:29:48.470420) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-02-05 20:29:48.470682) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.udTnQUDdPb/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.JdOvlkOwcW/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 20:29:48 INFO - MultiFileLogger online at 20160205 20:29:48 in /builds/slave/test 20:29:48 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 20:29:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:29:48 INFO - {'append_to_log': False, 20:29:48 INFO - 'base_work_dir': '/builds/slave/test', 20:29:48 INFO - 'blob_upload_branch': 'Firefox', 20:29:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:29:48 INFO - 'branch': 'Firefox', 20:29:48 INFO - 'buildbot_json_path': 'buildprops.json', 20:29:48 INFO - 'config_files': ('talos/mac_config.py',), 20:29:48 INFO - 'default_actions': ('clobber', 20:29:48 INFO - 'read-buildbot-config', 20:29:48 INFO - 'download-and-extract', 20:29:48 INFO - 'populate-webroot', 20:29:48 INFO - 'create-virtualenv', 20:29:48 INFO - 'install', 20:29:48 INFO - 'run-tests'), 20:29:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:29:48 INFO - 'download_minidump_stackwalk': True, 20:29:48 INFO - 'download_symbols': 'ondemand', 20:29:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:29:48 INFO - 'tooltool.py': '/tools/tooltool.py', 20:29:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:29:48 INFO - '/tools/misc-python/virtualenv.py')}, 20:29:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:29:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:29:48 INFO - 'installer_path': 'installer.exe', 20:29:48 INFO - 'log_level': 'info', 20:29:48 INFO - 'log_name': 'talos', 20:29:48 INFO - 'log_to_console': True, 20:29:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:29:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:29:48 INFO - 'opt_config_files': (), 20:29:48 INFO - 'pip_index': False, 20:29:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:29:48 INFO - 'cmd': ('bash', 20:29:48 INFO - '-c', 20:29:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:29:48 INFO - 'enabled': True, 20:29:48 INFO - 'halt_on_failure': False, 20:29:48 INFO - 'name': 'check_screen_resolution'},), 20:29:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:29:48 INFO - 'cmd': ('bash', 20:29:48 INFO - '-c', 20:29:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:29:48 INFO - 'enabled': True, 20:29:48 INFO - 'halt_on_failure': False, 20:29:48 INFO - 'name': 'check_screen_resolution'},), 20:29:48 INFO - 'run_cmd_checks_enabled': True, 20:29:48 INFO - 'sps_profile': False, 20:29:48 INFO - 'sps_profile_interval': 0, 20:29:48 INFO - 'suite': 'dromaeojs-e10s', 20:29:48 INFO - 'system_bits': '32', 20:29:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:29:48 INFO - 'title': 't-yosemite-r7-0134', 20:29:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:29:48 INFO - 'use_talos_json': True, 20:29:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:29:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:29:48 INFO - 'work_dir': 'build'} 20:29:48 INFO - ##### 20:29:48 INFO - ##### Running clobber step. 20:29:48 INFO - ##### 20:29:48 INFO - Running pre-action listener: _resource_record_pre_action 20:29:48 INFO - Running main action method: clobber 20:29:48 INFO - rmtree: /builds/slave/test/build 20:29:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:29:50 INFO - Running post-action listener: _resource_record_post_action 20:29:50 INFO - ##### 20:29:50 INFO - ##### Running read-buildbot-config step. 20:29:50 INFO - ##### 20:29:50 INFO - Running pre-action listener: _resource_record_pre_action 20:29:50 INFO - Running main action method: read_buildbot_config 20:29:50 INFO - Using buildbot properties: 20:29:50 INFO - { 20:29:50 INFO - "project": "", 20:29:50 INFO - "product": "firefox", 20:29:50 INFO - "script_repo_revision": "production", 20:29:50 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 20:29:50 INFO - "repository": "", 20:29:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 20:29:50 INFO - "buildid": "20160205184242", 20:29:50 INFO - "pgo_build": "False", 20:29:50 INFO - "basedir": "/builds/slave/test", 20:29:50 INFO - "buildnumber": 100, 20:29:50 INFO - "slavename": "t-yosemite-r7-0134", 20:29:50 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 20:29:50 INFO - "platform": "yosemite_r7", 20:29:50 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 20:29:50 INFO - "branch": "mozilla-central", 20:29:50 INFO - "repo_path": "mozilla-central", 20:29:50 INFO - "revision": "0885625045f0d07ab8ce6d46d8b354939aa3b617", 20:29:50 INFO - "stage_platform": "macosx64", 20:29:50 INFO - "builduid": "b81e17307b524502a4d5965ed72b6c98", 20:29:50 INFO - "slavebuilddir": "test" 20:29:50 INFO - } 20:29:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 20:29:50 INFO - Running post-action listener: _resource_record_post_action 20:29:50 INFO - ##### 20:29:50 INFO - ##### Running download-and-extract step. 20:29:50 INFO - ##### 20:29:50 INFO - Running pre-action listener: _resource_record_pre_action 20:29:50 INFO - Running main action method: download_and_extract 20:29:50 INFO - mkdir: /builds/slave/test/build/tests 20:29:50 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')]} 20:29:50 INFO - https://queue.taskcluster.net/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:29:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/test_packages.json 20:29:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/test_packages.json 20:29:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:29:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:29:58 INFO - Downloaded 1277 bytes. 20:29:58 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:29:58 INFO - Using the following test package requirements: 20:29:58 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:29:58 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:29:58 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 20:29:58 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:29:58 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 20:29:58 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:29:58 INFO - u'jsshell-mac.zip'], 20:29:58 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:29:58 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 20:29:58 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:29:58 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:29:58 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 20:29:58 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:29:58 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 20:29:58 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:29:58 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 20:29:58 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 20:29:58 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 20:29:58 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 20:29:58 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:29:58 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')]} 20:29:58 INFO - https://queue.taskcluster.net/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:29:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:29:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:29:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/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 20:29:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/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 20:30:02 INFO - Downloaded 17751695 bytes. 20:30:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:30:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 20:30:05 INFO - Return code: 0 20:30:05 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 20:30: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')]} 20:30:05 INFO - https://queue.taskcluster.net/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 20:30:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:30:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 20:30:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/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 20:30:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/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 20:30:06 INFO - Downloaded 17751695 bytes. 20:30: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'] 20:30: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 20:30:10 INFO - Return code: 0 20:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:10 INFO - https://queue.taskcluster.net/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 20:30:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 20:30:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 20:30:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/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 20:30:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/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 20:30:11 INFO - Downloaded 10706547 bytes. 20:30:11 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'] 20:30:11 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 20:30:11 INFO - Return code: 0 20:30:11 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')]} 20:30:11 INFO - https://queue.taskcluster.net/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 20:30:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:30:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:30:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 20:30:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/btYcCT2YSQe818na9Ue--g/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 20:30:15 INFO - Downloaded 111812251 bytes. 20:30:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:30:15 INFO - mkdir: /builds/slave/test/properties 20:30:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:30:15 INFO - Writing to file /builds/slave/test/properties/build_url 20:30:15 INFO - Contents: 20:30:15 INFO - build_url:https://queue.taskcluster.net/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 20:30:16 INFO - Running post-action listener: _resource_record_post_action 20:30:16 INFO - Running post-action listener: set_extra_try_arguments 20:30:16 INFO - ##### 20:30:16 INFO - ##### Running populate-webroot step. 20:30:16 INFO - ##### 20:30:16 INFO - Running pre-action listener: _resource_record_pre_action 20:30:16 INFO - Running main action method: populate_webroot 20:30:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:30:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:30:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:30:16 INFO - '--tppagecycles', 20:30:16 INFO - '7'], 20:30:16 INFO - 'tests': ['tsvgm']}}, 20:30:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:30:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:30:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:30:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 20:30:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:30:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:30:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:30:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:16 INFO - 'talos_options': ['--e10s'], 20:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:30:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:16 INFO - 'tests': ['damp', 'tps']}, 20:30:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:16 INFO - 'talos_options': ['--e10s'], 20:30:16 INFO - 'tests': ['damp', 'tps']}, 20:30:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:30:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:30:16 INFO - 'other': {'tests': ['a11yr', 20:30:16 INFO - 'ts_paint', 20:30:16 INFO - 'tpaint', 20:30:16 INFO - 'sessionrestore', 20:30:16 INFO - 'sessionrestore_no_auto_restore']}, 20:30:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:30:16 INFO - 'tests': ['a11yr', 20:30:16 INFO - 'ts_paint', 20:30:16 INFO - 'tpaint', 20:30:16 INFO - 'sessionrestore', 20:30:16 INFO - 'sessionrestore_no_auto_restore']}, 20:30:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:30:16 INFO - 'tests': ['a11yr', 20:30:16 INFO - 'ts_paint', 20:30:16 INFO - 'tpaint', 20:30:16 INFO - 'sessionrestore', 20:30:16 INFO - 'sessionrestore_no_auto_restore']}, 20:30:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:30:16 INFO - 'tests': ['a11yr', 20:30:16 INFO - 'ts_paint', 20:30:16 INFO - 'tpaint', 20:30:16 INFO - 'sessionrestore', 20:30:16 INFO - 'sessionrestore_no_auto_restore']}, 20:30:16 INFO - 'other_l64': {'tests': ['a11yr', 20:30:16 INFO - 'ts_paint', 20:30:16 INFO - 'tpaint', 20:30:16 INFO - 'sessionrestore', 20:30:16 INFO - 'sessionrestore_no_auto_restore']}, 20:30:16 INFO - 'other_nol64': {'tests': ['a11yr', 20:30:16 INFO - 'ts_paint', 20:30:16 INFO - 'tpaint', 20:30:16 INFO - 'sessionrestore', 20:30:16 INFO - 'sessionrestore_no_auto_restore']}, 20:30:16 INFO - 'svgr': {'tests': ['tsvgx', 20:30:16 INFO - 'tsvgr_opacity', 20:30:16 INFO - 'tart', 20:30:16 INFO - 'tscrollx', 20:30:16 INFO - 'cart']}, 20:30:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:30:16 INFO - 'tests': ['tsvgx', 20:30:16 INFO - 'tsvgr_opacity', 20:30:16 INFO - 'tart', 20:30:16 INFO - 'tscrollx', 20:30:16 INFO - 'cart']}, 20:30:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:16 INFO - 'tests': ['tp5o']}, 20:30:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:16 INFO - 'talos_options': ['--e10s'], 20:30:16 INFO - 'tests': ['tp5o']}, 20:30:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:16 INFO - 'talos_options': ['--xperf_path', 20:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:30:16 INFO - 'tests': ['tp5n']}, 20:30:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:30:16 INFO - 'talos_options': ['--e10s', 20:30:16 INFO - '--xperf_path', 20:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:30:16 INFO - 'tests': ['tp5n']}}, 20:30:16 INFO - 'talos.zip': {'path': '', 20:30:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:30:16 INFO - Running post-action listener: _resource_record_post_action 20:30:16 INFO - ##### 20:30:16 INFO - ##### Running create-virtualenv step. 20:30:16 INFO - ##### 20:30:16 INFO - Running pre-action listener: _resource_record_pre_action 20:30:16 INFO - Running main action method: create_virtualenv 20:30:16 INFO - Creating virtualenv /builds/slave/test/build/venv 20:30:16 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 20:30:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:30:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:30:16 INFO - Using real prefix '/tools/python27' 20:30:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:30:16 INFO - Installing distribute.............................................................................................................................................................................................done. 20:30:19 INFO - Installing pip.................done. 20:30:19 INFO - Return code: 0 20:30:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10757ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075824c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98db464830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107420d30>, '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 0x107283db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107416b20>, '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.udTnQUDdPb/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.JdOvlkOwcW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 20:30:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 20:30:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 20:30:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.udTnQUDdPb/Render', 20:30:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:30:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:30:19 INFO - 'HOME': '/Users/cltbld', 20:30:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:30:19 INFO - 'LOGNAME': 'cltbld', 20:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:19 INFO - 'MOZ_NO_REMOTE': '1', 20:30:19 INFO - 'NO_EM_RESTART': '1', 20:30:19 INFO - 'PAGER': '/bin/cat', 20:30:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:19 INFO - 'PWD': '/builds/slave/test', 20:30:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:30:19 INFO - 'SHELL': '/bin/bash', 20:30:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdOvlkOwcW/Listeners', 20:30:19 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 20:30:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:30:19 INFO - 'USER': 'cltbld', 20:30:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:30:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:19 INFO - 'XPC_FLAGS': '0x0', 20:30:19 INFO - 'XPC_SERVICE_NAME': '0', 20:30:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:20 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 20:30:20 INFO - Cleaning up... 20:30:20 INFO - Return code: 0 20:30:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10757ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075824c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98db464830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107420d30>, '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 0x107283db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107416b20>, '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.udTnQUDdPb/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.JdOvlkOwcW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 20:30:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 20:30:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 20:30:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.udTnQUDdPb/Render', 20:30:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:30:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:30:20 INFO - 'HOME': '/Users/cltbld', 20:30:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:30:20 INFO - 'LOGNAME': 'cltbld', 20:30:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:20 INFO - 'MOZ_NO_REMOTE': '1', 20:30:20 INFO - 'NO_EM_RESTART': '1', 20:30:20 INFO - 'PAGER': '/bin/cat', 20:30:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:30:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:20 INFO - 'PWD': '/builds/slave/test', 20:30:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:30:20 INFO - 'SHELL': '/bin/bash', 20:30:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdOvlkOwcW/Listeners', 20:30:20 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 20:30:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:30:20 INFO - 'USER': 'cltbld', 20:30:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:30:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:30:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:20 INFO - 'XPC_FLAGS': '0x0', 20:30:20 INFO - 'XPC_SERVICE_NAME': '0', 20:30:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:30:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:20 INFO - Downloading/unpacking psutil>=0.7.1 20:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:30:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:30:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:30:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:30:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:30:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:30:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:30:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:30:23 INFO - Installing collected packages: psutil 20:30:23 INFO - Running setup.py install for psutil 20:30:23 INFO - building 'psutil._psutil_osx' extension 20:30:23 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 20:30:23 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 20:30:23 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 20:30:24 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 20:30:24 INFO - building 'psutil._psutil_posix' extension 20:30:24 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 20:30:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:30:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:30:24 INFO - ^ 20:30:24 INFO - 1 warning generated. 20:30:24 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 20:30:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:30:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:30:24 INFO - Successfully installed psutil 20:30:24 INFO - Cleaning up... 20:30:24 INFO - Return code: 0 20:30:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:30:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10757ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075824c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98db464830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107420d30>, '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 0x107283db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107416b20>, '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.udTnQUDdPb/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.JdOvlkOwcW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 20:30:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 20:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 20:30:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.udTnQUDdPb/Render', 20:30:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:30:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:30:24 INFO - 'HOME': '/Users/cltbld', 20:30:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:30:24 INFO - 'LOGNAME': 'cltbld', 20:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:24 INFO - 'MOZ_NO_REMOTE': '1', 20:30:24 INFO - 'NO_EM_RESTART': '1', 20:30:24 INFO - 'PAGER': '/bin/cat', 20:30:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:24 INFO - 'PWD': '/builds/slave/test', 20:30:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:30:24 INFO - 'SHELL': '/bin/bash', 20:30:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdOvlkOwcW/Listeners', 20:30:24 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 20:30:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:30:24 INFO - 'USER': 'cltbld', 20:30:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:30:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:24 INFO - 'XPC_FLAGS': '0x0', 20:30:24 INFO - 'XPC_SERVICE_NAME': '0', 20:30:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:30:24 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 20:30:24 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 20:30:24 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 20:30:24 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 20:30:24 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 20:30:24 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 20:30:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:30:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:30:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:30:27 INFO - Installing collected packages: mozsystemmonitor 20:30:27 INFO - Running setup.py install for mozsystemmonitor 20:30:27 INFO - Successfully installed mozsystemmonitor 20:30:27 INFO - Cleaning up... 20:30:27 INFO - Return code: 0 20:30:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30: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', '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 0x10757ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075824c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98db464830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107420d30>, '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 0x107283db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107416b20>, '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.udTnQUDdPb/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.JdOvlkOwcW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 20:30: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:30: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 blobuploader==1.2.4 20:30:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.udTnQUDdPb/Render', 20:30:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:30:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:30:27 INFO - 'HOME': '/Users/cltbld', 20:30:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:30:27 INFO - 'LOGNAME': 'cltbld', 20:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:27 INFO - 'MOZ_NO_REMOTE': '1', 20:30:27 INFO - 'NO_EM_RESTART': '1', 20:30:27 INFO - 'PAGER': '/bin/cat', 20:30:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:27 INFO - 'PWD': '/builds/slave/test', 20:30:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:30:27 INFO - 'SHELL': '/bin/bash', 20:30:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdOvlkOwcW/Listeners', 20:30:27 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 20:30:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:30:27 INFO - 'USER': 'cltbld', 20:30:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:30:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:27 INFO - 'XPC_FLAGS': '0x0', 20:30:27 INFO - 'XPC_SERVICE_NAME': '0', 20:30:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:30:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:27 INFO - Downloading/unpacking blobuploader==1.2.4 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30:29 INFO - Downloading blobuploader-1.2.4.tar.gz 20:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:30:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:30:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:30:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:30:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:30:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:30:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30:30 INFO - Downloading docopt-0.6.1.tar.gz 20:30:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:30:31 INFO - Installing collected packages: blobuploader, requests, docopt 20:30:31 INFO - Running setup.py install for blobuploader 20:30:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:30:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:30:31 INFO - Running setup.py install for requests 20:30:31 INFO - Running setup.py install for docopt 20:30:31 INFO - Successfully installed blobuploader requests docopt 20:30:31 INFO - Cleaning up... 20:30:31 INFO - Return code: 0 20:30:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:31 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 0x10757ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075824c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98db464830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107420d30>, '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 0x107283db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107416b20>, '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.udTnQUDdPb/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.JdOvlkOwcW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 20:30:31 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 20:30:31 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 20:30:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.udTnQUDdPb/Render', 20:30:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:30:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:30:31 INFO - 'HOME': '/Users/cltbld', 20:30:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:30:31 INFO - 'LOGNAME': 'cltbld', 20:30:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:31 INFO - 'MOZ_NO_REMOTE': '1', 20:30:31 INFO - 'NO_EM_RESTART': '1', 20:30:31 INFO - 'PAGER': '/bin/cat', 20:30:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:30:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:31 INFO - 'PWD': '/builds/slave/test', 20:30:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:30:31 INFO - 'SHELL': '/bin/bash', 20:30:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdOvlkOwcW/Listeners', 20:30:31 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 20:30:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:30:31 INFO - 'USER': 'cltbld', 20:30:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:30:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:30:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:31 INFO - 'XPC_FLAGS': '0x0', 20:30:31 INFO - 'XPC_SERVICE_NAME': '0', 20:30:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:30:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:30:32 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-Ij52U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:30:32 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ABVCy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:30:32 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-ucKNrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:30:32 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-nKf5I6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:30:32 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-HS0xr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:30:32 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-2mYuiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:30:32 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-tPNPuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:30:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:30:32 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-cx3bKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:30:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-VuuUUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:30:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-k0Ijng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:30:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-9VQ2cE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:30:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-KYAuUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:30:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-nBmsUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:30:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-LGu3Rr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:30:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-pjaqmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:30:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-OXsMdB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:30:33 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-wExCLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:30:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:30:33 INFO - Running setup.py install for manifestparser 20:30:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:30:34 INFO - Running setup.py install for mozcrash 20:30:34 INFO - Running setup.py install for mozdebug 20:30:34 INFO - Running setup.py install for mozdevice 20:30:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:30:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:30:34 INFO - Running setup.py install for mozfile 20:30:34 INFO - Running setup.py install for mozhttpd 20:30:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:30:34 INFO - Running setup.py install for mozinfo 20:30:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:30:34 INFO - Running setup.py install for mozInstall 20:30:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:30:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:30:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:30:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:30:35 INFO - Running setup.py install for mozleak 20:30:35 INFO - Running setup.py install for mozlog 20:30:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:30:35 INFO - Running setup.py install for moznetwork 20:30:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:30:35 INFO - Running setup.py install for mozprocess 20:30:35 INFO - Running setup.py install for mozprofile 20:30:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:30:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:30:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:30:35 INFO - Running setup.py install for mozrunner 20:30:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:30:36 INFO - Running setup.py install for mozscreenshot 20:30:36 INFO - Running setup.py install for moztest 20:30:36 INFO - Running setup.py install for mozversion 20:30:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:30:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:30:36 INFO - Cleaning up... 20:30:36 INFO - Return code: 0 20:30:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:36 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 0x10757ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075824c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98db464830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107420d30>, '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 0x107283db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107416b20>, '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.udTnQUDdPb/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.JdOvlkOwcW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 20:30:36 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 20:30:36 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 20:30:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.udTnQUDdPb/Render', 20:30:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:30:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:30:36 INFO - 'HOME': '/Users/cltbld', 20:30:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:30:36 INFO - 'LOGNAME': 'cltbld', 20:30:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:36 INFO - 'MOZ_NO_REMOTE': '1', 20:30:36 INFO - 'NO_EM_RESTART': '1', 20:30:36 INFO - 'PAGER': '/bin/cat', 20:30:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:30:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:36 INFO - 'PWD': '/builds/slave/test', 20:30:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:30:36 INFO - 'SHELL': '/bin/bash', 20:30:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdOvlkOwcW/Listeners', 20:30:36 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 20:30:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:30:36 INFO - 'USER': 'cltbld', 20:30:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:30:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:30:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:36 INFO - 'XPC_FLAGS': '0x0', 20:30:36 INFO - 'XPC_SERVICE_NAME': '0', 20:30:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:30:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:30:36 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-1ouOsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:30:36 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)) 20:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:30:36 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-0pkKU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:30:36 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)) 20:30:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:30:36 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-beAwyZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:30:37 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)) 20:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:30:37 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-fLnZWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:30:37 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)) 20:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:30:37 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-SL83dK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:30:37 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)) 20:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:30:37 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-rt4EkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:30:37 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)) 20:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:30:37 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-WeDZb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:30:37 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)) 20:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:30:37 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-hsLHqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:30:37 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)) 20:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:30:37 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-hqqMun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:30:37 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)) 20:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:30:37 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-icXE6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:30:37 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)) 20:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:30:37 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-CBPVmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:30:37 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)) 20:30:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:30:37 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-h_bJB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:30:38 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)) 20:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:30:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-16YQq2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:30:38 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)) 20:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:30:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-gECRPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:30:38 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)) 20:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:30:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-58cUVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:30:38 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)) 20:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:30:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-uteTYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:30:38 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)) 20:30:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:30:38 INFO - Running setup.py (path:/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/pip-yHifxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:30:38 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)) 20:30:38 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)) 20:30:38 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)) 20:30:38 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)) 20:30:38 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)) 20:30:38 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)) 20:30:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:30:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:30:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:30:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:30:41 INFO - Downloading blessings-1.6.tar.gz 20:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:30:41 INFO - Installing collected packages: blessings 20:30:41 INFO - Running setup.py install for blessings 20:30:42 INFO - Successfully installed blessings 20:30:42 INFO - Cleaning up... 20:30:42 INFO - Return code: 0 20:30:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:30:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:30:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:30:42 INFO - Reading from file tmpfile_stdout 20:30:42 INFO - Current package versions: 20:30:42 INFO - blessings == 1.6 20:30:42 INFO - blobuploader == 1.2.4 20:30:42 INFO - docopt == 0.6.1 20:30:42 INFO - manifestparser == 1.1 20:30:42 INFO - mozInstall == 1.12 20:30:42 INFO - mozcrash == 0.16 20:30:42 INFO - mozdebug == 0.1 20:30:42 INFO - mozdevice == 0.48 20:30:42 INFO - mozfile == 1.2 20:30:42 INFO - mozhttpd == 0.7 20:30:42 INFO - mozinfo == 0.9 20:30:42 INFO - mozleak == 0.1 20:30:42 INFO - mozlog == 3.1 20:30:42 INFO - moznetwork == 0.27 20:30:42 INFO - mozprocess == 0.22 20:30:42 INFO - mozprofile == 0.28 20:30:42 INFO - mozrunner == 6.11 20:30:42 INFO - mozscreenshot == 0.1 20:30:42 INFO - mozsystemmonitor == 0.0 20:30:42 INFO - moztest == 0.7 20:30:42 INFO - mozversion == 1.4 20:30:42 INFO - psutil == 3.1.1 20:30:42 INFO - requests == 1.2.3 20:30:42 INFO - wsgiref == 0.1.2 20:30:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:30:42 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')]} 20:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:42 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')]} 20:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:42 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 0x10757ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075824c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98db464830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107420d30>, '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 0x107283db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107416b20>, '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.udTnQUDdPb/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.JdOvlkOwcW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 20:30:42 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 20:30:42 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 20:30:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.udTnQUDdPb/Render', 20:30:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:30:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:30:42 INFO - 'HOME': '/Users/cltbld', 20:30:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:30:42 INFO - 'LOGNAME': 'cltbld', 20:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:42 INFO - 'MOZ_NO_REMOTE': '1', 20:30:42 INFO - 'NO_EM_RESTART': '1', 20:30:42 INFO - 'PAGER': '/bin/cat', 20:30:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:42 INFO - 'PWD': '/builds/slave/test', 20:30:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:30:42 INFO - 'SHELL': '/bin/bash', 20:30:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdOvlkOwcW/Listeners', 20:30:42 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 20:30:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:30:42 INFO - 'USER': 'cltbld', 20:30:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:30:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:42 INFO - 'XPC_FLAGS': '0x0', 20:30:42 INFO - 'XPC_SERVICE_NAME': '0', 20:30:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:42 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)) 20:30:42 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)) 20:30:42 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)) 20:30:42 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)) 20:30:42 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)) 20:30:42 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)) 20:30:42 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)) 20:30:42 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)) 20:30:42 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)) 20:30:42 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)) 20:30:42 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)) 20:30:42 INFO - Cleaning up... 20:30:42 INFO - Return code: 0 20:30:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:30:42 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')]} 20:30:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:42 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')]} 20:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:42 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 0x10757ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075824c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98db464830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107420d30>, '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 0x107283db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107416b20>, '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.udTnQUDdPb/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.JdOvlkOwcW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 20:30:42 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 20:30:42 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 20:30:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.udTnQUDdPb/Render', 20:30:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:30:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:30:42 INFO - 'HOME': '/Users/cltbld', 20:30:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:30:42 INFO - 'LOGNAME': 'cltbld', 20:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:42 INFO - 'MOZ_NO_REMOTE': '1', 20:30:42 INFO - 'NO_EM_RESTART': '1', 20:30:42 INFO - 'PAGER': '/bin/cat', 20:30:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:42 INFO - 'PWD': '/builds/slave/test', 20:30:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:30:42 INFO - 'SHELL': '/bin/bash', 20:30:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdOvlkOwcW/Listeners', 20:30:42 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 20:30:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:30:42 INFO - 'USER': 'cltbld', 20:30:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:30:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:42 INFO - 'XPC_FLAGS': '0x0', 20:30:42 INFO - 'XPC_SERVICE_NAME': '0', 20:30:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:42 INFO - Downloading/unpacking jsonschema 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:30:45 INFO - Downloading/unpacking functools32 (from jsonschema) 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30:45 INFO - Downloading functools32-3.2.3-2.tar.gz 20:30:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:30:45 INFO - warning: no files found matching '*.txt' 20:30:45 INFO - no previously-included directories found matching 'build' 20:30:45 INFO - no previously-included directories found matching 'dist' 20:30:45 INFO - no previously-included directories found matching '.git*' 20:30:45 INFO - Installing collected packages: jsonschema, functools32 20:30:45 INFO - Running setup.py install for functools32 20:30:45 INFO - warning: no files found matching '*.txt' 20:30:45 INFO - no previously-included directories found matching 'build' 20:30:45 INFO - no previously-included directories found matching 'dist' 20:30:45 INFO - no previously-included directories found matching '.git*' 20:30:45 INFO - Successfully installed jsonschema functools32 20:30:45 INFO - Cleaning up... 20:30:46 INFO - Return code: 0 20:30:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:30:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:30:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:30:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:30:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10757ba30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1075824c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f98db464830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107420d30>, '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 0x107283db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107416b20>, '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.udTnQUDdPb/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.JdOvlkOwcW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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 20:30:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 20:30:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 20:30:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.udTnQUDdPb/Render', 20:30:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:30:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:30:46 INFO - 'HOME': '/Users/cltbld', 20:30:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:30:46 INFO - 'LOGNAME': 'cltbld', 20:30:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:30:46 INFO - 'MOZ_NO_REMOTE': '1', 20:30:46 INFO - 'NO_EM_RESTART': '1', 20:30:46 INFO - 'PAGER': '/bin/cat', 20:30:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:30:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:30:46 INFO - 'PWD': '/builds/slave/test', 20:30:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:30:46 INFO - 'SHELL': '/bin/bash', 20:30:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdOvlkOwcW/Listeners', 20:30:46 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 20:30:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:30:46 INFO - 'USER': 'cltbld', 20:30:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:30:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:30:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:30:46 INFO - 'XPC_FLAGS': '0x0', 20:30:46 INFO - 'XPC_SERVICE_NAME': '0', 20:30:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:30:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:30:46 INFO - Downloading/unpacking flake8 20:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:30:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:30:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:30:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:30:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:30:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30: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 20:30:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:30:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:30:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:30:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:30:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:30:49 INFO - no previously-included directories found matching 'docs/_build' 20:30:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:30:49 INFO - Running setup.py install for pep8 20:30:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:30:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:30:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:30:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:30:50 INFO - no previously-included directories found matching 'docs/_build' 20:30:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:30:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:30:50 INFO - Cleaning up... 20:30:50 INFO - Return code: 0 20:30:50 INFO - Running post-action listener: _resource_record_post_action 20:30:50 INFO - Running post-action listener: _start_resource_monitoring 20:30:50 INFO - Starting resource monitoring. 20:30:50 INFO - ##### 20:30:50 INFO - ##### Running install step. 20:30:50 INFO - ##### 20:30:50 INFO - Running pre-action listener: _resource_record_pre_action 20:30:50 INFO - Running main action method: install 20:30:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:30:50 INFO - Reading from file tmpfile_stdout 20:30:50 INFO - Detecting whether we're running mozinstall >=1.0... 20:30:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:30:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:30:50 INFO - Reading from file tmpfile_stdout 20:30:50 INFO - Output received: 20:30:50 INFO - Usage: mozinstall [options] installer 20:30:50 INFO - Options: 20:30:50 INFO - -h, --help show this help message and exit 20:30:50 INFO - -d DEST, --destination=DEST 20:30:50 INFO - Directory to install application into. [default: 20:30:50 INFO - "/builds/slave/test"] 20:30:50 INFO - --app=APP Application being installed. [default: firefox] 20:30:50 INFO - mkdir: /builds/slave/test/build/application 20:30:50 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'] 20:30:50 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 20:31:24 INFO - Reading from file tmpfile_stdout 20:31:24 INFO - Output received: 20:31:24 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:31:24 INFO - Running post-action listener: _resource_record_post_action 20:31:24 INFO - ##### 20:31:24 INFO - ##### Running run-tests step. 20:31:24 INFO - ##### 20:31:24 INFO - Running pre-action listener: _resource_record_pre_action 20:31:24 INFO - Running main action method: run_tests 20:31:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:31:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:31:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:31:24 INFO - 2016-02-05 20:31:24.831 screenresolution[1659:8169] starting screenresolution argv=screenresolution get 20:31:24 INFO - 2016-02-05 20:31:24.834 screenresolution[1659:8169] Display 0: 1600x1200x32@60 20:31:24 INFO - 2016-02-05 20:31:24.839 screenresolution[1660:8171] starting screenresolution argv=screenresolution list 20:31:24 INFO - Available Modes on Display 0 20:31:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:31:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:31:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:31:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:31:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:31:25 INFO - Intel Iris: 20:31:25 INFO - Chipset Model: Intel Iris 20:31:25 INFO - Type: GPU 20:31:25 INFO - Bus: Built-In 20:31:25 INFO - VRAM (Dynamic, Max): 1536 MB 20:31:25 INFO - Vendor: Intel (0x8086) 20:31:25 INFO - Device ID: 0x0a2e 20:31:25 INFO - Revision ID: 0x0009 20:31:25 INFO - Displays: 20:31:25 INFO - Display: 20:31:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:31:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:31:25 INFO - Display Serial Number: 1600x1200 60 20:31:25 INFO - Main Display: Yes 20:31:25 INFO - Mirror: Off 20:31:25 INFO - Online: Yes 20:31:25 INFO - Rotation: Supported 20:31:25 INFO - Return code: 0 20:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:31:25 INFO - Python 2.7.3 20:31:25 INFO - Return code: 0 20:31:25 INFO - grabbing minidump binary from tooltool 20:31:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:31:25 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 0x107420d30>, '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 0x107283db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107416b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:31:25 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 20:31:25 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 20:31:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:31:25 INFO - Return code: 0 20:31:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:31:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:31:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:31:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:31:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:31:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:31:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:31:26 INFO - Return code: 0 20:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0134 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.udTnQUDdPb/Render', 20:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:31:26 INFO - 'HOME': '/Users/cltbld', 20:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:31:26 INFO - 'LOGNAME': 'cltbld', 20:31:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:31:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:31:26 INFO - 'MOZ_NO_REMOTE': '1', 20:31:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:31:26 INFO - 'NO_EM_RESTART': '1', 20:31:26 INFO - 'PAGER': '/bin/cat', 20:31:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:31:26 INFO - 'PWD': '/builds/slave/test', 20:31:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:31:26 INFO - 'SHELL': '/bin/bash', 20:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JdOvlkOwcW/Listeners', 20:31:26 INFO - 'TMPDIR': '/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/', 20:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:31:26 INFO - 'USER': 'cltbld', 20:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:31:26 INFO - 'XPC_FLAGS': '0x0', 20:31:26 INFO - 'XPC_SERVICE_NAME': '0', 20:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:31:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0134', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:31:26 INFO - mozversion application_buildid: 20160205184242 20:31:26 INFO - mozversion application_changeset: 0885625045f0d07ab8ce6d46d8b354939aa3b617 20:31:26 INFO - mozversion application_display_name: Nightly 20:31:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:31:26 INFO - mozversion application_name: Firefox 20:31:26 INFO - mozversion application_remotingname: firefox 20:31:26 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 20:31:26 INFO - mozversion application_vendor: Mozilla 20:31:26 INFO - mozversion application_version: 47.0a1 20:31:26 INFO - mozversion platform_buildid: 20160205184242 20:31:26 INFO - mozversion platform_changeset: 0885625045f0d07ab8ce6d46d8b354939aa3b617 20:31:26 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 20:31:26 INFO - mozversion platform_version: 47.0a1 20:31:26 INFO - using testdate: 1454733086 20:31:26 INFO - actual date: 1454733086 20:31:26 INFO - starting webserver on 'localhost:49274' 20:31:26 INFO - SUITE-START | Running 2 tests 20:31:26 INFO - TEST-START | dromaeo_css 20:31:26 INFO - operating with platform_type : mac_ 20:31:26 INFO - Initialising browser for dromaeo_css test... 20:31:26 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpypBFzp/profile http://localhost:49274/getInfo.html) 20:31:30 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 20:31:30 INFO - PROCESS | 1678 | colorDepth:24 20:31:30 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 20:31:30 INFO - PROCESS | 1678 | __metrics 20:31:30 INFO - PROCESS | 1678 | 20:31:30 INFO - PROCESS | 1678 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 20:31:30 INFO - PROCESS | 1678 | 20:31:30 INFO - TEST-INFO | 1678: exit 0 20:31:30 INFO - Browser initialized. 20:31:30 INFO - Running cycle 1/1 for dromaeo_css test... 20:31:30 INFO - TEST-INFO | started process 1683 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpypBFzp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:31:42 INFO - PROCESS | 1683 | RSS: Main: 258375680 20:31:42 INFO - PROCESS | 1683 | 20:32:32 INFO - PROCESS | 1683 | 1454733152513 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] 20:34:42 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 20:34:43 INFO - PROCESS | 1683 | RSS: Main: 272392192 20:34:43 INFO - PROCESS | 1683 | 20:37:46 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 20:37:46 INFO - PROCESS | 1683 | RSS: Main: 284307456 20:37:46 INFO - PROCESS | 1683 | 20:40:48 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 20:40:48 INFO - PROCESS | 1683 | RSS: Main: 285712384 20:40:48 INFO - PROCESS | 1683 | 20:43:50 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 20:43:51 INFO - PROCESS | 1683 | RSS: Main: 287453184 20:43:51 INFO - PROCESS | 1683 | 20:46:53 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 20:46:54 INFO - PROCESS | 1683 | RSS: Main: 288784384 20:46:54 INFO - PROCESS | 1683 | 20:49:56 INFO - PROCESS | 1683 | Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 20:49:57 INFO - PROCESS | 1683 | RSS: Main: 291966976 20:49:57 INFO - PROCESS | 1683 | 20:49:57 INFO - PROCESS | 1683 | __start_tp_report 20:49:57 INFO - PROCESS | 1683 | _x_x_mozilla_page_load 20:49:57 INFO - PROCESS | 1683 | _x_x_mozilla_page_load_details 20:49:57 INFO - PROCESS | 1683 | |i|pagename|runs| 20:49:57 INFO - PROCESS | 1683 | |0;dojo.html;3547.698445632121;3574.803385813781;3599.94600080999;3643.5809881863593;3646.270745850829;5359.598030147735;5372.54941165886;5757.568182386322;5826.096954971981;5830.883382332351;5598.944010559903;5823.621464604797;5852.76588936442;5926.703664816763;6031.75872965082;5213.296205012322;5282.841514754545;5283.199904050859;5343.652662576939;5355.464453554633;528.9049859971585;4795.2807078938085;4832.3717916670785;5248.396434410053;5326.041312563756;4231.661467082626;5115.769790359443;5245.842624721265;5283.682979021251;5329.626926115174;5136.974315128437;5289.338832645919;5308.177232528964;5321.707306098163;5342.439043900412;5137.8201762938115;5151.510606492415;5181.1969144782615;5203.427622961472;5260.763265653055;5675.262215911946;5683.914741278884;5770;5791.391903850077;5803.448672376117;6099.5519121886955;6183.258009038944;6289.119523266746;6302.46429053531;6332.4934005279465;6264.655443950581;6273.278572964122;6290.24517057956;6291.182146320994;6317.1156038154695;5891.7054147292465;5906.907222163871;5927.962988702011;5933.139694744238;5952.315483719428;6247.9062814057825;6377.394147555975;6423.42189202974;6423.775167869102;6426.389492998158;5093.949060509348;6188.628682279078;6234.719437625317;6267;6282.2147231596055;6114.753609057711;6212.81361559154;6312.242530896322;6326.683665816783;6334.5249106317215;6238.750449982041;6240.375962403814;6241.375862413723;6266.843328916722;6273.905891411632;5772.826815195551;6213.627182369072;6268.968655156695;6275.121482992385;6294.15028971083;4886.486918873538;4953.529414705597;4966.950330496648;5011.5489605935645;5043.016611760671;4392.472903251631;4423.955760442419;4427.46870375557;4487.214737420938;4490.887727806831;5698.1452782083015;5881.735321910524;5917.023691090922;5920.200772895604;5921.289445266596;6211.503079753609;6279.811605651837;6284.968575157095;6309.684515774193;6315.873682526324;5849.766009359663;5910.763569457174;5930.258717660293;5937.228160339215;5955.7617695292565;5400.000999814968;5403.729813509387;5495.53287970527;5497.39528651848;5501.752421141058;6471.255805582324;6479.481641468671;6481.902771458432;6489.286178520453;6520.315366886409;6253.124562561154;6264.749410023548;6282.277538082996;6304.275008373912;6324.367563243639;6294.874102518015;6404.615723056445;6499.350064993463;6519;6534.738610455529;4584.8767052071125;5137.023965446553;6040.546958978182;6246.156768836149;6264.21697287839;5422.620416570802;6182.6599537025895;6193.040078787615;6299.622022678471;6411.551191416556;6148.938510614837;6255.906161407674;6263.843403914756;6264.091706702594;6282.371762823864;6073.271207455134;6212.347703491249;6212.658303793335;6246.250449946036;6322.146510221245;4810.518948105161;5582.688068304026;5739.339975902658;6141.355157708376;6160.876782464416;6103.633781973096;6105.084237364254;6106.297775755845;6111.297200821962;6128.4790792783115;5938.584299099021;5986.580939334205;6002.87994240104;6005.339412664516;6028.33688294296 20:49:57 INFO - PROCESS | 1683 | |1;ext.html;446.089976448046;475.09731510130746;498.6982875360407;561.2030916099138;582.947534721875;30636.927707530213;37083.81458092709;37634.4354834677;38171.61828381715;38222.662206822766;32900;39292;40084.59915400845;40138.39792403109;40222.79888600553;9301.95349023254;9485.004074572174;9490;9559.56981935811;9607.423554586747;9310.76723081925;9492.905070949271;9520.619175232983;9526.28552858535;9551.856722149174;9556.761080972996;9563.80872382552;9578.808423831553;9599.856002159973;9610.855837162448;9470.242380609534;9517.619295228182;9553.187979021757;9560.187384072362;9589.856152157723;9437.386569873004;9562.330636855422;9569.665061722875;9583.568739406674;9627.037296270388;38112.856614301614;38537.03657408587;38659.8067009666;38930.61069389298;39035;2795.9235694257654;2845.644294463192;3071.2475443516482;3557.875474358385;4021;27049.053283134996;27538;27911;28056.054114317907;28479.430411391655;2720.6327145835257;2751.17464760571;2824.223338581886;2858.1711303721895;2942.7792915531422;328113;331967;332121;333476.9935352891;333745;57083.42916570864;58616.70691646515;70343;70400;71656;68288.65855670789;68838.65580672065;69141.30858691348;69183.96224056643;69303;16517.834821651628;16850.073245971344;16939.068351240552;16983.575410614834;17060.91469542669;12848.550300739429;12895.613131606067;12945.741085178244;13075.869241307466;13184.340782960813;21039.368818935458;21202.939853007596;21300.25449109274;21327.36017919465;21358.893205533874;6290.308066112724;7870.409719270963;8039.995000624922;8114.634841432032;8140.511569305861;805.7139715400948;993.4933184076173;1017.5166795772097;1025.266934142092;1079.6329248055542;23299.534009320058;26688.466230675665;29822.40355192884;30267.545986810215;30666.62000209996;984.3306551545019;1110.9944450277858;1128.2891778179694;1181.2262967756133;1228.1587112827742;15200;15320.387184512718;15469;15486.303116359792;15707.978981366176;451063.7446812745;545410;546490;547025.2648736731;553591;58850;59299.703501483076;59533;59738.402615974155;59889.401105988385;1420.1692010173958;1422.7510185717458;1438.6187660270036;1457.6501639606417;1461.883049356049;25884.741152588987;29801.252111696656;30175.547366789953;30195.849020754755;30840.53739193869;47152.52847471481;47303.526964729914;47303.52696473129;47509.762451187526;47539;521882;523494;523596;523806;524437;32092.358152836347;32733;33283;33371.66628333783;33682.66317336795;40194.99512512211;40841.183176336905;41414.58585414107;41507.792461037505;42559.14881702287;34192.55496785402;35002.64997349994;35127.7705280314;35749;35958.74144404933;34664.653353467154;34706.132346691535;34904.30191396209;35244.47133293054;35327.823360883034;34547.30905381828;35067.86427145709;35833.1041723959;35886.461703073954;36091;32591.859284924914;32697;32710.34579308448;32900.50649240311;33273.500897486076;24781.876090619433;24862.37844053913;24932.501349973263;25030;25149.37126571777 20:49:57 INFO - PROCESS | 1683 | |2;jquery.html;365.435402303441;368.8303380444995;370.70343725019984;373.1883154139747;375.46683709133026;14990.175540345304;18737.875727456347;20176.798232017674;20482.873441960684;20931.790682093175;11596.652100436979;11673.299602023862;11991.580294689687;12017.197420386947;19573.314933977315;3297.3240485700494;5113.923291150626;5536.972315138419;5610.354809196933;5848.970755146218;5759.568032397587;5806.390329015456;5847.590668653196;5851.15158302046;5880.059190529516;5634.929363420957;5749.281339832521;5840.707964601774;5843.883122337551;5890.087036509348;4599.436191694823;5678.375378708339;5789.7684092636455;5837.124431335334;6198.256209254873;5520.282363292747;5521.723913804334;5524.751386187631;5527.2538207342295;5550.639208451437;13607.863921360859;13698.246596437191;19979.801211927184;23913.521729565313;24484.408513446568;1793.3454289184353;1976.5256338478662;2136.4445244236454;2169.5010147666126;2353.7881590656752;7618.276263754934;7655.961720191363;8341.365980662042;11235.775284494346;11876.821847672292;1746.4760571828529;1770.725537541683;1778.1820362633205;1798.5683435975402;1825.904457325594;95545.6559020431;97009;98604.50697746465;100695;101704.47443288357;11074.889251107386;11136.164787640797;11186.216964812547;11262.549498019987;11425.885741142649;13533.661658458617;13535.932320338336;13539.932300338633;13583.932080339733;13677.31613419325;6892.758753443605;8455.661773529113;8548.700795472128;8582.013068497203;8669.263112635497;7207.639618019078;7868.763937081897;8348.248657620843;8618.569071546523;8642.524661143572;3970.927849480624;3971.62269584389;3984.382420724792;4240.660747140221;4432.623227025674;1758.7098128808602;1878.9718154227699;1880.7366968624403;1885.849132069431;1897.724829899657;909.4452384045727;922.7324076018014;937.105064663245;1001.2840818814583;1013.8428543575758;18342.724859127124;18403.26386944534;19103.2358705653;20151.093200805706;20283.492912677008;882.5675419044622;907.8774365460711;934.9859752103724;941.5668792355456;979.8579206015088;6958;10649.201309901788;10764.56941722338;10780.245382823126;10822.18833587484;430771;775364;787294;790295;794007;114184.42907785573;118727.40636296764;118840;120562.79437205692;122445;1084.728817795551;1131.2081542919989;1133.2916926920675;1171.3616079236836;1186.8694443611196;18059;18366.98981556027;18419.171137299123;18436.81563184351;18545.44363669092;48537;48571;48596;48978.5102148974;49084.75457622689;70849.29150708427;71090;71220.64389678226;71806.28193717996;72080.63959680167;7229.7469588564145;7478.439117066133;7688.154303026551;7733.729319473791;7847.9215207849475;9455.770749802481;11464.4267786612;11652.533898644298;11794.29234245948;12140.939295303468;10036.447995360326;10353.534090965773;10412.791744164922;10654.520546575577;10662.200334974752;10051.497425128568;10170.542325595217;10263;10519.684409467729;10585.8941410588;10209.642662506776;10472.842907356244;10728.088112510524;10880.45597720095;10899.56401743953;7235.493515453868;7398.59307738058;7609.39124869998;7736.110347310131;7756.495827771177;8768.816209811848;8784.956075219583;10004.899951000396;10431.217658675478;10716 20:49:57 INFO - PROCESS | 1683 | |3;mootools.html;1523.908565486071;1533.7469317562602;1786.5980154465246;1898.9905050474745;1921.2027008791351;7982.52104873708;8743.081976392476;8743.081976392483;8976.685815996441;8977.326700497464;8685.435446695976;8749.387542872002;8862.822743545124;8885.777855553615;8892.599833007514;2477.4797292568537;2489.788367988723;2498.475320182764;2509.7490250974847;2511.3721569607596;2443.1693224303735;2516.471540976397;2518.4711210645787;2518.559252130879;2518.659980902582;2175.8041776240134;2393.8444001139956;2466.5436894174545;2495.7878580320603;2526.6462695222685;2448.408534452611;2462.753724627541;2490.9252722418355;2492.9127480538186;2494.0148641286683;2074.66805311151;2479.3925488255313;2491.987540062288;2493.1523282084;2500.2624225853415;8577.571121443965;8753.956230218871;8760.605772740242;8824.558772061371;8860;5321.787128514855;5386.730663466811;5442.755076021588;5458.5087342139395;5477.945220547823;3616.72874534411;3652.4703917932015;3729.216864458467;3743.3262012837677;3747.5128233329765;990.8315586350337;1029.9588016479331;1060;1088;1092.1317552545665;11913.344766037864;12068.275903445734;12071.517139314417;12085.395730213455;12107.334096624681;4880.145974454456;4922.040202160616;4938.4320803107385;4965.950340496621;4994.800207991712;10079;10156.695299141038;10195.031472010147;10212.387256764618;10234.692959211236;5393.2449457076045;5412.945870541323;5461.5357694596405;5486.615936884459;5491.093969494988;4813.470518242991;4904.239842824368;4912.459629440758;4959.702417854868;5009.874753131128;3983;4010.6991975601945;4023.396490526386;4054.9659836741444;4061.411095391211;1115.6039605939936;1206.4993027893327;1251.0429521416124;1319.8680131986725;1339.7186590815843;1018.7147598672384;1120.6301920366259;1156.8496095507699;1266.5630357526638;1377.9104358216684;7934.365250779923;7960.203979602109;8033.959830200812;8306.792330191673;8502.914970850336;1183.4910988274953;1193.3078814287692;1212.630147804928;1222.1261797814605;1230.7107829660022;6414.550981431255;6435.742570297136;6498.805035848932;6516.315786842408;6519;10853.077488413574;10854.294470859526;11259.887401126047;11290.604828830952;11294.209405341711;10738.785224295627;10858.565657373616;10935.507902144423;11110.61112861046;11120.777584448266;7068.681909314093;8407.201315874981;8422.873656895028;8542.103079176597;8596.753470746708;6446.709898054505;7908.327792137733;7928.563928983961;7960.04479462445;8079.636416361395;9421.764455888657;9564.947855736003;9803.068708472683;9811.116999470081;9856.950715246378;8707.651693932172;9227.077292270988;9703.66037188695;10019.699409017741;10085.747856303358;6966;7097.751578694721;7147.499675022698;7174.2108368078425;7215.963920180366;8242.381821363542;8312;8314.792130196793;8321.16788321163;8332.791680208044;7033;7756.495827771177;7978.481398709066;7992.920070799218;8041.396895232764;6976.7558135465015;7676.6161691916295;7701.075870895528;7846.5292082475235;7916.722914697958;7871.685132594861;7888.290053895177;7932.6033698316005;7953.761387158394;7959.681612735426;6856.314368563104;7013.544119632207;7015.543989640657;7024.5082844200415;7151.392131668658;7020.929790702027;7091.858162836817;7115.359617634438;7124.893126603209;7195.640217989185 20:49:57 INFO - PROCESS | 1683 | |4;prototype.html;320.5112203889069;325.9331836973421;326.09996409908643;330.9751768617354;334.83425704276374;5197.402298735647;6218.564700470969;6824.795256142312;6861.519693621455;6887.4490040796745;6768.153980752406;6799.6600169991425;6801.877690181126;6810.62541560214;6923.861522769542;5037.06814239365;5049.203256905945;5050.696958182502;5057.4689657585795;5061.519155680205;4670.252759558454;4739.980904105617;4891.828785992491;5047.520485553867;5053.873653158664;4033.394990751396;4991.450940396571;5001.374828146481;5020.974895125538;5038.748062596874;4993.725345106018;5002.774875130628;5007.949920500803;5009.499050094998;5014.097462456756;4013.9397909031386;4070.75575465473;4108.671306295519;4272.46594175728;4286.121345124242;6586.7035983380865;6623.503237257177;6629.105070815426;6646.368594983469;6665.133532640774;5923.259592550931;5927.407259274081;5944.881102377972;5954.106883967396;5975.760969561213;7008.614526201057;7264.8547029059655;7283.526570772936;7286.81782955425;7290;4771.355866957986;4811.340087669749;4815.3258543803895;4817.108834865526;4826.131296366652;7725.768226953201;7765.1070126935565;7771.417143714244;7782.727604533814;7789.065312162576;4572.565606267399;4722.268048452495;4886.462489126193;4887.120318342661;4890.388701412324;4262.742490965173;4641.512641172628;4802.615790736732;4808.831690890802;4819.3012013257885;5814.767409303665;5823.4467725566;5849.473547380756;5851.853703657443;5887.116932460165;7182.533135346186;7354.639391712551;7387.6675549600395;7406.555606663617;7433.442491813135;1648.934042638305;1673.6234347271766;1676.2708221923501;1678.1106013812698;1680.663867226535;912.2838571721167;1057.0486562094177;1057.6826951914395;1062.245805478119;1077.5905156040653;5610.831675049755;6898.620575868275;6907.481938854606;6908.274631163756;6913.308669133147;7587.468877178655;7592.633326001373;7594.620268986529;7601.821717633776;7605.277498637621;6751.696173672197;6877.105976223059;6886.724531018703;6891.138607674041;7040;3917.490726205632;4007.579204183577;4048.6153815387493;4087.3868919661695;4094.7133700641266;6422.45409140219;8124.471909325875;8140.470869393471;8145.185481451807;8152.429329946846;7806.57063861493;7983.640736166886;7997.520148791091;8002.279794818494;8016.55908925003;6819.624920629314;7814.788707750307;8078.474899131537;8105.189481051965;8110.594470276463;7711.421643376882;7712.807179820549;7724.304812566896;7725.1502334744255;7763.534187948741;5689.089745640843;7216.530925489827;7407.296321845898;7555.395568354408;7595.658195381111;8093.3929955252415;8105.716299929474;8108.594570271581;8124.634391452517;8135;4171.957010747313;4478.641708663234;4751.691140075884;4757.09615173116;4757.738324392053;6185.659788711484;7474.738384156746;7660.616969151632;7692.7692169235015;7696.923030769844;7213.891791623235;7296.635168241673;7337.74317898871;7351.081114860643;7354.154272258545;7190.1731300901065;7348.926510735038;7372.299631534996;7377.1885092638695;7408.333250007525;7184.856302873809;7195;7213.422926165999;7215.71137154508;7226.530275532074;7361.779146625609;7372.299631534996;7378.5941773202985;7382.483226174117;7409.184989651242;5208.374995000624;5926.851828704317;6991.475639326969;7229.674664639999;7247.420206383371 20:49:57 INFO - PROCESS | 1683 | |5;yui.html;677.5114864025826;679.2562144451823;688.2910602079858;695.1658010387533;747.4543583184279;12093.516259349637;14745.189014604219;14778.704425911488;14779.926100369497;14909.030912990647;13552.525661601845;13729.725405491885;13846.584602461917;13887.861121388783;13910.234937078456;645.6642545876165;781.2773184804062;798.3214267872305;805.9314958228529;807.2532907060975;659.4987809264945;804.9356051515894;809.1948511231333;814.1004190369615;817.4972391978949;823.1315961660446;843.0936743001267;851.276415047208;851.9105493923141;851.9989012909837;834.7454026521908;845.4927043773748;851.2594043182409;854.6196942360652;854.628236717027;609.250621735268;614.8370681769335;615.6644628677382;622.1445512420422;626.545754328113;14522.709545809024;14576.271186440636;14587.978841481101;14617.488387906478;14688.339024743806;13131.409086591126;13165.802512962313;13204.207747535083;13247.20516768997;13398.196108233537;8268.958655206745;9318.20795232406;9866.766654168228;10161.847572286422;10309.020643038899;3510.5611798525183;3535.699465545406;3538.31002954424;3542.291541691672;3748.0817199785956;73095;73098.26901730968;74180.51638967244;74216.62891685561;74649.25350746477;9323.347365684336;9637.37357071788;9804;9804.509774511245;10079.143272821746;20630;20891.26880559173;20910;20922.581548369253;21186.36440906775;6212.782552610727;7511.248875112445;7622.923770762332;7702.191269916578;7725;4165.708400411942;4181.581841815855;4238.427812245307;4244.469441319835;4290.2706539888295;3548.751587388858;3549.18368775178;3569;3585.103724068983;3585.1216451969435;657.5331514624575;664.6377724140356;672.7712577723597;672.9972341211658;673.9966300168566;524.29744142848;553.3277068361879;599.7301214453513;623.6476390839161;634.5304474688697;8342.62458189383;8600.39797214189;8792.912070879338;8887.15572020657;8945.25369146248;501.30068554366454;520.8906129712727;521.4446614355699;548.4953842464942;574.3251679276833;4009.4787677601726;4034.415009823559;4120.75275483472;4132.669386449077;4214.157168566299;93067.53466232626;95893.5205323969;97738;97952;98037.50981245049;58760;80478.19521804825;81017;81107.18892811115;83815.13294069479;53686.73156634192;69704;70983;71223.64388178026;71773;8288.58557072132;8378.790530236793;8491.23578877904;8555.31557475413;8613.612387442456;48240.758796205795;48546.02907941892;49302.506974931224;49604.00791984212;50023.24965125599;65188.34811651823;70481.94277085745;70651.64674176596;70945;71215;8057.919420805717;9932.801343973224;9942.353747006422;10013.048760367754;10361.22290828206;9946.850797237903;11067.391293478937;11191.88808111941;11931.76136477283;12720;11805.881941180478;11886.108541859569;11943.16397852142;12063.974562162315;12105.515779368727;10428.217883658604;10441.590385297888;11721.589744358907;12048.277103373826;12077.939610301892;9926.659900913284;11408.429578520874;11656.766864662828;11878.703032424259;12009.459574319002;9040.141186587263;9193.54032298369;9428.888466806075;9586.856197156909;9711.805763884824;8957.28341732673;9129.402354588054;9410.38832475887;9714.222862171151;10146.391216526737 20:49:57 INFO - PROCESS | 1683 | __end_tp_report 20:49:57 INFO - PROCESS | 1683 | __start_cc_report 20:49:57 INFO - PROCESS | 1683 | _x_x_mozilla_cycle_collect,375 20:49:57 INFO - PROCESS | 1683 | __end_cc_report 20:49:57 INFO - PROCESS | 1683 | __startTimestamp1454734197119__endTimestamp 20:49:57 INFO - PROCESS | 1683 | 20:49:57 INFO - PROCESS | 1683 | ------- Summary: start ------- 20:49:57 INFO - PROCESS | 1683 | Number of tests: 6 20:49:57 INFO - PROCESS | 1683 | 20:49:57 INFO - PROCESS | 1683 | [#0] dojo.html Cycles:165 Average:5741.33 Median:5955.76 stddev:774.65 (13.0%) stddev-sans-first:757.67 20:49:57 INFO - PROCESS | 1683 | Values: 3547.7 3574.8 3599.9 3643.6 3646.3 5359.6 5372.5 5757.6 5826.1 5830.9 5598.9 5823.6 5852.8 5926.7 6031.8 5213.3 5282.8 5283.2 5343.7 5355.5 528.9 4795.3 4832.4 5248.4 5326.0 4231.7 5115.8 5245.8 5283.7 5329.6 5137.0 5289.3 5308.2 5321.7 5342.4 5137.8 5151.5 5181.2 5203.4 5260.8 5675.3 5683.9 5770.0 5791.4 5803.4 6099.6 6183.3 6289.1 6302.5 6332.5 6264.7 6273.3 6290.2 6291.2 6317.1 5891.7 5906.9 5928.0 5933.1 5952.3 6247.9 6377.4 6423.4 6423.8 6426.4 5093.9 6188.6 6234.7 6267.0 6282.2 6114.8 6212.8 6312.2 6326.7 6334.5 6238.8 6240.4 6241.4 6266.8 6273.9 5772.8 6213.6 6269.0 6275.1 6294.2 4886.5 4953.5 4967.0 5011.5 5043.0 4392.5 4424.0 4427.5 4487.2 4490.9 5698.1 5881.7 5917.0 5920.2 5921.3 6211.5 6279.8 6285.0 6309.7 6315.9 5849.8 5910.8 5930.3 5937.2 5955.8 5400.0 5403.7 5495.5 5497.4 5501.8 6471.3 6479.5 6481.9 6489.3 6520.3 6253.1 6264.7 6282.3 6304.3 6324.4 6294.9 6404.6 6499.4 6519.0 6534.7 4584.9 5137.0 6040.5 6246.2 6264.2 5422.6 6182.7 6193.0 6299.6 6411.6 6148.9 6255.9 6263.8 6264.1 6282.4 6073.3 6212.3 6212.7 6246.3 6322.1 4810.5 5582.7 5739.3 6141.4 6160.9 6103.6 6105.1 6106.3 6111.3 6128.5 5938.6 5986.6 6002.9 6005.3 6028.3 20:49:57 INFO - PROCESS | 1683 | 20:49:57 INFO - PROCESS | 1683 | [#1] ext.html Cycles:180 Average:60947.50 Median:35922.60 stddev:125405.86 (349.1%) stddev-sans-first:125675.38 20:49:57 INFO - PROCESS | 1683 | Values: 446.1 475.1 498.7 561.2 582.9 30636.9 37083.8 37634.4 38171.6 38222.7 32900.0 39292.0 40084.6 40138.4 40222.8 9302.0 9485.0 9490.0 9559.6 9607.4 9310.8 9492.9 9520.6 9526.3 9551.9 9556.8 9563.8 9578.8 9599.9 9610.9 9470.2 9517.6 9553.2 9560.2 9589.9 9437.4 9562.3 9569.7 9583.6 9627.0 38112.9 38537.0 38659.8 38930.6 39035.0 2795.9 2845.6 3071.2 3557.9 4021.0 27049.1 27538.0 27911.0 28056.1 28479.4 2720.6 2751.2 2824.2 2858.2 2942.8 328113.0 331967.0 332121.0 333477.0 333745.0 57083.4 58616.7 70343.0 70400.0 71656.0 68288.7 68838.7 69141.3 69184.0 69303.0 16517.8 16850.1 16939.1 16983.6 17060.9 12848.6 12895.6 12945.7 13075.9 13184.3 21039.4 21202.9 21300.3 21327.4 21358.9 6290.3 7870.4 8040.0 8114.6 8140.5 805.7 993.5 1017.5 1025.3 1079.6 23299.5 26688.5 29822.4 30267.5 30666.6 984.3 1111.0 1128.3 1181.2 1228.2 15200.0 15320.4 15469.0 15486.3 15708.0 451063.7 545410.0 546490.0 547025.3 553591.0 58850.0 59299.7 59533.0 59738.4 59889.4 1420.2 1422.8 1438.6 1457.7 1461.9 25884.7 29801.3 30175.5 30195.8 30840.5 47152.5 47303.5 47303.5 47509.8 47539.0 521882.0 523494.0 523596.0 523806.0 524437.0 32092.4 32733.0 33283.0 33371.7 33682.7 40195.0 40841.2 41414.6 41507.8 42559.1 34192.6 35002.6 35127.8 35749.0 35958.7 34664.7 34706.1 34904.3 35244.5 35327.8 34547.3 35067.9 35833.1 35886.5 36091.0 32591.9 32697.0 32710.3 32900.5 33273.5 24781.9 24862.4 24932.5 25030.0 25149.4 20:49:57 INFO - PROCESS | 1683 | 20:49:57 INFO - PROCESS | 1683 | [#2] jquery.html Cycles:180 Average:36436.97 Median:24198.97 stddev:120410.60 (497.6%) stddev-sans-first:120717.91 20:49:57 INFO - PROCESS | 1683 | Values: 365.4 368.8 370.7 373.2 375.5 14990.2 18737.9 20176.8 20482.9 20931.8 11596.7 11673.3 11991.6 12017.2 19573.3 3297.3 5113.9 5537.0 5610.4 5849.0 5759.6 5806.4 5847.6 5851.2 5880.1 5634.9 5749.3 5840.7 5843.9 5890.1 4599.4 5678.4 5789.8 5837.1 6198.3 5520.3 5521.7 5524.8 5527.3 5550.6 13607.9 13698.2 19979.8 23913.5 24484.4 1793.3 1976.5 2136.4 2169.5 2353.8 7618.3 7656.0 8341.4 11235.8 11876.8 1746.5 1770.7 1778.2 1798.6 1825.9 95545.7 97009.0 98604.5 100695.0 101704.5 11074.9 11136.2 11186.2 11262.5 11425.9 13533.7 13535.9 13539.9 13583.9 13677.3 6892.8 8455.7 8548.7 8582.0 8669.3 7207.6 7868.8 8348.2 8618.6 8642.5 3970.9 3971.6 3984.4 4240.7 4432.6 1758.7 1879.0 1880.7 1885.8 1897.7 909.4 922.7 937.1 1001.3 1013.8 18342.7 18403.3 19103.2 20151.1 20283.5 882.6 907.9 935.0 941.6 979.9 6958.0 10649.2 10764.6 10780.2 10822.2 430771.0 775364.0 787294.0 790295.0 794007.0 114184.4 118727.4 118840.0 120562.8 122445.0 1084.7 1131.2 1133.3 1171.4 1186.9 18059.0 18367.0 18419.2 18436.8 18545.4 48537.0 48571.0 48596.0 48978.5 49084.8 70849.3 71090.0 71220.6 71806.3 72080.6 7229.7 7478.4 7688.2 7733.7 7847.9 9455.8 11464.4 11652.5 11794.3 12140.9 10036.4 10353.5 10412.8 10654.5 10662.2 10051.5 10170.5 10263.0 10519.7 10585.9 10209.6 10472.8 10728.1 10880.5 10899.6 7235.5 7398.6 7609.4 7736.1 7756.5 8768.8 8785.0 10004.9 10431.2 10716.0 20:49:57 INFO - PROCESS | 1683 | 20:49:57 INFO - PROCESS | 1683 | [#3] mootools.html Cycles:180 Average:6119.71 Median:5165.83 stddev:3222.25 (62.4%) stddev-sans-first:3212.77 20:49:57 INFO - PROCESS | 1683 | Values: 1523.9 1533.7 1786.6 1899.0 1921.2 7982.5 8743.1 8743.1 8976.7 8977.3 8685.4 8749.4 8862.8 8885.8 8892.6 2477.5 2489.8 2498.5 2509.7 2511.4 2443.2 2516.5 2518.5 2518.6 2518.7 2175.8 2393.8 2466.5 2495.8 2526.6 2448.4 2462.8 2490.9 2492.9 2494.0 2074.7 2479.4 2492.0 2493.2 2500.3 8577.6 8754.0 8760.6 8824.6 8860.0 5321.8 5386.7 5442.8 5458.5 5477.9 3616.7 3652.5 3729.2 3743.3 3747.5 990.8 1030.0 1060.0 1088.0 1092.1 11913.3 12068.3 12071.5 12085.4 12107.3 4880.1 4922.0 4938.4 4966.0 4994.8 10079.0 10156.7 10195.0 10212.4 10234.7 5393.2 5412.9 5461.5 5486.6 5491.1 4813.5 4904.2 4912.5 4959.7 5009.9 3983.0 4010.7 4023.4 4055.0 4061.4 1115.6 1206.5 1251.0 1319.9 1339.7 1018.7 1120.6 1156.8 1266.6 1377.9 7934.4 7960.2 8034.0 8306.8 8502.9 1183.5 1193.3 1212.6 1222.1 1230.7 6414.6 6435.7 6498.8 6516.3 6519.0 10853.1 10854.3 11259.9 11290.6 11294.2 10738.8 10858.6 10935.5 11110.6 11120.8 7068.7 8407.2 8422.9 8542.1 8596.8 6446.7 7908.3 7928.6 7960.0 8079.6 9421.8 9564.9 9803.1 9811.1 9857.0 8707.7 9227.1 9703.7 10019.7 10085.7 6966.0 7097.8 7147.5 7174.2 7216.0 8242.4 8312.0 8314.8 8321.2 8332.8 7033.0 7756.5 7978.5 7992.9 8041.4 6976.8 7676.6 7701.1 7846.5 7916.7 7871.7 7888.3 7932.6 7953.8 7959.7 6856.3 7013.5 7015.5 7024.5 7151.4 7020.9 7091.9 7115.4 7124.9 7195.6 20:49:57 INFO - PROCESS | 1683 | 20:49:57 INFO - PROCESS | 1683 | [#4] prototype.html Cycles:180 Average:5958.81 Median:6806.25 stddev:1953.64 (28.7%) stddev-sans-first:1912.74 20:49:57 INFO - PROCESS | 1683 | Values: 320.5 325.9 326.1 331.0 334.8 5197.4 6218.6 6824.8 6861.5 6887.4 6768.2 6799.7 6801.9 6810.6 6923.9 5037.1 5049.2 5050.7 5057.5 5061.5 4670.3 4740.0 4891.8 5047.5 5053.9 4033.4 4991.5 5001.4 5021.0 5038.7 4993.7 5002.8 5007.9 5009.5 5014.1 4013.9 4070.8 4108.7 4272.5 4286.1 6586.7 6623.5 6629.1 6646.4 6665.1 5923.3 5927.4 5944.9 5954.1 5975.8 7008.6 7264.9 7283.5 7286.8 7290.0 4771.4 4811.3 4815.3 4817.1 4826.1 7725.8 7765.1 7771.4 7782.7 7789.1 4572.6 4722.3 4886.5 4887.1 4890.4 4262.7 4641.5 4802.6 4808.8 4819.3 5814.8 5823.4 5849.5 5851.9 5887.1 7182.5 7354.6 7387.7 7406.6 7433.4 1648.9 1673.6 1676.3 1678.1 1680.7 912.3 1057.0 1057.7 1062.2 1077.6 5610.8 6898.6 6907.5 6908.3 6913.3 7587.5 7592.6 7594.6 7601.8 7605.3 6751.7 6877.1 6886.7 6891.1 7040.0 3917.5 4007.6 4048.6 4087.4 4094.7 6422.5 8124.5 8140.5 8145.2 8152.4 7806.6 7983.6 7997.5 8002.3 8016.6 6819.6 7814.8 8078.5 8105.2 8110.6 7711.4 7712.8 7724.3 7725.2 7763.5 5689.1 7216.5 7407.3 7555.4 7595.7 8093.4 8105.7 8108.6 8124.6 8135.0 4172.0 4478.6 4751.7 4757.1 4757.7 6185.7 7474.7 7660.6 7692.8 7696.9 7213.9 7296.6 7337.7 7351.1 7354.2 7190.2 7348.9 7372.3 7377.2 7408.3 7184.9 7195.0 7213.4 7215.7 7226.5 7361.8 7372.3 7378.6 7382.5 7409.2 5208.4 5926.9 6991.5 7229.7 7247.4 20:49:57 INFO - PROCESS | 1683 | 20:49:57 INFO - PROCESS | 1683 | [#5] yui.html Cycles:180 Average:18076.60 Median:630.54 stddev:25561.01 (4053.8%) stddev-sans-first:25599.33 20:49:57 INFO - PROCESS | 1683 | Values: 677.5 679.3 688.3 695.2 747.5 12093.5 14745.2 14778.7 14779.9 14909.0 13552.5 13729.7 13846.6 13887.9 13910.2 645.7 781.3 798.3 805.9 807.3 659.5 804.9 809.2 814.1 817.5 823.1 843.1 851.3 851.9 852.0 834.7 845.5 851.3 854.6 854.6 609.3 614.8 615.7 622.1 626.5 14522.7 14576.3 14588.0 14617.5 14688.3 13131.4 13165.8 13204.2 13247.2 13398.2 8269.0 9318.2 9866.8 10161.8 10309.0 3510.6 3535.7 3538.3 3542.3 3748.1 73095.0 73098.3 74180.5 74216.6 74649.3 9323.3 9637.4 9804.0 9804.5 10079.1 20630.0 20891.3 20910.0 20922.6 21186.4 6212.8 7511.2 7622.9 7702.2 7725.0 4165.7 4181.6 4238.4 4244.5 4290.3 3548.8 3549.2 3569.0 3585.1 3585.1 657.5 664.6 672.8 673.0 674.0 524.3 553.3 599.7 623.6 634.5 8342.6 8600.4 8792.9 8887.2 8945.3 501.3 520.9 521.4 548.5 574.3 4009.5 4034.4 4120.8 4132.7 4214.2 93067.5 95893.5 97738.0 97952.0 98037.5 58760.0 80478.2 81017.0 81107.2 83815.1 53686.7 69704.0 70983.0 71223.6 71773.0 8288.6 8378.8 8491.2 8555.3 8613.6 48240.8 48546.0 49302.5 49604.0 50023.2 65188.3 70481.9 70651.6 70945.0 71215.0 8057.9 9932.8 9942.4 10013.0 10361.2 9946.9 11067.4 11191.9 11931.8 12720.0 11805.9 11886.1 11943.2 12064.0 12105.5 10428.2 10441.6 11721.6 12048.3 12077.9 9926.7 11408.4 11656.8 11878.7 12009.5 9040.1 9193.5 9428.9 9586.9 9711.8 8957.3 9129.4 9410.4 9714.2 10146.4 20:49:57 INFO - PROCESS | 1683 | -------- Summary: end -------- 20:49:57 INFO - PROCESS | 1683 | 20:49:57 INFO - TEST-INFO | 1683: exit 0 20:49:57 INFO - TEST-OK | dromaeo_css | took 1110854ms 20:49:57 INFO - TEST-START | kraken 20:49:57 INFO - operating with platform_type : mac_ 20:49:57 INFO - Initialising browser for kraken test... 20:49:57 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpWwIc9f/profile http://localhost:49274/getInfo.html) 20:50:00 INFO - PROCESS | 1691 | __metrics Screen width/height:1600/1200 20:50:00 INFO - PROCESS | 1691 | colorDepth:24 20:50:00 INFO - PROCESS | 1691 | Browser inner width/height: 1024/689 20:50:00 INFO - PROCESS | 1691 | __metrics 20:50:00 INFO - PROCESS | 1691 | 20:50:00 INFO - PROCESS | 1691 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 20:50:00 INFO - PROCESS | 1691 | 20:50:01 INFO - TEST-INFO | 1691: exit 0 20:50:01 INFO - Browser initialized. 20:50:01 INFO - Running cycle 1/1 for kraken test... 20:50:01 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/tmpWwIc9f/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:50:13 INFO - PROCESS | 1694 | RSS: Main: 257998848 20:50:13 INFO - PROCESS | 1694 | 20:50:15 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 20:50:16 INFO - PROCESS | 1694 | RSS: Main: 270839808 20:50:16 INFO - PROCESS | 1694 | 20:50:19 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 20:50:19 INFO - PROCESS | 1694 | RSS: Main: 279318528 20:50:19 INFO - PROCESS | 1694 | 20:50:23 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 20:50:24 INFO - PROCESS | 1694 | RSS: Main: 281915392 20:50:24 INFO - PROCESS | 1694 | 20:50:26 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 20:50:26 INFO - PROCESS | 1694 | RSS: Main: 284839936 20:50:26 INFO - PROCESS | 1694 | 20:50:28 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:50:29 INFO - PROCESS | 1694 | RSS: Main: 285220864 20:50:29 INFO - PROCESS | 1694 | 20:50:32 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 20:50:32 INFO - PROCESS | 1694 | RSS: Main: 286633984 20:50:32 INFO - PROCESS | 1694 | 20:50:35 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 20:50:36 INFO - PROCESS | 1694 | RSS: Main: 286093312 20:50:36 INFO - PROCESS | 1694 | 20:50:39 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 20:50:40 INFO - PROCESS | 1694 | RSS: Main: 286576640 20:50:40 INFO - PROCESS | 1694 | 20:50:41 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:50:42 INFO - PROCESS | 1694 | RSS: Main: 286724096 20:50:42 INFO - PROCESS | 1694 | 20:50:44 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:50:44 INFO - PROCESS | 1694 | RSS: Main: 285437952 20:50:44 INFO - PROCESS | 1694 | 20:50:46 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:50:47 INFO - PROCESS | 1694 | RSS: Main: 285851648 20:50:47 INFO - PROCESS | 1694 | 20:50:50 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:50:50 INFO - PROCESS | 1694 | RSS: Main: 285274112 20:50:50 INFO - PROCESS | 1694 | 20:50:53 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:50:53 INFO - PROCESS | 1694 | RSS: Main: 286105600 20:50:53 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 20:50:55 INFO - PROCESS | 1694 | RSS: Main: 288096256 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | __start_tp_report 20:50:55 INFO - PROCESS | 1694 | _x_x_mozilla_page_load 20:50:55 INFO - PROCESS | 1694 | _x_x_mozilla_page_load_details 20:50:55 INFO - PROCESS | 1694 | |i|pagename|runs| 20:50:55 INFO - PROCESS | 1694 | |0;ai-astar;124;151;99;168;167;179;113;115;115;125 20:50:55 INFO - PROCESS | 1694 | |1;audio-beat-detection;185;110;177;180;148;153;177;157;150;102 20:50:55 INFO - PROCESS | 1694 | |2;audio-dft;201;194;201;214;271;273;196;225;167;251 20:50:55 INFO - PROCESS | 1694 | |3;audio-fft;66;83;95;119;58;82;49;63;97;82 20:50:55 INFO - PROCESS | 1694 | |4;audio-oscillator;81;81;132;117;120;123;119;81;82;122 20:50:55 INFO - PROCESS | 1694 | |5;imaging-gaussian-blur;87;93;102;140;85;92;85;92;86;93 20:50:55 INFO - PROCESS | 1694 | |6;imaging-darkroom;96;96;96;107;134;95;106;127;97;122 20:50:55 INFO - PROCESS | 1694 | |7;imaging-desaturate;93;77;151;151;91;91;92;135;151;94 20:50:55 INFO - PROCESS | 1694 | |8;json-parse-financial;57;57;55;58;55;65;85;97;87;54 20:50:55 INFO - PROCESS | 1694 | |9;json-stringify-tinderbox;62;65;65;62;71;71;69;65;65;66 20:50:55 INFO - PROCESS | 1694 | |10;stanford-crypto-aes;85;87;83;74;112;111;112;112;87;88 20:50:55 INFO - PROCESS | 1694 | |11;stanford-crypto-ccm;119;126;126;117;127;140;138;142;147;143 20:50:55 INFO - PROCESS | 1694 | |12;stanford-crypto-pbkdf2;142;141;142;127;112;181;177;182;156;144 20:50:55 INFO - PROCESS | 1694 | |13;stanford-crypto-sha256-iterative;72;71;68;69;71;69;67;69;68;68 20:50:55 INFO - PROCESS | 1694 | __end_tp_report 20:50:55 INFO - PROCESS | 1694 | __start_cc_report 20:50:55 INFO - PROCESS | 1694 | _x_x_mozilla_cycle_collect,917 20:50:55 INFO - PROCESS | 1694 | __end_cc_report 20:50:55 INFO - PROCESS | 1694 | __startTimestamp1454734255841__endTimestamp 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | ------- Summary: start ------- 20:50:55 INFO - PROCESS | 1694 | Number of tests: 14 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#0] ai-astar Cycles:10 Average:135.60 Median:159.00 stddev:28.09 (17.7%) stddev-sans-first:29.48 20:50:55 INFO - PROCESS | 1694 | Values: 124.0 151.0 99.0 168.0 167.0 179.0 113.0 115.0 115.0 125.0 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#1] audio-beat-detection Cycles:10 Average:153.90 Median:167.00 stddev:28.67 (17.2%) stddev-sans-first:28.11 20:50:55 INFO - PROCESS | 1694 | Values: 185.0 110.0 177.0 180.0 148.0 153.0 177.0 157.0 150.0 102.0 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#2] audio-dft Cycles:10 Average:219.30 Median:219.50 stddev:35.29 (16.1%) stddev-sans-first:36.81 20:50:55 INFO - PROCESS | 1694 | Values: 201.0 194.0 201.0 214.0 271.0 273.0 196.0 225.0 167.0 251.0 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#3] audio-fft Cycles:10 Average:79.40 Median:82.00 stddev:21.02 (25.6%) stddev-sans-first:21.73 20:50:55 INFO - PROCESS | 1694 | Values: 66.0 83.0 95.0 119.0 58.0 82.0 49.0 63.0 97.0 82.0 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#4] audio-oscillator Cycles:10 Average:105.80 Median:106.50 stddev:21.49 (20.2%) stddev-sans-first:20.84 20:50:55 INFO - PROCESS | 1694 | Values: 81.0 81.0 132.0 117.0 120.0 123.0 119.0 81.0 82.0 122.0 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#5] imaging-gaussian-blur Cycles:10 Average:95.50 Median:89.50 stddev:16.47 (18.4%) stddev-sans-first:17.18 20:50:55 INFO - PROCESS | 1694 | Values: 87.0 93.0 102.0 140.0 85.0 92.0 85.0 92.0 86.0 93.0 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#6] imaging-darkroom Cycles:10 Average:107.60 Median:95.50 stddev:14.75 (15.4%) stddev-sans-first:15.04 20:50:55 INFO - PROCESS | 1694 | Values: 96.0 96.0 96.0 107.0 134.0 95.0 106.0 127.0 97.0 122.0 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#7] imaging-desaturate Cycles:10 Average:112.60 Median:91.00 stddev:30.33 (33.3%) stddev-sans-first:31.33 20:50:55 INFO - PROCESS | 1694 | Values: 93.0 77.0 151.0 151.0 91.0 91.0 92.0 135.0 151.0 94.0 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:61.50 stddev:16.21 (26.4%) stddev-sans-first:16.79 20:50:55 INFO - PROCESS | 1694 | Values: 57.0 57.0 55.0 58.0 55.0 65.0 85.0 97.0 87.0 54.0 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:65.50 stddev:3.25 (5.0%) stddev-sans-first:3.09 20:50:55 INFO - PROCESS | 1694 | Values: 62.0 65.0 65.0 62.0 71.0 71.0 69.0 65.0 65.0 66.0 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#10] stanford-crypto-aes Cycles:10 Average:95.10 Median:84.00 stddev:14.85 (17.7%) stddev-sans-first:15.30 20:50:55 INFO - PROCESS | 1694 | Values: 85.0 87.0 83.0 74.0 112.0 111.0 112.0 112.0 87.0 88.0 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:139.00 stddev:10.72 (7.7%) stddev-sans-first:10.20 20:50:55 INFO - PROCESS | 1694 | Values: 119.0 126.0 126.0 117.0 127.0 140.0 138.0 142.0 147.0 143.0 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.40 Median:150.00 stddev:23.49 (15.7%) stddev-sans-first:24.72 20:50:55 INFO - PROCESS | 1694 | Values: 142.0 141.0 142.0 127.0 112.0 181.0 177.0 182.0 156.0 144.0 20:50:55 INFO - PROCESS | 1694 | 20:50:55 INFO - PROCESS | 1694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:1.62 (2.3%) stddev-sans-first:1.36 20:50:55 INFO - PROCESS | 1694 | Values: 72.0 71.0 68.0 69.0 71.0 69.0 67.0 69.0 68.0 68.0 20:50:55 INFO - PROCESS | 1694 | -------- Summary: end -------- 20:50:55 INFO - PROCESS | 1694 | 20:50:56 INFO - TEST-INFO | 1694: exit 0 20:50:56 INFO - TEST-OK | kraken | took 58949ms 20:50:56 INFO - SUITE-END | took 1169s 20:50:57 INFO - Completed test suite (00:19:30) 20:50:57 INFO - Working with test: dromaeo_css 20:50:57 INFO - Generating results file: dromaeo_css 20:50:57 INFO - Working with test: kraken 20:50:57 INFO - Generating results file: kraken 20:50:57 INFO - javascript benchmark 20:50:57 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:50:57 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 20:50:57 INFO - process_Request line: dromaeo_css 7490.13 graph.html#tests=[[72,1,61]] 20:50:57 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:50:57 INFO - process_Request line: kraken 1590.00 graph.html#tests=[[232,1,61]] 20:50:57 INFO - RETURN: dromaeo_css: 7490.13 20:50:57 INFO - RETURN: kraken: 1590.00 20:50:57 INFO - javascript benchmark 20:50:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3547.698445632121, 3574.803385813781, 3599.94600080999, 3643.5809881863593, 3646.270745850829, 5359.598030147735, 5372.54941165886, 5757.568182386322, 5826.096954971981, 5830.883382332351, 5598.944010559903, 5823.621464604797, 5852.76588936442, 5926.703664816763, 6031.75872965082, 5213.296205012322, 5282.841514754545, 5283.199904050859, 5343.652662576939, 5355.464453554633, 528.9049859971585, 4795.2807078938085, 4832.3717916670785, 5248.396434410053, 5326.041312563756, 4231.661467082626, 5115.769790359443, 5245.842624721265, 5283.682979021251, 5329.626926115174, 5136.974315128437, 5289.338832645919, 5308.177232528964, 5321.707306098163, 5342.439043900412, 5137.8201762938115, 5151.510606492415, 5181.1969144782615, 5203.427622961472, 5260.763265653055, 5675.262215911946, 5683.914741278884, 5770.0, 5791.391903850077, 5803.448672376117, 6099.5519121886955, 6183.258009038944, 6289.119523266746, 6302.46429053531, 6332.4934005279465, 6264.655443950581, 6273.278572964122, 6290.24517057956, 6291.182146320994, 6317.1156038154695, 5891.7054147292465, 5906.907222163871, 5927.962988702011, 5933.139694744238, 5952.315483719428, 6247.9062814057825, 6377.394147555975, 6423.42189202974, 6423.775167869102, 6426.389492998158, 5093.949060509348, 6188.628682279078, 6234.719437625317, 6267.0, 6282.2147231596055, 6114.753609057711, 6212.81361559154, 6312.242530896322, 6326.683665816783, 6334.5249106317215, 6238.750449982041, 6240.375962403814, 6241.375862413723, 6266.843328916722, 6273.905891411632, 5772.826815195551, 6213.627182369072, 6268.968655156695, 6275.121482992385, 6294.15028971083, 4886.486918873538, 4953.529414705597, 4966.950330496648, 5011.5489605935645, 5043.016611760671, 4392.472903251631, 4423.955760442419, 4427.46870375557, 4487.214737420938, 4490.887727806831, 5698.1452782083015, 5881.735321910524, 5917.023691090922, 5920.200772895604, 5921.289445266596, 6211.503079753609, 6279.811605651837, 6284.968575157095, 6309.684515774193, 6315.873682526324, 5849.766009359663, 5910.763569457174, 5930.258717660293, 5937.228160339215, 5955.7617695292565, 5400.000999814968, 5403.729813509387, 5495.53287970527, 5497.39528651848, 5501.752421141058, 6471.255805582324, 6479.481641468671, 6481.902771458432, 6489.286178520453, 6520.315366886409, 6253.124562561154, 6264.749410023548, 6282.277538082996, 6304.275008373912, 6324.367563243639, 6294.874102518015, 6404.615723056445, 6499.350064993463, 6519.0, 6534.738610455529, 4584.8767052071125, 5137.023965446553, 6040.546958978182, 6246.156768836149, 6264.21697287839, 5422.620416570802, 6182.6599537025895, 6193.040078787615, 6299.622022678471, 6411.551191416556, 6148.938510614837, 6255.906161407674, 6263.843403914756, 6264.091706702594, 6282.371762823864, 6073.271207455134, 6212.347703491249, 6212.658303793335, 6246.250449946036, 6322.146510221245, 4810.518948105161, 5582.688068304026, 5739.339975902658, 6141.355157708376, 6160.876782464416, 6103.633781973096, 6105.084237364254, 6106.297775755845, 6111.297200821962, 6128.4790792783115, 5938.584299099021, 5986.580939334205, 6002.87994240104, 6005.339412664516, 6028.33688294296], "unit": "score", "name": "dojo.html", "value": 5695.6631532441825}, {"lowerIsBetter": false, "replicates": [446.089976448046, 475.09731510130746, 498.6982875360407, 561.2030916099138, 582.947534721875, 30636.927707530213, 37083.81458092709, 37634.4354834677, 38171.61828381715, 38222.662206822766, 32900.0, 39292.0, 40084.59915400845, 40138.39792403109, 40222.79888600553, 9301.95349023254, 9485.004074572174, 9490.0, 9559.56981935811, 9607.423554586747, 9310.76723081925, 9492.905070949271, 9520.619175232983, 9526.28552858535, 9551.856722149174, 9556.761080972996, 9563.80872382552, 9578.808423831553, 9599.856002159973, 9610.855837162448, 9470.242380609534, 9517.619295228182, 9553.187979021757, 9560.187384072362, 9589.856152157723, 9437.386569873004, 9562.330636855422, 9569.665061722875, 9583.568739406674, 9627.037296270388, 38112.856614301614, 38537.03657408587, 38659.8067009666, 38930.61069389298, 39035.0, 2795.9235694257654, 2845.644294463192, 3071.2475443516482, 3557.875474358385, 4021.0, 27049.053283134996, 27538.0, 27911.0, 28056.054114317907, 28479.430411391655, 2720.6327145835257, 2751.17464760571, 2824.223338581886, 2858.1711303721895, 2942.7792915531422, 328113.0, 331967.0, 332121.0, 333476.9935352891, 333745.0, 57083.42916570864, 58616.70691646515, 70343.0, 70400.0, 71656.0, 68288.65855670789, 68838.65580672065, 69141.30858691348, 69183.96224056643, 69303.0, 16517.834821651628, 16850.073245971344, 16939.068351240552, 16983.575410614834, 17060.91469542669, 12848.550300739429, 12895.613131606067, 12945.741085178244, 13075.869241307466, 13184.340782960813, 21039.368818935458, 21202.939853007596, 21300.25449109274, 21327.36017919465, 21358.893205533874, 6290.308066112724, 7870.409719270963, 8039.995000624922, 8114.634841432032, 8140.511569305861, 805.7139715400948, 993.4933184076173, 1017.5166795772097, 1025.266934142092, 1079.6329248055542, 23299.534009320058, 26688.466230675665, 29822.40355192884, 30267.545986810215, 30666.62000209996, 984.3306551545019, 1110.9944450277858, 1128.2891778179694, 1181.2262967756133, 1228.1587112827742, 15200.0, 15320.387184512718, 15469.0, 15486.303116359792, 15707.978981366176, 451063.7446812745, 545410.0, 546490.0, 547025.2648736731, 553591.0, 58850.0, 59299.703501483076, 59533.0, 59738.402615974155, 59889.401105988385, 1420.1692010173958, 1422.7510185717458, 1438.6187660270036, 1457.6501639606417, 1461.883049356049, 25884.741152588987, 29801.252111696656, 30175.547366789953, 30195.849020754755, 30840.53739193869, 47152.52847471481, 47303.526964729914, 47303.52696473129, 47509.762451187526, 47539.0, 521882.0, 523494.0, 523596.0, 523806.0, 524437.0, 32092.358152836347, 32733.0, 33283.0, 33371.66628333783, 33682.66317336795, 40194.99512512211, 40841.183176336905, 41414.58585414107, 41507.792461037505, 42559.14881702287, 34192.55496785402, 35002.64997349994, 35127.7705280314, 35749.0, 35958.74144404933, 34664.653353467154, 34706.132346691535, 34904.30191396209, 35244.47133293054, 35327.823360883034, 34547.30905381828, 35067.86427145709, 35833.1041723959, 35886.461703073954, 36091.0, 32591.859284924914, 32697.0, 32710.34579308448, 32900.50649240311, 33273.500897486076, 24781.876090619433, 24862.37844053913, 24932.501349973263, 25030.0, 25149.37126571777], "unit": "score", "name": "ext.html", "value": 19409.42478698634}, {"lowerIsBetter": false, "replicates": [365.435402303441, 368.8303380444995, 370.70343725019984, 373.1883154139747, 375.46683709133026, 14990.175540345304, 18737.875727456347, 20176.798232017674, 20482.873441960684, 20931.790682093175, 11596.652100436979, 11673.299602023862, 11991.580294689687, 12017.197420386947, 19573.314933977315, 3297.3240485700494, 5113.923291150626, 5536.972315138419, 5610.354809196933, 5848.970755146218, 5759.568032397587, 5806.390329015456, 5847.590668653196, 5851.15158302046, 5880.059190529516, 5634.929363420957, 5749.281339832521, 5840.707964601774, 5843.883122337551, 5890.087036509348, 4599.436191694823, 5678.375378708339, 5789.7684092636455, 5837.124431335334, 6198.256209254873, 5520.282363292747, 5521.723913804334, 5524.751386187631, 5527.2538207342295, 5550.639208451437, 13607.863921360859, 13698.246596437191, 19979.801211927184, 23913.521729565313, 24484.408513446568, 1793.3454289184353, 1976.5256338478662, 2136.4445244236454, 2169.5010147666126, 2353.7881590656752, 7618.276263754934, 7655.961720191363, 8341.365980662042, 11235.775284494346, 11876.821847672292, 1746.4760571828529, 1770.725537541683, 1778.1820362633205, 1798.5683435975402, 1825.904457325594, 95545.6559020431, 97009.0, 98604.50697746465, 100695.0, 101704.47443288357, 11074.889251107386, 11136.164787640797, 11186.216964812547, 11262.549498019987, 11425.885741142649, 13533.661658458617, 13535.932320338336, 13539.932300338633, 13583.932080339733, 13677.31613419325, 6892.758753443605, 8455.661773529113, 8548.700795472128, 8582.013068497203, 8669.263112635497, 7207.639618019078, 7868.763937081897, 8348.248657620843, 8618.569071546523, 8642.524661143572, 3970.927849480624, 3971.62269584389, 3984.382420724792, 4240.660747140221, 4432.623227025674, 1758.7098128808602, 1878.9718154227699, 1880.7366968624403, 1885.849132069431, 1897.724829899657, 909.4452384045727, 922.7324076018014, 937.105064663245, 1001.2840818814583, 1013.8428543575758, 18342.724859127124, 18403.26386944534, 19103.2358705653, 20151.093200805706, 20283.492912677008, 882.5675419044622, 907.8774365460711, 934.9859752103724, 941.5668792355456, 979.8579206015088, 6958.0, 10649.201309901788, 10764.56941722338, 10780.245382823126, 10822.18833587484, 430771.0, 775364.0, 787294.0, 790295.0, 794007.0, 114184.42907785573, 118727.40636296764, 118840.0, 120562.79437205692, 122445.0, 1084.728817795551, 1131.2081542919989, 1133.2916926920675, 1171.3616079236836, 1186.8694443611196, 18059.0, 18366.98981556027, 18419.171137299123, 18436.81563184351, 18545.44363669092, 48537.0, 48571.0, 48596.0, 48978.5102148974, 49084.75457622689, 70849.29150708427, 71090.0, 71220.64389678226, 71806.28193717996, 72080.63959680167, 7229.7469588564145, 7478.439117066133, 7688.154303026551, 7733.729319473791, 7847.9215207849475, 9455.770749802481, 11464.4267786612, 11652.533898644298, 11794.29234245948, 12140.939295303468, 10036.447995360326, 10353.534090965773, 10412.791744164922, 10654.520546575577, 10662.200334974752, 10051.497425128568, 10170.542325595217, 10263.0, 10519.684409467729, 10585.8941410588, 10209.642662506776, 10472.842907356244, 10728.088112510524, 10880.45597720095, 10899.56401743953, 7235.493515453868, 7398.59307738058, 7609.39124869998, 7736.110347310131, 7756.495827771177, 8768.816209811848, 8784.956075219583, 10004.899951000396, 10431.217658675478, 10716.0], "unit": "score", "name": "jquery.html", "value": 8970.046944510621}, {"lowerIsBetter": false, "replicates": [1523.908565486071, 1533.7469317562602, 1786.5980154465246, 1898.9905050474745, 1921.2027008791351, 7982.52104873708, 8743.081976392476, 8743.081976392483, 8976.685815996441, 8977.326700497464, 8685.435446695976, 8749.387542872002, 8862.822743545124, 8885.777855553615, 8892.599833007514, 2477.4797292568537, 2489.788367988723, 2498.475320182764, 2509.7490250974847, 2511.3721569607596, 2443.1693224303735, 2516.471540976397, 2518.4711210645787, 2518.559252130879, 2518.659980902582, 2175.8041776240134, 2393.8444001139956, 2466.5436894174545, 2495.7878580320603, 2526.6462695222685, 2448.408534452611, 2462.753724627541, 2490.9252722418355, 2492.9127480538186, 2494.0148641286683, 2074.66805311151, 2479.3925488255313, 2491.987540062288, 2493.1523282084, 2500.2624225853415, 8577.571121443965, 8753.956230218871, 8760.605772740242, 8824.558772061371, 8860.0, 5321.787128514855, 5386.730663466811, 5442.755076021588, 5458.5087342139395, 5477.945220547823, 3616.72874534411, 3652.4703917932015, 3729.216864458467, 3743.3262012837677, 3747.5128233329765, 990.8315586350337, 1029.9588016479331, 1060.0, 1088.0, 1092.1317552545665, 11913.344766037864, 12068.275903445734, 12071.517139314417, 12085.395730213455, 12107.334096624681, 4880.145974454456, 4922.040202160616, 4938.4320803107385, 4965.950340496621, 4994.800207991712, 10079.0, 10156.695299141038, 10195.031472010147, 10212.387256764618, 10234.692959211236, 5393.2449457076045, 5412.945870541323, 5461.5357694596405, 5486.615936884459, 5491.093969494988, 4813.470518242991, 4904.239842824368, 4912.459629440758, 4959.702417854868, 5009.874753131128, 3983.0, 4010.6991975601945, 4023.396490526386, 4054.9659836741444, 4061.411095391211, 1115.6039605939936, 1206.4993027893327, 1251.0429521416124, 1319.8680131986725, 1339.7186590815843, 1018.7147598672384, 1120.6301920366259, 1156.8496095507699, 1266.5630357526638, 1377.9104358216684, 7934.365250779923, 7960.203979602109, 8033.959830200812, 8306.792330191673, 8502.914970850336, 1183.4910988274953, 1193.3078814287692, 1212.630147804928, 1222.1261797814605, 1230.7107829660022, 6414.550981431255, 6435.742570297136, 6498.805035848932, 6516.315786842408, 6519.0, 10853.077488413574, 10854.294470859526, 11259.887401126047, 11290.604828830952, 11294.209405341711, 10738.785224295627, 10858.565657373616, 10935.507902144423, 11110.61112861046, 11120.777584448266, 7068.681909314093, 8407.201315874981, 8422.873656895028, 8542.103079176597, 8596.753470746708, 6446.709898054505, 7908.327792137733, 7928.563928983961, 7960.04479462445, 8079.636416361395, 9421.764455888657, 9564.947855736003, 9803.068708472683, 9811.116999470081, 9856.950715246378, 8707.651693932172, 9227.077292270988, 9703.66037188695, 10019.699409017741, 10085.747856303358, 6966.0, 7097.751578694721, 7147.499675022698, 7174.2108368078425, 7215.963920180366, 8242.381821363542, 8312.0, 8314.792130196793, 8321.16788321163, 8332.791680208044, 7033.0, 7756.495827771177, 7978.481398709066, 7992.920070799218, 8041.396895232764, 6976.7558135465015, 7676.6161691916295, 7701.075870895528, 7846.5292082475235, 7916.722914697958, 7871.685132594861, 7888.290053895177, 7932.6033698316005, 7953.761387158394, 7959.681612735426, 6856.314368563104, 7013.544119632207, 7015.543989640657, 7024.5082844200415, 7151.392131668658, 7020.929790702027, 7091.858162836817, 7115.359617634438, 7124.893126603209, 7195.640217989185], "unit": "score", "name": "mootools.html", "value": 4987.983558126447}, {"lowerIsBetter": false, "replicates": [320.5112203889069, 325.9331836973421, 326.09996409908643, 330.9751768617354, 334.83425704276374, 5197.402298735647, 6218.564700470969, 6824.795256142312, 6861.519693621455, 6887.4490040796745, 6768.153980752406, 6799.6600169991425, 6801.877690181126, 6810.62541560214, 6923.861522769542, 5037.06814239365, 5049.203256905945, 5050.696958182502, 5057.4689657585795, 5061.519155680205, 4670.252759558454, 4739.980904105617, 4891.828785992491, 5047.520485553867, 5053.873653158664, 4033.394990751396, 4991.450940396571, 5001.374828146481, 5020.974895125538, 5038.748062596874, 4993.725345106018, 5002.774875130628, 5007.949920500803, 5009.499050094998, 5014.097462456756, 4013.9397909031386, 4070.75575465473, 4108.671306295519, 4272.46594175728, 4286.121345124242, 6586.7035983380865, 6623.503237257177, 6629.105070815426, 6646.368594983469, 6665.133532640774, 5923.259592550931, 5927.407259274081, 5944.881102377972, 5954.106883967396, 5975.760969561213, 7008.614526201057, 7264.8547029059655, 7283.526570772936, 7286.81782955425, 7290.0, 4771.355866957986, 4811.340087669749, 4815.3258543803895, 4817.108834865526, 4826.131296366652, 7725.768226953201, 7765.1070126935565, 7771.417143714244, 7782.727604533814, 7789.065312162576, 4572.565606267399, 4722.268048452495, 4886.462489126193, 4887.120318342661, 4890.388701412324, 4262.742490965173, 4641.512641172628, 4802.615790736732, 4808.831690890802, 4819.3012013257885, 5814.767409303665, 5823.4467725566, 5849.473547380756, 5851.853703657443, 5887.116932460165, 7182.533135346186, 7354.639391712551, 7387.6675549600395, 7406.555606663617, 7433.442491813135, 1648.934042638305, 1673.6234347271766, 1676.2708221923501, 1678.1106013812698, 1680.663867226535, 912.2838571721167, 1057.0486562094177, 1057.6826951914395, 1062.245805478119, 1077.5905156040653, 5610.831675049755, 6898.620575868275, 6907.481938854606, 6908.274631163756, 6913.308669133147, 7587.468877178655, 7592.633326001373, 7594.620268986529, 7601.821717633776, 7605.277498637621, 6751.696173672197, 6877.105976223059, 6886.724531018703, 6891.138607674041, 7040.0, 3917.490726205632, 4007.579204183577, 4048.6153815387493, 4087.3868919661695, 4094.7133700641266, 6422.45409140219, 8124.471909325875, 8140.470869393471, 8145.185481451807, 8152.429329946846, 7806.57063861493, 7983.640736166886, 7997.520148791091, 8002.279794818494, 8016.55908925003, 6819.624920629314, 7814.788707750307, 8078.474899131537, 8105.189481051965, 8110.594470276463, 7711.421643376882, 7712.807179820549, 7724.304812566896, 7725.1502334744255, 7763.534187948741, 5689.089745640843, 7216.530925489827, 7407.296321845898, 7555.395568354408, 7595.658195381111, 8093.3929955252415, 8105.716299929474, 8108.594570271581, 8124.634391452517, 8135.0, 4171.957010747313, 4478.641708663234, 4751.691140075884, 4757.09615173116, 4757.738324392053, 6185.659788711484, 7474.738384156746, 7660.616969151632, 7692.7692169235015, 7696.923030769844, 7213.891791623235, 7296.635168241673, 7337.74317898871, 7351.081114860643, 7354.154272258545, 7190.1731300901065, 7348.926510735038, 7372.299631534996, 7377.1885092638695, 7408.333250007525, 7184.856302873809, 7195.0, 7213.422926165999, 7215.71137154508, 7226.530275532074, 7361.779146625609, 7372.299631534996, 7378.5941773202985, 7382.483226174117, 7409.184989651242, 5208.374995000624, 5926.851828704317, 6991.475639326969, 7229.674664639999, 7247.420206383371], "unit": "score", "name": "prototype.html", "value": 5299.313089934289}, {"lowerIsBetter": false, "replicates": [677.5114864025826, 679.2562144451823, 688.2910602079858, 695.1658010387533, 747.4543583184279, 12093.516259349637, 14745.189014604219, 14778.704425911488, 14779.926100369497, 14909.030912990647, 13552.525661601845, 13729.725405491885, 13846.584602461917, 13887.861121388783, 13910.234937078456, 645.6642545876165, 781.2773184804062, 798.3214267872305, 805.9314958228529, 807.2532907060975, 659.4987809264945, 804.9356051515894, 809.1948511231333, 814.1004190369615, 817.4972391978949, 823.1315961660446, 843.0936743001267, 851.276415047208, 851.9105493923141, 851.9989012909837, 834.7454026521908, 845.4927043773748, 851.2594043182409, 854.6196942360652, 854.628236717027, 609.250621735268, 614.8370681769335, 615.6644628677382, 622.1445512420422, 626.545754328113, 14522.709545809024, 14576.271186440636, 14587.978841481101, 14617.488387906478, 14688.339024743806, 13131.409086591126, 13165.802512962313, 13204.207747535083, 13247.20516768997, 13398.196108233537, 8268.958655206745, 9318.20795232406, 9866.766654168228, 10161.847572286422, 10309.020643038899, 3510.5611798525183, 3535.699465545406, 3538.31002954424, 3542.291541691672, 3748.0817199785956, 73095.0, 73098.26901730968, 74180.51638967244, 74216.62891685561, 74649.25350746477, 9323.347365684336, 9637.37357071788, 9804.0, 9804.509774511245, 10079.143272821746, 20630.0, 20891.26880559173, 20910.0, 20922.581548369253, 21186.36440906775, 6212.782552610727, 7511.248875112445, 7622.923770762332, 7702.191269916578, 7725.0, 4165.708400411942, 4181.581841815855, 4238.427812245307, 4244.469441319835, 4290.2706539888295, 3548.751587388858, 3549.18368775178, 3569.0, 3585.103724068983, 3585.1216451969435, 657.5331514624575, 664.6377724140356, 672.7712577723597, 672.9972341211658, 673.9966300168566, 524.29744142848, 553.3277068361879, 599.7301214453513, 623.6476390839161, 634.5304474688697, 8342.62458189383, 8600.39797214189, 8792.912070879338, 8887.15572020657, 8945.25369146248, 501.30068554366454, 520.8906129712727, 521.4446614355699, 548.4953842464942, 574.3251679276833, 4009.4787677601726, 4034.415009823559, 4120.75275483472, 4132.669386449077, 4214.157168566299, 93067.53466232626, 95893.5205323969, 97738.0, 97952.0, 98037.50981245049, 58760.0, 80478.19521804825, 81017.0, 81107.18892811115, 83815.13294069479, 53686.73156634192, 69704.0, 70983.0, 71223.64388178026, 71773.0, 8288.58557072132, 8378.790530236793, 8491.23578877904, 8555.31557475413, 8613.612387442456, 48240.758796205795, 48546.02907941892, 49302.506974931224, 49604.00791984212, 50023.24965125599, 65188.34811651823, 70481.94277085745, 70651.64674176596, 70945.0, 71215.0, 8057.919420805717, 9932.801343973224, 9942.353747006422, 10013.048760367754, 10361.22290828206, 9946.850797237903, 11067.391293478937, 11191.88808111941, 11931.76136477283, 12720.0, 11805.881941180478, 11886.108541859569, 11943.16397852142, 12063.974562162315, 12105.515779368727, 10428.217883658604, 10441.590385297888, 11721.589744358907, 12048.277103373826, 12077.939610301892, 9926.659900913284, 11408.429578520874, 11656.766864662828, 11878.703032424259, 12009.459574319002, 9040.141186587263, 9193.54032298369, 9428.888466806075, 9586.856197156909, 9711.805763884824, 8957.28341732673, 9129.402354588054, 9410.38832475887, 9714.222862171151, 10146.391216526737], "unit": "score", "name": "yui.html", "value": 6736.1110972624465}], "name": "dromaeo_css", "value": 7490.135784823381}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [124.0, 151.0, 99.0, 168.0, 167.0, 179.0, 113.0, 115.0, 115.0, 125.0], "unit": "score", "name": "ai-astar", "value": 135.6}, {"lowerIsBetter": true, "replicates": [185.0, 110.0, 177.0, 180.0, 148.0, 153.0, 177.0, 157.0, 150.0, 102.0], "unit": "score", "name": "audio-beat-detection", "value": 153.9}, {"lowerIsBetter": true, "replicates": [201.0, 194.0, 201.0, 214.0, 271.0, 273.0, 196.0, 225.0, 167.0, 251.0], "unit": "score", "name": "audio-dft", "value": 219.3}, {"lowerIsBetter": true, "replicates": [66.0, 83.0, 95.0, 119.0, 58.0, 82.0, 49.0, 63.0, 97.0, 82.0], "unit": "score", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 132.0, 117.0, 120.0, 123.0, 119.0, 81.0, 82.0, 122.0], "unit": "score", "name": "audio-oscillator", "value": 105.8}, {"lowerIsBetter": true, "replicates": [87.0, 93.0, 102.0, 140.0, 85.0, 92.0, 85.0, 92.0, 86.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 95.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 107.0, 134.0, 95.0, 106.0, 127.0, 97.0, 122.0], "unit": "score", "name": "imaging-darkroom", "value": 107.6}, {"lowerIsBetter": true, "replicates": [93.0, 77.0, 151.0, 151.0, 91.0, 91.0, 92.0, 135.0, 151.0, 94.0], "unit": "score", "name": "imaging-desaturate", "value": 112.6}, {"lowerIsBetter": true, "replicates": [57.0, 57.0, 55.0, 58.0, 55.0, 65.0, 85.0, 97.0, 87.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 67.0}, {"lowerIsBetter": true, "replicates": [62.0, 65.0, 65.0, 62.0, 71.0, 71.0, 69.0, 65.0, 65.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 66.1}, {"lowerIsBetter": true, "replicates": [85.0, 87.0, 83.0, 74.0, 112.0, 111.0, 112.0, 112.0, 87.0, 88.0], "unit": "score", "name": "stanford-crypto-aes", "value": 95.1}, {"lowerIsBetter": true, "replicates": [119.0, 126.0, 126.0, 117.0, 127.0, 140.0, 138.0, 142.0, 147.0, 143.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 132.5}, {"lowerIsBetter": true, "replicates": [142.0, 141.0, 142.0, 127.0, 112.0, 181.0, 177.0, 182.0, 156.0, 144.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.4}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 68.0, 69.0, 71.0, 69.0, 67.0, 69.0, 68.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1590.0}]} 20:50:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1590.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7490.13"}}} 20:50:57 INFO - Return code: 0 20:50:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:50:57 INFO - # TBPL SUCCESS # 20:50:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:50:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:50:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:50:57 INFO - 2016-02-05 20:50:57.626 screenresolution[1699:11060] starting screenresolution argv=screenresolution get 20:50:57 INFO - 2016-02-05 20:50:57.628 screenresolution[1699:11060] Display 0: 1600x1200x32@60 20:50:57 INFO - 2016-02-05 20:50:57.634 screenresolution[1700:11063] starting screenresolution argv=screenresolution list 20:50:57 INFO - Available Modes on Display 0 20:50:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:50:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:50:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:50:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:50:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:50:57 INFO - Intel Iris: 20:50:57 INFO - Chipset Model: Intel Iris 20:50:57 INFO - Type: GPU 20:50:57 INFO - Bus: Built-In 20:50:57 INFO - VRAM (Dynamic, Max): 1536 MB 20:50:57 INFO - Vendor: Intel (0x8086) 20:50:57 INFO - Device ID: 0x0a2e 20:50:57 INFO - Revision ID: 0x0009 20:50:57 INFO - Displays: 20:50:57 INFO - Display: 20:50:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:50:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:50:57 INFO - Display Serial Number: 1600x1200 60 20:50:57 INFO - Main Display: Yes 20:50:57 INFO - Mirror: Off 20:50:57 INFO - Online: Yes 20:50:57 INFO - Rotation: Supported 20:50:57 INFO - Return code: 0 20:50:57 INFO - Running post-action listener: _resource_record_post_action 20:50:57 INFO - Running post-run listener: _resource_record_post_run 20:50:58 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 34078208; Write bytes: 715980288; Read time: 361; Write time: 2141 20:50:58 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 395401728; Write bytes: 390137344; Read time: 29748; Write time: 755 20:50:58 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 32308736; Write bytes: 305911808; Read time: 343; Write time: 1340 20:50:58 INFO - Running post-run listener: _upload_blobber_files 20:50:58 INFO - Blob upload gear active. 20:50:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:50:58 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 20:50:58 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'] 20:50:58 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 20:50:59 INFO - (blobuploader) - INFO - Open directory for files ... 20:50:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:50:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:50:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:51:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:51:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:51:00 INFO - (blobuploader) - INFO - Done attempting. 20:51:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:51:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:51:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:51:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:51:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:51:01 INFO - (blobuploader) - INFO - Done attempting. 20:51:01 INFO - (blobuploader) - INFO - Iteration through files over. 20:51:01 INFO - Return code: 0 20:51:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:51:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:51:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b07b6121026262980b462b8c47f75e5d715294ff1a459815f6b3b8be4efcd0747429eef709f28239cfba90d9ade9a345bb7362fddbedb424d2db920c32f2a9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d451b2e0ef35a4c657b885e2bbd60fb5c10ded86484b78aca0fcd898100639118e76248921ddda446bf8a891ec1f418472f7208753b9726741cfda44360383ee"} 20:51:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:51:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:51:01 INFO - Contents: 20:51:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b07b6121026262980b462b8c47f75e5d715294ff1a459815f6b3b8be4efcd0747429eef709f28239cfba90d9ade9a345bb7362fddbedb424d2db920c32f2a9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d451b2e0ef35a4c657b885e2bbd60fb5c10ded86484b78aca0fcd898100639118e76248921ddda446bf8a891ec1f418472f7208753b9726741cfda44360383ee"} 20:51:01 INFO - Running post-run listener: copy_logs_to_upload_dir 20:51:01 INFO - Copying logs to upload dir... 20:51:01 INFO - mkdir: /builds/slave/test/build/upload/logs 20:51:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1272.741292 ========= master_lag: 3.36 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-02-05 20:51:04.573282) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-05 20:51:04.579493) ========= 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.udTnQUDdPb/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.JdOvlkOwcW/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b07b6121026262980b462b8c47f75e5d715294ff1a459815f6b3b8be4efcd0747429eef709f28239cfba90d9ade9a345bb7362fddbedb424d2db920c32f2a9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d451b2e0ef35a4c657b885e2bbd60fb5c10ded86484b78aca0fcd898100639118e76248921ddda446bf8a891ec1f418472f7208753b9726741cfda44360383ee"} build_url:https://queue.taskcluster.net/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010418 build_url: 'https://queue.taskcluster.net/v1/task/btYcCT2YSQe818na9Ue--g/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b07b6121026262980b462b8c47f75e5d715294ff1a459815f6b3b8be4efcd0747429eef709f28239cfba90d9ade9a345bb7362fddbedb424d2db920c32f2a9b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d451b2e0ef35a4c657b885e2bbd60fb5c10ded86484b78aca0fcd898100639118e76248921ddda446bf8a891ec1f418472f7208753b9726741cfda44360383ee"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-05 20:51:04.634492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 20:51:04.634835) ========= 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.udTnQUDdPb/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.JdOvlkOwcW/Listeners TMPDIR=/var/folders/tp/rw9d9fx970v_2f584_850cxc00000w/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.005177 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-05 20:51:04.683697) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-05 20:51:04.684022) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-05 20:51:04.684420) ========= ========= Total master_lag: 4.11 =========