builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0114 starttime: 1459259615.45 results: success (0) buildid: 20160329051731 builduid: d0df4c616f7a4068869afcba50bb5c5b revision: d5d53a3b4e50b94cdf85d20690526e5a00d5b63e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 06:53:35.452832) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-29 06:53:35.453257) ========= ========= Started set props: basedir (results: 0, elapsed: 2 secs) (at 2016-03-29 06:53:35.453549) ========= 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.NKHQPSRVB5/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.S3baZpgg2L/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005375 basedir: '/builds/slave/test' ========= master_lag: 2.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 2 secs) (at 2016-03-29 06:53:37.488298) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 06:53:37.488629) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-29 06:53:38.449020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 06:53:38.449381) ========= 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.NKHQPSRVB5/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.S3baZpgg2L/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005250 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-29 06:53:38.515608) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 06:53:38.515968) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-29 06:53:38.519350) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-29 06:53:38.519648) ========= 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.NKHQPSRVB5/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.S3baZpgg2L/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-29 06:53:38-- 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% 159M=0s 2016-03-29 06:53:39 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.883835 ========= master_lag: 1.52 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-29 06:53:40.919807) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-03-29 06:53:40.920189) ========= 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.NKHQPSRVB5/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.S3baZpgg2L/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.020014 ========= master_lag: 5.70 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 5 secs) (at 2016-03-29 06:53:46.635665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-29 06:53:46.636004) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d5d53a3b4e50b94cdf85d20690526e5a00d5b63e --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 d5d53a3b4e50b94cdf85d20690526e5a00d5b63e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NKHQPSRVB5/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.S3baZpgg2L/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-29 06:53:47,111 truncating revision to first 12 chars 2016-03-29 06:53:47,111 Setting DEBUG logging. 2016-03-29 06:53:47,111 attempt 1/10 2016-03-29 06:53:47,111 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d5d53a3b4e50?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-29 06:53:48,795 unpacking tar archive at: mozilla-central-d5d53a3b4e50/testing/mozharness/ program finished with exit code 0 elapsedTime=1.932912 ========= master_lag: 4.86 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 6 secs) (at 2016-03-29 06:53:53.428650) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 06:53:53.429021) ========= echo d5d53a3b4e50b94cdf85d20690526e5a00d5b63e in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd5d53a3b4e50b94cdf85d20690526e5a00d5b63e'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NKHQPSRVB5/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.S3baZpgg2L/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 d5d53a3b4e50b94cdf85d20690526e5a00d5b63e program finished with exit code 0 elapsedTime=0.005201 script_repo_revision: 'd5d53a3b4e50b94cdf85d20690526e5a00d5b63e' ========= master_lag: 0.17 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-29 06:53:53.605651) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 06:53:53.606021) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-29 06:53:54.531648) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2016-03-29 06:53:54.532083) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.NKHQPSRVB5/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.S3baZpgg2L/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 06:53:54 INFO - MultiFileLogger online at 20160329 06:53:54 in /builds/slave/test 06:53:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:53:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:53:54 INFO - {'append_to_log': False, 06:53:54 INFO - 'base_work_dir': '/builds/slave/test', 06:53:54 INFO - 'blob_upload_branch': 'Firefox', 06:53:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:53:54 INFO - 'branch': 'Firefox', 06:53:54 INFO - 'buildbot_json_path': 'buildprops.json', 06:53:54 INFO - 'config_files': ('talos/mac_config.py',), 06:53:54 INFO - 'default_actions': ('clobber', 06:53:54 INFO - 'read-buildbot-config', 06:53:54 INFO - 'download-and-extract', 06:53:54 INFO - 'populate-webroot', 06:53:54 INFO - 'create-virtualenv', 06:53:54 INFO - 'install', 06:53:54 INFO - 'run-tests'), 06:53:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:53:54 INFO - 'download_minidump_stackwalk': True, 06:53:54 INFO - 'download_symbols': 'ondemand', 06:53:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:53:54 INFO - 'tooltool.py': '/tools/tooltool.py', 06:53:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:53:54 INFO - '/tools/misc-python/virtualenv.py')}, 06:53:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:53:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:53:54 INFO - 'installer_path': 'installer.exe', 06:53:54 INFO - 'log_level': 'info', 06:53:54 INFO - 'log_name': 'talos', 06:53:54 INFO - 'log_to_console': True, 06:53:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:53:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:53:54 INFO - 'opt_config_files': (), 06:53:54 INFO - 'pip_index': False, 06:53:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:53:54 INFO - 'cmd': ('bash', 06:53:54 INFO - '-c', 06:53:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:53:55 INFO - 'enabled': True, 06:53:55 INFO - 'halt_on_failure': False, 06:53:55 INFO - 'name': 'check_screen_resolution'},), 06:53:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:53:55 INFO - 'cmd': ('bash', 06:53:55 INFO - '-c', 06:53:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:53:55 INFO - 'enabled': True, 06:53:55 INFO - 'halt_on_failure': False, 06:53:55 INFO - 'name': 'check_screen_resolution'},), 06:53:55 INFO - 'run_cmd_checks_enabled': True, 06:53:55 INFO - 'sps_profile': False, 06:53:55 INFO - 'sps_profile_interval': 0, 06:53:55 INFO - 'suite': 'dromaeojs', 06:53:55 INFO - 'system_bits': '32', 06:53:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:53:55 INFO - 'title': 't-yosemite-r7-0114', 06:53:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:53:55 INFO - 'use_talos_json': True, 06:53:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:53:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:53:55 INFO - 'work_dir': 'build'} 06:53:55 INFO - ##### 06:53:55 INFO - ##### Running clobber step. 06:53:55 INFO - ##### 06:53:55 INFO - Running pre-action listener: _resource_record_pre_action 06:53:55 INFO - Running main action method: clobber 06:53:55 INFO - rmtree: /builds/slave/test/build 06:53:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:53:55 INFO - Running post-action listener: _resource_record_post_action 06:53:55 INFO - ##### 06:53:55 INFO - ##### Running read-buildbot-config step. 06:53:55 INFO - ##### 06:53:55 INFO - Running pre-action listener: _resource_record_pre_action 06:53:55 INFO - Running main action method: read_buildbot_config 06:53:55 INFO - Using buildbot properties: 06:53:55 INFO - { 06:53:55 INFO - "project": "", 06:53:55 INFO - "product": "firefox", 06:53:55 INFO - "script_repo_revision": "production", 06:53:55 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:53:55 INFO - "repository": "", 06:53:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:53:55 INFO - "buildid": "20160329051731", 06:53:55 INFO - "pgo_build": "False", 06:53:55 INFO - "basedir": "/builds/slave/test", 06:53:55 INFO - "buildnumber": 196, 06:53:55 INFO - "slavename": "t-yosemite-r7-0114", 06:53:55 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 06:53:55 INFO - "platform": "yosemite_r7", 06:53:55 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:53:55 INFO - "branch": "mozilla-central", 06:53:55 INFO - "repo_path": "mozilla-central", 06:53:55 INFO - "revision": "d5d53a3b4e50b94cdf85d20690526e5a00d5b63e", 06:53:55 INFO - "stage_platform": "macosx64", 06:53:55 INFO - "builduid": "d0df4c616f7a4068869afcba50bb5c5b", 06:53:55 INFO - "slavebuilddir": "test" 06:53:55 INFO - } 06:53:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 06:53:55 INFO - Running post-action listener: _resource_record_post_action 06:53:55 INFO - ##### 06:53:55 INFO - ##### Running download-and-extract step. 06:53:55 INFO - ##### 06:53:55 INFO - Running pre-action listener: _resource_record_pre_action 06:53:55 INFO - Running main action method: download_and_extract 06:53:55 INFO - mkdir: /builds/slave/test/build/tests 06:53:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:53:55 INFO - https://queue.taskcluster.net/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:53:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:53:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 06:53:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 06:53:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 06:54:12 INFO - Downloaded 1199 bytes. 06:54:12 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 06:54:12 INFO - Using the following test package requirements: 06:54:12 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:54:12 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:54:12 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 06:54:12 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:54:12 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 06:54:12 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:54:12 INFO - u'jsshell-mac.zip'], 06:54:12 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:54:12 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 06:54:12 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 06:54:12 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:54:12 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 06:54:12 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:54:12 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 06:54:12 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:54:12 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 06:54:12 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 06:54:12 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 06:54:12 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:54:12 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')]} 06:54:12 INFO - https://queue.taskcluster.net/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:54:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:54:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:54:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:54:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:54:14 INFO - Downloaded 17944727 bytes. 06:54:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:54:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:54:17 INFO - Return code: 0 06:54:17 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:54:17 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')]} 06:54:17 INFO - https://queue.taskcluster.net/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:54:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:54:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:54:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 06:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:54:23 INFO - Downloaded 17944727 bytes. 06:54:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:54:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:54:26 INFO - Return code: 0 06:54:26 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')]} 06:54:26 INFO - https://queue.taskcluster.net/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:54:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:54:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:54:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 06:54:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:54:28 INFO - Downloaded 10847531 bytes. 06:54:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:54:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:54:28 INFO - Return code: 0 06:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:54:28 INFO - https://queue.taskcluster.net/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 06:54:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:54:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:54:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 06:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 06:54:37 INFO - Downloaded 111423060 bytes. 06:54:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:54:37 INFO - mkdir: /builds/slave/test/properties 06:54:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:54:37 INFO - Writing to file /builds/slave/test/properties/build_url 06:54:37 INFO - Contents: 06:54:37 INFO - build_url:https://queue.taskcluster.net/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 06:54:38 INFO - Running post-action listener: _resource_record_post_action 06:54:38 INFO - Running post-action listener: set_extra_try_arguments 06:54:38 INFO - ##### 06:54:38 INFO - ##### Running populate-webroot step. 06:54:38 INFO - ##### 06:54:38 INFO - Running pre-action listener: _resource_record_pre_action 06:54:38 INFO - Running main action method: populate_webroot 06:54:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:54:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:54:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:54:38 INFO - '--tppagecycles', 06:54:38 INFO - '7'], 06:54:38 INFO - 'tests': ['tsvgm']}}, 06:54:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:54:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:54:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:54:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:54:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:54:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:54:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:38 INFO - 'talos_options': ['--e10s'], 06:54:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:54:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:38 INFO - 'tests': ['damp', 'tps']}, 06:54:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:38 INFO - 'talos_options': ['--e10s'], 06:54:38 INFO - 'tests': ['damp', 'tps']}, 06:54:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:54:38 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 06:54:38 INFO - 'tests': ['dromaeo_dom']}, 06:54:38 INFO - 'other': {'tests': ['a11yr', 06:54:38 INFO - 'ts_paint', 06:54:38 INFO - 'tpaint', 06:54:38 INFO - 'sessionrestore', 06:54:38 INFO - 'sessionrestore_no_auto_restore', 06:54:38 INFO - 'tabpaint']}, 06:54:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:54:38 INFO - 'tests': ['a11yr', 06:54:38 INFO - 'ts_paint', 06:54:38 INFO - 'tpaint', 06:54:38 INFO - 'sessionrestore', 06:54:38 INFO - 'sessionrestore_no_auto_restore', 06:54:38 INFO - 'tabpaint']}, 06:54:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:54:38 INFO - 'tests': ['a11yr', 06:54:38 INFO - 'ts_paint', 06:54:38 INFO - 'tpaint', 06:54:38 INFO - 'sessionrestore', 06:54:38 INFO - 'sessionrestore_no_auto_restore', 06:54:38 INFO - 'tabpaint']}, 06:54:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:54:38 INFO - 'tests': ['a11yr', 06:54:38 INFO - 'ts_paint', 06:54:38 INFO - 'tpaint', 06:54:38 INFO - 'sessionrestore', 06:54:38 INFO - 'sessionrestore_no_auto_restore', 06:54:38 INFO - 'tabpaint']}, 06:54:38 INFO - 'other_l64': {'tests': ['a11yr', 06:54:38 INFO - 'ts_paint', 06:54:38 INFO - 'tpaint', 06:54:38 INFO - 'sessionrestore', 06:54:38 INFO - 'sessionrestore_no_auto_restore', 06:54:38 INFO - 'tabpaint']}, 06:54:38 INFO - 'other_nol64': {'tests': ['a11yr', 06:54:38 INFO - 'ts_paint', 06:54:38 INFO - 'tpaint', 06:54:38 INFO - 'sessionrestore', 06:54:38 INFO - 'sessionrestore_no_auto_restore', 06:54:38 INFO - 'tabpaint']}, 06:54:38 INFO - 'svgr': {'tests': ['tsvgx', 06:54:38 INFO - 'tsvgr_opacity', 06:54:38 INFO - 'tart', 06:54:38 INFO - 'tscrollx', 06:54:38 INFO - 'cart']}, 06:54:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:54:38 INFO - 'tests': ['tsvgx', 06:54:38 INFO - 'tsvgr_opacity', 06:54:38 INFO - 'tart', 06:54:38 INFO - 'tscrollx', 06:54:38 INFO - 'cart']}, 06:54:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:38 INFO - 'tests': ['tp5o']}, 06:54:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:38 INFO - 'talos_options': ['--e10s'], 06:54:38 INFO - 'tests': ['tp5o']}, 06:54:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:38 INFO - 'talos_options': ['--xperf_path', 06:54:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:38 INFO - 'tests': ['tp5n']}, 06:54:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:54:38 INFO - 'talos_options': ['--e10s', 06:54:38 INFO - '--xperf_path', 06:54:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:54:38 INFO - 'tests': ['tp5n']}}, 06:54:38 INFO - 'talos.zip': {'path': '', 06:54:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:54:38 INFO - Running post-action listener: _resource_record_post_action 06:54:38 INFO - ##### 06:54:38 INFO - ##### Running create-virtualenv step. 06:54:38 INFO - ##### 06:54:38 INFO - Running pre-action listener: _resource_record_pre_action 06:54:38 INFO - Running main action method: create_virtualenv 06:54:38 INFO - Creating virtualenv /builds/slave/test/build/venv 06:54:38 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 06:54:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:54:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:54:38 INFO - Using real prefix '/tools/python27' 06:54:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:54:39 INFO - Installing distribute.............................................................................................................................................................................................done. 06:54:42 INFO - Installing pip.................done. 06:54:42 INFO - Return code: 0 06:54:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fd92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc14a3260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc31e00>, '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 0x10fa5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc2cb20>, '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.NKHQPSRVB5/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.S3baZpgg2L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 06:54: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', 'pip>=1.5'] in /builds/slave/test/build 06:54: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 pip>=1.5 06:54:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKHQPSRVB5/Render', 06:54:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:42 INFO - 'HOME': '/Users/cltbld', 06:54:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:42 INFO - 'LOGNAME': 'cltbld', 06:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:42 INFO - 'MOZ_NO_REMOTE': '1', 06:54:42 INFO - 'NO_EM_RESTART': '1', 06:54:42 INFO - 'PAGER': '/bin/cat', 06:54:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:42 INFO - 'PWD': '/builds/slave/test', 06:54:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:42 INFO - 'SHELL': '/bin/bash', 06:54:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S3baZpgg2L/Listeners', 06:54:42 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 06:54:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:42 INFO - 'USER': 'cltbld', 06:54:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:42 INFO - 'XPC_FLAGS': '0x0', 06:54:42 INFO - 'XPC_SERVICE_NAME': '0', 06:54:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:42 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 06:54:42 INFO - Cleaning up... 06:54:42 INFO - Return code: 0 06:54:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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', '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 0x10fd92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc14a3260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc31e00>, '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 0x10fa5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc2cb20>, '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.NKHQPSRVB5/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.S3baZpgg2L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 06:54: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', 'psutil>=0.7.1'] in /builds/slave/test/build 06:54: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 psutil>=0.7.1 06:54:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKHQPSRVB5/Render', 06:54:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:42 INFO - 'HOME': '/Users/cltbld', 06:54:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:42 INFO - 'LOGNAME': 'cltbld', 06:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:42 INFO - 'MOZ_NO_REMOTE': '1', 06:54:42 INFO - 'NO_EM_RESTART': '1', 06:54:42 INFO - 'PAGER': '/bin/cat', 06:54:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:42 INFO - 'PWD': '/builds/slave/test', 06:54:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:42 INFO - 'SHELL': '/bin/bash', 06:54:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S3baZpgg2L/Listeners', 06:54:42 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 06:54:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:42 INFO - 'USER': 'cltbld', 06:54:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:42 INFO - 'XPC_FLAGS': '0x0', 06:54:42 INFO - 'XPC_SERVICE_NAME': '0', 06:54:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:43 INFO - Downloading/unpacking psutil>=0.7.1 06:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:54:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:46 INFO - Installing collected packages: psutil 06:54:46 INFO - Running setup.py install for psutil 06:54:46 INFO - building 'psutil._psutil_osx' extension 06:54:46 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 06:54:46 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 06:54:46 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 06:54:46 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 06:54:46 INFO - building 'psutil._psutil_posix' extension 06:54:46 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 06:54:46 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:54:46 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:54:46 INFO - ^ 06:54:46 INFO - 1 warning generated. 06:54:46 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 06:54:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:54:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:54:46 INFO - Successfully installed psutil 06:54:46 INFO - Cleaning up... 06:54:47 INFO - Return code: 0 06:54:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:54:47 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')]} 06:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:47 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')]} 06:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:47 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 0x10fd92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc14a3260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc31e00>, '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 0x10fa5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc2cb20>, '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.NKHQPSRVB5/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.S3baZpgg2L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 06:54:47 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 06:54:47 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 06:54:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKHQPSRVB5/Render', 06:54:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:47 INFO - 'HOME': '/Users/cltbld', 06:54:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:47 INFO - 'LOGNAME': 'cltbld', 06:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:47 INFO - 'MOZ_NO_REMOTE': '1', 06:54:47 INFO - 'NO_EM_RESTART': '1', 06:54:47 INFO - 'PAGER': '/bin/cat', 06:54:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:47 INFO - 'PWD': '/builds/slave/test', 06:54:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:47 INFO - 'SHELL': '/bin/bash', 06:54:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S3baZpgg2L/Listeners', 06:54:47 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 06:54:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:47 INFO - 'USER': 'cltbld', 06:54:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:47 INFO - 'XPC_FLAGS': '0x0', 06:54:47 INFO - 'XPC_SERVICE_NAME': '0', 06:54:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:47 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:54:47 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 06:54:47 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 06:54:47 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 06:54:47 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 06:54:47 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 06:54:47 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 06:54:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:54:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:54:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:54:49 INFO - Installing collected packages: mozsystemmonitor 06:54:49 INFO - Running setup.py install for mozsystemmonitor 06:54:50 INFO - Successfully installed mozsystemmonitor 06:54:50 INFO - Cleaning up... 06:54:50 INFO - Return code: 0 06:54:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:54: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')]} 06:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54: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')]} 06:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:50 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 0x10fd92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc14a3260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc31e00>, '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 0x10fa5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc2cb20>, '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.NKHQPSRVB5/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.S3baZpgg2L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 06:54:50 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 06:54:50 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 06:54:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKHQPSRVB5/Render', 06:54:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:50 INFO - 'HOME': '/Users/cltbld', 06:54:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:50 INFO - 'LOGNAME': 'cltbld', 06:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:50 INFO - 'MOZ_NO_REMOTE': '1', 06:54:50 INFO - 'NO_EM_RESTART': '1', 06:54:50 INFO - 'PAGER': '/bin/cat', 06:54:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:50 INFO - 'PWD': '/builds/slave/test', 06:54:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:50 INFO - 'SHELL': '/bin/bash', 06:54:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S3baZpgg2L/Listeners', 06:54:50 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 06:54:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:50 INFO - 'USER': 'cltbld', 06:54:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:50 INFO - 'XPC_FLAGS': '0x0', 06:54:50 INFO - 'XPC_SERVICE_NAME': '0', 06:54:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:50 INFO - Downloading/unpacking blobuploader==1.2.4 06:54:50 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 06:54:50 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 06:54:50 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 06:54:50 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 06:54:50 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 06:54:50 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 06:54:52 INFO - Downloading blobuploader-1.2.4.tar.gz 06:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:54:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:54:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:54:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:54:53 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 06:54:53 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 06:54:53 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 06:54:53 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 06:54:53 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 06:54:53 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 06:54:53 INFO - Downloading docopt-0.6.1.tar.gz 06:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:54:54 INFO - Installing collected packages: blobuploader, requests, docopt 06:54:54 INFO - Running setup.py install for blobuploader 06:54:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:54:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:54:54 INFO - Running setup.py install for requests 06:54:54 INFO - Running setup.py install for docopt 06:54:54 INFO - Successfully installed blobuploader requests docopt 06:54:54 INFO - Cleaning up... 06:54:54 INFO - Return code: 0 06:54:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:54 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')]} 06:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:54 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')]} 06:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:54 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 0x10fd92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc14a3260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc31e00>, '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 0x10fa5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc2cb20>, '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.NKHQPSRVB5/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.S3baZpgg2L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 06:54:54 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 06:54:54 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 06:54:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKHQPSRVB5/Render', 06:54:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:54 INFO - 'HOME': '/Users/cltbld', 06:54:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:54 INFO - 'LOGNAME': 'cltbld', 06:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:54 INFO - 'MOZ_NO_REMOTE': '1', 06:54:54 INFO - 'NO_EM_RESTART': '1', 06:54:54 INFO - 'PAGER': '/bin/cat', 06:54:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:54 INFO - 'PWD': '/builds/slave/test', 06:54:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:54 INFO - 'SHELL': '/bin/bash', 06:54:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S3baZpgg2L/Listeners', 06:54:54 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 06:54:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:54 INFO - 'USER': 'cltbld', 06:54:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:54 INFO - 'XPC_FLAGS': '0x0', 06:54:54 INFO - 'XPC_SERVICE_NAME': '0', 06:54:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:54:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-pMcgb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:54:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-lFvCNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:54:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-bIAliE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:54:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-Fvj9Tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:54:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-AR2fFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:54:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-4k1OA3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:54:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-nSLVR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:54:55 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-_MKSJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:54:56 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-CDFHHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:54:56 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-lYlTCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:54:56 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-fUu12I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:54:56 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-ntStYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:54:56 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-xc52Br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:54:56 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-nc2f6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:56 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-tcmTsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:54:56 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-_GoKBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:54:56 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-KhHCnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:54:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:54:56 INFO - Running setup.py install for manifestparser 06:54:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:54:57 INFO - Running setup.py install for mozcrash 06:54:57 INFO - Running setup.py install for mozdebug 06:54:57 INFO - Running setup.py install for mozdevice 06:54:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:54:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:54:57 INFO - Running setup.py install for mozfile 06:54:57 INFO - Running setup.py install for mozhttpd 06:54:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:54:57 INFO - Running setup.py install for mozinfo 06:54:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:54:57 INFO - Running setup.py install for mozInstall 06:54:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Running setup.py install for mozleak 06:54:58 INFO - Running setup.py install for mozlog 06:54:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Running setup.py install for moznetwork 06:54:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Running setup.py install for mozprocess 06:54:58 INFO - Running setup.py install for mozprofile 06:54:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:54:58 INFO - Running setup.py install for mozrunner 06:54:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:54:59 INFO - Running setup.py install for mozscreenshot 06:54:59 INFO - Running setup.py install for moztest 06:54:59 INFO - Running setup.py install for mozversion 06:54:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:54:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:54:59 INFO - Cleaning up... 06:54:59 INFO - Return code: 0 06:54:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:54:59 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')]} 06:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:59 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')]} 06:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:54:59 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 0x10fd92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc14a3260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc31e00>, '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 0x10fa5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc2cb20>, '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.NKHQPSRVB5/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.S3baZpgg2L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 06:54:59 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 06:54:59 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 06:54:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKHQPSRVB5/Render', 06:54:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:54:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:54:59 INFO - 'HOME': '/Users/cltbld', 06:54:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:54:59 INFO - 'LOGNAME': 'cltbld', 06:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:54:59 INFO - 'MOZ_NO_REMOTE': '1', 06:54:59 INFO - 'NO_EM_RESTART': '1', 06:54:59 INFO - 'PAGER': '/bin/cat', 06:54:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:54:59 INFO - 'PWD': '/builds/slave/test', 06:54:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:54:59 INFO - 'SHELL': '/bin/bash', 06:54:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S3baZpgg2L/Listeners', 06:54:59 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 06:54:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:54:59 INFO - 'USER': 'cltbld', 06:54:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:54:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:54:59 INFO - 'XPC_FLAGS': '0x0', 06:54:59 INFO - 'XPC_SERVICE_NAME': '0', 06:54:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:55:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-uC0xFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:55:00 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)) 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:55:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-kQy1Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:55:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:55:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-YR3Gpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:55:00 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)) 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:55:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-wyCbDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:55:00 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)) 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:55:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-VLOIr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:55:00 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)) 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:55:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-6k1GBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:55:00 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)) 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:55:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-kkgqPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:55:00 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)) 06:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:55:00 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-g54iPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:55:01 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)) 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:55:01 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-iyBGCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:55:01 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)) 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:55:01 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-7unwdx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:55:01 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)) 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:55:01 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-viY3Od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:55:01 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)) 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:55:01 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-jk9n8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:55:01 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)) 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:55:01 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-kpZEWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:55:01 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)) 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:55:01 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-did_0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:55:01 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)) 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:01 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-uB2N0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:55:01 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)) 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:55:01 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-EbzTAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:55:01 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)) 06:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:55:01 INFO - Running setup.py (path:/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/pip-hqgfLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:55:01 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)) 06:55:01 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:55:01 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:55:01 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)) 06:55:01 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)) 06:55:01 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)) 06:55:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:55:01 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 06:55:01 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 06:55:01 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 06:55:01 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 06:55:01 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 06:55:01 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 06:55:04 INFO - Downloading blessings-1.6.tar.gz 06:55:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:55:04 INFO - Installing collected packages: blessings 06:55:04 INFO - Running setup.py install for blessings 06:55:05 INFO - Successfully installed blessings 06:55:05 INFO - Cleaning up... 06:55:05 INFO - Return code: 0 06:55:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:55:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:05 INFO - Reading from file tmpfile_stdout 06:55:05 INFO - Current package versions: 06:55:05 INFO - blessings == 1.6 06:55:05 INFO - blobuploader == 1.2.4 06:55:05 INFO - docopt == 0.6.1 06:55:05 INFO - manifestparser == 1.1 06:55:05 INFO - mozInstall == 1.12 06:55:05 INFO - mozcrash == 0.17 06:55:05 INFO - mozdebug == 0.1 06:55:05 INFO - mozdevice == 0.48 06:55:05 INFO - mozfile == 1.2 06:55:05 INFO - mozhttpd == 0.7 06:55:05 INFO - mozinfo == 0.9 06:55:05 INFO - mozleak == 0.1 06:55:05 INFO - mozlog == 3.1 06:55:05 INFO - moznetwork == 0.27 06:55:05 INFO - mozprocess == 0.22 06:55:05 INFO - mozprofile == 0.28 06:55:05 INFO - mozrunner == 6.11 06:55:05 INFO - mozscreenshot == 0.1 06:55:05 INFO - mozsystemmonitor == 0.0 06:55:05 INFO - moztest == 0.7 06:55:05 INFO - mozversion == 1.4 06:55:05 INFO - psutil == 3.1.1 06:55:05 INFO - requests == 1.2.3 06:55:05 INFO - wsgiref == 0.1.2 06:55:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:55: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')]} 06:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55: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')]} 06:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:05 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 0x10fd92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc14a3260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc31e00>, '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 0x10fa5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc2cb20>, '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.NKHQPSRVB5/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.S3baZpgg2L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 06:55:05 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 06:55:05 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 06:55:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKHQPSRVB5/Render', 06:55:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:05 INFO - 'HOME': '/Users/cltbld', 06:55:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:05 INFO - 'LOGNAME': 'cltbld', 06:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:05 INFO - 'MOZ_NO_REMOTE': '1', 06:55:05 INFO - 'NO_EM_RESTART': '1', 06:55:05 INFO - 'PAGER': '/bin/cat', 06:55:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:05 INFO - 'PWD': '/builds/slave/test', 06:55:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:05 INFO - 'SHELL': '/bin/bash', 06:55:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S3baZpgg2L/Listeners', 06:55:05 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 06:55:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:05 INFO - 'USER': 'cltbld', 06:55:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:05 INFO - 'XPC_FLAGS': '0x0', 06:55:05 INFO - 'XPC_SERVICE_NAME': '0', 06:55:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 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)) 06:55:05 INFO - Cleaning up... 06:55:05 INFO - Return code: 0 06:55:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:55: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')]} 06:55:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55: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')]} 06:55:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:05 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 0x10fd92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc14a3260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc31e00>, '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 0x10fa5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc2cb20>, '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.NKHQPSRVB5/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.S3baZpgg2L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 06:55:05 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 06:55:05 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 06:55:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKHQPSRVB5/Render', 06:55:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:05 INFO - 'HOME': '/Users/cltbld', 06:55:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:05 INFO - 'LOGNAME': 'cltbld', 06:55:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:05 INFO - 'MOZ_NO_REMOTE': '1', 06:55:05 INFO - 'NO_EM_RESTART': '1', 06:55:05 INFO - 'PAGER': '/bin/cat', 06:55:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:05 INFO - 'PWD': '/builds/slave/test', 06:55:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:05 INFO - 'SHELL': '/bin/bash', 06:55:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S3baZpgg2L/Listeners', 06:55:05 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 06:55:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:05 INFO - 'USER': 'cltbld', 06:55:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:05 INFO - 'XPC_FLAGS': '0x0', 06:55:05 INFO - 'XPC_SERVICE_NAME': '0', 06:55:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:05 INFO - Downloading/unpacking jsonschema 06:55:05 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 06:55:05 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 06:55:05 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 06:55:05 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 06:55:05 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 06:55:05 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 06:55:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:55:08 INFO - Downloading/unpacking functools32 (from jsonschema) 06:55:08 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 06:55:08 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 06:55:08 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 06:55:08 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 06:55:08 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 06:55:08 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 06:55:08 INFO - Downloading functools32-3.2.3-2.tar.gz 06:55:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:55:08 INFO - warning: no files found matching '*.txt' 06:55:08 INFO - no previously-included directories found matching 'build' 06:55:08 INFO - no previously-included directories found matching 'dist' 06:55:08 INFO - no previously-included directories found matching '.git*' 06:55:08 INFO - Installing collected packages: jsonschema, functools32 06:55:08 INFO - Running setup.py install for functools32 06:55:09 INFO - warning: no files found matching '*.txt' 06:55:09 INFO - no previously-included directories found matching 'build' 06:55:09 INFO - no previously-included directories found matching 'dist' 06:55:09 INFO - no previously-included directories found matching '.git*' 06:55:09 INFO - Successfully installed jsonschema functools32 06:55:09 INFO - Cleaning up... 06:55:09 INFO - Return code: 0 06:55:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:55:09 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 0x10fd92a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fda2420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbc14a3260>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc31e00>, '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 0x10fa5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc2cb20>, '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.NKHQPSRVB5/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.S3baZpgg2L/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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 06:55:09 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 06:55:09 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 06:55:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKHQPSRVB5/Render', 06:55:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:09 INFO - 'HOME': '/Users/cltbld', 06:55:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:09 INFO - 'LOGNAME': 'cltbld', 06:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:09 INFO - 'MOZ_NO_REMOTE': '1', 06:55:09 INFO - 'NO_EM_RESTART': '1', 06:55:09 INFO - 'PAGER': '/bin/cat', 06:55:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:09 INFO - 'PWD': '/builds/slave/test', 06:55:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:09 INFO - 'SHELL': '/bin/bash', 06:55:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S3baZpgg2L/Listeners', 06:55:09 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 06:55:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:09 INFO - 'USER': 'cltbld', 06:55:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:09 INFO - 'XPC_FLAGS': '0x0', 06:55:09 INFO - 'XPC_SERVICE_NAME': '0', 06:55:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:55:09 INFO - Downloading/unpacking flake8 06:55:09 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 06:55:09 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 06:55:09 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 06:55:09 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 06:55:09 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 06:55:09 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 06:55:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:55:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:55:11 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 06:55:11 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 06:55:11 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 06:55:11 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 06:55:11 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 06:55:11 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 06:55:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:55:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:55:12 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 06:55:12 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 06:55:12 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 06:55:12 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 06:55:12 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 06:55:12 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 06:55:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:55:12 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 06:55:12 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 06:55:12 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 06:55:12 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 06:55:12 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 06:55:12 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 06:55:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:55:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:55:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:55:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:55:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:55:13 INFO - no previously-included directories found matching 'docs/_build' 06:55:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:55:13 INFO - Running setup.py install for pep8 06:55:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:55:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:55:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:55:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:55:13 INFO - no previously-included directories found matching 'docs/_build' 06:55:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:55:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:55:13 INFO - Cleaning up... 06:55:13 INFO - Return code: 0 06:55:13 INFO - Running post-action listener: _resource_record_post_action 06:55:13 INFO - Running post-action listener: _start_resource_monitoring 06:55:13 INFO - Starting resource monitoring. 06:55:13 INFO - ##### 06:55:13 INFO - ##### Running install step. 06:55:13 INFO - ##### 06:55:13 INFO - Running pre-action listener: _resource_record_pre_action 06:55:13 INFO - Running main action method: install 06:55:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:55:13 INFO - Reading from file tmpfile_stdout 06:55:13 INFO - Detecting whether we're running mozinstall >=1.0... 06:55:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:55:13 INFO - Reading from file tmpfile_stdout 06:55:13 INFO - Output received: 06:55:13 INFO - Usage: mozinstall [options] installer 06:55:13 INFO - Options: 06:55:13 INFO - -h, --help show this help message and exit 06:55:13 INFO - -d DEST, --destination=DEST 06:55:13 INFO - Directory to install application into. [default: 06:55:13 INFO - "/builds/slave/test"] 06:55:13 INFO - --app=APP Application being installed. [default: firefox] 06:55:13 INFO - mkdir: /builds/slave/test/build/application 06:55:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:55:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:55:48 INFO - Reading from file tmpfile_stdout 06:55:48 INFO - Output received: 06:55:48 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:55:48 INFO - Running post-action listener: _resource_record_post_action 06:55:48 INFO - ##### 06:55:48 INFO - ##### Running run-tests step. 06:55:48 INFO - ##### 06:55:48 INFO - Running pre-action listener: _resource_record_pre_action 06:55:48 INFO - Running main action method: run_tests 06:55:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:55:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:55:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:55:48 INFO - 2016-03-29 06:55:48.170 screenresolution[2039:15917] starting screenresolution argv=screenresolution get 06:55:48 INFO - 2016-03-29 06:55:48.173 screenresolution[2039:15917] Display 0: 1600x1200x32@60 06:55:48 INFO - 2016-03-29 06:55:48.180 screenresolution[2040:15919] starting screenresolution argv=screenresolution list 06:55:48 INFO - Available Modes on Display 0 06:55:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:55:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:55:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:55:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:55:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:55:48 INFO - Intel Iris: 06:55:48 INFO - Chipset Model: Intel Iris 06:55:48 INFO - Type: GPU 06:55:48 INFO - Bus: Built-In 06:55:48 INFO - VRAM (Dynamic, Max): 1536 MB 06:55:48 INFO - Vendor: Intel (0x8086) 06:55:48 INFO - Device ID: 0x0a2e 06:55:48 INFO - Revision ID: 0x0009 06:55:48 INFO - Displays: 06:55:48 INFO - Display: 06:55:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:55:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:55:48 INFO - Display Serial Number: 1600x1200 60 06:55:48 INFO - Main Display: Yes 06:55:48 INFO - Mirror: Off 06:55:48 INFO - Online: Yes 06:55:48 INFO - Rotation: Supported 06:55:48 INFO - Return code: 0 06:55:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:55:48 INFO - Python 2.7.3 06:55:48 INFO - Return code: 0 06:55:48 INFO - grabbing minidump binary from tooltool 06:55:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:55:48 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 0x10fc31e00>, '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 0x10fa5adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10fc2cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:55:48 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 06:55:48 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 06:55:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:55:48 INFO - Return code: 0 06:55:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:55:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:55:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:55:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:55:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:55:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:55:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:55:49 INFO - Return code: 0 06:55:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:55:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0114 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:55:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.NKHQPSRVB5/Render', 06:55:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:55:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:55:49 INFO - 'HOME': '/Users/cltbld', 06:55:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:55:49 INFO - 'LOGNAME': 'cltbld', 06:55:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:55:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:55:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:55:49 INFO - 'MOZ_NO_REMOTE': '1', 06:55:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:55:49 INFO - 'NO_EM_RESTART': '1', 06:55:49 INFO - 'PAGER': '/bin/cat', 06:55:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:55:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:55:49 INFO - 'PWD': '/builds/slave/test', 06:55:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:55:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:55:49 INFO - 'SHELL': '/bin/bash', 06:55:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.S3baZpgg2L/Listeners', 06:55:49 INFO - 'TMPDIR': '/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/', 06:55:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:55:49 INFO - 'USER': 'cltbld', 06:55:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:55:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:55:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:55:49 INFO - 'XPC_FLAGS': '0x0', 06:55:49 INFO - 'XPC_SERVICE_NAME': '0', 06:55:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:55:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0114', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:55:49 INFO - mozversion application_buildid: 20160329051731 06:55:49 INFO - mozversion application_changeset: d5d53a3b4e50b94cdf85d20690526e5a00d5b63e 06:55:49 INFO - mozversion application_display_name: Nightly 06:55:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:55:49 INFO - mozversion application_name: Firefox 06:55:49 INFO - mozversion application_remotingname: firefox 06:55:49 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:55:49 INFO - mozversion application_vendor: Mozilla 06:55:49 INFO - mozversion application_version: 48.0a1 06:55:49 INFO - mozversion platform_buildid: 20160329051731 06:55:49 INFO - mozversion platform_changeset: d5d53a3b4e50b94cdf85d20690526e5a00d5b63e 06:55:49 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:55:49 INFO - mozversion platform_version: 48.0a1 06:55:49 INFO - using testdate: 1459259749 06:55:49 INFO - actual date: 1459259749 06:55:49 INFO - starting webserver on 'localhost:51417' 06:55:49 INFO - SUITE-START | Running 2 tests 06:55:49 INFO - TEST-START | dromaeo_css 06:55:49 INFO - operating with platform_type : mac_ 06:55:49 INFO - Initialising browser for dromaeo_css test... 06:55:49 INFO - TEST-INFO | started process 2058 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpDx2HpU/profile http://localhost:51417/getInfo.html) 06:55:52 INFO - PROCESS | 2058 | __metrics Screen width/height:1600/1200 06:55:52 INFO - PROCESS | 2058 | colorDepth:24 06:55:52 INFO - PROCESS | 2058 | Browser inner width/height: 1024/689 06:55:52 INFO - PROCESS | 2058 | __metrics 06:55:52 INFO - PROCESS | 2058 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:55:52 ERROR - PROCESS | 2058 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 06:55:52 INFO - TEST-INFO | 2058: exit 0 06:55:52 INFO - Browser initialized. 06:55:52 INFO - Running cycle 1/1 for dromaeo_css test... 06:55:52 INFO - TEST-INFO | started process 2061 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmpDx2HpU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:04 INFO - PROCESS | 2061 | RSS: Main: 244244480 06:56:04 INFO - PROCESS | 2061 | 06:56:55 INFO - PROCESS | 2061 | 1459259815676 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] 06:59:07 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:51417/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51417/tests/dromaeo/cssquery-ext.html) 06:59:08 INFO - PROCESS | 2061 | RSS: Main: 375840768 06:59:08 INFO - PROCESS | 2061 | 07:02:11 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:51417/tests/dromaeo/cssquery-ext.html (next: http://localhost:51417/tests/dromaeo/cssquery-jquery.html) 07:02:11 INFO - PROCESS | 2061 | RSS: Main: 376860672 07:02:11 INFO - PROCESS | 2061 | 07:05:13 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:51417/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51417/tests/dromaeo/cssquery-mootools.html) 07:05:14 INFO - PROCESS | 2061 | RSS: Main: 376606720 07:05:14 INFO - PROCESS | 2061 | 07:08:16 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:51417/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51417/tests/dromaeo/cssquery-prototype.html) 07:08:16 INFO - PROCESS | 2061 | RSS: Main: 332394496 07:08:16 INFO - PROCESS | 2061 | 07:11:19 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:51417/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51417/tests/dromaeo/cssquery-yui.html) 07:11:20 INFO - PROCESS | 2061 | RSS: Main: 334471168 07:11:20 INFO - PROCESS | 2061 | 07:14:23 INFO - PROCESS | 2061 | Cycle 1(1): loaded http://localhost:51417/tests/dromaeo/cssquery-yui.html (next: http://localhost:51417/tests/dromaeo/cssquery-dojo.html) 07:14:23 INFO - PROCESS | 2061 | RSS: Main: 443166720 07:14:23 INFO - PROCESS | 2061 | 07:14:23 INFO - PROCESS | 2061 | __start_tp_report 07:14:23 INFO - PROCESS | 2061 | _x_x_mozilla_page_load 07:14:23 INFO - PROCESS | 2061 | _x_x_mozilla_page_load_details 07:14:23 INFO - PROCESS | 2061 | |i|pagename|runs| 07:14:23 INFO - PROCESS | 2061 | |0;dojo.html;3438.295149494353;3473.3574288756568;3497.5802903651565;3503.3693935091674;3541.557305336833;5646.237757902682;5707.258056452655;5717.571182161334;5743.454371834674;5790.913136302954;4444.666650001254;5491.835244942648;5635.239242702234;5659.971700141504;5664.037113690672;5103.668261563005;5154.664946778447;5178.1197196476505;5193.402758682743;5263.736813159346;5285.762140703659;5290.1271290237255;5297.12597421425;5344.144936810111;5362.65142765721;5097.7960881564695;5172.9741351293005;5195.610329225323;5226.189940559219;5237.947620523784;5150.356205474316;5170.638055336128;5180.067587834188;5189.299444575009;5189.688618682853;5112.41207261166;5147.536721695028;5150.639455238135;5156.510131537498;5160.174372100446;5641.294838145232;5644.238027866268;5646.802361917355;5655.886882262373;5683.119116536944;5700.3159620845345;6237.500999919996;6245.937540624581;6247.875042499125;6270.874582508324;5994.220751302303;6075.131143872926;6247.219097612799;6316.810495685137;6331.96834015827;4855.32025516428;5763.423657634203;5770.740316685759;5829.154772557956;5861.999999999957;6291.433770960635;6302.810915672537;6311.715972781236;6321.431071203522;6328.335524769833;6035.758569657164;6089;6128.693565321716;6144.784932527429;6149.5080393568405;6167.136600875791;6189.226346706661;6190.41191086846;6227.19046523949;6323.241211054703;5779.133130030445;5792.652440853478;5804.216430781875;5822.912656310159;5880.382559831241;5789.9710501447225;5813.331466881363;5818.7672493100645;5819.156222347736;5866.501347385435;4787.593054590329;4827.589654879304;4860.198067318853;4876.926846097312;4886.3403440535785;3970.3448930926074;4349.978250108729;4457.799399026987;4459.620932220732;4516.480604730433;5758.971205144031;5761.481466667936;5764.510016648632;5765.769369225268;5772.422757724194;5194.896102077937;6173.59871608344;6264.5301602379095;6270.655113968684;6277.811665650038;4698.976505117453;5620.381758006616;5662.688552129673;5673.3475650299915;5865.4134586541;5214.843554693365;5346.278252435949;5355.598330125256;5367.677939323575;5388.784448622089;6226.1905952227735;6233.657148856766;6243.750249989949;6288.9056664150075;6331.841703957438;6244.812655620339;6257.655828929271;6263.718132683949;6278.529110316653;6301.338359472189;6298.401651843251;6299.401556852092;6299.937000629935;6302.180716506825;6313.431791138636;6063.969680151571;6097.603655762361;6145.647957449354;6155.692215389302;6159.876802463836;4695.5304469552775;6281.3404592518955;6283.622982621057;6285.74857005733;6317.020861766434;6152.815415537541;6158.414950579688;6166.691665416622;6169.01295792671;6194.163787888758;5921.467067963904;6039.728212230548;6073.787417440369;6131.448169664752;6134.375358695336;5971.970140149271;5986.952283350483;5999.070144127667;6005;6005.159277701038;6144.569880108528;6150.876982460236;6154.292256390393;6158.107074474266;6163.260408750979;5809.390014048633;5873.119032145212;5909.320428150818;5910.054391297372;5916.704164791657 07:14:23 INFO - PROCESS | 2061 | |1;ext.html;483.4681849965037;524.0253129179728;542.9294191755073;565.2171742137139;629.7638385605396;27589.586156207646;35424.58301667937;36768.448473272925;39721;39803.80098099505;43257.7837110814;43424;43651.90870228246;43823.3426498602;43869.7806510967;9637.951810240957;9884.456354900478;9890.060444257784;9890.752731181707;9912.653057143001;9571.42571445712;9685.709428717115;9763.853542196874;9851.014898510164;9855.556499957484;9809.852852207223;9893.901060989407;9898.554565044555;9904.50477476127;9908.900910990906;9742.1719153872;9858.211343092607;9859.35914165577;9862.704118876445;9863.556139973682;9835.31152819303;9920.454375009444;9966.202703783752;9972.90027099727;9990.150837178848;41761;42248.57751422508;42284;42402;42411.363829542584;3261.72275356595;3291.1772056985756;3432.3993301172195;3752.689028762642;3854.768713877176;29111.272218194503;29300.267493312625;29578.408431831456;29767.25581860449;29862.85068574665;2735.37086470111;2748.8900443982216;2778.2220978126156;2781.276868014311;2861.0558515689772;476651;478488;478650.60674696753;479686;481363;69554.65222673854;70014;70042;70132.58408990852;70135.29864701288;72393.63803181055;74846;76059;76065;76254.61872690602;14018.369173387222;17077.060761658227;17300.48098557045;17309;17313;12781.61655150347;12868.871311286768;12883.48466061347;12895.742085158245;12908.031897607718;21979.890100549714;22234.777652223594;22241.777582224295;22253.888730556566;22255.887205639654;8836.602352894135;9094.727158185266;9125.908740912506;9133.862992055125;9221.446713197229;898.9280857531381;913.3515204205089;957.6552441121191;1010.8332125199407;1102.162356608967;28170.181324387228;28328;28590.856365745138;28594.71405285962;28859.422811543653;1004.347174336687;1098.340995402768;1105.7622611138484;1172.2204733851893;1172.454808514045;14508.782368264485;14816.111033338035;14879.542752080837;14912.956093073597;15073.397064117313;583541;586997;595035;596216;596294;63178.368216318166;63611;63693.68153159205;63717.68141159357;64083.35916640867;1214.7084699672191;1297.2475963940892;1452.847451017649;1472.639203395175;1497.2513743128436;30147;31241.062768116994;31515.684843151274;31631.36737265196;32135.357292854478;57576.42423575878;57926.7103664479;58502;58661;58717;474271;484179;484561;485116;486045.56977214885;37376.95411119573;45853.85365365892;46033.539664602926;46358;47255.29117063178;47107.76446117885;47916.76041619769;48016.5198348026;48602;49411.258831118284;38226.85319440421;39271.607283926794;39290.607093928695;40140.79929600333;40872;38537;38573.22853542857;38616;39391.40912886366;39633.80183099066;38470.615293846706;39016.41475377928;39239.41140882946;39273.49171320195;39659.2068158641;33392.33215335728;34333.141671457415;35007.949761507196;35073.29853402969;35133.648663513035;25621.48757024812;25666.486670266862;25739.742602573733;25828.35429114287;26356.472870542097 07:14:23 INFO - PROCESS | 2061 | |2;jquery.html;363.28976850257743;369.15831903260573;371.08527479762387;374.61976094264327;378.89012186465925;19605.50986225343;19966.201351945903;20254.594908101866;20380.796192038077;20474.873881936506;20726.37820865373;21027.894860525714;21439.785602143973;21723.13107475699;21725.782742172574;5938.52491800656;6109.7861574844665;6118.663473508956;6166.938330616704;6179.104029915659;5867.618604790697;5894.056950887859;6070.453659170674;6072.544559158058;6096.420840020191;5991.400859914017;6006.129111278862;6013.699315034252;6016.2479690038745;6033.456988871001;5897.085951677475;5931.051031834907;6063.120847477136;6087.634741915499;6089.360617135181;5111.667741596784;5201.973990130025;5234.685918844843;5234.685918844882;5240.79036838526;25692.48615027689;25994.350141246432;26397.20808375752;26429;26453;2165.231342873273;2336;2449.816263780224;2605.6873175218907;2748.395353022332;13489.325533723373;14795;14886.70226595462;15164.848351516564;15278.15970121643;1486.780839711437;1731.9826801731947;1750.844442667846;1773.2286455391945;1808.8552915766707;96164.51917740436;98205;100682.4965875166;100717.49641251747;101513.49243253736;10149;10308.948455257676;10593.364398136137;10641.521131548943;10719.785604288027;13341.266230357423;13350.332483375792;13361.665958350924;13362.665933351744;13363.131396459394;8408.579571021424;8553.74338769838;8569.914300857037;8672.696455624024;8674.522901240367;7507.924920750832;8452.66189352419;8462.957685211657;8470.915290847013;8591.613377397907;5452.318460192476;5902.852428689317;6065.999110146865;6116.666416802853;6280.8694435002135;1526.2979029646488;1828.9268429262947;1853.7404763333145;1855.730919016762;1860.9906950465431;866.9913300867037;959.856021596766;1008.9142422893989;1072.8658917635296;1129.8644162700527;20702.068406921724;21274.27700152467;21448.678269825967;21477.67783483249;21494.032768525452;965.5751469353462;1007.3099926550336;1022.7085280694967;1030.7680771826278;1102.7629059752192;11260;11705;11710.531578736754;11715.824262636068;11727.47226374798;616604;617809;620934;642031;642806;97790.5110474443;98164.50917745508;99862.5006874961;100277.49861250793;100657.49671251597;935.7554452578055;1084.5553323137476;1105.4251789069638;1130.383940752292;1132.3828513460185;18282.634347313244;18655.720164197275;18734.6253074935;18735.625287494448;18961.336353227573;46967.29549056835;47643.04713905633;49361.753191233816;49741.502584973685;50556.49443505665;62803.37196627975;63472;63708;63898.72202556016;65210;7205.495615306878;7724.729634462767;7780;7903.367730581424;8092;11908.460595472689;12151.939240303742;12315.93842030784;12376.504939802668;12855.614331570068;10637.574497020341;10676.306040107369;10726.463676816284;10968.670939871816;11075.778484430428;10006.899931000597;10476.319039262728;10541.947290263499;10966;10968.17738669587;9052.411593246417;11107.555697772323;11438.485268162785;11520.596779112691;11534.134939879375;7633.160352361347;7673.503458144473;7689.615519224129;7721.498102623312;8017.438779285394;8248.216419440143;10002.949985250027;10938.343699378063;11233.269837460539;11299.265547739371 07:14:23 INFO - PROCESS | 2061 | |3;mootools.html;1409.5348534983452;1444.4944269505681;1624.277196647492;1855.2949879045962;2017.616652835962;8034.9196508034975;8685.001224859143;8924.241439477652;8927.732168034969;8935.821283574332;8514.191151840581;8759.78100547485;8771.07903670115;8771.605277762501;8781.91218087819;2190.2553131935138;2371.1937941100023;2432.9391765205924;2463.1625247415873;2494.550980823451;2518.49630073985;2522.2811498722867;2524.2301098165053;2529.29179829648;2529.3170843872144;2413.3242692046256;2490.1284550407395;2500.174942269056;2505.8997640094376;2507.3480894967347;2432.4770174412497;2481.0819996601194;2481.3176376496426;2486.191987604036;2489.7385774493687;2438.5488684593406;2474.950500989988;2479.1818699829014;2485.72657007729;2485.7389974052826;8952.060033696433;9004.189622933967;9032.593533291018;9042.367034307601;9062.68280610182;5441.102218134003;5608.298962629671;5611.214429979766;5612.522935550483;5618.073017952033;3508.8421021054114;3687.115092377837;3690.6493883081066;3696.8890933272046;3747.9812600937094;1044.926855120142;1057.0592172966067;1063.4420573859256;1077.8167711489066;1078.2075174746556;12127.757444851053;12136.817947730791;12142.089343299287;12144.332061736513;12146.696332591668;4802.951970480251;4813.518648135158;4903.87740306488;4911.705297682151;4919.286703428054;10233.1301839343;10240.897591024144;10260.179185665129;10272.691819245434;10289.22830787694;5543.029969755276;5553.305836770403;5553.361363443175;5553.888922221533;5556.805286863263;4454.265046267395;4661.184292748823;4849.127157111683;4960.727160006162;4969.602431805447;3789.6778773803985;3903.394973779069;3903.414487826792;3929.426225822091;3952.8023598819946;1280.0399700224832;1304.6347022833622;1311.672081979505;1317.7298653775954;1323.9669008274677;1142.9257098288585;1170.8653504846882;1186.3297237061033;1414.8868090552937;1426.736053830024;8257.463264887763;8315.750527484186;8443.95778021106;8448.408611397143;8459.450135741157;515.7988384530037;516.0375898948434;518.9662671926312;520.6485622204997;536.5064140990298;6284.02597597364;6290.937090629035;6347.55567110307;6347.936520634827;6358.872822543523;10675.412852293042;11007.889921100847;11096.500657470433;11098.722531936604;11104.611338603272;8906.59920303575;10609.204309676805;10876.72808179786;10973.725656858483;10979.231453798158;8438.957805210935;8458.450200736932;8465.026521950054;8520;8535.743927682179;7827.295543401121;8026.8394632105865;8031.915691381589;8036.758897233092;8065.435419520577;9349.25205983506;9631.759206019906;9711.805763884542;9759.609615615296;9896.901030989886;9871;10067.1442927352;10190.74523136898;10276.691699249035;10284.485775711335;6006.459418652343;6671.833204169935;6684.732610695518;7631.771046868381;7685.00094987648;8324.916750832414;8383.622736976973;8396.202360775716;8400.201980811813;8403.075661677089;7280.5995670236525;7321.670524826289;7388.965544823836;7462.141853686896;7511.51175173612;7189.5521871024785;7204.24355442671;7246.094238220223;7271.4546409020595;7289.125304963438;7807.648655810389;7861.764147075597;7872.488288261245;7875.409344299315;7923.722669706764;6876.759313424006;7074.504784665024;7150.998860159686;7161.248068952685;7166.928330716626;7131.144262688511;7179.497435179487;7191.856162876608;7224.277572242734;7226 07:14:23 INFO - PROCESS | 2061 | |4;prototype.html;323.43399051659594;324.2590680295524;329.22303364060826;331.61201394368584;333.73968304722325;6483.675816209188;6526.314736952617;6530.510211734115;6535.869282614345;6613.933860661392;6320.367963203677;6468.029795530672;6469.02964555317;6476.093346931421;6582.637954912478;3679.5584529856455;4683.601893839028;4707.835225767099;4783.760811959405;4856.514348565133;4765.547273009059;4777.259524773648;4794.952050479503;4806.4712881583;4825.396825396825;4789.353437285957;4793.113274044295;4803.759812009403;4812.109759694467;4825.131476334259;4573.268277075652;4632.14305353509;4778;4826.420829500483;4828.203346447832;4112.979435102805;4133.8966525836795;4145.751254924684;4150.405996252342;4154.958450415487;6243.65659888706;6245.281792593864;6267.749290028393;6270.435660790505;6280.864506067913;5639.351474580435;5643.6049476536655;5644.379118296984;5657.462541058593;5658.207850900877;6670.599764014126;6910.894256918868;6927.51058522415;6937.445004399636;6944.02783610295;4551.453825540923;4638.582527572535;4647.488776234612;4652.976735116336;4663.626909847204;7235.167955685111;7296.7446139384865;7311.415086793044;7325.926740732578;7328.157261914841;4690.929636055462;4699.906001879944;4701.3888194535175;4702.294655801657;4713.95286047142;4742.217534106834;4751.548602882721;4757.8096876125255;4766.404199475066;4774;5577.553795696334;5586.636868603528;5599.664020158803;5602.831915042555;5609.775608975595;6722.28135752653;6798.898016529756;6923.515353925177;6952.687129079203;6976.616286104211;1511.4105498855456;1544.1584336536614;1640.1553200101957;1649.909254990963;1657.3370651739401;1004.7437903334603;1054.8259537176434;1074.6561100447939;1085.7122862441458;1086.6359769477156;6225.252969643671;6231.4391704746795;6240.219972503437;6246.312905580383;6351.364863513704;6996.545224560387;7135.4648401370105;7206.495545311883;7236.312550307713;7263.346298833025;6272.466840318624;6504.577202481823;6506.512011599149;6510.544261901716;6520.413162815369;3218.8873389431255;3832.2335532893535;3838.213166300902;3839.462475253467;3840.9423858642144;6094.329623741385;7283.235260297698;7464.776056718307;7585.6965721371635;7602.771916842504;6034.24571928509;6071.271447426248;7397.445191610651;7462.328390444886;7490.213527579525;7570.659320330598;7575.659095340613;7578.204288549733;7580.279873412017;7586.203448637924;7199.028131202221;7227.421806255382;7230.13238411394;7239.239879812544;7252.637368131678;6830.45356371499;7091.751788687371;7117.644117794193;7123.109611298588;7143.892841607276;7517.060367454068;7535.13345965221;7543.943847861194;7577.696892124473;7583.203763604742;3541.8937431877084;4016.3172260715164;4081.20416518776;4556.954430455653;4691.648126390603;7154.785356439315;7159.105111861018;7161.57030578167;7168.139823221039;7194.064771579661;6608.306127856698;6921.792346229621;6936.861262774817;6950.930490695028;6969.54697944632;6820.965895170492;6887.483438742214;6909;6915.550489218184;6940.583564986117;5530.889382212414;6783.321667833177;6783.626900520519;6819.113515242987;6828.624425656637;6956.408705259907;6957.547759395623;6965.233824279224;6968.163820341591;6981.755638552626;6479.773207937888;6516.152900122954;6591.472682185509;6760.492963027891;6794.52438329332 07:14:23 INFO - PROCESS | 2061 | |5;yui.html;685.3352248319129;690.8721886451004;749.970001199952;755.199488542145;764.1937755667772;15123.848761512396;15353.769693454593;15356.69286614267;15367.231638418076;15370;13962.371693273803;14084.08453450525;14117.57647270581;14141.505047323346;14196.858031419708;732.0775822463708;748.7192302886417;899.2850683706437;913.1005959130251;915.46445329482;901.9368644194909;926.073926073926;926.1155596405416;926.8980412154658;927.3554879358849;978.3738407419257;988.4859872866141;988.7874107067015;989.5200827598609;990.0297708245923;765.5024234247755;957.0190554681507;962.8363178259677;976.2921881635757;984.6553706202843;726.2737262737263;726.6548389514991;728.8032231297573;728.8578727148208;730.0290613484053;14965.102093874293;15033.774493382609;15038.774418383624;15062.774058389134;15081.019733717274;12402.56591019319;12581.874181258254;12596.81104783429;12703.364831758376;12914.22514649124;10030;10150.340227885164;10380.584776608926;10922.399268040255;11018.228723989325;3119.82840943748;3156.936861262785;3652.7990960497164;3685.318216129998;3690.2066055797864;82399.17600823975;84206;84460.57769711173;84656;84856.57571712101;9367.62529498826;9368.4378937264;9433.151016408556;9603.9039609603;10276.177905767521;17676.38132665376;21384.572308554052;21407.715537067827;21428.89285553562;21439;6828.736683713529;7117.92882071183;7369.668364923484;7635.42734294919;7788.610569471503;4057.736247143926;4113.382992551141;4116.938245926313;4185.393117997874;4220.198162349144;3561.3411518869093;3604.5133906922756;3611.331903597843;3612.9638703612627;3624.637536246354;627.0938493876396;630.4042679667762;636.3763511758502;637.8182218067828;643.7811144210897;587.748096554345;594.8334466349429;596.150485558078;609.9085137229363;611.245112286326;7770.650320735581;8183.14077021916;8297.211764882326;8318.12659670738;8654.826903461895;519.3689667054547;536.5895090255957;575.3670961941831;610.3743662745721;617.2161355079024;3520.753547251668;3541.8480288521328;3590.9461358079648;3713.3687273163628;3840.807959602009;91656.54171729232;92981;93233.60149597761;96581;97425;80230;81347.37305253862;81574;81843.18156818475;83817.58091209504;72786.27213727795;73664.63167684234;73903.63048184724;75063;75458.86811697939;8350.58247087631;8428;8434;8511.106333835105;8602.655893764178;46937;47547;47615.523844762494;51237.74381128071;51683;56046.59883502782;69719;70956.64521677358;71910.64044679744;73885;10853.565857365616;11143.442827858737;11204.88795112071;11255.887441125484;11425.828612570653;12135.635930922086;12282.140250182401;12283.201591896499;12290.938545307215;12685.556005539762;11327.207095503236;11444.656660300205;11473.36896470702;11800.940995294968;11913.404329783303;11266.605668801552;11331.546738130382;11332;11445.427728613702;12447.315397653216;10607.575696972035;10890.128789696964;11173.776524469627;11370.829437558277;11548.076153907836;9521.57152928106;9763.707088787347;9854.753631159278;10018.799624007333;10600.893726439946;8859.557022148996;9080.727578172666;9112.362134650775;9446;9779 07:14:23 INFO - PROCESS | 2061 | __end_tp_report 07:14:23 INFO - PROCESS | 2061 | __start_cc_report 07:14:23 INFO - PROCESS | 2061 | _x_x_mozilla_cycle_collect,1216 07:14:23 INFO - PROCESS | 2061 | __end_cc_report 07:14:23 INFO - PROCESS | 2061 | __startTimestamp1459260863638__endTimestamp 07:14:23 INFO - PROCESS | 2061 | 07:14:23 INFO - PROCESS | 2061 | ------- Summary: start ------- 07:14:23 INFO - PROCESS | 2061 | Number of tests: 6 07:14:23 INFO - PROCESS | 2061 | 07:14:23 INFO - PROCESS | 2061 | [#0] dojo.html Cycles:165 Average:5682.03 Median:5819.16 stddev:642.96 (11.0%) stddev-sans-first:620.37 07:14:23 INFO - PROCESS | 2061 | Values: 3438.3 3473.4 3497.6 3503.4 3541.6 5646.2 5707.3 5717.6 5743.5 5790.9 4444.7 5491.8 5635.2 5660.0 5664.0 5103.7 5154.7 5178.1 5193.4 5263.7 5285.8 5290.1 5297.1 5344.1 5362.7 5097.8 5173.0 5195.6 5226.2 5237.9 5150.4 5170.6 5180.1 5189.3 5189.7 5112.4 5147.5 5150.6 5156.5 5160.2 5641.3 5644.2 5646.8 5655.9 5683.1 5700.3 6237.5 6245.9 6247.9 6270.9 5994.2 6075.1 6247.2 6316.8 6332.0 4855.3 5763.4 5770.7 5829.2 5862.0 6291.4 6302.8 6311.7 6321.4 6328.3 6035.8 6089.0 6128.7 6144.8 6149.5 6167.1 6189.2 6190.4 6227.2 6323.2 5779.1 5792.7 5804.2 5822.9 5880.4 5790.0 5813.3 5818.8 5819.2 5866.5 4787.6 4827.6 4860.2 4876.9 4886.3 3970.3 4350.0 4457.8 4459.6 4516.5 5759.0 5761.5 5764.5 5765.8 5772.4 5194.9 6173.6 6264.5 6270.7 6277.8 4699.0 5620.4 5662.7 5673.3 5865.4 5214.8 5346.3 5355.6 5367.7 5388.8 6226.2 6233.7 6243.8 6288.9 6331.8 6244.8 6257.7 6263.7 6278.5 6301.3 6298.4 6299.4 6299.9 6302.2 6313.4 6064.0 6097.6 6145.6 6155.7 6159.9 4695.5 6281.3 6283.6 6285.7 6317.0 6152.8 6158.4 6166.7 6169.0 6194.2 5921.5 6039.7 6073.8 6131.4 6134.4 5972.0 5987.0 5999.1 6005.0 6005.2 6144.6 6150.9 6154.3 6158.1 6163.3 5809.4 5873.1 5909.3 5910.1 5916.7 07:14:23 INFO - PROCESS | 2061 | 07:14:23 INFO - PROCESS | 2061 | [#1] ext.html Cycles:180 Average:67708.89 Median:42343.00 stddev:138402.42 (326.9%) stddev-sans-first:138698.64 07:14:23 INFO - PROCESS | 2061 | Values: 483.5 524.0 542.9 565.2 629.8 27589.6 35424.6 36768.4 39721.0 39803.8 43257.8 43424.0 43651.9 43823.3 43869.8 9638.0 9884.5 9890.1 9890.8 9912.7 9571.4 9685.7 9763.9 9851.0 9855.6 9809.9 9893.9 9898.6 9904.5 9908.9 9742.2 9858.2 9859.4 9862.7 9863.6 9835.3 9920.5 9966.2 9972.9 9990.2 41761.0 42248.6 42284.0 42402.0 42411.4 3261.7 3291.2 3432.4 3752.7 3854.8 29111.3 29300.3 29578.4 29767.3 29862.9 2735.4 2748.9 2778.2 2781.3 2861.1 476651.0 478488.0 478650.6 479686.0 481363.0 69554.7 70014.0 70042.0 70132.6 70135.3 72393.6 74846.0 76059.0 76065.0 76254.6 14018.4 17077.1 17300.5 17309.0 17313.0 12781.6 12868.9 12883.5 12895.7 12908.0 21979.9 22234.8 22241.8 22253.9 22255.9 8836.6 9094.7 9125.9 9133.9 9221.4 898.9 913.4 957.7 1010.8 1102.2 28170.2 28328.0 28590.9 28594.7 28859.4 1004.3 1098.3 1105.8 1172.2 1172.5 14508.8 14816.1 14879.5 14913.0 15073.4 583541.0 586997.0 595035.0 596216.0 596294.0 63178.4 63611.0 63693.7 63717.7 64083.4 1214.7 1297.2 1452.8 1472.6 1497.3 30147.0 31241.1 31515.7 31631.4 32135.4 57576.4 57926.7 58502.0 58661.0 58717.0 474271.0 484179.0 484561.0 485116.0 486045.6 37377.0 45853.9 46033.5 46358.0 47255.3 47107.8 47916.8 48016.5 48602.0 49411.3 38226.9 39271.6 39290.6 40140.8 40872.0 38537.0 38573.2 38616.0 39391.4 39633.8 38470.6 39016.4 39239.4 39273.5 39659.2 33392.3 34333.1 35007.9 35073.3 35133.6 25621.5 25666.5 25739.7 25828.4 26356.5 07:14:23 INFO - PROCESS | 2061 | 07:14:23 INFO - PROCESS | 2061 | [#2] jquery.html Cycles:180 Average:34150.44 Median:2392.91 stddev:103419.20 (4321.9%) stddev-sans-first:103678.20 07:14:23 INFO - PROCESS | 2061 | Values: 363.3 369.2 371.1 374.6 378.9 19605.5 19966.2 20254.6 20380.8 20474.9 20726.4 21027.9 21439.8 21723.1 21725.8 5938.5 6109.8 6118.7 6166.9 6179.1 5867.6 5894.1 6070.5 6072.5 6096.4 5991.4 6006.1 6013.7 6016.2 6033.5 5897.1 5931.1 6063.1 6087.6 6089.4 5111.7 5202.0 5234.7 5234.7 5240.8 25692.5 25994.4 26397.2 26429.0 26453.0 2165.2 2336.0 2449.8 2605.7 2748.4 13489.3 14795.0 14886.7 15164.8 15278.2 1486.8 1732.0 1750.8 1773.2 1808.9 96164.5 98205.0 100682.5 100717.5 101513.5 10149.0 10308.9 10593.4 10641.5 10719.8 13341.3 13350.3 13361.7 13362.7 13363.1 8408.6 8553.7 8569.9 8672.7 8674.5 7507.9 8452.7 8463.0 8470.9 8591.6 5452.3 5902.9 6066.0 6116.7 6280.9 1526.3 1828.9 1853.7 1855.7 1861.0 867.0 959.9 1008.9 1072.9 1129.9 20702.1 21274.3 21448.7 21477.7 21494.0 965.6 1007.3 1022.7 1030.8 1102.8 11260.0 11705.0 11710.5 11715.8 11727.5 616604.0 617809.0 620934.0 642031.0 642806.0 97790.5 98164.5 99862.5 100277.5 100657.5 935.8 1084.6 1105.4 1130.4 1132.4 18282.6 18655.7 18734.6 18735.6 18961.3 46967.3 47643.0 49361.8 49741.5 50556.5 62803.4 63472.0 63708.0 63898.7 65210.0 7205.5 7724.7 7780.0 7903.4 8092.0 11908.5 12151.9 12315.9 12376.5 12855.6 10637.6 10676.3 10726.5 10968.7 11075.8 10006.9 10476.3 10541.9 10966.0 10968.2 9052.4 11107.6 11438.5 11520.6 11534.1 7633.2 7673.5 7689.6 7721.5 8017.4 8248.2 10002.9 10938.3 11233.3 11299.3 07:14:23 INFO - PROCESS | 2061 | 07:14:23 INFO - PROCESS | 2061 | [#3] mootools.html Cycles:180 Average:6108.87 Median:519.81 stddev:3262.89 (627.7%) stddev-sans-first:3252.92 07:14:23 INFO - PROCESS | 2061 | Values: 1409.5 1444.5 1624.3 1855.3 2017.6 8034.9 8685.0 8924.2 8927.7 8935.8 8514.2 8759.8 8771.1 8771.6 8781.9 2190.3 2371.2 2432.9 2463.2 2494.6 2518.5 2522.3 2524.2 2529.3 2529.3 2413.3 2490.1 2500.2 2505.9 2507.3 2432.5 2481.1 2481.3 2486.2 2489.7 2438.5 2475.0 2479.2 2485.7 2485.7 8952.1 9004.2 9032.6 9042.4 9062.7 5441.1 5608.3 5611.2 5612.5 5618.1 3508.8 3687.1 3690.6 3696.9 3748.0 1044.9 1057.1 1063.4 1077.8 1078.2 12127.8 12136.8 12142.1 12144.3 12146.7 4803.0 4813.5 4903.9 4911.7 4919.3 10233.1 10240.9 10260.2 10272.7 10289.2 5543.0 5553.3 5553.4 5553.9 5556.8 4454.3 4661.2 4849.1 4960.7 4969.6 3789.7 3903.4 3903.4 3929.4 3952.8 1280.0 1304.6 1311.7 1317.7 1324.0 1142.9 1170.9 1186.3 1414.9 1426.7 8257.5 8315.8 8444.0 8448.4 8459.5 515.8 516.0 519.0 520.6 536.5 6284.0 6290.9 6347.6 6347.9 6358.9 10675.4 11007.9 11096.5 11098.7 11104.6 8906.6 10609.2 10876.7 10973.7 10979.2 8439.0 8458.5 8465.0 8520.0 8535.7 7827.3 8026.8 8031.9 8036.8 8065.4 9349.3 9631.8 9711.8 9759.6 9896.9 9871.0 10067.1 10190.7 10276.7 10284.5 6006.5 6671.8 6684.7 7631.8 7685.0 8324.9 8383.6 8396.2 8400.2 8403.1 7280.6 7321.7 7389.0 7462.1 7511.5 7189.6 7204.2 7246.1 7271.5 7289.1 7807.6 7861.8 7872.5 7875.4 7923.7 6876.8 7074.5 7151.0 7161.2 7166.9 7131.1 7179.5 7191.9 7224.3 7226.0 07:14:23 INFO - PROCESS | 2061 | 07:14:23 INFO - PROCESS | 2061 | [#4] prototype.html Cycles:180 Average:5667.52 Median:6409.70 stddev:1810.43 (28.2%) stddev-sans-first:1770.51 07:14:23 INFO - PROCESS | 2061 | Values: 323.4 324.3 329.2 331.6 333.7 6483.7 6526.3 6530.5 6535.9 6613.9 6320.4 6468.0 6469.0 6476.1 6582.6 3679.6 4683.6 4707.8 4783.8 4856.5 4765.5 4777.3 4795.0 4806.5 4825.4 4789.4 4793.1 4803.8 4812.1 4825.1 4573.3 4632.1 4778.0 4826.4 4828.2 4113.0 4133.9 4145.8 4150.4 4155.0 6243.7 6245.3 6267.7 6270.4 6280.9 5639.4 5643.6 5644.4 5657.5 5658.2 6670.6 6910.9 6927.5 6937.4 6944.0 4551.5 4638.6 4647.5 4653.0 4663.6 7235.2 7296.7 7311.4 7325.9 7328.2 4690.9 4699.9 4701.4 4702.3 4714.0 4742.2 4751.5 4757.8 4766.4 4774.0 5577.6 5586.6 5599.7 5602.8 5609.8 6722.3 6798.9 6923.5 6952.7 6976.6 1511.4 1544.2 1640.2 1649.9 1657.3 1004.7 1054.8 1074.7 1085.7 1086.6 6225.3 6231.4 6240.2 6246.3 6351.4 6996.5 7135.5 7206.5 7236.3 7263.3 6272.5 6504.6 6506.5 6510.5 6520.4 3218.9 3832.2 3838.2 3839.5 3840.9 6094.3 7283.2 7464.8 7585.7 7602.8 6034.2 6071.3 7397.4 7462.3 7490.2 7570.7 7575.7 7578.2 7580.3 7586.2 7199.0 7227.4 7230.1 7239.2 7252.6 6830.5 7091.8 7117.6 7123.1 7143.9 7517.1 7535.1 7543.9 7577.7 7583.2 3541.9 4016.3 4081.2 4557.0 4691.6 7154.8 7159.1 7161.6 7168.1 7194.1 6608.3 6921.8 6936.9 6950.9 6969.5 6821.0 6887.5 6909.0 6915.6 6940.6 5530.9 6783.3 6783.6 6819.1 6828.6 6956.4 6957.5 6965.2 6968.2 6981.8 6479.8 6516.2 6591.5 6760.5 6794.5 07:14:23 INFO - PROCESS | 2061 | 07:14:23 INFO - PROCESS | 2061 | [#5] yui.html Cycles:180 Average:18684.59 Median:610.14 stddev:26588.42 (4357.7%) stddev-sans-first:26628.65 07:14:23 INFO - PROCESS | 2061 | Values: 685.3 690.9 750.0 755.2 764.2 15123.8 15353.8 15356.7 15367.2 15370.0 13962.4 14084.1 14117.6 14141.5 14196.9 732.1 748.7 899.3 913.1 915.5 901.9 926.1 926.1 926.9 927.4 978.4 988.5 988.8 989.5 990.0 765.5 957.0 962.8 976.3 984.7 726.3 726.7 728.8 728.9 730.0 14965.1 15033.8 15038.8 15062.8 15081.0 12402.6 12581.9 12596.8 12703.4 12914.2 10030.0 10150.3 10380.6 10922.4 11018.2 3119.8 3156.9 3652.8 3685.3 3690.2 82399.2 84206.0 84460.6 84656.0 84856.6 9367.6 9368.4 9433.2 9603.9 10276.2 17676.4 21384.6 21407.7 21428.9 21439.0 6828.7 7117.9 7369.7 7635.4 7788.6 4057.7 4113.4 4116.9 4185.4 4220.2 3561.3 3604.5 3611.3 3613.0 3624.6 627.1 630.4 636.4 637.8 643.8 587.7 594.8 596.2 609.9 611.2 7770.7 8183.1 8297.2 8318.1 8654.8 519.4 536.6 575.4 610.4 617.2 3520.8 3541.8 3590.9 3713.4 3840.8 91656.5 92981.0 93233.6 96581.0 97425.0 80230.0 81347.4 81574.0 81843.2 83817.6 72786.3 73664.6 73903.6 75063.0 75458.9 8350.6 8428.0 8434.0 8511.1 8602.7 46937.0 47547.0 47615.5 51237.7 51683.0 56046.6 69719.0 70956.6 71910.6 73885.0 10853.6 11143.4 11204.9 11255.9 11425.8 12135.6 12282.1 12283.2 12290.9 12685.6 11327.2 11444.7 11473.4 11800.9 11913.4 11266.6 11331.5 11332.0 11445.4 12447.3 10607.6 10890.1 11173.8 11370.8 11548.1 9521.6 9763.7 9854.8 10018.8 10600.9 8859.6 9080.7 9112.4 9446.0 9779.0 07:14:23 INFO - PROCESS | 2061 | -------- Summary: end -------- 07:14:23 INFO - PROCESS | 2061 | 07:14:24 INFO - TEST-INFO | 2061: exit 0 07:14:24 INFO - TEST-OK | dromaeo_css | took 1114362ms 07:14:24 INFO - TEST-START | kraken 07:14:24 INFO - operating with platform_type : mac_ 07:14:24 INFO - Initialising browser for kraken test... 07:14:24 INFO - TEST-INFO | started process 2065 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmp7CTe1c/profile http://localhost:51417/getInfo.html) 07:14:26 INFO - PROCESS | 2065 | __metrics Screen width/height:1600/1200 07:14:26 INFO - PROCESS | 2065 | colorDepth:24 07:14:26 INFO - PROCESS | 2065 | Browser inner width/height: 1024/689 07:14:26 INFO - PROCESS | 2065 | __metrics 07:14:26 INFO - PROCESS | 2065 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:14:26 ERROR - PROCESS | 2065 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:14:27 INFO - TEST-INFO | 2065: exit 0 07:14:27 INFO - Browser initialized. 07:14:27 INFO - Running cycle 1/1 for kraken test... 07:14:27 INFO - TEST-INFO | started process 2067 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/tmp7CTe1c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:14:39 INFO - PROCESS | 2067 | RSS: Main: 244350976 07:14:39 INFO - PROCESS | 2067 | 07:14:41 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51417/tests/kraken/driver.html?testName=audio-beat-detection) 07:14:42 INFO - PROCESS | 2067 | RSS: Main: 290889728 07:14:42 INFO - PROCESS | 2067 | 07:14:45 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51417/tests/kraken/driver.html?testName=audio-dft) 07:14:45 INFO - PROCESS | 2067 | RSS: Main: 300797952 07:14:45 INFO - PROCESS | 2067 | 07:14:48 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51417/tests/kraken/driver.html?testName=audio-fft) 07:14:49 INFO - PROCESS | 2067 | RSS: Main: 287309824 07:14:49 INFO - PROCESS | 2067 | 07:14:51 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51417/tests/kraken/driver.html?testName=audio-oscillator) 07:14:52 INFO - PROCESS | 2067 | RSS: Main: 289030144 07:14:52 INFO - PROCESS | 2067 | 07:14:54 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51417/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:14:54 INFO - PROCESS | 2067 | RSS: Main: 289976320 07:14:54 INFO - PROCESS | 2067 | 07:14:57 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51417/tests/kraken/driver.html?testName=imaging-darkroom) 07:14:58 INFO - PROCESS | 2067 | RSS: Main: 291647488 07:14:58 INFO - PROCESS | 2067 | 07:15:01 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51417/tests/kraken/driver.html?testName=imaging-desaturate) 07:15:01 INFO - PROCESS | 2067 | RSS: Main: 291594240 07:15:01 INFO - PROCESS | 2067 | 07:15:04 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51417/tests/kraken/driver.html?testName=json-parse-financial) 07:15:05 INFO - PROCESS | 2067 | RSS: Main: 291827712 07:15:05 INFO - PROCESS | 2067 | 07:15:06 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51417/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:15:07 INFO - PROCESS | 2067 | RSS: Main: 325320704 07:15:07 INFO - PROCESS | 2067 | 07:15:08 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51417/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:15:09 INFO - PROCESS | 2067 | RSS: Main: 325451776 07:15:09 INFO - PROCESS | 2067 | 07:15:11 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51417/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:15:12 INFO - PROCESS | 2067 | RSS: Main: 330878976 07:15:12 INFO - PROCESS | 2067 | 07:15:14 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:15:15 INFO - PROCESS | 2067 | RSS: Main: 332324864 07:15:15 INFO - PROCESS | 2067 | 07:15:18 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:15:18 INFO - PROCESS | 2067 | RSS: Main: 332152832 07:15:18 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | Cycle 1(1): loaded http://localhost:51417/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51417/tests/kraken/driver.html?testName=ai-astar) 07:15:20 INFO - PROCESS | 2067 | RSS: Main: 394465280 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | __start_tp_report 07:15:20 INFO - PROCESS | 2067 | _x_x_mozilla_page_load 07:15:20 INFO - PROCESS | 2067 | _x_x_mozilla_page_load_details 07:15:20 INFO - PROCESS | 2067 | |i|pagename|runs| 07:15:20 INFO - PROCESS | 2067 | |0;ai-astar;112;109;110;111;111;110;119;111;111;112 07:15:20 INFO - PROCESS | 2067 | |1;audio-beat-detection;157;120;143;159;128;173;165;131;202;147 07:15:20 INFO - PROCESS | 2067 | |2;audio-dft;186;185;186;184;183;185;183;183;184;182 07:15:20 INFO - PROCESS | 2067 | |3;audio-fft;78;72;86;79;56;58;56;75;77;54 07:15:20 INFO - PROCESS | 2067 | |4;audio-oscillator;93;95;128;83;106;67;121;108;117;152 07:15:20 INFO - PROCESS | 2067 | |5;imaging-gaussian-blur;89;86;89;87;88;86;89;87;88;85 07:15:20 INFO - PROCESS | 2067 | |6;imaging-darkroom;95;94;95;95;95;95;94;96;94;97 07:15:20 INFO - PROCESS | 2067 | |7;imaging-desaturate;86;87;87;84;85;84;87;86;87;83 07:15:20 INFO - PROCESS | 2067 | |8;json-parse-financial;53;53;53;53;53;54;55;64;55;53 07:15:20 INFO - PROCESS | 2067 | |9;json-stringify-tinderbox;63;63;75;79;71;68;68;68;68;68 07:15:20 INFO - PROCESS | 2067 | |10;stanford-crypto-aes;85;82;83;82;84;83;80;83;81;87 07:15:20 INFO - PROCESS | 2067 | |11;stanford-crypto-ccm;136;121;129;128;136;135;123;121;118;121 07:15:20 INFO - PROCESS | 2067 | |12;stanford-crypto-pbkdf2;143;129;141;139;127;133;139;141;136;133 07:15:20 INFO - PROCESS | 2067 | |13;stanford-crypto-sha256-iterative;68;67;71;91;97;97;95;69;70;79 07:15:20 INFO - PROCESS | 2067 | __end_tp_report 07:15:20 INFO - PROCESS | 2067 | __start_cc_report 07:15:20 INFO - PROCESS | 2067 | _x_x_mozilla_cycle_collect,1242 07:15:20 INFO - PROCESS | 2067 | __end_cc_report 07:15:20 INFO - PROCESS | 2067 | __startTimestamp1459260920743__endTimestamp 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | ------- Summary: start ------- 07:15:20 INFO - PROCESS | 2067 | Number of tests: 14 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.00 stddev:2.76 (2.5%) stddev-sans-first:2.92 07:15:20 INFO - PROCESS | 2067 | Values: 112.0 109.0 110.0 111.0 111.0 110.0 119.0 111.0 111.0 112.0 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:158.00 stddev:24.33 (15.4%) stddev-sans-first:25.75 07:15:20 INFO - PROCESS | 2067 | Values: 157.0 120.0 143.0 159.0 128.0 173.0 165.0 131.0 202.0 147.0 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:1.37 (0.7%) stddev-sans-first:1.27 07:15:20 INFO - PROCESS | 2067 | Values: 186.0 185.0 186.0 184.0 183.0 185.0 183.0 183.0 184.0 182.0 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#3] audio-fft Cycles:10 Average:69.10 Median:76.00 stddev:11.85 (15.6%) stddev-sans-first:12.12 07:15:20 INFO - PROCESS | 2067 | Values: 78.0 72.0 86.0 79.0 56.0 58.0 56.0 75.0 77.0 54.0 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#4] audio-oscillator Cycles:10 Average:107.00 Median:109.50 stddev:24.22 (22.1%) stddev-sans-first:25.16 07:15:20 INFO - PROCESS | 2067 | Values: 93.0 95.0 128.0 83.0 106.0 67.0 121.0 108.0 117.0 152.0 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#5] imaging-gaussian-blur Cycles:10 Average:87.40 Median:88.00 stddev:1.43 (1.6%) stddev-sans-first:1.39 07:15:20 INFO - PROCESS | 2067 | Values: 89.0 86.0 89.0 87.0 88.0 86.0 89.0 87.0 88.0 85.0 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#6] imaging-darkroom Cycles:10 Average:95.00 Median:95.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 07:15:20 INFO - PROCESS | 2067 | Values: 95.0 94.0 95.0 95.0 95.0 95.0 94.0 96.0 94.0 97.0 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.50 stddev:1.51 (1.7%) stddev-sans-first:1.59 07:15:20 INFO - PROCESS | 2067 | Values: 86.0 87.0 87.0 84.0 85.0 84.0 87.0 86.0 87.0 83.0 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:53.50 stddev:3.41 (6.4%) stddev-sans-first:3.56 07:15:20 INFO - PROCESS | 2067 | Values: 53.0 53.0 53.0 53.0 53.0 54.0 55.0 64.0 55.0 53.0 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:68.00 stddev:4.91 (7.2%) stddev-sans-first:4.68 07:15:20 INFO - PROCESS | 2067 | Values: 63.0 63.0 75.0 79.0 71.0 68.0 68.0 68.0 68.0 68.0 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:2.00 (2.4%) stddev-sans-first:1.99 07:15:20 INFO - PROCESS | 2067 | Values: 85.0 82.0 83.0 82.0 84.0 83.0 80.0 83.0 81.0 87.0 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:128.50 stddev:6.96 (5.4%) stddev-sans-first:6.53 07:15:20 INFO - PROCESS | 2067 | Values: 136.0 121.0 129.0 128.0 136.0 135.0 123.0 121.0 118.0 121.0 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:136.10 Median:139.00 stddev:5.43 (3.9%) stddev-sans-first:5.15 07:15:20 INFO - PROCESS | 2067 | Values: 143.0 129.0 141.0 139.0 127.0 133.0 139.0 141.0 136.0 133.0 07:15:20 INFO - PROCESS | 2067 | 07:15:20 INFO - PROCESS | 2067 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.40 Median:85.00 stddev:13.07 (15.4%) stddev-sans-first:13.07 07:15:20 INFO - PROCESS | 2067 | Values: 68.0 67.0 71.0 91.0 97.0 97.0 95.0 69.0 70.0 79.0 07:15:20 INFO - PROCESS | 2067 | -------- Summary: end -------- 07:15:20 INFO - PROCESS | 2067 | 07:15:21 INFO - TEST-INFO | 2067: exit 0 07:15:21 INFO - TEST-OK | kraken | took 57289ms 07:15:21 INFO - SUITE-END | took 1171s 07:15:21 INFO - Completed test suite (00:19:31) 07:15:21 INFO - javascript benchmark 07:15:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3438.295149494353, 3473.3574288756568, 3497.5802903651565, 3503.3693935091674, 3541.557305336833, 5646.237757902682, 5707.258056452655, 5717.571182161334, 5743.454371834674, 5790.913136302954, 4444.666650001254, 5491.835244942648, 5635.239242702234, 5659.971700141504, 5664.037113690672, 5103.668261563005, 5154.664946778447, 5178.1197196476505, 5193.402758682743, 5263.736813159346, 5285.762140703659, 5290.1271290237255, 5297.12597421425, 5344.144936810111, 5362.65142765721, 5097.7960881564695, 5172.9741351293005, 5195.610329225323, 5226.189940559219, 5237.947620523784, 5150.356205474316, 5170.638055336128, 5180.067587834188, 5189.299444575009, 5189.688618682853, 5112.41207261166, 5147.536721695028, 5150.639455238135, 5156.510131537498, 5160.174372100446, 5641.294838145232, 5644.238027866268, 5646.802361917355, 5655.886882262373, 5683.119116536944, 5700.3159620845345, 6237.500999919996, 6245.937540624581, 6247.875042499125, 6270.874582508324, 5994.220751302303, 6075.131143872926, 6247.219097612799, 6316.810495685137, 6331.96834015827, 4855.32025516428, 5763.423657634203, 5770.740316685759, 5829.154772557956, 5861.999999999957, 6291.433770960635, 6302.810915672537, 6311.715972781236, 6321.431071203522, 6328.335524769833, 6035.758569657164, 6089.0, 6128.693565321716, 6144.784932527429, 6149.5080393568405, 6167.136600875791, 6189.226346706661, 6190.41191086846, 6227.19046523949, 6323.241211054703, 5779.133130030445, 5792.652440853478, 5804.216430781875, 5822.912656310159, 5880.382559831241, 5789.9710501447225, 5813.331466881363, 5818.7672493100645, 5819.156222347736, 5866.501347385435, 4787.593054590329, 4827.589654879304, 4860.198067318853, 4876.926846097312, 4886.3403440535785, 3970.3448930926074, 4349.978250108729, 4457.799399026987, 4459.620932220732, 4516.480604730433, 5758.971205144031, 5761.481466667936, 5764.510016648632, 5765.769369225268, 5772.422757724194, 5194.896102077937, 6173.59871608344, 6264.5301602379095, 6270.655113968684, 6277.811665650038, 4698.976505117453, 5620.381758006616, 5662.688552129673, 5673.3475650299915, 5865.4134586541, 5214.843554693365, 5346.278252435949, 5355.598330125256, 5367.677939323575, 5388.784448622089, 6226.1905952227735, 6233.657148856766, 6243.750249989949, 6288.9056664150075, 6331.841703957438, 6244.812655620339, 6257.655828929271, 6263.718132683949, 6278.529110316653, 6301.338359472189, 6298.401651843251, 6299.401556852092, 6299.937000629935, 6302.180716506825, 6313.431791138636, 6063.969680151571, 6097.603655762361, 6145.647957449354, 6155.692215389302, 6159.876802463836, 4695.5304469552775, 6281.3404592518955, 6283.622982621057, 6285.74857005733, 6317.020861766434, 6152.815415537541, 6158.414950579688, 6166.691665416622, 6169.01295792671, 6194.163787888758, 5921.467067963904, 6039.728212230548, 6073.787417440369, 6131.448169664752, 6134.375358695336, 5971.970140149271, 5986.952283350483, 5999.070144127667, 6005.0, 6005.159277701038, 6144.569880108528, 6150.876982460236, 6154.292256390393, 6158.107074474266, 6163.260408750979, 5809.390014048633, 5873.119032145212, 5909.320428150818, 5910.054391297372, 5916.704164791657], "unit": "score", "name": "dojo.html", "value": 5643.913069756526}, {"lowerIsBetter": false, "replicates": [483.4681849965037, 524.0253129179728, 542.9294191755073, 565.2171742137139, 629.7638385605396, 27589.586156207646, 35424.58301667937, 36768.448473272925, 39721.0, 39803.80098099505, 43257.7837110814, 43424.0, 43651.90870228246, 43823.3426498602, 43869.7806510967, 9637.951810240957, 9884.456354900478, 9890.060444257784, 9890.752731181707, 9912.653057143001, 9571.42571445712, 9685.709428717115, 9763.853542196874, 9851.014898510164, 9855.556499957484, 9809.852852207223, 9893.901060989407, 9898.554565044555, 9904.50477476127, 9908.900910990906, 9742.1719153872, 9858.211343092607, 9859.35914165577, 9862.704118876445, 9863.556139973682, 9835.31152819303, 9920.454375009444, 9966.202703783752, 9972.90027099727, 9990.150837178848, 41761.0, 42248.57751422508, 42284.0, 42402.0, 42411.363829542584, 3261.72275356595, 3291.1772056985756, 3432.3993301172195, 3752.689028762642, 3854.768713877176, 29111.272218194503, 29300.267493312625, 29578.408431831456, 29767.25581860449, 29862.85068574665, 2735.37086470111, 2748.8900443982216, 2778.2220978126156, 2781.276868014311, 2861.0558515689772, 476651.0, 478488.0, 478650.60674696753, 479686.0, 481363.0, 69554.65222673854, 70014.0, 70042.0, 70132.58408990852, 70135.29864701288, 72393.63803181055, 74846.0, 76059.0, 76065.0, 76254.61872690602, 14018.369173387222, 17077.060761658227, 17300.48098557045, 17309.0, 17313.0, 12781.61655150347, 12868.871311286768, 12883.48466061347, 12895.742085158245, 12908.031897607718, 21979.890100549714, 22234.777652223594, 22241.777582224295, 22253.888730556566, 22255.887205639654, 8836.602352894135, 9094.727158185266, 9125.908740912506, 9133.862992055125, 9221.446713197229, 898.9280857531381, 913.3515204205089, 957.6552441121191, 1010.8332125199407, 1102.162356608967, 28170.181324387228, 28328.0, 28590.856365745138, 28594.71405285962, 28859.422811543653, 1004.347174336687, 1098.340995402768, 1105.7622611138484, 1172.2204733851893, 1172.454808514045, 14508.782368264485, 14816.111033338035, 14879.542752080837, 14912.956093073597, 15073.397064117313, 583541.0, 586997.0, 595035.0, 596216.0, 596294.0, 63178.368216318166, 63611.0, 63693.68153159205, 63717.68141159357, 64083.35916640867, 1214.7084699672191, 1297.2475963940892, 1452.847451017649, 1472.639203395175, 1497.2513743128436, 30147.0, 31241.062768116994, 31515.684843151274, 31631.36737265196, 32135.357292854478, 57576.42423575878, 57926.7103664479, 58502.0, 58661.0, 58717.0, 474271.0, 484179.0, 484561.0, 485116.0, 486045.56977214885, 37376.95411119573, 45853.85365365892, 46033.539664602926, 46358.0, 47255.29117063178, 47107.76446117885, 47916.76041619769, 48016.5198348026, 48602.0, 49411.258831118284, 38226.85319440421, 39271.607283926794, 39290.607093928695, 40140.79929600333, 40872.0, 38537.0, 38573.22853542857, 38616.0, 39391.40912886366, 39633.80183099066, 38470.615293846706, 39016.41475377928, 39239.41140882946, 39273.49171320195, 39659.2068158641, 33392.33215335728, 34333.141671457415, 35007.949761507196, 35073.29853402969, 35133.648663513035, 25621.48757024812, 25666.486670266862, 25739.742602573733, 25828.35429114287, 26356.472870542097], "unit": "score", "name": "ext.html", "value": 20750.338093306917}, {"lowerIsBetter": false, "replicates": [363.28976850257743, 369.15831903260573, 371.08527479762387, 374.61976094264327, 378.89012186465925, 19605.50986225343, 19966.201351945903, 20254.594908101866, 20380.796192038077, 20474.873881936506, 20726.37820865373, 21027.894860525714, 21439.785602143973, 21723.13107475699, 21725.782742172574, 5938.52491800656, 6109.7861574844665, 6118.663473508956, 6166.938330616704, 6179.104029915659, 5867.618604790697, 5894.056950887859, 6070.453659170674, 6072.544559158058, 6096.420840020191, 5991.400859914017, 6006.129111278862, 6013.699315034252, 6016.2479690038745, 6033.456988871001, 5897.085951677475, 5931.051031834907, 6063.120847477136, 6087.634741915499, 6089.360617135181, 5111.667741596784, 5201.973990130025, 5234.685918844843, 5234.685918844882, 5240.79036838526, 25692.48615027689, 25994.350141246432, 26397.20808375752, 26429.0, 26453.0, 2165.231342873273, 2336.0, 2449.816263780224, 2605.6873175218907, 2748.395353022332, 13489.325533723373, 14795.0, 14886.70226595462, 15164.848351516564, 15278.15970121643, 1486.780839711437, 1731.9826801731947, 1750.844442667846, 1773.2286455391945, 1808.8552915766707, 96164.51917740436, 98205.0, 100682.4965875166, 100717.49641251747, 101513.49243253736, 10149.0, 10308.948455257676, 10593.364398136137, 10641.521131548943, 10719.785604288027, 13341.266230357423, 13350.332483375792, 13361.665958350924, 13362.665933351744, 13363.131396459394, 8408.579571021424, 8553.74338769838, 8569.914300857037, 8672.696455624024, 8674.522901240367, 7507.924920750832, 8452.66189352419, 8462.957685211657, 8470.915290847013, 8591.613377397907, 5452.318460192476, 5902.852428689317, 6065.999110146865, 6116.666416802853, 6280.8694435002135, 1526.2979029646488, 1828.9268429262947, 1853.7404763333145, 1855.730919016762, 1860.9906950465431, 866.9913300867037, 959.856021596766, 1008.9142422893989, 1072.8658917635296, 1129.8644162700527, 20702.068406921724, 21274.27700152467, 21448.678269825967, 21477.67783483249, 21494.032768525452, 965.5751469353462, 1007.3099926550336, 1022.7085280694967, 1030.7680771826278, 1102.7629059752192, 11260.0, 11705.0, 11710.531578736754, 11715.824262636068, 11727.47226374798, 616604.0, 617809.0, 620934.0, 642031.0, 642806.0, 97790.5110474443, 98164.50917745508, 99862.5006874961, 100277.49861250793, 100657.49671251597, 935.7554452578055, 1084.5553323137476, 1105.4251789069638, 1130.383940752292, 1132.3828513460185, 18282.634347313244, 18655.720164197275, 18734.6253074935, 18735.625287494448, 18961.336353227573, 46967.29549056835, 47643.04713905633, 49361.753191233816, 49741.502584973685, 50556.49443505665, 62803.37196627975, 63472.0, 63708.0, 63898.72202556016, 65210.0, 7205.495615306878, 7724.729634462767, 7780.0, 7903.367730581424, 8092.0, 11908.460595472689, 12151.939240303742, 12315.93842030784, 12376.504939802668, 12855.614331570068, 10637.574497020341, 10676.306040107369, 10726.463676816284, 10968.670939871816, 11075.778484430428, 10006.899931000597, 10476.319039262728, 10541.947290263499, 10966.0, 10968.17738669587, 9052.411593246417, 11107.555697772323, 11438.485268162785, 11520.596779112691, 11534.134939879375, 7633.160352361347, 7673.503458144473, 7689.615519224129, 7721.498102623312, 8017.438779285394, 8248.216419440143, 10002.949985250027, 10938.343699378063, 11233.269837460539, 11299.265547739371], "unit": "score", "name": "jquery.html", "value": 9536.90464366774}, {"lowerIsBetter": false, "replicates": [1409.5348534983452, 1444.4944269505681, 1624.277196647492, 1855.2949879045962, 2017.616652835962, 8034.9196508034975, 8685.001224859143, 8924.241439477652, 8927.732168034969, 8935.821283574332, 8514.191151840581, 8759.78100547485, 8771.07903670115, 8771.605277762501, 8781.91218087819, 2190.2553131935138, 2371.1937941100023, 2432.9391765205924, 2463.1625247415873, 2494.550980823451, 2518.49630073985, 2522.2811498722867, 2524.2301098165053, 2529.29179829648, 2529.3170843872144, 2413.3242692046256, 2490.1284550407395, 2500.174942269056, 2505.8997640094376, 2507.3480894967347, 2432.4770174412497, 2481.0819996601194, 2481.3176376496426, 2486.191987604036, 2489.7385774493687, 2438.5488684593406, 2474.950500989988, 2479.1818699829014, 2485.72657007729, 2485.7389974052826, 8952.060033696433, 9004.189622933967, 9032.593533291018, 9042.367034307601, 9062.68280610182, 5441.102218134003, 5608.298962629671, 5611.214429979766, 5612.522935550483, 5618.073017952033, 3508.8421021054114, 3687.115092377837, 3690.6493883081066, 3696.8890933272046, 3747.9812600937094, 1044.926855120142, 1057.0592172966067, 1063.4420573859256, 1077.8167711489066, 1078.2075174746556, 12127.757444851053, 12136.817947730791, 12142.089343299287, 12144.332061736513, 12146.696332591668, 4802.951970480251, 4813.518648135158, 4903.87740306488, 4911.705297682151, 4919.286703428054, 10233.1301839343, 10240.897591024144, 10260.179185665129, 10272.691819245434, 10289.22830787694, 5543.029969755276, 5553.305836770403, 5553.361363443175, 5553.888922221533, 5556.805286863263, 4454.265046267395, 4661.184292748823, 4849.127157111683, 4960.727160006162, 4969.602431805447, 3789.6778773803985, 3903.394973779069, 3903.414487826792, 3929.426225822091, 3952.8023598819946, 1280.0399700224832, 1304.6347022833622, 1311.672081979505, 1317.7298653775954, 1323.9669008274677, 1142.9257098288585, 1170.8653504846882, 1186.3297237061033, 1414.8868090552937, 1426.736053830024, 8257.463264887763, 8315.750527484186, 8443.95778021106, 8448.408611397143, 8459.450135741157, 515.7988384530037, 516.0375898948434, 518.9662671926312, 520.6485622204997, 536.5064140990298, 6284.02597597364, 6290.937090629035, 6347.55567110307, 6347.936520634827, 6358.872822543523, 10675.412852293042, 11007.889921100847, 11096.500657470433, 11098.722531936604, 11104.611338603272, 8906.59920303575, 10609.204309676805, 10876.72808179786, 10973.725656858483, 10979.231453798158, 8438.957805210935, 8458.450200736932, 8465.026521950054, 8520.0, 8535.743927682179, 7827.295543401121, 8026.8394632105865, 8031.915691381589, 8036.758897233092, 8065.435419520577, 9349.25205983506, 9631.759206019906, 9711.805763884542, 9759.609615615296, 9896.901030989886, 9871.0, 10067.1442927352, 10190.74523136898, 10276.691699249035, 10284.485775711335, 6006.459418652343, 6671.833204169935, 6684.732610695518, 7631.771046868381, 7685.00094987648, 8324.916750832414, 8383.622736976973, 8396.202360775716, 8400.201980811813, 8403.075661677089, 7280.5995670236525, 7321.670524826289, 7388.965544823836, 7462.141853686896, 7511.51175173612, 7189.5521871024785, 7204.24355442671, 7246.094238220223, 7271.4546409020595, 7289.125304963438, 7807.648655810389, 7861.764147075597, 7872.488288261245, 7875.409344299315, 7923.722669706764, 6876.759313424006, 7074.504784665024, 7150.998860159686, 7161.248068952685, 7166.928330716626, 7131.144262688511, 7179.497435179487, 7191.856162876608, 7224.277572242734, 7226.0], "unit": "score", "name": "mootools.html", "value": 4884.855835775868}, {"lowerIsBetter": false, "replicates": [323.43399051659594, 324.2590680295524, 329.22303364060826, 331.61201394368584, 333.73968304722325, 6483.675816209188, 6526.314736952617, 6530.510211734115, 6535.869282614345, 6613.933860661392, 6320.367963203677, 6468.029795530672, 6469.02964555317, 6476.093346931421, 6582.637954912478, 3679.5584529856455, 4683.601893839028, 4707.835225767099, 4783.760811959405, 4856.514348565133, 4765.547273009059, 4777.259524773648, 4794.952050479503, 4806.4712881583, 4825.396825396825, 4789.353437285957, 4793.113274044295, 4803.759812009403, 4812.109759694467, 4825.131476334259, 4573.268277075652, 4632.14305353509, 4778.0, 4826.420829500483, 4828.203346447832, 4112.979435102805, 4133.8966525836795, 4145.751254924684, 4150.405996252342, 4154.958450415487, 6243.65659888706, 6245.281792593864, 6267.749290028393, 6270.435660790505, 6280.864506067913, 5639.351474580435, 5643.6049476536655, 5644.379118296984, 5657.462541058593, 5658.207850900877, 6670.599764014126, 6910.894256918868, 6927.51058522415, 6937.445004399636, 6944.02783610295, 4551.453825540923, 4638.582527572535, 4647.488776234612, 4652.976735116336, 4663.626909847204, 7235.167955685111, 7296.7446139384865, 7311.415086793044, 7325.926740732578, 7328.157261914841, 4690.929636055462, 4699.906001879944, 4701.3888194535175, 4702.294655801657, 4713.95286047142, 4742.217534106834, 4751.548602882721, 4757.8096876125255, 4766.404199475066, 4774.0, 5577.553795696334, 5586.636868603528, 5599.664020158803, 5602.831915042555, 5609.775608975595, 6722.28135752653, 6798.898016529756, 6923.515353925177, 6952.687129079203, 6976.616286104211, 1511.4105498855456, 1544.1584336536614, 1640.1553200101957, 1649.909254990963, 1657.3370651739401, 1004.7437903334603, 1054.8259537176434, 1074.6561100447939, 1085.7122862441458, 1086.6359769477156, 6225.252969643671, 6231.4391704746795, 6240.219972503437, 6246.312905580383, 6351.364863513704, 6996.545224560387, 7135.4648401370105, 7206.495545311883, 7236.312550307713, 7263.346298833025, 6272.466840318624, 6504.577202481823, 6506.512011599149, 6510.544261901716, 6520.413162815369, 3218.8873389431255, 3832.2335532893535, 3838.213166300902, 3839.462475253467, 3840.9423858642144, 6094.329623741385, 7283.235260297698, 7464.776056718307, 7585.6965721371635, 7602.771916842504, 6034.24571928509, 6071.271447426248, 7397.445191610651, 7462.328390444886, 7490.213527579525, 7570.659320330598, 7575.659095340613, 7578.204288549733, 7580.279873412017, 7586.203448637924, 7199.028131202221, 7227.421806255382, 7230.13238411394, 7239.239879812544, 7252.637368131678, 6830.45356371499, 7091.751788687371, 7117.644117794193, 7123.109611298588, 7143.892841607276, 7517.060367454068, 7535.13345965221, 7543.943847861194, 7577.696892124473, 7583.203763604742, 3541.8937431877084, 4016.3172260715164, 4081.20416518776, 4556.954430455653, 4691.648126390603, 7154.785356439315, 7159.105111861018, 7161.57030578167, 7168.139823221039, 7194.064771579661, 6608.306127856698, 6921.792346229621, 6936.861262774817, 6950.930490695028, 6969.54697944632, 6820.965895170492, 6887.483438742214, 6909.0, 6915.550489218184, 6940.583564986117, 5530.889382212414, 6783.321667833177, 6783.626900520519, 6819.113515242987, 6828.624425656637, 6956.408705259907, 6957.547759395623, 6965.233824279224, 6968.163820341591, 6981.755638552626, 6479.773207937888, 6516.152900122954, 6591.472682185509, 6760.492963027891, 6794.52438329332], "unit": "score", "name": "prototype.html", "value": 5063.905301430084}, {"lowerIsBetter": false, "replicates": [685.3352248319129, 690.8721886451004, 749.970001199952, 755.199488542145, 764.1937755667772, 15123.848761512396, 15353.769693454593, 15356.69286614267, 15367.231638418076, 15370.0, 13962.371693273803, 14084.08453450525, 14117.57647270581, 14141.505047323346, 14196.858031419708, 732.0775822463708, 748.7192302886417, 899.2850683706437, 913.1005959130251, 915.46445329482, 901.9368644194909, 926.073926073926, 926.1155596405416, 926.8980412154658, 927.3554879358849, 978.3738407419257, 988.4859872866141, 988.7874107067015, 989.5200827598609, 990.0297708245923, 765.5024234247755, 957.0190554681507, 962.8363178259677, 976.2921881635757, 984.6553706202843, 726.2737262737263, 726.6548389514991, 728.8032231297573, 728.8578727148208, 730.0290613484053, 14965.102093874293, 15033.774493382609, 15038.774418383624, 15062.774058389134, 15081.019733717274, 12402.56591019319, 12581.874181258254, 12596.81104783429, 12703.364831758376, 12914.22514649124, 10030.0, 10150.340227885164, 10380.584776608926, 10922.399268040255, 11018.228723989325, 3119.82840943748, 3156.936861262785, 3652.7990960497164, 3685.318216129998, 3690.2066055797864, 82399.17600823975, 84206.0, 84460.57769711173, 84656.0, 84856.57571712101, 9367.62529498826, 9368.4378937264, 9433.151016408556, 9603.9039609603, 10276.177905767521, 17676.38132665376, 21384.572308554052, 21407.715537067827, 21428.89285553562, 21439.0, 6828.736683713529, 7117.92882071183, 7369.668364923484, 7635.42734294919, 7788.610569471503, 4057.736247143926, 4113.382992551141, 4116.938245926313, 4185.393117997874, 4220.198162349144, 3561.3411518869093, 3604.5133906922756, 3611.331903597843, 3612.9638703612627, 3624.637536246354, 627.0938493876396, 630.4042679667762, 636.3763511758502, 637.8182218067828, 643.7811144210897, 587.748096554345, 594.8334466349429, 596.150485558078, 609.9085137229363, 611.245112286326, 7770.650320735581, 8183.14077021916, 8297.211764882326, 8318.12659670738, 8654.826903461895, 519.3689667054547, 536.5895090255957, 575.3670961941831, 610.3743662745721, 617.2161355079024, 3520.753547251668, 3541.8480288521328, 3590.9461358079648, 3713.3687273163628, 3840.807959602009, 91656.54171729232, 92981.0, 93233.60149597761, 96581.0, 97425.0, 80230.0, 81347.37305253862, 81574.0, 81843.18156818475, 83817.58091209504, 72786.27213727795, 73664.63167684234, 73903.63048184724, 75063.0, 75458.86811697939, 8350.58247087631, 8428.0, 8434.0, 8511.106333835105, 8602.655893764178, 46937.0, 47547.0, 47615.523844762494, 51237.74381128071, 51683.0, 56046.59883502782, 69719.0, 70956.64521677358, 71910.64044679744, 73885.0, 10853.565857365616, 11143.442827858737, 11204.88795112071, 11255.887441125484, 11425.828612570653, 12135.635930922086, 12282.140250182401, 12283.201591896499, 12290.938545307215, 12685.556005539762, 11327.207095503236, 11444.656660300205, 11473.36896470702, 11800.940995294968, 11913.404329783303, 11266.605668801552, 11331.546738130382, 11332.0, 11445.427728613702, 12447.315397653216, 10607.575696972035, 10890.128789696964, 11173.776524469627, 11370.829437558277, 11548.076153907836, 9521.57152928106, 9763.707088787347, 9854.753631159278, 10018.799624007333, 10600.893726439946, 8859.557022148996, 9080.727578172666, 9112.362134650775, 9446.0, 9779.0], "unit": "score", "name": "yui.html", "value": 6954.521664811491}], "name": "dromaeo_css", "value": 7596.423534626216}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 109.0, 110.0, 111.0, 111.0, 110.0, 119.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [157.0, 120.0, 143.0, 159.0, 128.0, 173.0, 165.0, 131.0, 202.0, 147.0], "unit": "score", "name": "audio-beat-detection", "value": 152.5}, {"lowerIsBetter": true, "replicates": [186.0, 185.0, 186.0, 184.0, 183.0, 185.0, 183.0, 183.0, 184.0, 182.0], "unit": "score", "name": "audio-dft", "value": 184.1}, {"lowerIsBetter": true, "replicates": [78.0, 72.0, 86.0, 79.0, 56.0, 58.0, 56.0, 75.0, 77.0, 54.0], "unit": "score", "name": "audio-fft", "value": 69.1}, {"lowerIsBetter": true, "replicates": [93.0, 95.0, 128.0, 83.0, 106.0, 67.0, 121.0, 108.0, 117.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 107.0}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 89.0, 87.0, 88.0, 86.0, 89.0, 87.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 94.0, 97.0], "unit": "score", "name": "imaging-darkroom", "value": 95.0}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 87.0, 84.0, 85.0, 84.0, 87.0, 86.0, 87.0, 83.0], "unit": "score", "name": "imaging-desaturate", "value": 85.6}, {"lowerIsBetter": true, "replicates": [53.0, 53.0, 53.0, 53.0, 53.0, 54.0, 55.0, 64.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 75.0, 79.0, 71.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [85.0, 82.0, 83.0, 82.0, 84.0, 83.0, 80.0, 83.0, 81.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.0}, {"lowerIsBetter": true, "replicates": [136.0, 121.0, 129.0, 128.0, 136.0, 135.0, 123.0, 121.0, 118.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.8}, {"lowerIsBetter": true, "replicates": [143.0, 129.0, 141.0, 139.0, 127.0, 133.0, 139.0, 141.0, 136.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 136.1}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 71.0, 91.0, 97.0, 97.0, 95.0, 69.0, 70.0, 79.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 80.4}], "name": "kraken", "value": 1442.3}]} 07:15:21 INFO - Return code: 0 07:15:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:15:22 ERROR - # TBPL SUCCESS # 07:15:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:15:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:15:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:15:22 INFO - 2016-03-29 07:15:22.025 screenresolution[2071:17993] starting screenresolution argv=screenresolution get 07:15:22 INFO - 2016-03-29 07:15:22.028 screenresolution[2071:17993] Display 0: 1600x1200x32@60 07:15:22 INFO - 2016-03-29 07:15:22.034 screenresolution[2072:17996] starting screenresolution argv=screenresolution list 07:15:22 INFO - Available Modes on Display 0 07:15:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:15:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:15:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:15:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:15:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:15:22 INFO - Intel Iris: 07:15:22 INFO - Chipset Model: Intel Iris 07:15:22 INFO - Type: GPU 07:15:22 INFO - Bus: Built-In 07:15:22 INFO - VRAM (Dynamic, Max): 1536 MB 07:15:22 INFO - Vendor: Intel (0x8086) 07:15:22 INFO - Device ID: 0x0a2e 07:15:22 INFO - Revision ID: 0x0009 07:15:22 INFO - Displays: 07:15:22 INFO - Display: 07:15:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:15:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:15:22 INFO - Display Serial Number: 1600x1200 60 07:15:22 INFO - Main Display: Yes 07:15:22 INFO - Mirror: Off 07:15:22 INFO - Online: Yes 07:15:22 INFO - Rotation: Supported 07:15:22 INFO - Return code: 0 07:15:22 INFO - Running post-action listener: _resource_record_post_action 07:15:22 INFO - Running post-run listener: _resource_record_post_run 07:15:23 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 795136; Write bytes: 705059328; Read time: 10; Write time: 2067 07:15:23 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 387723776; Write bytes: 382170624; Read time: 30078; Write time: 800 07:15:23 INFO - run-tests - Wall time: 1174s; CPU: 52.0%; Read bytes: 795136; Write bytes: 300098560; Read time: 10; Write time: 1216 07:15:23 INFO - Running post-run listener: _upload_blobber_files 07:15:23 INFO - Blob upload gear active. 07:15:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:15:23 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 07:15:23 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'] 07:15:23 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 07:15:23 INFO - (blobuploader) - INFO - Open directory for files ... 07:15:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:15:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:15:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:25 INFO - (blobuploader) - INFO - Done attempting. 07:15:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:15:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:15:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:15:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:15:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:15:27 INFO - (blobuploader) - INFO - Done attempting. 07:15:27 INFO - (blobuploader) - INFO - Iteration through files over. 07:15:27 INFO - Return code: 0 07:15:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:15:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:15:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/015a2269db0c85d907b6c835cd1cc6a69aec87427b07b7bf2db6e98894deb1fe96534940ee0468d00e7f4e45420b150488e7c7b12872ffb39feee48514291d29", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1274f9a1b035d88cbf8dfec8de87c922418362d7ed82e109601be6f03ac972fdb289e8cbbfe3c00fba96f75cbe81cf87c99cb66723342d1dfae97037967678d8"} 07:15:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:15:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:15:27 INFO - Contents: 07:15:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/015a2269db0c85d907b6c835cd1cc6a69aec87427b07b7bf2db6e98894deb1fe96534940ee0468d00e7f4e45420b150488e7c7b12872ffb39feee48514291d29", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1274f9a1b035d88cbf8dfec8de87c922418362d7ed82e109601be6f03ac972fdb289e8cbbfe3c00fba96f75cbe81cf87c99cb66723342d1dfae97037967678d8"} 07:15:27 INFO - Running post-run listener: copy_logs_to_upload_dir 07:15:27 INFO - Copying logs to upload dir... 07:15:27 INFO - mkdir: /builds/slave/test/build/upload/logs 07:15:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1292.464218 ========= master_lag: 18.76 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 51 secs) (at 2016-03-29 07:15:45.754987) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-29 07:15:45.759549) ========= 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.NKHQPSRVB5/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.S3baZpgg2L/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/015a2269db0c85d907b6c835cd1cc6a69aec87427b07b7bf2db6e98894deb1fe96534940ee0468d00e7f4e45420b150488e7c7b12872ffb39feee48514291d29", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1274f9a1b035d88cbf8dfec8de87c922418362d7ed82e109601be6f03ac972fdb289e8cbbfe3c00fba96f75cbe81cf87c99cb66723342d1dfae97037967678d8"} build_url:https://queue.taskcluster.net/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011375 build_url: 'https://queue.taskcluster.net/v1/task/YuZIOR39Q8GTF3Vp1kdwag/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/015a2269db0c85d907b6c835cd1cc6a69aec87427b07b7bf2db6e98894deb1fe96534940ee0468d00e7f4e45420b150488e7c7b12872ffb39feee48514291d29", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1274f9a1b035d88cbf8dfec8de87c922418362d7ed82e109601be6f03ac972fdb289e8cbbfe3c00fba96f75cbe81cf87c99cb66723342d1dfae97037967678d8"}' ========= master_lag: 2.30 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-29 07:15:48.073996) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 07:15:48.080434) ========= 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.NKHQPSRVB5/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.S3baZpgg2L/Listeners TMPDIR=/var/folders/fd/qd_slwb90wlgg0k7hddkt1cr00000w/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.005323 ========= master_lag: 1.49 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-03-29 07:15:49.573727) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 07:15:49.574048) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-29 07:15:49.580896) ========= ========= Total master_lag: 36.88 =========