builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0151 starttime: 1459557262.06 results: success (0) buildid: 20160401153231 builduid: 0d15d21e68904bc19d82d3bcffe901af revision: b6ea6a3bb8a6fc355b46403919d8c70e798c7007 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:22.060002) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:22.063463) ========= ========= Started set props: basedir (results: 0, elapsed: 6 secs) (at 2016-04-01 17:34:22.063750) ========= 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.GzmEuSvN1j/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.m5shcTkPMj/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.005213 basedir: '/builds/slave/test' ========= master_lag: 6.43 ========= ========= Finished set props: basedir (results: 0, elapsed: 6 secs) (at 2016-04-01 17:34:28.498719) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:28.499004) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:29.463912) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:29.464173) ========= 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.GzmEuSvN1j/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.m5shcTkPMj/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.005107 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:29.513173) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:29.517474) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:29.517811) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 17:34:29.518082) ========= 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.GzmEuSvN1j/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.m5shcTkPMj/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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-04-01 17:34:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.52M=0.002s 2016-04-01 17:34:30 (7.52 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.543507 ========= master_lag: 0.96 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 17:34:31.020924) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:31.021205) ========= 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.GzmEuSvN1j/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.m5shcTkPMj/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.020374 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:31.085892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 17:34:31.090328) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b6ea6a3bb8a6fc355b46403919d8c70e798c7007 --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 b6ea6a3bb8a6fc355b46403919d8c70e798c7007 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GzmEuSvN1j/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.m5shcTkPMj/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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-04-01 17:34:31,191 truncating revision to first 12 chars 2016-04-01 17:34:31,191 Setting DEBUG logging. 2016-04-01 17:34:31,191 attempt 1/10 2016-04-01 17:34:31,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b6ea6a3bb8a6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 17:34:32,482 unpacking tar archive at: mozilla-central-b6ea6a3bb8a6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.577466 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-01 17:34:32.804312) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:32.804639) ========= echo b6ea6a3bb8a6fc355b46403919d8c70e798c7007 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b6ea6a3bb8a6fc355b46403919d8c70e798c7007'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GzmEuSvN1j/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.m5shcTkPMj/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 b6ea6a3bb8a6fc355b46403919d8c70e798c7007 program finished with exit code 0 elapsedTime=0.005161 script_repo_revision: 'b6ea6a3bb8a6fc355b46403919d8c70e798c7007' ========= master_lag: 0.03 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:32.840092) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:32.843385) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 17:34:32.905300) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-01 17:34:32.905596) ========= /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.GzmEuSvN1j/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.m5shcTkPMj/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:34:33 INFO - MultiFileLogger online at 20160401 17:34:33 in /builds/slave/test 17:34:33 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 17:34:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:34:33 INFO - {'append_to_log': False, 17:34:33 INFO - 'base_work_dir': '/builds/slave/test', 17:34:33 INFO - 'blob_upload_branch': 'Firefox', 17:34:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:34:33 INFO - 'branch': 'Firefox', 17:34:33 INFO - 'buildbot_json_path': 'buildprops.json', 17:34:33 INFO - 'config_files': ('talos/mac_config.py',), 17:34:33 INFO - 'default_actions': ('clobber', 17:34:33 INFO - 'read-buildbot-config', 17:34:33 INFO - 'download-and-extract', 17:34:33 INFO - 'populate-webroot', 17:34:33 INFO - 'create-virtualenv', 17:34:33 INFO - 'install', 17:34:33 INFO - 'run-tests'), 17:34:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:34:33 INFO - 'download_minidump_stackwalk': True, 17:34:33 INFO - 'download_symbols': 'ondemand', 17:34:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:34:33 INFO - 'tooltool.py': '/tools/tooltool.py', 17:34:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:34:33 INFO - '/tools/misc-python/virtualenv.py')}, 17:34:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:34:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:34:33 INFO - 'installer_path': 'installer.exe', 17:34:33 INFO - 'log_level': 'info', 17:34:33 INFO - 'log_name': 'talos', 17:34:33 INFO - 'log_to_console': True, 17:34:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:34:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:34:33 INFO - 'opt_config_files': (), 17:34:33 INFO - 'pip_index': False, 17:34:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:34:33 INFO - 'cmd': ('bash', 17:34:33 INFO - '-c', 17:34:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:34:33 INFO - 'enabled': True, 17:34:33 INFO - 'halt_on_failure': False, 17:34:33 INFO - 'name': 'check_screen_resolution'},), 17:34:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:34:33 INFO - 'cmd': ('bash', 17:34:33 INFO - '-c', 17:34:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:34:33 INFO - 'enabled': True, 17:34:33 INFO - 'halt_on_failure': False, 17:34:33 INFO - 'name': 'check_screen_resolution'},), 17:34:33 INFO - 'run_cmd_checks_enabled': True, 17:34:33 INFO - 'sps_profile': False, 17:34:33 INFO - 'sps_profile_interval': 0, 17:34:33 INFO - 'suite': 'dromaeojs', 17:34:33 INFO - 'system_bits': '32', 17:34:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:34:33 INFO - 'title': 't-yosemite-r7-0151', 17:34:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:34:33 INFO - 'use_talos_json': True, 17:34:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:34:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:34:33 INFO - 'work_dir': 'build'} 17:34:33 INFO - ##### 17:34:33 INFO - ##### Running clobber step. 17:34:33 INFO - ##### 17:34:33 INFO - Running pre-action listener: _resource_record_pre_action 17:34:33 INFO - Running main action method: clobber 17:34:33 INFO - rmtree: /builds/slave/test/build 17:34:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:34:33 INFO - Running post-action listener: _resource_record_post_action 17:34:33 INFO - ##### 17:34:33 INFO - ##### Running read-buildbot-config step. 17:34:33 INFO - ##### 17:34:33 INFO - Running pre-action listener: _resource_record_pre_action 17:34:33 INFO - Running main action method: read_buildbot_config 17:34:33 INFO - Using buildbot properties: 17:34:33 INFO - { 17:34:33 INFO - "project": "", 17:34:33 INFO - "product": "firefox", 17:34:33 INFO - "script_repo_revision": "production", 17:34:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:34:33 INFO - "repository": "", 17:34:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:34:33 INFO - "buildid": "20160401153231", 17:34:33 INFO - "pgo_build": "False", 17:34:33 INFO - "basedir": "/builds/slave/test", 17:34:33 INFO - "buildnumber": 198, 17:34:33 INFO - "slavename": "t-yosemite-r7-0151", 17:34:33 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:34:33 INFO - "platform": "yosemite_r7", 17:34:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:34:33 INFO - "branch": "mozilla-central", 17:34:33 INFO - "repo_path": "mozilla-central", 17:34:33 INFO - "revision": "b6ea6a3bb8a6fc355b46403919d8c70e798c7007", 17:34:33 INFO - "stage_platform": "macosx64", 17:34:33 INFO - "builduid": "0d15d21e68904bc19d82d3bcffe901af", 17:34:33 INFO - "slavebuilddir": "test" 17:34:33 INFO - } 17:34:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 17:34:33 INFO - Running post-action listener: _resource_record_post_action 17:34:33 INFO - ##### 17:34:33 INFO - ##### Running download-and-extract step. 17:34:33 INFO - ##### 17:34:33 INFO - Running pre-action listener: _resource_record_pre_action 17:34:33 INFO - Running main action method: download_and_extract 17:34:33 INFO - mkdir: /builds/slave/test/build/tests 17:34:33 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')]} 17:34:33 INFO - https://queue.taskcluster.net/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 17:34:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:34:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 17:34:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/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 17:34:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/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 17:34:34 INFO - Downloaded 1199 bytes. 17:34:34 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 17:34:34 INFO - Using the following test package requirements: 17:34:34 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:34:34 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:34:34 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 17:34:34 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:34:34 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 17:34:34 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:34:34 INFO - u'jsshell-mac.zip'], 17:34:34 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:34:34 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 17:34:34 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 17:34:34 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:34:34 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 17:34:34 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:34:34 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 17:34:34 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:34:34 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 17:34:34 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 17:34:34 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 17:34:34 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:34:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:34:34 INFO - https://queue.taskcluster.net/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:34:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:34:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:34:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/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 17:34:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/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 17:34:36 INFO - Downloaded 17959134 bytes. 17:34:36 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'] 17:34:36 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 17:34:39 INFO - Return code: 0 17:34:39 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 17:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:34:39 INFO - https://queue.taskcluster.net/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 17:34:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:34:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 17:34:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/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 17:34:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/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 17:34:42 INFO - Downloaded 17959134 bytes. 17:34:42 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'] 17:34:42 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 17:34:45 INFO - Return code: 0 17:34:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:34:45 INFO - https://queue.taskcluster.net/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 17:34:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:34:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 17:34:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/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 17:34:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/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 17:34:47 INFO - Downloaded 10847584 bytes. 17:34:47 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'] 17:34:47 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 17:34:47 INFO - Return code: 0 17:34: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')]} 17:34:47 INFO - https://queue.taskcluster.net/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 17:34:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:34:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:34:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 17:34:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Mnn2OakLT2mzbVZaOEGIYw/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 17:34:57 INFO - Downloaded 111428108 bytes. 17:34:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:34:57 INFO - mkdir: /builds/slave/test/properties 17:34:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:34:57 INFO - Writing to file /builds/slave/test/properties/build_url 17:34:57 INFO - Contents: 17:34:57 INFO - build_url:https://queue.taskcluster.net/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 17:34:59 INFO - Running post-action listener: _resource_record_post_action 17:34:59 INFO - Running post-action listener: set_extra_try_arguments 17:34:59 INFO - ##### 17:34:59 INFO - ##### Running populate-webroot step. 17:34:59 INFO - ##### 17:34:59 INFO - Running pre-action listener: _resource_record_pre_action 17:34:59 INFO - Running main action method: populate_webroot 17:34:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:34:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:34:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:34:59 INFO - '--tppagecycles', 17:34:59 INFO - '7'], 17:34:59 INFO - 'tests': ['tsvgm']}}, 17:34:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:34:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:34:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:34:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 17:34:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:34:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:34:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:59 INFO - 'talos_options': ['--e10s'], 17:34:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:34:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:59 INFO - 'tests': ['damp', 'tps']}, 17:34:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:59 INFO - 'talos_options': ['--e10s'], 17:34:59 INFO - 'tests': ['damp', 'tps']}, 17:34:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:34:59 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 17:34:59 INFO - 'tests': ['dromaeo_dom']}, 17:34:59 INFO - 'other': {'tests': ['a11yr', 17:34:59 INFO - 'ts_paint', 17:34:59 INFO - 'tpaint', 17:34:59 INFO - 'sessionrestore', 17:34:59 INFO - 'sessionrestore_no_auto_restore', 17:34:59 INFO - 'tabpaint']}, 17:34:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:34:59 INFO - 'tests': ['a11yr', 17:34:59 INFO - 'ts_paint', 17:34:59 INFO - 'tpaint', 17:34:59 INFO - 'sessionrestore', 17:34:59 INFO - 'sessionrestore_no_auto_restore', 17:34:59 INFO - 'tabpaint']}, 17:34:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:34:59 INFO - 'tests': ['a11yr', 17:34:59 INFO - 'ts_paint', 17:34:59 INFO - 'tpaint', 17:34:59 INFO - 'sessionrestore', 17:34:59 INFO - 'sessionrestore_no_auto_restore', 17:34:59 INFO - 'tabpaint']}, 17:34:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:34:59 INFO - 'tests': ['a11yr', 17:34:59 INFO - 'ts_paint', 17:34:59 INFO - 'tpaint', 17:34:59 INFO - 'sessionrestore', 17:34:59 INFO - 'sessionrestore_no_auto_restore', 17:34:59 INFO - 'tabpaint']}, 17:34:59 INFO - 'other_l64': {'tests': ['a11yr', 17:34:59 INFO - 'ts_paint', 17:34:59 INFO - 'tpaint', 17:34:59 INFO - 'sessionrestore', 17:34:59 INFO - 'sessionrestore_no_auto_restore', 17:34:59 INFO - 'tabpaint']}, 17:34:59 INFO - 'other_nol64': {'tests': ['a11yr', 17:34:59 INFO - 'ts_paint', 17:34:59 INFO - 'tpaint', 17:34:59 INFO - 'sessionrestore', 17:34:59 INFO - 'sessionrestore_no_auto_restore', 17:34:59 INFO - 'tabpaint']}, 17:34:59 INFO - 'svgr': {'tests': ['tsvgx', 17:34:59 INFO - 'tsvgr_opacity', 17:34:59 INFO - 'tart', 17:34:59 INFO - 'tscrollx', 17:34:59 INFO - 'cart']}, 17:34:59 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:34:59 INFO - 'tests': ['tsvgx', 17:34:59 INFO - 'tsvgr_opacity', 17:34:59 INFO - 'tart', 17:34:59 INFO - 'tscrollx', 17:34:59 INFO - 'cart']}, 17:34:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:59 INFO - 'tests': ['tp5o']}, 17:34:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:59 INFO - 'talos_options': ['--e10s'], 17:34:59 INFO - 'tests': ['tp5o']}, 17:34:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:59 INFO - 'talos_options': ['--xperf_path', 17:34:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:59 INFO - 'tests': ['tp5n']}, 17:34:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:34:59 INFO - 'talos_options': ['--e10s', 17:34:59 INFO - '--xperf_path', 17:34:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:34:59 INFO - 'tests': ['tp5n']}}, 17:34:59 INFO - 'talos.zip': {'path': '', 17:34:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:34:59 INFO - Running post-action listener: _resource_record_post_action 17:34:59 INFO - ##### 17:34:59 INFO - ##### Running create-virtualenv step. 17:34:59 INFO - ##### 17:34:59 INFO - Running pre-action listener: _resource_record_pre_action 17:34:59 INFO - Running main action method: create_virtualenv 17:34:59 INFO - Creating virtualenv /builds/slave/test/build/venv 17:34:59 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 17:34:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:34:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:34:59 INFO - Using real prefix '/tools/python27' 17:34:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:34:59 INFO - Installing distribute.............................................................................................................................................................................................done. 17:35:02 INFO - Installing pip.................done. 17:35:02 INFO - Return code: 0 17:35:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:35:02 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')]} 17:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:02 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')]} 17:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:02 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 0x102615a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102625420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc428da4b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b4e00>, '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 0x1022dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024afb20>, '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.GzmEuSvN1j/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.m5shcTkPMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:35:02 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 17:35:02 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 17:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GzmEuSvN1j/Render', 17:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:02 INFO - 'HOME': '/Users/cltbld', 17:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:02 INFO - 'LOGNAME': 'cltbld', 17:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:02 INFO - 'MOZ_NO_REMOTE': '1', 17:35:02 INFO - 'NO_EM_RESTART': '1', 17:35:02 INFO - 'PAGER': '/bin/cat', 17:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:02 INFO - 'PWD': '/builds/slave/test', 17:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:02 INFO - 'SHELL': '/bin/bash', 17:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5shcTkPMj/Listeners', 17:35:02 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:02 INFO - 'USER': 'cltbld', 17:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:02 INFO - 'XPC_FLAGS': '0x0', 17:35:02 INFO - 'XPC_SERVICE_NAME': '0', 17:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:02 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 17:35:02 INFO - Cleaning up... 17:35:02 INFO - Return code: 0 17:35:02 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:35:02 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')]} 17:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:02 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')]} 17:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:02 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 0x102615a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102625420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc428da4b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b4e00>, '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 0x1022dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024afb20>, '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.GzmEuSvN1j/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.m5shcTkPMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:35:02 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 17:35:02 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 17:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GzmEuSvN1j/Render', 17:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:02 INFO - 'HOME': '/Users/cltbld', 17:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:02 INFO - 'LOGNAME': 'cltbld', 17:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:02 INFO - 'MOZ_NO_REMOTE': '1', 17:35:02 INFO - 'NO_EM_RESTART': '1', 17:35:02 INFO - 'PAGER': '/bin/cat', 17:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:02 INFO - 'PWD': '/builds/slave/test', 17:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:02 INFO - 'SHELL': '/bin/bash', 17:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5shcTkPMj/Listeners', 17:35:02 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:02 INFO - 'USER': 'cltbld', 17:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:02 INFO - 'XPC_FLAGS': '0x0', 17:35:02 INFO - 'XPC_SERVICE_NAME': '0', 17:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:03 INFO - Downloading/unpacking psutil>=0.7.1 17:35:03 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 17:35:03 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 17:35:03 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 17:35:03 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 17:35:03 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 17:35:03 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 17:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:35:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:35:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:35:06 INFO - Installing collected packages: psutil 17:35:06 INFO - Running setup.py install for psutil 17:35:06 INFO - building 'psutil._psutil_osx' extension 17:35:06 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 17:35:07 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 17:35:07 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 17:35:07 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 17:35:07 INFO - building 'psutil._psutil_posix' extension 17:35:07 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 17:35:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:35:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:35:07 INFO - ^ 17:35:07 INFO - 1 warning generated. 17:35:07 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 17:35:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:35:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:35:07 INFO - Successfully installed psutil 17:35:07 INFO - Cleaning up... 17:35:07 INFO - Return code: 0 17:35:07 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:07 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 0x102615a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102625420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc428da4b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b4e00>, '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 0x1022dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024afb20>, '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.GzmEuSvN1j/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.m5shcTkPMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:35:07 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 17:35:07 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 17:35:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GzmEuSvN1j/Render', 17:35:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:07 INFO - 'HOME': '/Users/cltbld', 17:35:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:07 INFO - 'LOGNAME': 'cltbld', 17:35:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:07 INFO - 'MOZ_NO_REMOTE': '1', 17:35:07 INFO - 'NO_EM_RESTART': '1', 17:35:07 INFO - 'PAGER': '/bin/cat', 17:35:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:07 INFO - 'PWD': '/builds/slave/test', 17:35:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:07 INFO - 'SHELL': '/bin/bash', 17:35:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5shcTkPMj/Listeners', 17:35:07 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:35:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:07 INFO - 'USER': 'cltbld', 17:35:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:07 INFO - 'XPC_FLAGS': '0x0', 17:35:07 INFO - 'XPC_SERVICE_NAME': '0', 17:35:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:07 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:35:07 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 17:35:07 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 17:35:07 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 17:35:07 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 17:35:07 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 17:35:07 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 17:35:10 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:35:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:35:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:35:10 INFO - Installing collected packages: mozsystemmonitor 17:35:10 INFO - Running setup.py install for mozsystemmonitor 17:35:10 INFO - Successfully installed mozsystemmonitor 17:35:10 INFO - Cleaning up... 17:35:10 INFO - Return code: 0 17:35:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:10 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 0x102615a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102625420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc428da4b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b4e00>, '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 0x1022dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024afb20>, '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.GzmEuSvN1j/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.m5shcTkPMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:35:10 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 17:35:10 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 17:35:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GzmEuSvN1j/Render', 17:35:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:10 INFO - 'HOME': '/Users/cltbld', 17:35:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:10 INFO - 'LOGNAME': 'cltbld', 17:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:10 INFO - 'MOZ_NO_REMOTE': '1', 17:35:10 INFO - 'NO_EM_RESTART': '1', 17:35:10 INFO - 'PAGER': '/bin/cat', 17:35:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:10 INFO - 'PWD': '/builds/slave/test', 17:35:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:10 INFO - 'SHELL': '/bin/bash', 17:35:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5shcTkPMj/Listeners', 17:35:10 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:35:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:10 INFO - 'USER': 'cltbld', 17:35:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:10 INFO - 'XPC_FLAGS': '0x0', 17:35:10 INFO - 'XPC_SERVICE_NAME': '0', 17:35:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:10 INFO - Downloading/unpacking blobuploader==1.2.4 17:35:10 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 17:35:10 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 17:35:10 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 17:35:10 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 17:35:10 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 17:35:10 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 17:35:13 INFO - Downloading blobuploader-1.2.4.tar.gz 17:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:35:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:35:13 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 17:35:13 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 17:35:13 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 17:35:13 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 17:35:13 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 17:35:13 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 17:35:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:35:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:35:13 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 17:35:13 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 17:35:13 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 17:35:13 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 17:35:13 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 17:35:13 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 17:35:14 INFO - Downloading docopt-0.6.1.tar.gz 17:35:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:35:14 INFO - Installing collected packages: blobuploader, requests, docopt 17:35:14 INFO - Running setup.py install for blobuploader 17:35:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:35:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:35:14 INFO - Running setup.py install for requests 17:35:15 INFO - Running setup.py install for docopt 17:35:15 INFO - Successfully installed blobuploader requests docopt 17:35:15 INFO - Cleaning up... 17:35:15 INFO - Return code: 0 17:35:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:15 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 0x102615a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102625420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc428da4b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b4e00>, '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 0x1022dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024afb20>, '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.GzmEuSvN1j/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.m5shcTkPMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:35:15 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 17:35:15 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 17:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GzmEuSvN1j/Render', 17:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:15 INFO - 'HOME': '/Users/cltbld', 17:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:15 INFO - 'LOGNAME': 'cltbld', 17:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:15 INFO - 'MOZ_NO_REMOTE': '1', 17:35:15 INFO - 'NO_EM_RESTART': '1', 17:35:15 INFO - 'PAGER': '/bin/cat', 17:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:15 INFO - 'PWD': '/builds/slave/test', 17:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:15 INFO - 'SHELL': '/bin/bash', 17:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5shcTkPMj/Listeners', 17:35:15 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:15 INFO - 'USER': 'cltbld', 17:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:15 INFO - 'XPC_FLAGS': '0x0', 17:35:15 INFO - 'XPC_SERVICE_NAME': '0', 17:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:15 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-8JTu47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:15 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-EGrn2P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:15 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-pQbsmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:15 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-BbnOu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:15 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-PLUsk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:16 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-UpkhV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:16 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-FMZ1S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:16 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-QdO6lI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:16 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-016snI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:16 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-LykdWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:16 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-o_D7Al-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:16 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-YWiSBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:16 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-ylVfC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:16 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-BMakz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:17 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-f0HvBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:17 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-2H2DMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:17 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-YMJiQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:35:17 INFO - Running setup.py install for manifestparser 17:35:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:35:17 INFO - Running setup.py install for mozcrash 17:35:17 INFO - Running setup.py install for mozdebug 17:35:17 INFO - Running setup.py install for mozdevice 17:35:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:35:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:35:17 INFO - Running setup.py install for mozfile 17:35:18 INFO - Running setup.py install for mozhttpd 17:35:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:35:18 INFO - Running setup.py install for mozinfo 17:35:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:35:18 INFO - Running setup.py install for mozInstall 17:35:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:35:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:35:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:35:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:35:18 INFO - Running setup.py install for mozleak 17:35:18 INFO - Running setup.py install for mozlog 17:35:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:35:18 INFO - Running setup.py install for moznetwork 17:35:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:35:18 INFO - Running setup.py install for mozprocess 17:35:19 INFO - Running setup.py install for mozprofile 17:35:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:35:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:35:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:35:19 INFO - Running setup.py install for mozrunner 17:35:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:35:19 INFO - Running setup.py install for mozscreenshot 17:35:19 INFO - Running setup.py install for moztest 17:35:19 INFO - Running setup.py install for mozversion 17:35:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:35:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:35:19 INFO - Cleaning up... 17:35:19 INFO - Return code: 0 17:35:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:19 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 0x102615a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102625420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc428da4b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b4e00>, '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 0x1022dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024afb20>, '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.GzmEuSvN1j/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.m5shcTkPMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:35:19 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 17:35:19 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 17:35:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GzmEuSvN1j/Render', 17:35:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:19 INFO - 'HOME': '/Users/cltbld', 17:35:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:19 INFO - 'LOGNAME': 'cltbld', 17:35:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:19 INFO - 'MOZ_NO_REMOTE': '1', 17:35:19 INFO - 'NO_EM_RESTART': '1', 17:35:19 INFO - 'PAGER': '/bin/cat', 17:35:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:19 INFO - 'PWD': '/builds/slave/test', 17:35:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:19 INFO - 'SHELL': '/bin/bash', 17:35:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5shcTkPMj/Listeners', 17:35:19 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:35:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:19 INFO - 'USER': 'cltbld', 17:35:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:19 INFO - 'XPC_FLAGS': '0x0', 17:35:19 INFO - 'XPC_SERVICE_NAME': '0', 17:35:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:35:20 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-OT_Tp2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:35:20 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)) 17:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:35:20 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Nkl4__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:35:20 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)) 17:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:35:20 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-Nqmz37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:35:20 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)) 17:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:35:20 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-nyxooX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:35:20 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)) 17:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:35:20 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-GFNIXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:35:20 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)) 17:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:35:20 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-bd6xHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:35:20 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)) 17:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:35:20 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-X1QHIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:35:20 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)) 17:35:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:35:20 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-jwd195-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:35:21 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)) 17:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:35:21 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-dRL3_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:35:21 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)) 17:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:35:21 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-9o_Tqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:35:21 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)) 17:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:35:21 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-VeJKTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:35:21 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)) 17:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:35:21 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-JQaG2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:35:21 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)) 17:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:35:21 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-keU2Ht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:35:21 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)) 17:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:35:21 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-MZxmA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:35:21 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)) 17:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:21 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-NPzL9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:35:21 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)) 17:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:35:21 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-JJSsfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:35:21 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)) 17:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:35:21 INFO - Running setup.py (path:/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/pip-P2gDLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:35:22 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)) 17:35:22 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)) 17:35:22 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)) 17:35:22 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)) 17:35:22 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)) 17:35:22 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)) 17:35:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:35:22 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 17:35:22 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 17:35:22 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 17:35:22 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 17:35:22 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 17:35:22 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 17:35:24 INFO - Downloading blessings-1.6.tar.gz 17:35:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:35:24 INFO - Installing collected packages: blessings 17:35:24 INFO - Running setup.py install for blessings 17:35:24 INFO - Successfully installed blessings 17:35:24 INFO - Cleaning up... 17:35:24 INFO - Return code: 0 17:35:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:35:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:25 INFO - Reading from file tmpfile_stdout 17:35:25 INFO - Current package versions: 17:35:25 INFO - blessings == 1.6 17:35:25 INFO - blobuploader == 1.2.4 17:35:25 INFO - docopt == 0.6.1 17:35:25 INFO - manifestparser == 1.1 17:35:25 INFO - mozInstall == 1.12 17:35:25 INFO - mozcrash == 0.17 17:35:25 INFO - mozdebug == 0.1 17:35:25 INFO - mozdevice == 0.48 17:35:25 INFO - mozfile == 1.2 17:35:25 INFO - mozhttpd == 0.7 17:35:25 INFO - mozinfo == 0.9 17:35:25 INFO - mozleak == 0.1 17:35:25 INFO - mozlog == 3.1 17:35:25 INFO - moznetwork == 0.27 17:35:25 INFO - mozprocess == 0.22 17:35:25 INFO - mozprofile == 0.28 17:35:25 INFO - mozrunner == 6.11 17:35:25 INFO - mozscreenshot == 0.1 17:35:25 INFO - mozsystemmonitor == 0.0 17:35:25 INFO - moztest == 0.7 17:35:25 INFO - mozversion == 1.4 17:35:25 INFO - psutil == 3.1.1 17:35:25 INFO - requests == 1.2.3 17:35:25 INFO - wsgiref == 0.1.2 17:35:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:25 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 0x102615a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102625420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc428da4b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b4e00>, '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 0x1022dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024afb20>, '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.GzmEuSvN1j/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.m5shcTkPMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:35:25 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 17:35:25 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 17:35:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GzmEuSvN1j/Render', 17:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:25 INFO - 'HOME': '/Users/cltbld', 17:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:25 INFO - 'LOGNAME': 'cltbld', 17:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:25 INFO - 'MOZ_NO_REMOTE': '1', 17:35:25 INFO - 'NO_EM_RESTART': '1', 17:35:25 INFO - 'PAGER': '/bin/cat', 17:35:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:25 INFO - 'PWD': '/builds/slave/test', 17:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:25 INFO - 'SHELL': '/bin/bash', 17:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5shcTkPMj/Listeners', 17:35:25 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:25 INFO - 'USER': 'cltbld', 17:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:25 INFO - 'XPC_FLAGS': '0x0', 17:35:25 INFO - 'XPC_SERVICE_NAME': '0', 17:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:25 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)) 17:35:25 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)) 17:35:25 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)) 17:35:25 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)) 17:35:25 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)) 17:35:25 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)) 17:35:25 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)) 17:35:25 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)) 17:35:25 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)) 17:35:25 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)) 17:35:25 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)) 17:35:25 INFO - Cleaning up... 17:35:25 INFO - Return code: 0 17:35:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:25 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 0x102615a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102625420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc428da4b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b4e00>, '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 0x1022dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024afb20>, '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.GzmEuSvN1j/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.m5shcTkPMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:35:25 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 17:35:25 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 17:35:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GzmEuSvN1j/Render', 17:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:25 INFO - 'HOME': '/Users/cltbld', 17:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:25 INFO - 'LOGNAME': 'cltbld', 17:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:25 INFO - 'MOZ_NO_REMOTE': '1', 17:35:25 INFO - 'NO_EM_RESTART': '1', 17:35:25 INFO - 'PAGER': '/bin/cat', 17:35:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:25 INFO - 'PWD': '/builds/slave/test', 17:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:25 INFO - 'SHELL': '/bin/bash', 17:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5shcTkPMj/Listeners', 17:35:25 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:25 INFO - 'USER': 'cltbld', 17:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:25 INFO - 'XPC_FLAGS': '0x0', 17:35:25 INFO - 'XPC_SERVICE_NAME': '0', 17:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:25 INFO - Downloading/unpacking jsonschema 17:35:25 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 17:35:25 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 17:35:25 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 17:35:25 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 17:35:25 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 17:35:25 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 17:35:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:35:28 INFO - Downloading/unpacking functools32 (from jsonschema) 17:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:28 INFO - Downloading functools32-3.2.3-2.tar.gz 17:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:35:28 INFO - warning: no files found matching '*.txt' 17:35:28 INFO - no previously-included directories found matching 'build' 17:35:28 INFO - no previously-included directories found matching 'dist' 17:35:28 INFO - no previously-included directories found matching '.git*' 17:35:28 INFO - Installing collected packages: jsonschema, functools32 17:35:28 INFO - Running setup.py install for functools32 17:35:28 INFO - warning: no files found matching '*.txt' 17:35:28 INFO - no previously-included directories found matching 'build' 17:35:28 INFO - no previously-included directories found matching 'dist' 17:35:28 INFO - no previously-included directories found matching '.git*' 17:35:28 INFO - Successfully installed jsonschema functools32 17:35:28 INFO - Cleaning up... 17:35:28 INFO - Return code: 0 17:35:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:35: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')]} 17:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35: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')]} 17:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:35:28 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 0x102615a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102625420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc428da4b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024b4e00>, '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 0x1022dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024afb20>, '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.GzmEuSvN1j/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.m5shcTkPMj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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 17:35:28 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 17:35:28 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 17:35:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GzmEuSvN1j/Render', 17:35:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:35:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:35:28 INFO - 'HOME': '/Users/cltbld', 17:35:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:35:28 INFO - 'LOGNAME': 'cltbld', 17:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:35:28 INFO - 'MOZ_NO_REMOTE': '1', 17:35:28 INFO - 'NO_EM_RESTART': '1', 17:35:28 INFO - 'PAGER': '/bin/cat', 17:35:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:35:28 INFO - 'PWD': '/builds/slave/test', 17:35:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:35:28 INFO - 'SHELL': '/bin/bash', 17:35:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5shcTkPMj/Listeners', 17:35:28 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:35:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:35:28 INFO - 'USER': 'cltbld', 17:35:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:35:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:35:28 INFO - 'XPC_FLAGS': '0x0', 17:35:28 INFO - 'XPC_SERVICE_NAME': '0', 17:35:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:35:29 INFO - Downloading/unpacking flake8 17:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:31 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:35:31 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:31 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:35:31 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:35:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:35:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:35:32 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 17:35:32 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 17:35:32 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 17:35:32 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 17:35:32 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 17:35:32 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 17:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:35:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:35:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:35:32 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:35:32 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:35:32 INFO - no previously-included directories found matching 'docs/_build' 17:35:32 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:35:32 INFO - Running setup.py install for pep8 17:35:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:35:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:35:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:35:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:35:33 INFO - no previously-included directories found matching 'docs/_build' 17:35:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:35:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:35:33 INFO - Cleaning up... 17:35:33 INFO - Return code: 0 17:35:33 INFO - Running post-action listener: _resource_record_post_action 17:35:33 INFO - Running post-action listener: _start_resource_monitoring 17:35:33 INFO - Starting resource monitoring. 17:35:33 INFO - ##### 17:35:33 INFO - ##### Running install step. 17:35:33 INFO - ##### 17:35:33 INFO - Running pre-action listener: _resource_record_pre_action 17:35:33 INFO - Running main action method: install 17:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:35:33 INFO - Reading from file tmpfile_stdout 17:35:33 INFO - Detecting whether we're running mozinstall >=1.0... 17:35:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:35:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:35:33 INFO - Reading from file tmpfile_stdout 17:35:33 INFO - Output received: 17:35:33 INFO - Usage: mozinstall [options] installer 17:35:33 INFO - Options: 17:35:33 INFO - -h, --help show this help message and exit 17:35:33 INFO - -d DEST, --destination=DEST 17:35:33 INFO - Directory to install application into. [default: 17:35:33 INFO - "/builds/slave/test"] 17:35:33 INFO - --app=APP Application being installed. [default: firefox] 17:35:33 INFO - mkdir: /builds/slave/test/build/application 17:35:33 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'] 17:35:33 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 17:36:07 INFO - Reading from file tmpfile_stdout 17:36:07 INFO - Output received: 17:36:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:36:07 INFO - Running post-action listener: _resource_record_post_action 17:36:07 INFO - ##### 17:36:07 INFO - ##### Running run-tests step. 17:36:07 INFO - ##### 17:36:07 INFO - Running pre-action listener: _resource_record_pre_action 17:36:07 INFO - Running main action method: run_tests 17:36:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:36:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:36:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:36:07 INFO - 2016-04-01 17:36:07.982 screenresolution[2070:11958] starting screenresolution argv=screenresolution get 17:36:07 INFO - 2016-04-01 17:36:07.984 screenresolution[2070:11958] Display 0: 1600x1200x32@60 17:36:07 INFO - 2016-04-01 17:36:07.990 screenresolution[2071:11961] starting screenresolution argv=screenresolution list 17:36:07 INFO - Available Modes on Display 0 17:36:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:36:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:36:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:36:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:36:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:36:08 INFO - Intel Iris: 17:36:08 INFO - Chipset Model: Intel Iris 17:36:08 INFO - Type: GPU 17:36:08 INFO - Bus: Built-In 17:36:08 INFO - VRAM (Dynamic, Max): 1536 MB 17:36:08 INFO - Vendor: Intel (0x8086) 17:36:08 INFO - Device ID: 0x0a2e 17:36:08 INFO - Revision ID: 0x0009 17:36:08 INFO - Displays: 17:36:08 INFO - Display: 17:36:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:36:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:36:08 INFO - Display Serial Number: 1600x1200 60 17:36:08 INFO - Main Display: Yes 17:36:08 INFO - Mirror: Off 17:36:08 INFO - Online: Yes 17:36:08 INFO - Rotation: Supported 17:36:08 INFO - Return code: 0 17:36:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:36:08 INFO - Python 2.7.3 17:36:08 INFO - Return code: 0 17:36:08 INFO - grabbing minidump binary from tooltool 17:36:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:36:08 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 0x1024b4e00>, '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 0x1022dddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024afb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:36:08 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 17:36:08 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 17:36:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:36:08 INFO - Return code: 0 17:36:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:36:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:36:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:36:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:36:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:36:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:36:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:36:09 INFO - Return code: 0 17:36:09 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/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--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 17:36:09 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/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0151 --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 17:36:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GzmEuSvN1j/Render', 17:36:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:36:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:36:09 INFO - 'HOME': '/Users/cltbld', 17:36:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:36:09 INFO - 'LOGNAME': 'cltbld', 17:36:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:36:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:36:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:36:09 INFO - 'MOZ_NO_REMOTE': '1', 17:36:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:36:09 INFO - 'NO_EM_RESTART': '1', 17:36:09 INFO - 'PAGER': '/bin/cat', 17:36:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:36:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:36:09 INFO - 'PWD': '/builds/slave/test', 17:36:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:36:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:36:09 INFO - 'SHELL': '/bin/bash', 17:36:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.m5shcTkPMj/Listeners', 17:36:09 INFO - 'TMPDIR': '/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/', 17:36:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:36:09 INFO - 'USER': 'cltbld', 17:36:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:36:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:36:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:36:09 INFO - 'XPC_FLAGS': '0x0', 17:36:09 INFO - 'XPC_SERVICE_NAME': '0', 17:36:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:36:09 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/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0151', '--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 17:36:09 INFO - mozversion application_buildid: 20160401153231 17:36:09 INFO - mozversion application_changeset: b6ea6a3bb8a6fc355b46403919d8c70e798c7007 17:36:09 INFO - mozversion application_display_name: Nightly 17:36:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:36:09 INFO - mozversion application_name: Firefox 17:36:09 INFO - mozversion application_remotingname: firefox 17:36:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:36:09 INFO - mozversion application_vendor: Mozilla 17:36:09 INFO - mozversion application_version: 48.0a1 17:36:09 INFO - mozversion platform_buildid: 20160401153231 17:36:09 INFO - mozversion platform_changeset: b6ea6a3bb8a6fc355b46403919d8c70e798c7007 17:36:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:36:09 INFO - mozversion platform_version: 48.0a1 17:36:09 INFO - using testdate: 1459557369 17:36:09 INFO - actual date: 1459557369 17:36:09 INFO - starting webserver on 'localhost:49354' 17:36:09 INFO - SUITE-START | Running 2 tests 17:36:09 INFO - TEST-START | dromaeo_css 17:36:09 INFO - operating with platform_type : mac_ 17:36:09 INFO - Initialising browser for dromaeo_css test... 17:36:09 INFO - TEST-INFO | started process 2089 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpy7u6OU/profile http://localhost:49354/getInfo.html) 17:36:12 INFO - PROCESS | 2089 | __metrics Screen width/height:1600/1200 17:36:12 INFO - PROCESS | 2089 | colorDepth:24 17:36:12 INFO - PROCESS | 2089 | Browser inner width/height: 1024/689 17:36:12 INFO - PROCESS | 2089 | __metrics 17:36:12 INFO - PROCESS | 2089 | 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" 17:36:12 ERROR - PROCESS | 2089 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:36:12 INFO - TEST-INFO | 2089: exit 0 17:36:12 INFO - Browser initialized. 17:36:12 INFO - Running cycle 1/1 for dromaeo_css test... 17:36:12 INFO - TEST-INFO | started process 2092 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpy7u6OU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:36:24 INFO - PROCESS | 2092 | RSS: Main: 236924928 17:36:24 INFO - PROCESS | 2092 | 17:37:15 INFO - PROCESS | 2092 | 1459557435880 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] 17:39:26 INFO - PROCESS | 2092 | Cycle 1(1): loaded http://localhost:49354/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49354/tests/dromaeo/cssquery-ext.html) 17:39:27 INFO - PROCESS | 2092 | RSS: Main: 331198464 17:39:27 INFO - PROCESS | 2092 | 17:42:30 INFO - PROCESS | 2092 | Cycle 1(1): loaded http://localhost:49354/tests/dromaeo/cssquery-ext.html (next: http://localhost:49354/tests/dromaeo/cssquery-jquery.html) 17:42:30 INFO - PROCESS | 2092 | RSS: Main: 369360896 17:42:30 INFO - PROCESS | 2092 | 17:45:32 INFO - PROCESS | 2092 | Cycle 1(1): loaded http://localhost:49354/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49354/tests/dromaeo/cssquery-mootools.html) 17:45:33 INFO - PROCESS | 2092 | RSS: Main: 368984064 17:45:33 INFO - PROCESS | 2092 | 17:48:35 INFO - PROCESS | 2092 | Cycle 1(1): loaded http://localhost:49354/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49354/tests/dromaeo/cssquery-prototype.html) 17:48:35 INFO - PROCESS | 2092 | RSS: Main: 325885952 17:48:35 INFO - PROCESS | 2092 | 17:51:39 INFO - PROCESS | 2092 | Cycle 1(1): loaded http://localhost:49354/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49354/tests/dromaeo/cssquery-yui.html) 17:51:39 INFO - PROCESS | 2092 | RSS: Main: 326094848 17:51:39 INFO - PROCESS | 2092 | 17:54:42 INFO - PROCESS | 2092 | Cycle 1(1): loaded http://localhost:49354/tests/dromaeo/cssquery-yui.html (next: http://localhost:49354/tests/dromaeo/cssquery-dojo.html) 17:54:42 INFO - PROCESS | 2092 | RSS: Main: 386330624 17:54:42 INFO - PROCESS | 2092 | 17:54:42 INFO - PROCESS | 2092 | __start_tp_report 17:54:42 INFO - PROCESS | 2092 | _x_x_mozilla_page_load 17:54:42 INFO - PROCESS | 2092 | _x_x_mozilla_page_load_details 17:54:42 INFO - PROCESS | 2092 | |i|pagename|runs| 17:54:42 INFO - PROCESS | 2092 | |0;dojo.html;3438.398280300947;3481.1819222482713;3498.755087143898;3525.576930768308;3550.3609350316933;5712.857178570538;5714.599978001531;5721.799737009205;5730.512906402955;5735.197072409861;5691.288588926384;5708.942910570893;5753.482186603205;5878.735456904439;5896.852578685535;5107.744612769366;5125.948740512603;5132.024915266106;5148.794048238066;5355.357357117132;5301.363836339645;5316.654417462872;5354.973225133869;5387.353517577876;5403.756830942617;5123.538881500683;5166;5278.049951008817;5282.286891269668;5290.338707661543;5211.166213405837;5237.711925844077;5245.554127899133;5258.1849813279005;5276.92084618731;5119.6160287978555;5177.767000484987;5211;5244.580433565306;5267.3942496613;5274.314339135926;5606.046972014768;5717.9714101429645;5720.998825205573;5730.312362516524;6262.937370626281;6265.122882796367;6271.090691849702;6272.8118156455375;6293.433590976788;6226.844328891769;6294.433500984934;6328.335524769925;6334.493240540745;6337.081123237151;5732.742026608813;5773.39379365169;5832.941670583282;5833.620814647034;5837.241158649434;6287.874242515124;6299.464545513591;6308.495320374359;6310.558260921692;6322.683865806691;6100.267967843887;6118.1434599156155;6119.143319935212;6131.080337949344;6139.2325959255095;6281.560290779693;6299.685015749286;6300.464460520815;6301.243850737941;6308.463780578611;6244.12582238487;6249.937500625027;6252.906206406908;6257.217847769029;6263.342349053375;6126.27339965311;6186.226721659793;6252;6281.874362512815;6290.811275661737;4904.6321525885705;4912.189488734391;4930.161872481615;4930.457649658535;4967.925481117786;4323.827046918151;4339.7830108494445;4376.409184760017;4385.978070109629;4426.889327766831;5597.496225339739;5657.971710141423;5658.85852853682;5664.97167514168;5715.857103572361;6187;6295.590786598948;6318;6319.115323854664;6326.398992095744;5657.066584013674;5669.574781891375;5697.601167918206;5707.1153971134545;5750.539956803445;5311.760970756325;5357.4106848246665;5387.353517577916;5396.946030539644;5399.541039011649;6347.333529979285;6367.076773867763;6392.680365981775;6406.135171751847;6423;6279.686015699105;6281.623102613858;6288.874222515433;6299.055141728777;6321.557490975588;6239.75040998355;6332.050192471166;6332.556721029668;6337.493000560036;6385.96807015962;6196.535259855619;6225.688715564294;6242.687865606611;6243.219597550306;6253.687315634291;6297.118403423616;6302.779402720883;6309.1167236587835;6311.211098612674;6311.526635502264;4981.452040275639;6057.121717351048;6100.702285530011;6160.722767475385;6163.96918015407;6091.878162436815;6153.72308246139;6167.6916154193;6175.660338681416;6183.350748171377;5993.520518358608;6004.369541198286;6014.458698716961;6046.758129674764;6062.727177277121;6065.120557519223;6070.48400885912;6164.876702466016;6195.473384762166;6197;6033.3255151280655;6045.486133678686;6050.515958723204;6055.333913269625;6113.694315284307 17:54:42 INFO - PROCESS | 2092 | |1;ext.html;479.84644913627653;563.3521450332117;594.7858770842496;634.768309567008;641;30033.399332013345;39654.60345396545;40158;40170.79914600427;40393.79803100984;43120.78439607798;43390.349144762775;43515.564844351546;43658.563414365926;43667;9568.043195680446;9798.510074496282;9803.509824508781;9817.361871478332;9828.164606008499;9502.192313653348;9657.661981830637;9664.710058698216;9674.322797404184;9676.903230967671;9823.705288841345;9873.407595544255;9883.50582470877;9889.554970026331;9906.702798916009;9755.365901216433;9837;9844;9854.359466634645;9857.162141217968;9582.952085239529;9678.806423871483;9695.418274903457;9843.310968232227;9865;41472.585274147175;41788.37317440241;42012;42177.78911105455;42194.99147580975;3165.5884734984534;3196.536502207167;3201.823899685516;3599.8380072896784;3719.1817800083936;29779.70220297791;29894.70105298941;30258.54612180819;30449.847750761324;30606.54090188649;2654.376221587925;2758.2828464599147;2786.5959435881887;2869.956950645742;2907.636545431821;469647;472725.272747275;473321;475028;475126;46604.06791864212;68576;68946.31053689499;68984.65507672429;69578.65210673914;46168.538314616424;46228.07543849104;46310.53689463062;46358.30462543065;46389.30416043762;15642.921785391;15845.366185352457;15877;15877.841221587867;15887;12594.496220151275;12606.747865042647;12634.052446066582;12641.367931603383;12645.93677031609;14665.340059697339;14680.926595366955;14966;14981.70036599262;15111.697766044617;6231.75072997075;6368.681565921685;6398.136251606066;6417.807465775941;6422;919.94940278284;973.5764942250003;1004.834202356603;1094.5676457799284;1192.928424294545;29411;29445.705542944725;29764.702352976627;29989.70010299869;30168.793248269823;1029.6447725534679;1061.543536279392;1138.3283862521153;1171.226990186473;1192.5885569478517;14939.626509337137;14963.326650300545;14972;15403;15513.689726205639;475154;477890;481069;483253;483911;59371.70314148402;59916.70041649851;60095.39904600986;60115.398846011856;60190.39809601936;1314.493919840868;1394.9372278247504;1436.3321055709146;1441.4162264282982;1468.6842328899338;28727.569086463303;28890.98881539136;29115.910022084692;29391.412171756874;29629.962951296602;48841.0231795355;49254;49304.75347623239;49330.506694934025;49433.50566494289;347162.5283747231;355332;356677;356711;357667;29197.270068248465;32955.83522082374;32994.835025824716;33825;33877.66122338844;41839.95400115022;42228;43491.56508435002;43506;43741.34387984119;36154.45768313425;36395.09012274714;36446.088847779014;36599.63400365962;37591.24817503689;31014.379712406077;36202.63797361992;36229.275414491036;36715.44926826046;37349;36140.63859361373;36190.8190459046;36724.44913326249;36895.44656830096;37339.62660373362;26801;27684.031058912842;31987.6801231994;32684;32702.672973269964;24073.27780166598;24336.634950476113;24769.876150619133;24830.751692482845;24861.005559777408 17:54:42 INFO - PROCESS | 2092 | |2;jquery.html;361.2233697550267;363.11037957005334;367.06581749447656;373.7495877761899;375.1465416178196;19670.803291967077;19975.700364494525;20415.795842041574;21145.57708845822;21150.365489035335;20728.79271207291;20926.162953481882;21197.152113915465;21298.36104916851;21325.827079510622;5531.25328080708;5839.474447299742;5876.76492940284;5879.470847623713;5892.263467066617;5586.664800111986;5790.536757059425;5852.268466441695;5860.648361098327;5860.794872179475;4684.43786745591;5774.162746401769;5795.884082318351;5808.215890854723;5819.883602327951;5536.086545719952;5732.942670573324;5733.39180004386;5739.139129130622;5757.769689212427;4982.82560110398;4995.775190116417;4996.875078123039;4998;5006.949930500685;24854.875725621438;25260.242192734248;25537.61693574598;25627.87186064058;25656.61515077275;1965.49879780655;2043.7022490718352;2131.26471367378;2442.546684722587;2582.5093232285803;12248.326342051183;14371.281435928162;14650.633734156625;14727.337269822883;14819.629509262248;1462.2104063805532;1583.9841601584067;1694.2291257477818;1859.386402487176;1883.990580047091;100703.49648251712;100750;104891;106969;107629.46185269102;11130.554777808797;11174;11219.60731374398;11230.494627741771;11316;13754.65613359674;13850.584482465541;13871.23708196059;13909.58271251864;13923.164610123426;8412.158784121539;8519.403641745019;8561.35789815754;8651.437656552303;8660.523671198018;8250.669973201126;8611.009733880559;8666.480011199348;8786.780330491789;8800.911990880137;4308.870733877989;4369.650427965755;4404.009097952935;4445.777711114496;4453.844115456009;1593.6573636668172;1787.4726955548144;1847.584293533971;1885.4437940807495;1893.2521653946615;905.6060613633091;981.3081777346953;988.3625061835077;1014.3052009373455;1030.160419258302;14937.925310373379;19735.802641973685;19842.305519306756;20009.399718008484;20056.49858753543;926.7720270641427;948.9478078705599;949.5726922884592;961.5576834656136;1053.9987012338308;10768.946155269174;10859.457027148612;10888.40113793749;10905.618303359344;10939.453027348602;467319;473840;474277;489017;574804;117530.41234793772;117688;121505.98916151746;124804;125383;978.6232300564192;996.9252306076928;1020.9132223761063;1021.7292417509366;1050.3382868792764;16063.91968040199;17545;17924.820751792315;18238.452846414628;18298.72551911749;50434.74782626063;50896.74551627218;51661.7416912913;51676.48323516867;52386.47613523816;67767.3223267761;70442;71228.57542849217;71410.28589714036;73033;7668.693252269847;7857.607119644109;7892.4080693947035;7932.484388514728;8152.103268640326;11283.492242848928;12573.622791316275;12658.98728101768;12675.93662031684;13008.739825203633;10754.677359679223;10911;10925.029111753975;11061.170412218955;11091.667249982513;10737.03366697001;10753.731156721145;10974.670759877217;11061.059809916247;11095.223334366518;9575.473348965874;10974.780504390028;11016;11080.168987325822;11173.553057877594;7652.426068044808;7700.922990770021;7816;7903.407244456804;7978.800529986796;8167.224113709188;10603.575856965635;10739.409332486788;11197;11210.495527701436 17:54:42 INFO - PROCESS | 2092 | |3;mootools.html;1429.928503574821;1572.504661031775;1593.1954363046664;1849.4636555398936;1985.305143199881;7921.128675845653;8673.479591224523;8820.426672266298;8827.205551500363;8838.33712471564;8441.78895527612;8712.1287871213;8717.433366831152;8723.825523489526;8732.214100730933;2125.6280150973594;2411.8191135664806;2462.101333013455;2466.703995520531;2492.3644470659956;2477.55404027275;2487.4154573675173;2489.55188066148;2492.464120214154;2492.703794027105;2385.3440303916477;2407.7953373963232;2427.890744916474;2430.368104292879;2439.1097249503982;2425.4300239443714;2437.6709144265565;2444.401121725171;2485.179890636086;2490.86300253486;2424.1636635360774;2424.2727181845553;2426.1751004658327;2429.186222615426;2470.3330100872845;8724.171203735636;8803.823923521493;8806.383553151281;8813.471191728517;8839.646414143426;5434.402215756264;5582.330120385539;5589.636673616202;5590.776368945238;5602.663840169562;3374.599541190403;3531.4173161428334;3547.255076433952;3668.394714872043;3737.364648009845;1002.293383164867;1007.6322142417964;1040.0379648824883;1046.3669479964587;1075.8601381820392;11979.94010029953;12002.759944801142;12024.158308918379;12034.97702695272;12045.879541204564;4098.938515922264;4833.806647734122;4914.557689807934;4978.2034874419915;4990.276409920614;10113.988601139974;10148.188144948386;10186.439745814052;10186.981301869902;10189.54147063384;5554.333479982428;5557.055300598908;5559.444055594489;5564.10974244119;5569.860753481114;4444.31113177458;4609.677322587387;4889.706617602955;4949.430815456197;5005.474425185376;3827.119762454651;3917;3927.8232479538487;3964.6431821136234;3992.121733218687;1105.4417519152776;1307.9863106092855;1309.7904335306305;1332.3072002558808;1332.6068809701162;1158.2702897174895;1166.3643314393676;1192.3620862838513;1274.5985014720334;1367.1660287224786;8055.395845311508;8171.346292296602;8220;8237.46456480339;8251.422400431911;510.62213961668095;518.1269560790006;518.3028826228716;523.4974424552396;523.9607029472804;6173.351798061229;6173.81478555644;6239.407256310643;6254;6265.8746825063245;10386.636467723745;10777.191710621579;10879.782404352027;10880.29278096937;10881.075108615856;10540.156787456985;10545.420001899969;10568.682939511827;10601.363918164934;10653.57385704563;8294.543800091053;8369.204925532065;8375.994880614366;8427.41008129425;8471.915280847114;7707.768766937001;7848.018997625297;7914.525128492309;7918.287354138155;7925.484843485155;9346.439213647203;9612.51937403113;9734.951325243612;9792.216622670026;9809.460479673686;8206.917930820615;9802.824779751232;9919.851202232117;10077.69766906994;10092.596296148073;6161.630302181883;6714;6722.529422940543;7491.737789177353;7579.052618422697;7972.043354797462;8301.875471867806;8335.249827515552;8343.45767525109;8344.41589088758;7253.963730181315;7345.963270183614;7361.227071157451;7492.026036615205;7512.361449276873;7177.641117943977;7235.0108799028785;7243.855122897618;7306.159791624032;7322.816929576803;7653.349465295512;7668.80827979305;7702.152763195932;7709.3447057000785;7738.2261773822165;6714.222423551564;6929.133858267716;7003.789886303419;7009.894851577128;7018.719251229893;7050.15398152225;7116.252793456612;7119.822004449723;7145.7498987537265;7148.177959534512 17:54:42 INFO - PROCESS | 2092 | |4;prototype.html;273.22404371584696;327.19836400818;332.25408956891783;335.31930181731093;336.8107302533532;6565.573237739543;6677.565958212719;6696.531242813011;6719.0929224554675;6747.291534388892;6558.6064836109745;6621.834454138649;6631.602103873759;6632.900506492394;6641.634710090955;4665.510121437251;4783.976080119594;4821.349117869096;4959.305697202394;4966.652334336598;4877.902441951159;4885.462599114095;4892.241702536113;4919.458859525449;4936.185529387664;4823.107725070873;4835.6131509479155;4839.467658557556;4845.53967373099;4871.244957031666;4646.6282697384295;4736.123817093849;4845.200541910581;4851.587615052725;4853.320535125085;3526.1713497328105;4041.969297829064;4130.235906357303;4151.377293405983;4159.729617574878;6223.7821676241565;6332.68336583169;6336.841578960563;6337.429631333156;6364.77723279683;4597.632189424838;5666.121751128581;5690.573207009449;5692.743826527775;5693.373728889819;6978.720851165947;6986.895196572055;6991.8601627967155;7002.474814388941;7006.369426751617;3912.941305880414;4565.4749703784155;4672.742999135046;4707.6233901287815;4720.43354797423;7148.213696493433;7273.963630181868;7330.780076597711;7348.559086454829;7366.558006519626;4795.256735206049;4802.447718512346;4813.975930120397;4818.349522814376;4819.180739274261;4070.470838790938;4878.804847806119;4885.60915126789;4907.803687852446;4917.311576379309;5717.514011309002;5732.656040637575;5756.222909907109;5756.625819321731;5782.421757824268;6769.39075483199;7006.824829379204;7027.789166325018;7033.859322813515;7058.752943646948;1306.9019823513274;1689.7127488327014;1706.1895599590096;1713.2119225156318;1717.6736420080144;1085.1806885801327;1092.579356947581;1109.6227282723912;1114.6934592986993;1115.252780636975;5335.199720042025;5376.435474275223;6274.623522588659;6551.246606640202;6556.311587283362;6761.154855643044;7328.157261914841;7333.083364579427;7342.302481264272;7344.70621175147;6604.702788374535;6605.141331626954;6620.271770105284;6621.238557565942;6622.2715501294815;3841.250956063541;3889.2804831106337;3889.8833035008997;3890.280298144852;3891.2995660780766;7330.67011984462;7611.543307401574;7642.770716878503;7662.118856331594;7675.462717609714;6837.179538455318;6904.722626314047;7486.925130748623;7488.555264578355;7544.585047822313;7618.847623047508;7619.580923049286;7624.504407213513;7630.7329243476215;7639.618019098912;7004.894926576004;7245.492815503075;7271.672774725044;7304.598247096248;7333.596652184181;5809.767609295581;7094.574325540484;7131.108611423572;7141.107361579802;7146.785596432115;6126.540509461897;7594.848103038019;7598.240175982358;7615.771526854203;7632;4813.590844778233;4824.807007719652;4830.4444988826735;4831.347768051268;4854.368932038812;7152.392046676091;7225.819354515969;7229.891551626835;7253.56478611285;7265.309795569412;6302.086197501429;6664.600123992576;6720.529562930744;7026.929730702627;7031.648417578998;6960.617166055916;7014.579125252501;7018.75434359795;7030.086088808626;7050.682719277543;6840.384365407137;6853.971904214408;6859.451243900576;6868.587884726732;6876.381125698711;6704.363085506869;7011.228764835966;7023.859522809413;7032.26161253061;7045.401140903081;6700.329967003261;6720.663966801738;6818.659067046528;6865.656717164022;6871.415929646036 17:54:42 INFO - PROCESS | 2092 | |5;yui.html;681.8636272745453;687.7455341523633;687.8211664967108;695.8921367188085;735.8381156145648;15053.62365940852;17616.91191544042;17774.555636109104;17811.554711132198;17865.196066177035;16236.675266494663;16296.592585185377;16374.918125409356;16390.754138687927;16409.589760256;731.7914394397598;892.0321451225428;912.0560220172123;913.0230653201078;913.4062859141545;732.9193788683241;896.3859756067114;914.7667344827094;916.193749500442;917.0554329041098;957.9568919398608;963.5326866469757;966.2656381150341;966.9661561845337;967.1923943507145;767.9193684663086;951.8952915179325;962.8940816510213;963.7831487915198;963.7831487915233;712.7826013066012;714.139461948351;715.5313269808283;716.4411758828122;717.2898830158158;15353.539393818204;15425.228738563026;15434.38262469511;15445.459408920746;15496.30266638004;12150.149489535735;12372.876271237263;12403.937980310131;12422.81365779514;12436.37818109091;9882.160016398615;10031.347962382422;10135.797284054352;10475.26673132881;10797.082248008928;3210.3097833965576;3343.164208947763;3477.965220347815;3578.9642103579154;3580.6240344763687;84397.57801211016;85091;86117.56941215317;86510;86727;9204.079592040742;9257.953710231406;9334.113259240361;9490.810183796286;9588.424694518351;17670.646587068186;21338;21487.57024859494;21492.677609835864;21523.354299371043;7404.111506619241;7415.740449084256;7462.925370746331;7629.0845098587415;7721.961390193013;4089.2230476209425;4112.218678451085;4150.667946564267;4204.222218889515;4420.756858372756;3585.551806024247;3648.945265821015;3650.105724097613;3650.361186792301;3656.561212654445;572.27892855003;638.237306418825;645.3707635055783;653.51313271612;658.6607896933083;499.6377626220961;562.8114581615205;563.8477611044995;585.9677717725566;636.0808631527399;7868.2131786822;8169;8266.710665126691;8446.873296900552;8452.366072544584;560.938296787353;572.9083346664513;585.7569108819793;599.811059516251;601.4106175947509;3587.4798154267487;3889.630485103911;3929.7052721046034;3934;3966.6231707987695;83883.58058209791;84254.05703991595;84533.12402197803;85599.14400856037;96691.51654241684;74729.62635186789;80723.7891431629;80740;81418.59290703508;81628;67843.98234026493;67992.98010529845;68563;71101;72541.54916901738;8416.87374689368;8417.70538031166;8430.15698430152;8433.451825631315;8586.356023298402;41448.171036579704;51249.23126153185;51378.486215138866;52106.478935210165;52202.477975219765;64275.678621606596;70356.6482167586;70611;71224.21939451554;71973.92039119522;10724.839127413252;10739.248252622241;10970.396628185526;11068.335899846035;11157.27477713946;11697.473613687234;11843.881561184622;12011.879881201075;12337.383130843602;12734.363281836057;11113.444327783416;11118.166137539554;11385.544578216779;11429.885701143216;11469.541218351505;11340.716482088013;11372.260803047775;11378.658640240807;11676.56191777419;11712.297262164297;9863.161631261422;9941;10787.756154654686;10837.854488364186;11176.664700059011;9003.954980225319;9095.636174553209;9212.953935230282;9265.073492650681;9688.903110969082;9109.726708198765;9322.207612353026;9337.439753614533;9389.765255868659;9450.763730906783 17:54:42 INFO - PROCESS | 2092 | __end_tp_report 17:54:42 INFO - PROCESS | 2092 | __start_cc_report 17:54:42 INFO - PROCESS | 2092 | _x_x_mozilla_cycle_collect,1241 17:54:42 INFO - PROCESS | 2092 | __end_cc_report 17:54:42 INFO - PROCESS | 2092 | __startTimestamp1459558482752__endTimestamp 17:54:42 INFO - PROCESS | 2092 | 17:54:42 INFO - PROCESS | 2092 | ------- Summary: start ------- 17:54:42 INFO - PROCESS | 2092 | Number of tests: 6 17:54:42 INFO - PROCESS | 2092 | 17:54:42 INFO - PROCESS | 2092 | [#0] dojo.html Cycles:165 Average:5773.90 Median:6050.52 stddev:643.77 (10.6%) stddev-sans-first:619.12 17:54:42 INFO - PROCESS | 2092 | Values: 3438.4 3481.2 3498.8 3525.6 3550.4 5712.9 5714.6 5721.8 5730.5 5735.2 5691.3 5708.9 5753.5 5878.7 5896.9 5107.7 5125.9 5132.0 5148.8 5355.4 5301.4 5316.7 5355.0 5387.4 5403.8 5123.5 5166.0 5278.0 5282.3 5290.3 5211.2 5237.7 5245.6 5258.2 5276.9 5119.6 5177.8 5211.0 5244.6 5267.4 5274.3 5606.0 5718.0 5721.0 5730.3 6262.9 6265.1 6271.1 6272.8 6293.4 6226.8 6294.4 6328.3 6334.5 6337.1 5732.7 5773.4 5832.9 5833.6 5837.2 6287.9 6299.5 6308.5 6310.6 6322.7 6100.3 6118.1 6119.1 6131.1 6139.2 6281.6 6299.7 6300.5 6301.2 6308.5 6244.1 6249.9 6252.9 6257.2 6263.3 6126.3 6186.2 6252.0 6281.9 6290.8 4904.6 4912.2 4930.2 4930.5 4967.9 4323.8 4339.8 4376.4 4386.0 4426.9 5597.5 5658.0 5658.9 5665.0 5715.9 6187.0 6295.6 6318.0 6319.1 6326.4 5657.1 5669.6 5697.6 5707.1 5750.5 5311.8 5357.4 5387.4 5396.9 5399.5 6347.3 6367.1 6392.7 6406.1 6423.0 6279.7 6281.6 6288.9 6299.1 6321.6 6239.8 6332.1 6332.6 6337.5 6386.0 6196.5 6225.7 6242.7 6243.2 6253.7 6297.1 6302.8 6309.1 6311.2 6311.5 4981.5 6057.1 6100.7 6160.7 6164.0 6091.9 6153.7 6167.7 6175.7 6183.4 5993.5 6004.4 6014.5 6046.8 6062.7 6065.1 6070.5 6164.9 6195.5 6197.0 6033.3 6045.5 6050.5 6055.3 6113.7 17:54:42 INFO - PROCESS | 2092 | 17:54:42 INFO - PROCESS | 2092 | [#1] ext.html Cycles:180 Average:58444.78 Median:20529.40 stddev:116678.88 (568.4%) stddev-sans-first:116925.03 17:54:42 INFO - PROCESS | 2092 | Values: 479.8 563.4 594.8 634.8 641.0 30033.4 39654.6 40158.0 40170.8 40393.8 43120.8 43390.3 43515.6 43658.6 43667.0 9568.0 9798.5 9803.5 9817.4 9828.2 9502.2 9657.7 9664.7 9674.3 9676.9 9823.7 9873.4 9883.5 9889.6 9906.7 9755.4 9837.0 9844.0 9854.4 9857.2 9583.0 9678.8 9695.4 9843.3 9865.0 41472.6 41788.4 42012.0 42177.8 42195.0 3165.6 3196.5 3201.8 3599.8 3719.2 29779.7 29894.7 30258.5 30449.8 30606.5 2654.4 2758.3 2786.6 2870.0 2907.6 469647.0 472725.3 473321.0 475028.0 475126.0 46604.1 68576.0 68946.3 68984.7 69578.7 46168.5 46228.1 46310.5 46358.3 46389.3 15642.9 15845.4 15877.0 15877.8 15887.0 12594.5 12606.7 12634.1 12641.4 12645.9 14665.3 14680.9 14966.0 14981.7 15111.7 6231.8 6368.7 6398.1 6417.8 6422.0 919.9 973.6 1004.8 1094.6 1192.9 29411.0 29445.7 29764.7 29989.7 30168.8 1029.6 1061.5 1138.3 1171.2 1192.6 14939.6 14963.3 14972.0 15403.0 15513.7 475154.0 477890.0 481069.0 483253.0 483911.0 59371.7 59916.7 60095.4 60115.4 60190.4 1314.5 1394.9 1436.3 1441.4 1468.7 28727.6 28891.0 29115.9 29391.4 29630.0 48841.0 49254.0 49304.8 49330.5 49433.5 347162.5 355332.0 356677.0 356711.0 357667.0 29197.3 32955.8 32994.8 33825.0 33877.7 41840.0 42228.0 43491.6 43506.0 43741.3 36154.5 36395.1 36446.1 36599.6 37591.2 31014.4 36202.6 36229.3 36715.4 37349.0 36140.6 36190.8 36724.4 36895.4 37339.6 26801.0 27684.0 31987.7 32684.0 32702.7 24073.3 24336.6 24769.9 24830.8 24861.0 17:54:42 INFO - PROCESS | 2092 | 17:54:42 INFO - PROCESS | 2092 | [#2] jquery.html Cycles:180 Average:31302.51 Median:11728.55 stddev:83460.05 (711.6%) stddev-sans-first:83661.84 17:54:42 INFO - PROCESS | 2092 | Values: 361.2 363.1 367.1 373.7 375.1 19670.8 19975.7 20415.8 21145.6 21150.4 20728.8 20926.2 21197.2 21298.4 21325.8 5531.3 5839.5 5876.8 5879.5 5892.3 5586.7 5790.5 5852.3 5860.6 5860.8 4684.4 5774.2 5795.9 5808.2 5819.9 5536.1 5732.9 5733.4 5739.1 5757.8 4982.8 4995.8 4996.9 4998.0 5006.9 24854.9 25260.2 25537.6 25627.9 25656.6 1965.5 2043.7 2131.3 2442.5 2582.5 12248.3 14371.3 14650.6 14727.3 14819.6 1462.2 1584.0 1694.2 1859.4 1884.0 100703.5 100750.0 104891.0 106969.0 107629.5 11130.6 11174.0 11219.6 11230.5 11316.0 13754.7 13850.6 13871.2 13909.6 13923.2 8412.2 8519.4 8561.4 8651.4 8660.5 8250.7 8611.0 8666.5 8786.8 8800.9 4308.9 4369.7 4404.0 4445.8 4453.8 1593.7 1787.5 1847.6 1885.4 1893.3 905.6 981.3 988.4 1014.3 1030.2 14937.9 19735.8 19842.3 20009.4 20056.5 926.8 948.9 949.6 961.6 1054.0 10768.9 10859.5 10888.4 10905.6 10939.5 467319.0 473840.0 474277.0 489017.0 574804.0 117530.4 117688.0 121506.0 124804.0 125383.0 978.6 996.9 1020.9 1021.7 1050.3 16063.9 17545.0 17924.8 18238.5 18298.7 50434.7 50896.7 51661.7 51676.5 52386.5 67767.3 70442.0 71228.6 71410.3 73033.0 7668.7 7857.6 7892.4 7932.5 8152.1 11283.5 12573.6 12659.0 12675.9 13008.7 10754.7 10911.0 10925.0 11061.2 11091.7 10737.0 10753.7 10974.7 11061.1 11095.2 9575.5 10974.8 11016.0 11080.2 11173.6 7652.4 7700.9 7816.0 7903.4 7978.8 8167.2 10603.6 10739.4 11197.0 11210.5 17:54:42 INFO - PROCESS | 2092 | 17:54:42 INFO - PROCESS | 2092 | [#3] mootools.html Cycles:180 Average:6034.20 Median:523.73 stddev:3217.72 (614.4%) stddev-sans-first:3208.13 17:54:42 INFO - PROCESS | 2092 | Values: 1429.9 1572.5 1593.2 1849.5 1985.3 7921.1 8673.5 8820.4 8827.2 8838.3 8441.8 8712.1 8717.4 8723.8 8732.2 2125.6 2411.8 2462.1 2466.7 2492.4 2477.6 2487.4 2489.6 2492.5 2492.7 2385.3 2407.8 2427.9 2430.4 2439.1 2425.4 2437.7 2444.4 2485.2 2490.9 2424.2 2424.3 2426.2 2429.2 2470.3 8724.2 8803.8 8806.4 8813.5 8839.6 5434.4 5582.3 5589.6 5590.8 5602.7 3374.6 3531.4 3547.3 3668.4 3737.4 1002.3 1007.6 1040.0 1046.4 1075.9 11979.9 12002.8 12024.2 12035.0 12045.9 4098.9 4833.8 4914.6 4978.2 4990.3 10114.0 10148.2 10186.4 10187.0 10189.5 5554.3 5557.1 5559.4 5564.1 5569.9 4444.3 4609.7 4889.7 4949.4 5005.5 3827.1 3917.0 3927.8 3964.6 3992.1 1105.4 1308.0 1309.8 1332.3 1332.6 1158.3 1166.4 1192.4 1274.6 1367.2 8055.4 8171.3 8220.0 8237.5 8251.4 510.6 518.1 518.3 523.5 524.0 6173.4 6173.8 6239.4 6254.0 6265.9 10386.6 10777.2 10879.8 10880.3 10881.1 10540.2 10545.4 10568.7 10601.4 10653.6 8294.5 8369.2 8376.0 8427.4 8471.9 7707.8 7848.0 7914.5 7918.3 7925.5 9346.4 9612.5 9735.0 9792.2 9809.5 8206.9 9802.8 9919.9 10077.7 10092.6 6161.6 6714.0 6722.5 7491.7 7579.1 7972.0 8301.9 8335.2 8343.5 8344.4 7254.0 7346.0 7361.2 7492.0 7512.4 7177.6 7235.0 7243.9 7306.2 7322.8 7653.3 7668.8 7702.2 7709.3 7738.2 6714.2 6929.1 7003.8 7009.9 7018.7 7050.2 7116.3 7119.8 7145.7 7148.2 17:54:42 INFO - PROCESS | 2092 | 17:54:42 INFO - PROCESS | 2092 | [#4] prototype.html Cycles:180 Average:5739.76 Median:6604.92 stddev:1815.41 (27.5%) stddev-sans-first:1773.53 17:54:42 INFO - PROCESS | 2092 | Values: 273.2 327.2 332.3 335.3 336.8 6565.6 6677.6 6696.5 6719.1 6747.3 6558.6 6621.8 6631.6 6632.9 6641.6 4665.5 4784.0 4821.3 4959.3 4966.7 4877.9 4885.5 4892.2 4919.5 4936.2 4823.1 4835.6 4839.5 4845.5 4871.2 4646.6 4736.1 4845.2 4851.6 4853.3 3526.2 4042.0 4130.2 4151.4 4159.7 6223.8 6332.7 6336.8 6337.4 6364.8 4597.6 5666.1 5690.6 5692.7 5693.4 6978.7 6986.9 6991.9 7002.5 7006.4 3912.9 4565.5 4672.7 4707.6 4720.4 7148.2 7274.0 7330.8 7348.6 7366.6 4795.3 4802.4 4814.0 4818.3 4819.2 4070.5 4878.8 4885.6 4907.8 4917.3 5717.5 5732.7 5756.2 5756.6 5782.4 6769.4 7006.8 7027.8 7033.9 7058.8 1306.9 1689.7 1706.2 1713.2 1717.7 1085.2 1092.6 1109.6 1114.7 1115.3 5335.2 5376.4 6274.6 6551.2 6556.3 6761.2 7328.2 7333.1 7342.3 7344.7 6604.7 6605.1 6620.3 6621.2 6622.3 3841.3 3889.3 3889.9 3890.3 3891.3 7330.7 7611.5 7642.8 7662.1 7675.5 6837.2 6904.7 7486.9 7488.6 7544.6 7618.8 7619.6 7624.5 7630.7 7639.6 7004.9 7245.5 7271.7 7304.6 7333.6 5809.8 7094.6 7131.1 7141.1 7146.8 6126.5 7594.8 7598.2 7615.8 7632.0 4813.6 4824.8 4830.4 4831.3 4854.4 7152.4 7225.8 7229.9 7253.6 7265.3 6302.1 6664.6 6720.5 7026.9 7031.6 6960.6 7014.6 7018.8 7030.1 7050.7 6840.4 6854.0 6859.5 6868.6 6876.4 6704.4 7011.2 7023.9 7032.3 7045.4 6700.3 6720.7 6818.7 6865.7 6871.4 17:54:42 INFO - PROCESS | 2092 | 17:54:42 INFO - PROCESS | 2092 | [#5] yui.html Cycles:180 Average:18456.23 Median:649.44 stddev:25846.24 (3979.8%) stddev-sans-first:25884.29 17:54:42 INFO - PROCESS | 2092 | Values: 681.9 687.7 687.8 695.9 735.8 15053.6 17616.9 17774.6 17811.6 17865.2 16236.7 16296.6 16374.9 16390.8 16409.6 731.8 892.0 912.1 913.0 913.4 732.9 896.4 914.8 916.2 917.1 958.0 963.5 966.3 967.0 967.2 767.9 951.9 962.9 963.8 963.8 712.8 714.1 715.5 716.4 717.3 15353.5 15425.2 15434.4 15445.5 15496.3 12150.1 12372.9 12403.9 12422.8 12436.4 9882.2 10031.3 10135.8 10475.3 10797.1 3210.3 3343.2 3478.0 3579.0 3580.6 84397.6 85091.0 86117.6 86510.0 86727.0 9204.1 9258.0 9334.1 9490.8 9588.4 17670.6 21338.0 21487.6 21492.7 21523.4 7404.1 7415.7 7462.9 7629.1 7722.0 4089.2 4112.2 4150.7 4204.2 4420.8 3585.6 3648.9 3650.1 3650.4 3656.6 572.3 638.2 645.4 653.5 658.7 499.6 562.8 563.8 586.0 636.1 7868.2 8169.0 8266.7 8446.9 8452.4 560.9 572.9 585.8 599.8 601.4 3587.5 3889.6 3929.7 3934.0 3966.6 83883.6 84254.1 84533.1 85599.1 96691.5 74729.6 80723.8 80740.0 81418.6 81628.0 67844.0 67993.0 68563.0 71101.0 72541.5 8416.9 8417.7 8430.2 8433.5 8586.4 41448.2 51249.2 51378.5 52106.5 52202.5 64275.7 70356.6 70611.0 71224.2 71973.9 10724.8 10739.2 10970.4 11068.3 11157.3 11697.5 11843.9 12011.9 12337.4 12734.4 11113.4 11118.2 11385.5 11429.9 11469.5 11340.7 11372.3 11378.7 11676.6 11712.3 9863.2 9941.0 10787.8 10837.9 11176.7 9004.0 9095.6 9213.0 9265.1 9688.9 9109.7 9322.2 9337.4 9389.8 9450.8 17:54:42 INFO - PROCESS | 2092 | -------- Summary: end -------- 17:54:42 INFO - PROCESS | 2092 | 17:54:43 INFO - TEST-INFO | 2092: exit 0 17:54:43 INFO - TEST-OK | dromaeo_css | took 1113581ms 17:54:43 INFO - TEST-START | kraken 17:54:43 INFO - operating with platform_type : mac_ 17:54:43 INFO - Initialising browser for kraken test... 17:54:43 INFO - TEST-INFO | started process 2096 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpbqrpkp/profile http://localhost:49354/getInfo.html) 17:54:45 INFO - PROCESS | 2096 | __metrics Screen width/height:1600/1200 17:54:45 INFO - PROCESS | 2096 | colorDepth:24 17:54:45 INFO - PROCESS | 2096 | Browser inner width/height: 1024/689 17:54:45 INFO - PROCESS | 2096 | __metrics 17:54:45 INFO - PROCESS | 2096 | 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" 17:54:45 ERROR - PROCESS | 2096 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:54:46 INFO - TEST-INFO | 2096: exit 0 17:54:46 INFO - Browser initialized. 17:54:46 INFO - Running cycle 1/1 for kraken test... 17:54:46 INFO - TEST-INFO | started process 2098 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/T/tmpbqrpkp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:54:58 INFO - PROCESS | 2098 | RSS: Main: 237023232 17:54:58 INFO - PROCESS | 2098 | 17:55:00 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49354/tests/kraken/driver.html?testName=audio-beat-detection) 17:55:01 INFO - PROCESS | 2098 | RSS: Main: 283385856 17:55:01 INFO - PROCESS | 2098 | 17:55:04 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49354/tests/kraken/driver.html?testName=audio-dft) 17:55:04 INFO - PROCESS | 2098 | RSS: Main: 293347328 17:55:04 INFO - PROCESS | 2098 | 17:55:08 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49354/tests/kraken/driver.html?testName=audio-fft) 17:55:08 INFO - PROCESS | 2098 | RSS: Main: 277876736 17:55:08 INFO - PROCESS | 2098 | 17:55:10 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49354/tests/kraken/driver.html?testName=audio-oscillator) 17:55:11 INFO - PROCESS | 2098 | RSS: Main: 280559616 17:55:11 INFO - PROCESS | 2098 | 17:55:13 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49354/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:55:13 INFO - PROCESS | 2098 | RSS: Main: 281653248 17:55:13 INFO - PROCESS | 2098 | 17:55:16 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49354/tests/kraken/driver.html?testName=imaging-darkroom) 17:55:17 INFO - PROCESS | 2098 | RSS: Main: 281731072 17:55:17 INFO - PROCESS | 2098 | 17:55:20 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49354/tests/kraken/driver.html?testName=imaging-desaturate) 17:55:20 INFO - PROCESS | 2098 | RSS: Main: 281808896 17:55:20 INFO - PROCESS | 2098 | 17:55:23 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49354/tests/kraken/driver.html?testName=json-parse-financial) 17:55:23 INFO - PROCESS | 2098 | RSS: Main: 282243072 17:55:23 INFO - PROCESS | 2098 | 17:55:25 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49354/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:55:26 INFO - PROCESS | 2098 | RSS: Main: 316633088 17:55:26 INFO - PROCESS | 2098 | 17:55:27 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:55:28 INFO - PROCESS | 2098 | RSS: Main: 316100608 17:55:28 INFO - PROCESS | 2098 | 17:55:30 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:55:31 INFO - PROCESS | 2098 | RSS: Main: 322985984 17:55:31 INFO - PROCESS | 2098 | 17:55:33 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:55:34 INFO - PROCESS | 2098 | RSS: Main: 324534272 17:55:34 INFO - PROCESS | 2098 | 17:55:37 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:55:37 INFO - PROCESS | 2098 | RSS: Main: 324661248 17:55:37 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | Cycle 1(1): loaded http://localhost:49354/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49354/tests/kraken/driver.html?testName=ai-astar) 17:55:39 INFO - PROCESS | 2098 | RSS: Main: 388194304 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | __start_tp_report 17:55:39 INFO - PROCESS | 2098 | _x_x_mozilla_page_load 17:55:39 INFO - PROCESS | 2098 | _x_x_mozilla_page_load_details 17:55:39 INFO - PROCESS | 2098 | |i|pagename|runs| 17:55:39 INFO - PROCESS | 2098 | |0;ai-astar;119;156;155;110;113;112;118;111;107;112 17:55:39 INFO - PROCESS | 2098 | |1;audio-beat-detection;160;122;144;160;121;144;145;146;177;116 17:55:39 INFO - PROCESS | 2098 | |2;audio-dft;187;183;185;184;185;184;185;179;180;184 17:55:39 INFO - PROCESS | 2098 | |3;audio-fft;75;76;84;81;57;57;57;78;79;55 17:55:39 INFO - PROCESS | 2098 | |4;audio-oscillator;91;93;126;77;78;79;115;80;76;118 17:55:39 INFO - PROCESS | 2098 | |5;imaging-gaussian-blur;88;86;89;86;88;86;90;87;84;128 17:55:39 INFO - PROCESS | 2098 | |6;imaging-darkroom;95;95;95;96;96;96;95;95;95;95 17:55:39 INFO - PROCESS | 2098 | |7;imaging-desaturate;85;86;84;84;86;84;85;83;84;84 17:55:39 INFO - PROCESS | 2098 | |8;json-parse-financial;55;54;55;52;54;53;54;63;54;52 17:55:39 INFO - PROCESS | 2098 | |9;json-stringify-tinderbox;65;62;70;73;72;70;66;66;67;69 17:55:39 INFO - PROCESS | 2098 | |10;stanford-crypto-aes;82;84;83;82;85;78;84;83;83;98 17:55:39 INFO - PROCESS | 2098 | |11;stanford-crypto-ccm;131;139;132;120;120;133;120;132;121;124 17:55:39 INFO - PROCESS | 2098 | |12;stanford-crypto-pbkdf2;134;170;128;163;180;130;139;140;137;131 17:55:39 INFO - PROCESS | 2098 | |13;stanford-crypto-sha256-iterative;68;66;65;67;69;67;66;68;67;67 17:55:39 INFO - PROCESS | 2098 | __end_tp_report 17:55:39 INFO - PROCESS | 2098 | __start_cc_report 17:55:39 INFO - PROCESS | 2098 | _x_x_mozilla_cycle_collect,1300 17:55:39 INFO - PROCESS | 2098 | __end_cc_report 17:55:39 INFO - PROCESS | 2098 | __startTimestamp1459558539636__endTimestamp 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | ------- Summary: start ------- 17:55:39 INFO - PROCESS | 2098 | Number of tests: 14 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#0] ai-astar Cycles:10 Average:121.30 Median:115.50 stddev:18.37 (15.9%) stddev-sans-first:19.46 17:55:39 INFO - PROCESS | 2098 | Values: 119.0 156.0 155.0 110.0 113.0 112.0 118.0 111.0 107.0 112.0 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#1] audio-beat-detection Cycles:10 Average:143.50 Median:145.50 stddev:19.44 (13.4%) stddev-sans-first:19.68 17:55:39 INFO - PROCESS | 2098 | Values: 160.0 122.0 144.0 160.0 121.0 144.0 145.0 146.0 177.0 116.0 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.50 stddev:2.41 (1.3%) stddev-sans-first:2.22 17:55:39 INFO - PROCESS | 2098 | Values: 187.0 183.0 185.0 184.0 185.0 184.0 185.0 179.0 180.0 184.0 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#3] audio-fft Cycles:10 Average:69.90 Median:77.00 stddev:11.81 (15.3%) stddev-sans-first:12.38 17:55:39 INFO - PROCESS | 2098 | Values: 75.0 76.0 84.0 81.0 57.0 57.0 57.0 78.0 79.0 55.0 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:78.50 stddev:19.25 (24.5%) stddev-sans-first:20.40 17:55:39 INFO - PROCESS | 2098 | Values: 91.0 93.0 126.0 77.0 78.0 79.0 115.0 80.0 76.0 118.0 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:87.50 stddev:13.05 (14.9%) stddev-sans-first:13.79 17:55:39 INFO - PROCESS | 2098 | Values: 88.0 86.0 89.0 86.0 88.0 86.0 90.0 87.0 84.0 128.0 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 17:55:39 INFO - PROCESS | 2098 | Values: 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.50 stddev:0.97 (1.2%) stddev-sans-first:1.01 17:55:39 INFO - PROCESS | 2098 | Values: 85.0 86.0 84.0 84.0 86.0 84.0 85.0 83.0 84.0 84.0 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#8] json-parse-financial Cycles:10 Average:54.60 Median:54.00 stddev:3.13 (5.8%) stddev-sans-first:3.32 17:55:39 INFO - PROCESS | 2098 | Values: 55.0 54.0 55.0 52.0 54.0 53.0 54.0 63.0 54.0 52.0 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:69.50 stddev:3.40 (4.9%) stddev-sans-first:3.43 17:55:39 INFO - PROCESS | 2098 | Values: 65.0 62.0 70.0 73.0 72.0 70.0 66.0 66.0 67.0 69.0 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:83.50 stddev:5.20 (6.2%) stddev-sans-first:5.46 17:55:39 INFO - PROCESS | 2098 | Values: 82.0 84.0 83.0 82.0 85.0 78.0 84.0 83.0 83.0 98.0 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:131.50 stddev:6.97 (5.3%) stddev-sans-first:7.26 17:55:39 INFO - PROCESS | 2098 | Values: 131.0 139.0 132.0 120.0 120.0 133.0 120.0 132.0 121.0 124.0 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.20 Median:139.50 stddev:18.65 (13.4%) stddev-sans-first:19.33 17:55:39 INFO - PROCESS | 2098 | Values: 134.0 170.0 128.0 163.0 180.0 130.0 139.0 140.0 137.0 131.0 17:55:39 INFO - PROCESS | 2098 | 17:55:39 INFO - PROCESS | 2098 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.00 Median:67.00 stddev:1.15 (1.7%) stddev-sans-first:1.17 17:55:39 INFO - PROCESS | 2098 | Values: 68.0 66.0 65.0 67.0 69.0 67.0 66.0 68.0 67.0 67.0 17:55:39 INFO - PROCESS | 2098 | -------- Summary: end -------- 17:55:39 INFO - PROCESS | 2098 | 17:55:40 INFO - TEST-INFO | 2098: exit 0 17:55:40 INFO - TEST-OK | kraken | took 57100ms 17:55:40 INFO - SUITE-END | took 1170s 17:55:40 INFO - Completed test suite (00:19:31) 17:55:40 INFO - javascript benchmark 17:55:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3438.398280300947, 3481.1819222482713, 3498.755087143898, 3525.576930768308, 3550.3609350316933, 5712.857178570538, 5714.599978001531, 5721.799737009205, 5730.512906402955, 5735.197072409861, 5691.288588926384, 5708.942910570893, 5753.482186603205, 5878.735456904439, 5896.852578685535, 5107.744612769366, 5125.948740512603, 5132.024915266106, 5148.794048238066, 5355.357357117132, 5301.363836339645, 5316.654417462872, 5354.973225133869, 5387.353517577876, 5403.756830942617, 5123.538881500683, 5166.0, 5278.049951008817, 5282.286891269668, 5290.338707661543, 5211.166213405837, 5237.711925844077, 5245.554127899133, 5258.1849813279005, 5276.92084618731, 5119.6160287978555, 5177.767000484987, 5211.0, 5244.580433565306, 5267.3942496613, 5274.314339135926, 5606.046972014768, 5717.9714101429645, 5720.998825205573, 5730.312362516524, 6262.937370626281, 6265.122882796367, 6271.090691849702, 6272.8118156455375, 6293.433590976788, 6226.844328891769, 6294.433500984934, 6328.335524769925, 6334.493240540745, 6337.081123237151, 5732.742026608813, 5773.39379365169, 5832.941670583282, 5833.620814647034, 5837.241158649434, 6287.874242515124, 6299.464545513591, 6308.495320374359, 6310.558260921692, 6322.683865806691, 6100.267967843887, 6118.1434599156155, 6119.143319935212, 6131.080337949344, 6139.2325959255095, 6281.560290779693, 6299.685015749286, 6300.464460520815, 6301.243850737941, 6308.463780578611, 6244.12582238487, 6249.937500625027, 6252.906206406908, 6257.217847769029, 6263.342349053375, 6126.27339965311, 6186.226721659793, 6252.0, 6281.874362512815, 6290.811275661737, 4904.6321525885705, 4912.189488734391, 4930.161872481615, 4930.457649658535, 4967.925481117786, 4323.827046918151, 4339.7830108494445, 4376.409184760017, 4385.978070109629, 4426.889327766831, 5597.496225339739, 5657.971710141423, 5658.85852853682, 5664.97167514168, 5715.857103572361, 6187.0, 6295.590786598948, 6318.0, 6319.115323854664, 6326.398992095744, 5657.066584013674, 5669.574781891375, 5697.601167918206, 5707.1153971134545, 5750.539956803445, 5311.760970756325, 5357.4106848246665, 5387.353517577916, 5396.946030539644, 5399.541039011649, 6347.333529979285, 6367.076773867763, 6392.680365981775, 6406.135171751847, 6423.0, 6279.686015699105, 6281.623102613858, 6288.874222515433, 6299.055141728777, 6321.557490975588, 6239.75040998355, 6332.050192471166, 6332.556721029668, 6337.493000560036, 6385.96807015962, 6196.535259855619, 6225.688715564294, 6242.687865606611, 6243.219597550306, 6253.687315634291, 6297.118403423616, 6302.779402720883, 6309.1167236587835, 6311.211098612674, 6311.526635502264, 4981.452040275639, 6057.121717351048, 6100.702285530011, 6160.722767475385, 6163.96918015407, 6091.878162436815, 6153.72308246139, 6167.6916154193, 6175.660338681416, 6183.350748171377, 5993.520518358608, 6004.369541198286, 6014.458698716961, 6046.758129674764, 6062.727177277121, 6065.120557519223, 6070.48400885912, 6164.876702466016, 6195.473384762166, 6197.0, 6033.3255151280655, 6045.486133678686, 6050.515958723204, 6055.333913269625, 6113.694315284307], "unit": "score", "name": "dojo.html", "value": 5733.055199202246}, {"lowerIsBetter": false, "replicates": [479.84644913627653, 563.3521450332117, 594.7858770842496, 634.768309567008, 641.0, 30033.399332013345, 39654.60345396545, 40158.0, 40170.79914600427, 40393.79803100984, 43120.78439607798, 43390.349144762775, 43515.564844351546, 43658.563414365926, 43667.0, 9568.043195680446, 9798.510074496282, 9803.509824508781, 9817.361871478332, 9828.164606008499, 9502.192313653348, 9657.661981830637, 9664.710058698216, 9674.322797404184, 9676.903230967671, 9823.705288841345, 9873.407595544255, 9883.50582470877, 9889.554970026331, 9906.702798916009, 9755.365901216433, 9837.0, 9844.0, 9854.359466634645, 9857.162141217968, 9582.952085239529, 9678.806423871483, 9695.418274903457, 9843.310968232227, 9865.0, 41472.585274147175, 41788.37317440241, 42012.0, 42177.78911105455, 42194.99147580975, 3165.5884734984534, 3196.536502207167, 3201.823899685516, 3599.8380072896784, 3719.1817800083936, 29779.70220297791, 29894.70105298941, 30258.54612180819, 30449.847750761324, 30606.54090188649, 2654.376221587925, 2758.2828464599147, 2786.5959435881887, 2869.956950645742, 2907.636545431821, 469647.0, 472725.272747275, 473321.0, 475028.0, 475126.0, 46604.06791864212, 68576.0, 68946.31053689499, 68984.65507672429, 69578.65210673914, 46168.538314616424, 46228.07543849104, 46310.53689463062, 46358.30462543065, 46389.30416043762, 15642.921785391, 15845.366185352457, 15877.0, 15877.841221587867, 15887.0, 12594.496220151275, 12606.747865042647, 12634.052446066582, 12641.367931603383, 12645.93677031609, 14665.340059697339, 14680.926595366955, 14966.0, 14981.70036599262, 15111.697766044617, 6231.75072997075, 6368.681565921685, 6398.136251606066, 6417.807465775941, 6422.0, 919.94940278284, 973.5764942250003, 1004.834202356603, 1094.5676457799284, 1192.928424294545, 29411.0, 29445.705542944725, 29764.702352976627, 29989.70010299869, 30168.793248269823, 1029.6447725534679, 1061.543536279392, 1138.3283862521153, 1171.226990186473, 1192.5885569478517, 14939.626509337137, 14963.326650300545, 14972.0, 15403.0, 15513.689726205639, 475154.0, 477890.0, 481069.0, 483253.0, 483911.0, 59371.70314148402, 59916.70041649851, 60095.39904600986, 60115.398846011856, 60190.39809601936, 1314.493919840868, 1394.9372278247504, 1436.3321055709146, 1441.4162264282982, 1468.6842328899338, 28727.569086463303, 28890.98881539136, 29115.910022084692, 29391.412171756874, 29629.962951296602, 48841.0231795355, 49254.0, 49304.75347623239, 49330.506694934025, 49433.50566494289, 347162.5283747231, 355332.0, 356677.0, 356711.0, 357667.0, 29197.270068248465, 32955.83522082374, 32994.835025824716, 33825.0, 33877.66122338844, 41839.95400115022, 42228.0, 43491.56508435002, 43506.0, 43741.34387984119, 36154.45768313425, 36395.09012274714, 36446.088847779014, 36599.63400365962, 37591.24817503689, 31014.379712406077, 36202.63797361992, 36229.275414491036, 36715.44926826046, 37349.0, 36140.63859361373, 36190.8190459046, 36724.44913326249, 36895.44656830096, 37339.62660373362, 26801.0, 27684.031058912842, 31987.6801231994, 32684.0, 32702.672973269964, 24073.27780166598, 24336.634950476113, 24769.876150619133, 24830.751692482845, 24861.005559777408], "unit": "score", "name": "ext.html", "value": 19166.547670026317}, {"lowerIsBetter": false, "replicates": [361.2233697550267, 363.11037957005334, 367.06581749447656, 373.7495877761899, 375.1465416178196, 19670.803291967077, 19975.700364494525, 20415.795842041574, 21145.57708845822, 21150.365489035335, 20728.79271207291, 20926.162953481882, 21197.152113915465, 21298.36104916851, 21325.827079510622, 5531.25328080708, 5839.474447299742, 5876.76492940284, 5879.470847623713, 5892.263467066617, 5586.664800111986, 5790.536757059425, 5852.268466441695, 5860.648361098327, 5860.794872179475, 4684.43786745591, 5774.162746401769, 5795.884082318351, 5808.215890854723, 5819.883602327951, 5536.086545719952, 5732.942670573324, 5733.39180004386, 5739.139129130622, 5757.769689212427, 4982.82560110398, 4995.775190116417, 4996.875078123039, 4998.0, 5006.949930500685, 24854.875725621438, 25260.242192734248, 25537.61693574598, 25627.87186064058, 25656.61515077275, 1965.49879780655, 2043.7022490718352, 2131.26471367378, 2442.546684722587, 2582.5093232285803, 12248.326342051183, 14371.281435928162, 14650.633734156625, 14727.337269822883, 14819.629509262248, 1462.2104063805532, 1583.9841601584067, 1694.2291257477818, 1859.386402487176, 1883.990580047091, 100703.49648251712, 100750.0, 104891.0, 106969.0, 107629.46185269102, 11130.554777808797, 11174.0, 11219.60731374398, 11230.494627741771, 11316.0, 13754.65613359674, 13850.584482465541, 13871.23708196059, 13909.58271251864, 13923.164610123426, 8412.158784121539, 8519.403641745019, 8561.35789815754, 8651.437656552303, 8660.523671198018, 8250.669973201126, 8611.009733880559, 8666.480011199348, 8786.780330491789, 8800.911990880137, 4308.870733877989, 4369.650427965755, 4404.009097952935, 4445.777711114496, 4453.844115456009, 1593.6573636668172, 1787.4726955548144, 1847.584293533971, 1885.4437940807495, 1893.2521653946615, 905.6060613633091, 981.3081777346953, 988.3625061835077, 1014.3052009373455, 1030.160419258302, 14937.925310373379, 19735.802641973685, 19842.305519306756, 20009.399718008484, 20056.49858753543, 926.7720270641427, 948.9478078705599, 949.5726922884592, 961.5576834656136, 1053.9987012338308, 10768.946155269174, 10859.457027148612, 10888.40113793749, 10905.618303359344, 10939.453027348602, 467319.0, 473840.0, 474277.0, 489017.0, 574804.0, 117530.41234793772, 117688.0, 121505.98916151746, 124804.0, 125383.0, 978.6232300564192, 996.9252306076928, 1020.9132223761063, 1021.7292417509366, 1050.3382868792764, 16063.91968040199, 17545.0, 17924.820751792315, 18238.452846414628, 18298.72551911749, 50434.74782626063, 50896.74551627218, 51661.7416912913, 51676.48323516867, 52386.47613523816, 67767.3223267761, 70442.0, 71228.57542849217, 71410.28589714036, 73033.0, 7668.693252269847, 7857.607119644109, 7892.4080693947035, 7932.484388514728, 8152.103268640326, 11283.492242848928, 12573.622791316275, 12658.98728101768, 12675.93662031684, 13008.739825203633, 10754.677359679223, 10911.0, 10925.029111753975, 11061.170412218955, 11091.667249982513, 10737.03366697001, 10753.731156721145, 10974.670759877217, 11061.059809916247, 11095.223334366518, 9575.473348965874, 10974.780504390028, 11016.0, 11080.168987325822, 11173.553057877594, 7652.426068044808, 7700.922990770021, 7816.0, 7903.407244456804, 7978.800529986796, 8167.224113709188, 10603.575856965635, 10739.409332486788, 11197.0, 11210.495527701436], "unit": "score", "name": "jquery.html", "value": 9342.932511187282}, {"lowerIsBetter": false, "replicates": [1429.928503574821, 1572.504661031775, 1593.1954363046664, 1849.4636555398936, 1985.305143199881, 7921.128675845653, 8673.479591224523, 8820.426672266298, 8827.205551500363, 8838.33712471564, 8441.78895527612, 8712.1287871213, 8717.433366831152, 8723.825523489526, 8732.214100730933, 2125.6280150973594, 2411.8191135664806, 2462.101333013455, 2466.703995520531, 2492.3644470659956, 2477.55404027275, 2487.4154573675173, 2489.55188066148, 2492.464120214154, 2492.703794027105, 2385.3440303916477, 2407.7953373963232, 2427.890744916474, 2430.368104292879, 2439.1097249503982, 2425.4300239443714, 2437.6709144265565, 2444.401121725171, 2485.179890636086, 2490.86300253486, 2424.1636635360774, 2424.2727181845553, 2426.1751004658327, 2429.186222615426, 2470.3330100872845, 8724.171203735636, 8803.823923521493, 8806.383553151281, 8813.471191728517, 8839.646414143426, 5434.402215756264, 5582.330120385539, 5589.636673616202, 5590.776368945238, 5602.663840169562, 3374.599541190403, 3531.4173161428334, 3547.255076433952, 3668.394714872043, 3737.364648009845, 1002.293383164867, 1007.6322142417964, 1040.0379648824883, 1046.3669479964587, 1075.8601381820392, 11979.94010029953, 12002.759944801142, 12024.158308918379, 12034.97702695272, 12045.879541204564, 4098.938515922264, 4833.806647734122, 4914.557689807934, 4978.2034874419915, 4990.276409920614, 10113.988601139974, 10148.188144948386, 10186.439745814052, 10186.981301869902, 10189.54147063384, 5554.333479982428, 5557.055300598908, 5559.444055594489, 5564.10974244119, 5569.860753481114, 4444.31113177458, 4609.677322587387, 4889.706617602955, 4949.430815456197, 5005.474425185376, 3827.119762454651, 3917.0, 3927.8232479538487, 3964.6431821136234, 3992.121733218687, 1105.4417519152776, 1307.9863106092855, 1309.7904335306305, 1332.3072002558808, 1332.6068809701162, 1158.2702897174895, 1166.3643314393676, 1192.3620862838513, 1274.5985014720334, 1367.1660287224786, 8055.395845311508, 8171.346292296602, 8220.0, 8237.46456480339, 8251.422400431911, 510.62213961668095, 518.1269560790006, 518.3028826228716, 523.4974424552396, 523.9607029472804, 6173.351798061229, 6173.81478555644, 6239.407256310643, 6254.0, 6265.8746825063245, 10386.636467723745, 10777.191710621579, 10879.782404352027, 10880.29278096937, 10881.075108615856, 10540.156787456985, 10545.420001899969, 10568.682939511827, 10601.363918164934, 10653.57385704563, 8294.543800091053, 8369.204925532065, 8375.994880614366, 8427.41008129425, 8471.915280847114, 7707.768766937001, 7848.018997625297, 7914.525128492309, 7918.287354138155, 7925.484843485155, 9346.439213647203, 9612.51937403113, 9734.951325243612, 9792.216622670026, 9809.460479673686, 8206.917930820615, 9802.824779751232, 9919.851202232117, 10077.69766906994, 10092.596296148073, 6161.630302181883, 6714.0, 6722.529422940543, 7491.737789177353, 7579.052618422697, 7972.043354797462, 8301.875471867806, 8335.249827515552, 8343.45767525109, 8344.41589088758, 7253.963730181315, 7345.963270183614, 7361.227071157451, 7492.026036615205, 7512.361449276873, 7177.641117943977, 7235.0108799028785, 7243.855122897618, 7306.159791624032, 7322.816929576803, 7653.349465295512, 7668.80827979305, 7702.152763195932, 7709.3447057000785, 7738.2261773822165, 6714.222423551564, 6929.133858267716, 7003.789886303419, 7009.894851577128, 7018.719251229893, 7050.15398152225, 7116.252793456612, 7119.822004449723, 7145.7498987537265, 7148.177959534512], "unit": "score", "name": "mootools.html", "value": 4825.143837716217}, {"lowerIsBetter": false, "replicates": [273.22404371584696, 327.19836400818, 332.25408956891783, 335.31930181731093, 336.8107302533532, 6565.573237739543, 6677.565958212719, 6696.531242813011, 6719.0929224554675, 6747.291534388892, 6558.6064836109745, 6621.834454138649, 6631.602103873759, 6632.900506492394, 6641.634710090955, 4665.510121437251, 4783.976080119594, 4821.349117869096, 4959.305697202394, 4966.652334336598, 4877.902441951159, 4885.462599114095, 4892.241702536113, 4919.458859525449, 4936.185529387664, 4823.107725070873, 4835.6131509479155, 4839.467658557556, 4845.53967373099, 4871.244957031666, 4646.6282697384295, 4736.123817093849, 4845.200541910581, 4851.587615052725, 4853.320535125085, 3526.1713497328105, 4041.969297829064, 4130.235906357303, 4151.377293405983, 4159.729617574878, 6223.7821676241565, 6332.68336583169, 6336.841578960563, 6337.429631333156, 6364.77723279683, 4597.632189424838, 5666.121751128581, 5690.573207009449, 5692.743826527775, 5693.373728889819, 6978.720851165947, 6986.895196572055, 6991.8601627967155, 7002.474814388941, 7006.369426751617, 3912.941305880414, 4565.4749703784155, 4672.742999135046, 4707.6233901287815, 4720.43354797423, 7148.213696493433, 7273.963630181868, 7330.780076597711, 7348.559086454829, 7366.558006519626, 4795.256735206049, 4802.447718512346, 4813.975930120397, 4818.349522814376, 4819.180739274261, 4070.470838790938, 4878.804847806119, 4885.60915126789, 4907.803687852446, 4917.311576379309, 5717.514011309002, 5732.656040637575, 5756.222909907109, 5756.625819321731, 5782.421757824268, 6769.39075483199, 7006.824829379204, 7027.789166325018, 7033.859322813515, 7058.752943646948, 1306.9019823513274, 1689.7127488327014, 1706.1895599590096, 1713.2119225156318, 1717.6736420080144, 1085.1806885801327, 1092.579356947581, 1109.6227282723912, 1114.6934592986993, 1115.252780636975, 5335.199720042025, 5376.435474275223, 6274.623522588659, 6551.246606640202, 6556.311587283362, 6761.154855643044, 7328.157261914841, 7333.083364579427, 7342.302481264272, 7344.70621175147, 6604.702788374535, 6605.141331626954, 6620.271770105284, 6621.238557565942, 6622.2715501294815, 3841.250956063541, 3889.2804831106337, 3889.8833035008997, 3890.280298144852, 3891.2995660780766, 7330.67011984462, 7611.543307401574, 7642.770716878503, 7662.118856331594, 7675.462717609714, 6837.179538455318, 6904.722626314047, 7486.925130748623, 7488.555264578355, 7544.585047822313, 7618.847623047508, 7619.580923049286, 7624.504407213513, 7630.7329243476215, 7639.618019098912, 7004.894926576004, 7245.492815503075, 7271.672774725044, 7304.598247096248, 7333.596652184181, 5809.767609295581, 7094.574325540484, 7131.108611423572, 7141.107361579802, 7146.785596432115, 6126.540509461897, 7594.848103038019, 7598.240175982358, 7615.771526854203, 7632.0, 4813.590844778233, 4824.807007719652, 4830.4444988826735, 4831.347768051268, 4854.368932038812, 7152.392046676091, 7225.819354515969, 7229.891551626835, 7253.56478611285, 7265.309795569412, 6302.086197501429, 6664.600123992576, 6720.529562930744, 7026.929730702627, 7031.648417578998, 6960.617166055916, 7014.579125252501, 7018.75434359795, 7030.086088808626, 7050.682719277543, 6840.384365407137, 6853.971904214408, 6859.451243900576, 6868.587884726732, 6876.381125698711, 6704.363085506869, 7011.228764835966, 7023.859522809413, 7032.26161253061, 7045.401140903081, 6700.329967003261, 6720.663966801738, 6818.659067046528, 6865.656717164022, 6871.415929646036], "unit": "score", "name": "prototype.html", "value": 5132.314486079859}, {"lowerIsBetter": false, "replicates": [681.8636272745453, 687.7455341523633, 687.8211664967108, 695.8921367188085, 735.8381156145648, 15053.62365940852, 17616.91191544042, 17774.555636109104, 17811.554711132198, 17865.196066177035, 16236.675266494663, 16296.592585185377, 16374.918125409356, 16390.754138687927, 16409.589760256, 731.7914394397598, 892.0321451225428, 912.0560220172123, 913.0230653201078, 913.4062859141545, 732.9193788683241, 896.3859756067114, 914.7667344827094, 916.193749500442, 917.0554329041098, 957.9568919398608, 963.5326866469757, 966.2656381150341, 966.9661561845337, 967.1923943507145, 767.9193684663086, 951.8952915179325, 962.8940816510213, 963.7831487915198, 963.7831487915233, 712.7826013066012, 714.139461948351, 715.5313269808283, 716.4411758828122, 717.2898830158158, 15353.539393818204, 15425.228738563026, 15434.38262469511, 15445.459408920746, 15496.30266638004, 12150.149489535735, 12372.876271237263, 12403.937980310131, 12422.81365779514, 12436.37818109091, 9882.160016398615, 10031.347962382422, 10135.797284054352, 10475.26673132881, 10797.082248008928, 3210.3097833965576, 3343.164208947763, 3477.965220347815, 3578.9642103579154, 3580.6240344763687, 84397.57801211016, 85091.0, 86117.56941215317, 86510.0, 86727.0, 9204.079592040742, 9257.953710231406, 9334.113259240361, 9490.810183796286, 9588.424694518351, 17670.646587068186, 21338.0, 21487.57024859494, 21492.677609835864, 21523.354299371043, 7404.111506619241, 7415.740449084256, 7462.925370746331, 7629.0845098587415, 7721.961390193013, 4089.2230476209425, 4112.218678451085, 4150.667946564267, 4204.222218889515, 4420.756858372756, 3585.551806024247, 3648.945265821015, 3650.105724097613, 3650.361186792301, 3656.561212654445, 572.27892855003, 638.237306418825, 645.3707635055783, 653.51313271612, 658.6607896933083, 499.6377626220961, 562.8114581615205, 563.8477611044995, 585.9677717725566, 636.0808631527399, 7868.2131786822, 8169.0, 8266.710665126691, 8446.873296900552, 8452.366072544584, 560.938296787353, 572.9083346664513, 585.7569108819793, 599.811059516251, 601.4106175947509, 3587.4798154267487, 3889.630485103911, 3929.7052721046034, 3934.0, 3966.6231707987695, 83883.58058209791, 84254.05703991595, 84533.12402197803, 85599.14400856037, 96691.51654241684, 74729.62635186789, 80723.7891431629, 80740.0, 81418.59290703508, 81628.0, 67843.98234026493, 67992.98010529845, 68563.0, 71101.0, 72541.54916901738, 8416.87374689368, 8417.70538031166, 8430.15698430152, 8433.451825631315, 8586.356023298402, 41448.171036579704, 51249.23126153185, 51378.486215138866, 52106.478935210165, 52202.477975219765, 64275.678621606596, 70356.6482167586, 70611.0, 71224.21939451554, 71973.92039119522, 10724.839127413252, 10739.248252622241, 10970.396628185526, 11068.335899846035, 11157.27477713946, 11697.473613687234, 11843.881561184622, 12011.879881201075, 12337.383130843602, 12734.363281836057, 11113.444327783416, 11118.166137539554, 11385.544578216779, 11429.885701143216, 11469.541218351505, 11340.716482088013, 11372.260803047775, 11378.658640240807, 11676.56191777419, 11712.297262164297, 9863.161631261422, 9941.0, 10787.756154654686, 10837.854488364186, 11176.664700059011, 9003.954980225319, 9095.636174553209, 9212.953935230282, 9265.073492650681, 9688.903110969082, 9109.726708198765, 9322.207612353026, 9337.439753614533, 9389.765255868659, 9450.763730906783], "unit": "score", "name": "yui.html", "value": 6929.428860467612}], "name": "dromaeo_css", "value": 7487.348702409687}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [119.0, 156.0, 155.0, 110.0, 113.0, 112.0, 118.0, 111.0, 107.0, 112.0], "unit": "score", "name": "ai-astar", "value": 121.3}, {"lowerIsBetter": true, "replicates": [160.0, 122.0, 144.0, 160.0, 121.0, 144.0, 145.0, 146.0, 177.0, 116.0], "unit": "score", "name": "audio-beat-detection", "value": 143.5}, {"lowerIsBetter": true, "replicates": [187.0, 183.0, 185.0, 184.0, 185.0, 184.0, 185.0, 179.0, 180.0, 184.0], "unit": "score", "name": "audio-dft", "value": 183.6}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 84.0, 81.0, 57.0, 57.0, 57.0, 78.0, 79.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.9}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 126.0, 77.0, 78.0, 79.0, 115.0, 80.0, 76.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 93.3}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 89.0, 86.0, 88.0, 86.0, 90.0, 87.0, 84.0, 128.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 91.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 95.3}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 84.0, 84.0, 86.0, 84.0, 85.0, 83.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 84.5}, {"lowerIsBetter": true, "replicates": [55.0, 54.0, 55.0, 52.0, 54.0, 53.0, 54.0, 63.0, 54.0, 52.0], "unit": "score", "name": "json-parse-financial", "value": 54.6}, {"lowerIsBetter": true, "replicates": [65.0, 62.0, 70.0, 73.0, 72.0, 70.0, 66.0, 66.0, 67.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 83.0, 82.0, 85.0, 78.0, 84.0, 83.0, 83.0, 98.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [131.0, 139.0, 132.0, 120.0, 120.0, 133.0, 120.0, 132.0, 121.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.2}, {"lowerIsBetter": true, "replicates": [134.0, 170.0, 128.0, 163.0, 180.0, 130.0, 139.0, 140.0, 137.0, 131.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.2}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 65.0, 67.0, 69.0, 67.0, 66.0, 68.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.0}], "name": "kraken", "value": 1428.8}]} 17:55:40 INFO - Return code: 0 17:55:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:55:40 ERROR - # TBPL SUCCESS # 17:55:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:55:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:55:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:55:40 INFO - 2016-04-01 17:55:40.947 screenresolution[2102:14047] starting screenresolution argv=screenresolution get 17:55:40 INFO - 2016-04-01 17:55:40.950 screenresolution[2102:14047] Display 0: 1600x1200x32@60 17:55:40 INFO - 2016-04-01 17:55:40.956 screenresolution[2103:14050] starting screenresolution argv=screenresolution list 17:55:40 INFO - Available Modes on Display 0 17:55:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:55:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:55:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:55:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:55:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:55:41 INFO - Intel Iris: 17:55:41 INFO - Chipset Model: Intel Iris 17:55:41 INFO - Type: GPU 17:55:41 INFO - Bus: Built-In 17:55:41 INFO - VRAM (Dynamic, Max): 1536 MB 17:55:41 INFO - Vendor: Intel (0x8086) 17:55:41 INFO - Device ID: 0x0a2e 17:55:41 INFO - Revision ID: 0x0009 17:55:41 INFO - Displays: 17:55:41 INFO - Display: 17:55:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:55:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:55:41 INFO - Display Serial Number: 1600x1200 60 17:55:41 INFO - Main Display: Yes 17:55:41 INFO - Mirror: Off 17:55:41 INFO - Online: Yes 17:55:41 INFO - Rotation: Supported 17:55:41 INFO - Return code: 0 17:55:41 INFO - Running post-action listener: _resource_record_post_action 17:55:41 INFO - Running post-run listener: _resource_record_post_run 17:55:42 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 30031360; Write bytes: 703424000; Read time: 299; Write time: 2078 17:55:42 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 387529216; Write bytes: 382611456; Read time: 29921; Write time: 706 17:55:42 INFO - run-tests - Wall time: 1173s; CPU: 52.0%; Read bytes: 30031360; Write bytes: 297924096; Read time: 299; Write time: 1320 17:55:42 INFO - Running post-run listener: _upload_blobber_files 17:55:42 INFO - Blob upload gear active. 17:55:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:55:42 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 17:55:42 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'] 17:55:42 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 17:55:42 INFO - (blobuploader) - INFO - Open directory for files ... 17:55:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:55:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:55:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:43 INFO - (blobuploader) - INFO - Done attempting. 17:55:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:55:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:55:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:55:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:55:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:55:44 INFO - (blobuploader) - INFO - Done attempting. 17:55:44 INFO - (blobuploader) - INFO - Iteration through files over. 17:55:44 INFO - Return code: 0 17:55:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:55:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:55:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0bb1c9efddeee53f3dade77b32a816c003f3890dc62291296a24c029acaebda24a049e97165a09bf3046d8042a88656c7bf42e010d93b9aae56b53a35b21986", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2209ad3e88b4ab98760762bc388f774db44c5c9e9eb7d93ccbabf2ddee30ad640821b2b9a72ef4846ddefbed16b4781490f3c8a3c8dd24a612f89521ba34aa60"} 17:55:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:55:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:55:44 INFO - Contents: 17:55:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0bb1c9efddeee53f3dade77b32a816c003f3890dc62291296a24c029acaebda24a049e97165a09bf3046d8042a88656c7bf42e010d93b9aae56b53a35b21986", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2209ad3e88b4ab98760762bc388f774db44c5c9e9eb7d93ccbabf2ddee30ad640821b2b9a72ef4846ddefbed16b4781490f3c8a3c8dd24a612f89521ba34aa60"} 17:55:44 INFO - Running post-run listener: copy_logs_to_upload_dir 17:55:44 INFO - Copying logs to upload dir... 17:55:44 INFO - mkdir: /builds/slave/test/build/upload/logs 17:55:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.833195 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-04-01 17:55:44.795850) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 17:55:44.800687) ========= 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.GzmEuSvN1j/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.m5shcTkPMj/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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/e0bb1c9efddeee53f3dade77b32a816c003f3890dc62291296a24c029acaebda24a049e97165a09bf3046d8042a88656c7bf42e010d93b9aae56b53a35b21986", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2209ad3e88b4ab98760762bc388f774db44c5c9e9eb7d93ccbabf2ddee30ad640821b2b9a72ef4846ddefbed16b4781490f3c8a3c8dd24a612f89521ba34aa60"} build_url:https://queue.taskcluster.net/v1/task/Mnn2OakLT2mzbVZaOEGIYw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011057 build_url: 'https://queue.taskcluster.net/v1/task/Mnn2OakLT2mzbVZaOEGIYw/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/e0bb1c9efddeee53f3dade77b32a816c003f3890dc62291296a24c029acaebda24a049e97165a09bf3046d8042a88656c7bf42e010d93b9aae56b53a35b21986", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2209ad3e88b4ab98760762bc388f774db44c5c9e9eb7d93ccbabf2ddee30ad640821b2b9a72ef4846ddefbed16b4781490f3c8a3c8dd24a612f89521ba34aa60"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 17:55:44.831212) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:55:44.834528) ========= 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.GzmEuSvN1j/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.m5shcTkPMj/Listeners TMPDIR=/var/folders/4s/k3nh3fqd501g1sztrgh4qx9000000w/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.004801 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:55:44.886006) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 17:55:44.886297) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 17:55:44.886667) ========= ========= Total master_lag: 7.77 =========