builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0023 starttime: 1457430479.92 results: success (0) buildid: 20160307110830 builduid: 3d893880bf6946649cd91a0559a56e1e revision: a06ac8e3220a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:59.923600) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:59.924213) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 01:47:59.924519) ========= 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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005631 basedir: '/builds/slave/test' ========= master_lag: 0.24 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:00.167152) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:00.167464) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:00.654192) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:00.654578) ========= 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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005897 ========= master_lag: 0.35 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:01.009316) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:01.009620) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:01.010026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:01.012297) ========= 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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-08 01:48:01-- 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% 15.6M=0.001s 2016-03-08 01:48:01 (15.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.222667 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:01.371340) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:01.371668) ========= 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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.027309 ========= master_lag: 0.23 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:01.633533) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-08 01:48:01.634097) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a06ac8e3220a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a06ac8e3220a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u8nDXjhjKs/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.RkGxTJOe3c/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-08 01:48:01,760 Setting DEBUG logging. 2016-03-08 01:48:01,760 attempt 1/10 2016-03-08 01:48:01,760 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a06ac8e3220a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-08 01:48:03,849 unpacking tar archive at: mozilla-aurora-a06ac8e3220a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.335736 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-08 01:48:04.110064) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:04.110457) ========= echo a06ac8e3220a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'a06ac8e3220a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u8nDXjhjKs/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.RkGxTJOe3c/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 a06ac8e3220a program finished with exit code 0 elapsedTime=0.005983 script_repo_revision: 'a06ac8e3220a' ========= master_lag: 0.30 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:04.416360) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:04.416669) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-08 01:48:04.969734) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-08 01:48:04.970130) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u8nDXjhjKs/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.RkGxTJOe3c/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 01:48:05 INFO - MultiFileLogger online at 20160308 01:48:05 in /builds/slave/test 01:48:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:48:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:48:05 INFO - {'append_to_log': False, 01:48:05 INFO - 'base_work_dir': '/builds/slave/test', 01:48:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:48:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:48:05 INFO - 'branch': 'Mozilla-Aurora', 01:48:05 INFO - 'buildbot_json_path': 'buildprops.json', 01:48:05 INFO - 'config_files': ('talos/mac_config.py',), 01:48:05 INFO - 'default_actions': ('clobber', 01:48:05 INFO - 'read-buildbot-config', 01:48:05 INFO - 'download-and-extract', 01:48:05 INFO - 'populate-webroot', 01:48:05 INFO - 'create-virtualenv', 01:48:05 INFO - 'install', 01:48:05 INFO - 'run-tests'), 01:48:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:48:05 INFO - 'download_minidump_stackwalk': True, 01:48:05 INFO - 'download_symbols': 'ondemand', 01:48:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:48:05 INFO - 'tooltool.py': '/tools/tooltool.py', 01:48:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:48:05 INFO - '/tools/misc-python/virtualenv.py')}, 01:48:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:48:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:48:05 INFO - 'installer_path': 'installer.exe', 01:48:05 INFO - 'log_level': 'info', 01:48:05 INFO - 'log_name': 'talos', 01:48:05 INFO - 'log_to_console': True, 01:48:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:48:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:48:05 INFO - 'opt_config_files': (), 01:48:05 INFO - 'pip_index': False, 01:48:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:48:05 INFO - 'cmd': ('bash', 01:48:05 INFO - '-c', 01:48:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:48:05 INFO - 'enabled': True, 01:48:05 INFO - 'halt_on_failure': False, 01:48:05 INFO - 'name': 'check_screen_resolution'},), 01:48:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:48:05 INFO - 'cmd': ('bash', 01:48:05 INFO - '-c', 01:48:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:48:05 INFO - 'enabled': True, 01:48:05 INFO - 'halt_on_failure': False, 01:48:05 INFO - 'name': 'check_screen_resolution'},), 01:48:05 INFO - 'run_cmd_checks_enabled': True, 01:48:05 INFO - 'sps_profile': False, 01:48:05 INFO - 'sps_profile_interval': 0, 01:48:05 INFO - 'suite': 'dromaeojs-e10s', 01:48:05 INFO - 'system_bits': '32', 01:48:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:48:05 INFO - 'title': 't-yosemite-r7-0023', 01:48:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:48:05 INFO - 'use_talos_json': True, 01:48:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:48:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:48:05 INFO - 'work_dir': 'build'} 01:48:05 INFO - ##### 01:48:05 INFO - ##### Running clobber step. 01:48:05 INFO - ##### 01:48:05 INFO - Running pre-action listener: _resource_record_pre_action 01:48:05 INFO - Running main action method: clobber 01:48:05 INFO - rmtree: /builds/slave/test/build 01:48:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:48:06 INFO - Running post-action listener: _resource_record_post_action 01:48:06 INFO - ##### 01:48:06 INFO - ##### Running read-buildbot-config step. 01:48:06 INFO - ##### 01:48:06 INFO - Running pre-action listener: _resource_record_pre_action 01:48:06 INFO - Running main action method: read_buildbot_config 01:48:06 INFO - Using buildbot properties: 01:48:06 INFO - { 01:48:06 INFO - "project": "", 01:48:06 INFO - "product": "firefox", 01:48:06 INFO - "script_repo_revision": "production", 01:48:06 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 01:48:06 INFO - "repository": "", 01:48:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 01:48:06 INFO - "buildid": "20160307110830", 01:48:06 INFO - "pgo_build": "False", 01:48:06 INFO - "basedir": "/builds/slave/test", 01:48:06 INFO - "buildnumber": 190, 01:48:06 INFO - "slavename": "t-yosemite-r7-0023", 01:48:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 01:48:06 INFO - "platform": "yosemite_r7", 01:48:06 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:48:06 INFO - "branch": "mozilla-aurora", 01:48:06 INFO - "repo_path": "releases/mozilla-aurora", 01:48:06 INFO - "revision": "a06ac8e3220a", 01:48:06 INFO - "stage_platform": "macosx64", 01:48:06 INFO - "builduid": "3d893880bf6946649cd91a0559a56e1e", 01:48:06 INFO - "slavebuilddir": "test" 01:48:06 INFO - } 01:48:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 01:48:06 INFO - Running post-action listener: _resource_record_post_action 01:48:06 INFO - ##### 01:48:06 INFO - ##### Running download-and-extract step. 01:48:06 INFO - ##### 01:48:06 INFO - Running pre-action listener: _resource_record_pre_action 01:48:06 INFO - Running main action method: download_and_extract 01:48:06 INFO - mkdir: /builds/slave/test/build/tests 01:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:06 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:48:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 01:48:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json 01:48:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 01:48:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json'}, attempt #1 01:48:10 INFO - Downloaded 1277 bytes. 01:48:10 INFO - Reading from file /builds/slave/test/build/firefox-47.0a1.en-US.mac.test_packages.json 01:48:10 INFO - Using the following test package requirements: 01:48:10 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:48:10 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:10 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 01:48:10 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:10 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 01:48:10 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:10 INFO - u'jsshell-mac.zip'], 01:48:10 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:10 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 01:48:10 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:48:10 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:10 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 01:48:10 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:10 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 01:48:10 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:10 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 01:48:10 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 01:48:10 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 01:48:10 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 01:48:10 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:48: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')]} 01:48:10 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:48:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:48:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:48:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:48:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:48:11 INFO - Downloaded 17859094 bytes. 01:48:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:48:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:48:14 INFO - Return code: 0 01:48:14 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:48:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:14 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:48:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:48:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:48:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 01:48:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:48:16 INFO - Downloaded 17859094 bytes. 01:48:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:48:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:48:20 INFO - Return code: 0 01:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:20 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:48:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:48:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:48:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 01:48:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:48:21 INFO - Downloaded 10803659 bytes. 01:48:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:48:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:48:21 INFO - Return code: 0 01:48:21 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')]} 01:48:21 INFO - https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:48:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:48:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:48:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 01:48:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 01:48:24 INFO - Downloaded 110928407 bytes. 01:48:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:48:24 INFO - mkdir: /builds/slave/test/properties 01:48:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:48:24 INFO - Writing to file /builds/slave/test/properties/build_url 01:48:24 INFO - Contents: 01:48:24 INFO - build_url:https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 01:48:25 INFO - Running post-action listener: _resource_record_post_action 01:48:25 INFO - Running post-action listener: set_extra_try_arguments 01:48:25 INFO - ##### 01:48:25 INFO - ##### Running populate-webroot step. 01:48:25 INFO - ##### 01:48:25 INFO - Running pre-action listener: _resource_record_pre_action 01:48:25 INFO - Running main action method: populate_webroot 01:48:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:48:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:48:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:48:25 INFO - '--tppagecycles', 01:48:25 INFO - '7'], 01:48:25 INFO - 'tests': ['tsvgm']}}, 01:48:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:48:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:48:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:48:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 01:48:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:48:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:48:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:48:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:25 INFO - 'talos_options': ['--e10s'], 01:48:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:48:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:25 INFO - 'tests': ['damp', 'tps']}, 01:48:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:25 INFO - 'talos_options': ['--e10s'], 01:48:25 INFO - 'tests': ['damp', 'tps']}, 01:48:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:48:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:48:25 INFO - 'other': {'tests': ['a11yr', 01:48:25 INFO - 'ts_paint', 01:48:25 INFO - 'tpaint', 01:48:25 INFO - 'sessionrestore', 01:48:25 INFO - 'sessionrestore_no_auto_restore']}, 01:48:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:48:25 INFO - 'tests': ['a11yr', 01:48:25 INFO - 'ts_paint', 01:48:25 INFO - 'tpaint', 01:48:25 INFO - 'sessionrestore', 01:48:25 INFO - 'sessionrestore_no_auto_restore']}, 01:48:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:48:25 INFO - 'tests': ['a11yr', 01:48:25 INFO - 'ts_paint', 01:48:25 INFO - 'tpaint', 01:48:25 INFO - 'sessionrestore', 01:48:25 INFO - 'sessionrestore_no_auto_restore']}, 01:48:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:48:25 INFO - 'tests': ['a11yr', 01:48:25 INFO - 'ts_paint', 01:48:25 INFO - 'tpaint', 01:48:25 INFO - 'sessionrestore', 01:48:25 INFO - 'sessionrestore_no_auto_restore']}, 01:48:25 INFO - 'other_l64': {'tests': ['a11yr', 01:48:25 INFO - 'ts_paint', 01:48:25 INFO - 'tpaint', 01:48:25 INFO - 'sessionrestore', 01:48:25 INFO - 'sessionrestore_no_auto_restore']}, 01:48:25 INFO - 'other_nol64': {'tests': ['a11yr', 01:48:25 INFO - 'ts_paint', 01:48:25 INFO - 'tpaint', 01:48:25 INFO - 'sessionrestore', 01:48:25 INFO - 'sessionrestore_no_auto_restore']}, 01:48:25 INFO - 'svgr': {'tests': ['tsvgx', 01:48:25 INFO - 'tsvgr_opacity', 01:48:25 INFO - 'tart', 01:48:25 INFO - 'tscrollx', 01:48:25 INFO - 'cart']}, 01:48:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:48:25 INFO - 'tests': ['tsvgx', 01:48:25 INFO - 'tsvgr_opacity', 01:48:25 INFO - 'tart', 01:48:25 INFO - 'tscrollx', 01:48:25 INFO - 'cart']}, 01:48:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:25 INFO - 'tests': ['tp5o']}, 01:48:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:25 INFO - 'talos_options': ['--e10s'], 01:48:25 INFO - 'tests': ['tp5o']}, 01:48:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:25 INFO - 'talos_options': ['--xperf_path', 01:48:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:48:25 INFO - 'tests': ['tp5n']}, 01:48:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:48:25 INFO - 'talos_options': ['--e10s', 01:48:25 INFO - '--xperf_path', 01:48:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:48:25 INFO - 'tests': ['tp5n']}}, 01:48:25 INFO - 'talos.zip': {'path': '', 01:48:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:48:25 INFO - Running post-action listener: _resource_record_post_action 01:48:25 INFO - ##### 01:48:25 INFO - ##### Running create-virtualenv step. 01:48:25 INFO - ##### 01:48:25 INFO - Running pre-action listener: _resource_record_pre_action 01:48:25 INFO - Running main action method: create_virtualenv 01:48:25 INFO - Creating virtualenv /builds/slave/test/build/venv 01:48:25 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 01:48:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:48:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:48:26 INFO - Using real prefix '/tools/python27' 01:48:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:48:26 INFO - Installing distribute.............................................................................................................................................................................................done. 01:48:29 INFO - Installing pip.................done. 01:48:29 INFO - Return code: 0 01:48:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:48:29 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')]} 01:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:29 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')]} 01:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:29 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 0x106877a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f05b28a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10671bd30>, '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 0x10657fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106712b20>, '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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 01:48:29 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 01:48:29 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 01:48:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u8nDXjhjKs/Render', 01:48:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:29 INFO - 'HOME': '/Users/cltbld', 01:48:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:29 INFO - 'LOGNAME': 'cltbld', 01:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:29 INFO - 'MOZ_NO_REMOTE': '1', 01:48:29 INFO - 'NO_EM_RESTART': '1', 01:48:29 INFO - 'PAGER': '/bin/cat', 01:48:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:29 INFO - 'PWD': '/builds/slave/test', 01:48:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:29 INFO - 'SHELL': '/bin/bash', 01:48:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RkGxTJOe3c/Listeners', 01:48:29 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 01:48:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:29 INFO - 'USER': 'cltbld', 01:48:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:29 INFO - 'XPC_FLAGS': '0x0', 01:48:29 INFO - 'XPC_SERVICE_NAME': '0', 01:48:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:29 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 01:48:29 INFO - Cleaning up... 01:48:29 INFO - Return code: 0 01:48:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:48:29 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')]} 01:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:29 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')]} 01:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:29 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 0x106877a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f05b28a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10671bd30>, '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 0x10657fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106712b20>, '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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 01:48:29 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 01:48:29 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 01:48:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u8nDXjhjKs/Render', 01:48:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:29 INFO - 'HOME': '/Users/cltbld', 01:48:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:29 INFO - 'LOGNAME': 'cltbld', 01:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:29 INFO - 'MOZ_NO_REMOTE': '1', 01:48:29 INFO - 'NO_EM_RESTART': '1', 01:48:29 INFO - 'PAGER': '/bin/cat', 01:48:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:29 INFO - 'PWD': '/builds/slave/test', 01:48:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:29 INFO - 'SHELL': '/bin/bash', 01:48:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RkGxTJOe3c/Listeners', 01:48:29 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 01:48:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:29 INFO - 'USER': 'cltbld', 01:48:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:29 INFO - 'XPC_FLAGS': '0x0', 01:48:29 INFO - 'XPC_SERVICE_NAME': '0', 01:48:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:30 INFO - Downloading/unpacking psutil>=0.7.1 01:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:48:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:48:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:48:34 INFO - Installing collected packages: psutil 01:48:34 INFO - Running setup.py install for psutil 01:48:34 INFO - building 'psutil._psutil_osx' extension 01:48:34 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 01:48:34 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 01:48:34 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 01:48:34 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 01:48:35 INFO - building 'psutil._psutil_posix' extension 01:48:35 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 01:48:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:48:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:48:35 INFO - ^ 01:48:35 INFO - 1 warning generated. 01:48:35 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 01:48:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:48:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:48:35 INFO - Successfully installed psutil 01:48:35 INFO - Cleaning up... 01:48:35 INFO - Return code: 0 01:48:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:35 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 0x106877a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f05b28a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10671bd30>, '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 0x10657fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106712b20>, '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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 01:48:35 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 01:48:35 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 01:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u8nDXjhjKs/Render', 01:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:35 INFO - 'HOME': '/Users/cltbld', 01:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:35 INFO - 'LOGNAME': 'cltbld', 01:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:35 INFO - 'MOZ_NO_REMOTE': '1', 01:48:35 INFO - 'NO_EM_RESTART': '1', 01:48:35 INFO - 'PAGER': '/bin/cat', 01:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:35 INFO - 'PWD': '/builds/slave/test', 01:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:35 INFO - 'SHELL': '/bin/bash', 01:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RkGxTJOe3c/Listeners', 01:48:35 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 01:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:35 INFO - 'USER': 'cltbld', 01:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:35 INFO - 'XPC_FLAGS': '0x0', 01:48:35 INFO - 'XPC_SERVICE_NAME': '0', 01:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:48:35 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 01:48:35 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 01:48:35 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 01:48:35 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 01:48:35 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 01:48:35 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 01:48:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:48:38 INFO - Installing collected packages: mozsystemmonitor 01:48:38 INFO - Running setup.py install for mozsystemmonitor 01:48:38 INFO - Successfully installed mozsystemmonitor 01:48:38 INFO - Cleaning up... 01:48:38 INFO - Return code: 0 01:48:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:48:38 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')]} 01:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:38 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')]} 01:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:38 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 0x106877a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f05b28a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10671bd30>, '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 0x10657fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106712b20>, '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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 01:48:38 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 01:48:38 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 01:48:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u8nDXjhjKs/Render', 01:48:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:38 INFO - 'HOME': '/Users/cltbld', 01:48:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:38 INFO - 'LOGNAME': 'cltbld', 01:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:38 INFO - 'MOZ_NO_REMOTE': '1', 01:48:38 INFO - 'NO_EM_RESTART': '1', 01:48:38 INFO - 'PAGER': '/bin/cat', 01:48:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:38 INFO - 'PWD': '/builds/slave/test', 01:48:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:38 INFO - 'SHELL': '/bin/bash', 01:48:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RkGxTJOe3c/Listeners', 01:48:38 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 01:48:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:38 INFO - 'USER': 'cltbld', 01:48:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:38 INFO - 'XPC_FLAGS': '0x0', 01:48:38 INFO - 'XPC_SERVICE_NAME': '0', 01:48:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:38 INFO - Downloading/unpacking blobuploader==1.2.4 01:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:39 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 01:48:41 INFO - Downloading blobuploader-1.2.4.tar.gz 01:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:48:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:48:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:42 INFO - Downloading docopt-0.6.1.tar.gz 01:48:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:48:42 INFO - Installing collected packages: blobuploader, requests, docopt 01:48:42 INFO - Running setup.py install for blobuploader 01:48:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:48:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:48:42 INFO - Running setup.py install for requests 01:48:43 INFO - Running setup.py install for docopt 01:48:43 INFO - Successfully installed blobuploader requests docopt 01:48:43 INFO - Cleaning up... 01:48:43 INFO - Return code: 0 01:48:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:43 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')]} 01:48:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:43 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')]} 01:48:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:43 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 0x106877a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f05b28a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10671bd30>, '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 0x10657fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106712b20>, '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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 01:48:43 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 01:48:43 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 01:48:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u8nDXjhjKs/Render', 01:48:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:43 INFO - 'HOME': '/Users/cltbld', 01:48:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:43 INFO - 'LOGNAME': 'cltbld', 01:48:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:43 INFO - 'MOZ_NO_REMOTE': '1', 01:48:43 INFO - 'NO_EM_RESTART': '1', 01:48:43 INFO - 'PAGER': '/bin/cat', 01:48:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:43 INFO - 'PWD': '/builds/slave/test', 01:48:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:43 INFO - 'SHELL': '/bin/bash', 01:48:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RkGxTJOe3c/Listeners', 01:48:43 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 01:48:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:43 INFO - 'USER': 'cltbld', 01:48:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:43 INFO - 'XPC_FLAGS': '0x0', 01:48:43 INFO - 'XPC_SERVICE_NAME': '0', 01:48:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:48:43 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-2J6Mc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:48:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-I25Jf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:48:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-QnTf7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:48:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-7pRAbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:48:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Zk6gRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:48:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ZXYc8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:48:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-DD8uN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:48:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-VhrTXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:48:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-HhIPQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:48:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-jom0HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:48:44 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-ETix7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:48:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Cg5mE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:48:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-3eO0QN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:48:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-cino6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-aP2aFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:48:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-eZM3mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:48:45 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-7V0TU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:48:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:48:45 INFO - Running setup.py install for manifestparser 01:48:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:48:45 INFO - Running setup.py install for mozcrash 01:48:45 INFO - Running setup.py install for mozdebug 01:48:46 INFO - Running setup.py install for mozdevice 01:48:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:48:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:48:46 INFO - Running setup.py install for mozfile 01:48:46 INFO - Running setup.py install for mozhttpd 01:48:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:48:46 INFO - Running setup.py install for mozinfo 01:48:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:48:46 INFO - Running setup.py install for mozInstall 01:48:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:48:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:48:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:48:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:48:46 INFO - Running setup.py install for mozleak 01:48:46 INFO - Running setup.py install for mozlog 01:48:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:48:47 INFO - Running setup.py install for moznetwork 01:48:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:48:47 INFO - Running setup.py install for mozprocess 01:48:47 INFO - Running setup.py install for mozprofile 01:48:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:48:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:48:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:48:47 INFO - Running setup.py install for mozrunner 01:48:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:48:47 INFO - Running setup.py install for mozscreenshot 01:48:47 INFO - Running setup.py install for moztest 01:48:48 INFO - Running setup.py install for mozversion 01:48:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:48:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:48:48 INFO - Cleaning up... 01:48:48 INFO - Return code: 0 01:48:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:48 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 0x106877a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f05b28a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10671bd30>, '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 0x10657fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106712b20>, '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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 01:48:48 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 01:48:48 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 01:48:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u8nDXjhjKs/Render', 01:48:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:48 INFO - 'HOME': '/Users/cltbld', 01:48:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:48 INFO - 'LOGNAME': 'cltbld', 01:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:48 INFO - 'MOZ_NO_REMOTE': '1', 01:48:48 INFO - 'NO_EM_RESTART': '1', 01:48:48 INFO - 'PAGER': '/bin/cat', 01:48:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:48 INFO - 'PWD': '/builds/slave/test', 01:48:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:48 INFO - 'SHELL': '/bin/bash', 01:48:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RkGxTJOe3c/Listeners', 01:48:48 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 01:48:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:48 INFO - 'USER': 'cltbld', 01:48:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:48 INFO - 'XPC_FLAGS': '0x0', 01:48:48 INFO - 'XPC_SERVICE_NAME': '0', 01:48:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:48:48 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Yhnu7S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:48:48 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)) 01:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:48:48 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-PXLPDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:48:48 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)) 01:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:48:48 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-xRlxuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:48:48 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)) 01:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:48:48 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-pfvD0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:48:48 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)) 01:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:48:48 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-zy1V_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:48:49 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)) 01:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:48:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-uqWO2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:48:49 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)) 01:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:48:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-mYAqXd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:48:49 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)) 01:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:48:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-69o88d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:48:49 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)) 01:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:48:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-pnYjik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:48:49 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)) 01:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:48:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-5iewSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:48:49 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)) 01:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:48:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-hsOGn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:48:49 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)) 01:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:48:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-o0ohjv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:48:49 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)) 01:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:48:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Z_W9Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:48:49 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)) 01:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:48:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-NciY03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:48:49 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)) 01:48:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:49 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-coE_YV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:48:50 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)) 01:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:48:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-Zv7mqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:48:50 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)) 01:48:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:48:50 INFO - Running setup.py (path:/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/pip-TzsT6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:48:50 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)) 01:48:50 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)) 01:48:50 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)) 01:48:50 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)) 01:48:50 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)) 01:48:50 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)) 01:48:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:48:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:48:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:48:52 INFO - Downloading blessings-1.6.tar.gz 01:48:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:48:52 INFO - Installing collected packages: blessings 01:48:52 INFO - Running setup.py install for blessings 01:48:52 INFO - Successfully installed blessings 01:48:52 INFO - Cleaning up... 01:48:52 INFO - Return code: 0 01:48:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:48:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:48:53 INFO - Reading from file tmpfile_stdout 01:48:53 INFO - Current package versions: 01:48:53 INFO - blessings == 1.6 01:48:53 INFO - blobuploader == 1.2.4 01:48:53 INFO - docopt == 0.6.1 01:48:53 INFO - manifestparser == 1.1 01:48:53 INFO - mozInstall == 1.12 01:48:53 INFO - mozcrash == 0.17 01:48:53 INFO - mozdebug == 0.1 01:48:53 INFO - mozdevice == 0.48 01:48:53 INFO - mozfile == 1.2 01:48:53 INFO - mozhttpd == 0.7 01:48:53 INFO - mozinfo == 0.9 01:48:53 INFO - mozleak == 0.1 01:48:53 INFO - mozlog == 3.1 01:48:53 INFO - moznetwork == 0.27 01:48:53 INFO - mozprocess == 0.22 01:48:53 INFO - mozprofile == 0.28 01:48:53 INFO - mozrunner == 6.11 01:48:53 INFO - mozscreenshot == 0.1 01:48:53 INFO - mozsystemmonitor == 0.0 01:48:53 INFO - moztest == 0.7 01:48:53 INFO - mozversion == 1.4 01:48:53 INFO - psutil == 3.1.1 01:48:53 INFO - requests == 1.2.3 01:48:53 INFO - wsgiref == 0.1.2 01:48:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:48:53 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')]} 01:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:53 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')]} 01:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:53 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 0x106877a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f05b28a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10671bd30>, '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 0x10657fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106712b20>, '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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 01:48:53 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 01:48:53 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 01:48:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u8nDXjhjKs/Render', 01:48:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:53 INFO - 'HOME': '/Users/cltbld', 01:48:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:53 INFO - 'LOGNAME': 'cltbld', 01:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:53 INFO - 'MOZ_NO_REMOTE': '1', 01:48:53 INFO - 'NO_EM_RESTART': '1', 01:48:53 INFO - 'PAGER': '/bin/cat', 01:48:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:53 INFO - 'PWD': '/builds/slave/test', 01:48:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:53 INFO - 'SHELL': '/bin/bash', 01:48:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RkGxTJOe3c/Listeners', 01:48:53 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 01:48:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:53 INFO - 'USER': 'cltbld', 01:48:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:53 INFO - 'XPC_FLAGS': '0x0', 01:48:53 INFO - 'XPC_SERVICE_NAME': '0', 01:48:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:53 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)) 01:48:53 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)) 01:48:53 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)) 01:48:53 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)) 01:48:53 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)) 01:48:53 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)) 01:48:53 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)) 01:48:53 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)) 01:48:53 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)) 01:48:53 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)) 01:48:53 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)) 01:48:53 INFO - Cleaning up... 01:48:53 INFO - Return code: 0 01:48:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:48:53 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')]} 01:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:53 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')]} 01:48:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:53 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 0x106877a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f05b28a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10671bd30>, '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 0x10657fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106712b20>, '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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 01:48:53 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 01:48:53 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 01:48:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u8nDXjhjKs/Render', 01:48:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:53 INFO - 'HOME': '/Users/cltbld', 01:48:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:53 INFO - 'LOGNAME': 'cltbld', 01:48:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:53 INFO - 'MOZ_NO_REMOTE': '1', 01:48:53 INFO - 'NO_EM_RESTART': '1', 01:48:53 INFO - 'PAGER': '/bin/cat', 01:48:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:53 INFO - 'PWD': '/builds/slave/test', 01:48:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:53 INFO - 'SHELL': '/bin/bash', 01:48:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RkGxTJOe3c/Listeners', 01:48:53 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 01:48:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:53 INFO - 'USER': 'cltbld', 01:48:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:53 INFO - 'XPC_FLAGS': '0x0', 01:48:53 INFO - 'XPC_SERVICE_NAME': '0', 01:48:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:54 INFO - Downloading/unpacking jsonschema 01:48:54 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 01:48:54 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 01:48:54 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 01:48:54 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 01:48:54 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 01:48:54 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 01:48:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:48:56 INFO - Downloading/unpacking functools32 (from jsonschema) 01:48:56 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 01:48:56 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 01:48:56 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 01:48:56 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 01:48:56 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 01:48:56 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 01:48:57 INFO - Downloading functools32-3.2.3-2.tar.gz 01:48:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:48:57 INFO - warning: no files found matching '*.txt' 01:48:57 INFO - no previously-included directories found matching 'build' 01:48:57 INFO - no previously-included directories found matching 'dist' 01:48:57 INFO - no previously-included directories found matching '.git*' 01:48:57 INFO - Installing collected packages: jsonschema, functools32 01:48:57 INFO - Running setup.py install for functools32 01:48:57 INFO - warning: no files found matching '*.txt' 01:48:57 INFO - no previously-included directories found matching 'build' 01:48:57 INFO - no previously-included directories found matching 'dist' 01:48:57 INFO - no previously-included directories found matching '.git*' 01:48:57 INFO - Successfully installed jsonschema functools32 01:48:57 INFO - Cleaning up... 01:48:57 INFO - Return code: 0 01:48:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:48:57 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')]} 01:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:48:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:57 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')]} 01:48:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:48:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:48:57 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 0x106877a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3f05b28a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10671bd30>, '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 0x10657fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106712b20>, '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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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 01:48:57 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 01:48:57 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 01:48:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u8nDXjhjKs/Render', 01:48:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:48:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:48:57 INFO - 'HOME': '/Users/cltbld', 01:48:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:48:57 INFO - 'LOGNAME': 'cltbld', 01:48:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:48:57 INFO - 'MOZ_NO_REMOTE': '1', 01:48:57 INFO - 'NO_EM_RESTART': '1', 01:48:57 INFO - 'PAGER': '/bin/cat', 01:48:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:48:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:48:57 INFO - 'PWD': '/builds/slave/test', 01:48:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:48:57 INFO - 'SHELL': '/bin/bash', 01:48:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RkGxTJOe3c/Listeners', 01:48:57 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 01:48:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:48:57 INFO - 'USER': 'cltbld', 01:48:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:48:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:48:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:48:57 INFO - 'XPC_FLAGS': '0x0', 01:48:57 INFO - 'XPC_SERVICE_NAME': '0', 01:48:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:48:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:48:57 INFO - Downloading/unpacking flake8 01:48:57 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 01:48:57 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 01:48:57 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 01:48:57 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 01:48:57 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 01:48:57 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 01:49:00 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:49:00 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:49:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 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 01:49:00 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 01:49:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:49:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:49:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:49:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:49:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:49:01 INFO - no previously-included directories found matching 'docs/_build' 01:49:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:49:01 INFO - Running setup.py install for pep8 01:49:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:49:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:49:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:49:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:49:01 INFO - no previously-included directories found matching 'docs/_build' 01:49:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:49:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:49:01 INFO - Cleaning up... 01:49:01 INFO - Return code: 0 01:49:01 INFO - Running post-action listener: _resource_record_post_action 01:49:01 INFO - Running post-action listener: _start_resource_monitoring 01:49:01 INFO - Starting resource monitoring. 01:49:01 INFO - ##### 01:49:01 INFO - ##### Running install step. 01:49:01 INFO - ##### 01:49:01 INFO - Running pre-action listener: _resource_record_pre_action 01:49:01 INFO - Running main action method: install 01:49:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:49:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:49:02 INFO - Reading from file tmpfile_stdout 01:49:02 INFO - Detecting whether we're running mozinstall >=1.0... 01:49:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:49:02 INFO - Reading from file tmpfile_stdout 01:49:02 INFO - Output received: 01:49:02 INFO - Usage: mozinstall [options] installer 01:49:02 INFO - Options: 01:49:02 INFO - -h, --help show this help message and exit 01:49:02 INFO - -d DEST, --destination=DEST 01:49:02 INFO - Directory to install application into. [default: 01:49:02 INFO - "/builds/slave/test"] 01:49:02 INFO - --app=APP Application being installed. [default: firefox] 01:49:02 INFO - mkdir: /builds/slave/test/build/application 01:49:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:49:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:49:36 INFO - Reading from file tmpfile_stdout 01:49:36 INFO - Output received: 01:49:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:49:36 INFO - Running post-action listener: _resource_record_post_action 01:49:36 INFO - ##### 01:49:36 INFO - ##### Running run-tests step. 01:49:36 INFO - ##### 01:49:36 INFO - Running pre-action listener: _resource_record_pre_action 01:49:36 INFO - Running main action method: run_tests 01:49:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:49:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:49:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:49:36 INFO - 2016-03-08 01:49:36.535 screenresolution[1641:7508] starting screenresolution argv=screenresolution get 01:49:36 INFO - 2016-03-08 01:49:36.537 screenresolution[1641:7508] Display 0: 1600x1200x32@60 01:49:36 INFO - 2016-03-08 01:49:36.543 screenresolution[1642:7510] starting screenresolution argv=screenresolution list 01:49:36 INFO - Available Modes on Display 0 01:49:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:49:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:49:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:49:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:49:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:49:36 INFO - Intel Iris: 01:49:36 INFO - Chipset Model: Intel Iris 01:49:36 INFO - Type: GPU 01:49:36 INFO - Bus: Built-In 01:49:36 INFO - VRAM (Dynamic, Max): 1536 MB 01:49:36 INFO - Vendor: Intel (0x8086) 01:49:36 INFO - Device ID: 0x0a2e 01:49:36 INFO - Revision ID: 0x0009 01:49:36 INFO - Displays: 01:49:36 INFO - Display: 01:49:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:49:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:49:36 INFO - Display Serial Number: 1600x1200 60 01:49:36 INFO - Main Display: Yes 01:49:36 INFO - Mirror: Off 01:49:36 INFO - Online: Yes 01:49:36 INFO - Rotation: Supported 01:49:36 INFO - Return code: 0 01:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:49:36 INFO - Python 2.7.3 01:49:36 INFO - Return code: 0 01:49:36 INFO - grabbing minidump binary from tooltool 01:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:49:36 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 0x10671bd30>, '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 0x10657fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106712b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:49:36 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 01:49:36 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 01:49:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:49:36 INFO - Return code: 0 01:49:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:49:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:49:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:49:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:49:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:49:38 INFO - Return code: 0 01:49:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:49:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0023 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:49:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u8nDXjhjKs/Render', 01:49:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:49:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:49:38 INFO - 'HOME': '/Users/cltbld', 01:49:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:49:38 INFO - 'LOGNAME': 'cltbld', 01:49:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:49:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:49:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:49:38 INFO - 'MOZ_NO_REMOTE': '1', 01:49:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:49:38 INFO - 'NO_EM_RESTART': '1', 01:49:38 INFO - 'PAGER': '/bin/cat', 01:49:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:49:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:49:38 INFO - 'PWD': '/builds/slave/test', 01:49:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:49:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:49:38 INFO - 'SHELL': '/bin/bash', 01:49:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RkGxTJOe3c/Listeners', 01:49:38 INFO - 'TMPDIR': '/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/', 01:49:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:49:38 INFO - 'USER': 'cltbld', 01:49:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:49:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:49:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:49:38 INFO - 'XPC_FLAGS': '0x0', 01:49:38 INFO - 'XPC_SERVICE_NAME': '0', 01:49:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:49:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0023', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:49:38 INFO - mozversion application_buildid: 20160307110830 01:49:38 INFO - mozversion application_changeset: a06ac8e3220aa7bb49f5b755936078772a2b7464 01:49:38 INFO - mozversion application_display_name: Nightly 01:49:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:49:38 INFO - mozversion application_name: Firefox 01:49:38 INFO - mozversion application_remotingname: firefox 01:49:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:49:38 INFO - mozversion application_vendor: Mozilla 01:49:38 INFO - mozversion application_version: 47.0a1 01:49:38 INFO - mozversion platform_buildid: 20160307110830 01:49:38 INFO - mozversion platform_changeset: a06ac8e3220aa7bb49f5b755936078772a2b7464 01:49:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:49:38 INFO - mozversion platform_version: 47.0a1 01:49:38 INFO - using testdate: 1457430578 01:49:38 INFO - actual date: 1457430578 01:49:38 INFO - starting webserver on 'localhost:49275' 01:49:38 INFO - SUITE-START | Running 2 tests 01:49:38 INFO - TEST-START | dromaeo_css 01:49:38 INFO - operating with platform_type : mac_ 01:49:38 INFO - Initialising browser for dromaeo_css test... 01:49:38 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpmDpBZ2/profile http://localhost:49275/getInfo.html) 01:49:41 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 01:49:41 INFO - PROCESS | 1660 | colorDepth:24 01:49:41 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 01:49:41 INFO - PROCESS | 1660 | __metrics 01:49:41 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 01:49:41 INFO - TEST-INFO | 1660: exit 0 01:49:41 INFO - Browser initialized. 01:49:41 INFO - Running cycle 1/1 for dromaeo_css test... 01:49:41 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpmDpBZ2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:49:53 INFO - PROCESS | 1664 | RSS: Main: 254152704 01:49:53 INFO - PROCESS | 1664 | 01:50:43 INFO - PROCESS | 1664 | 1457430643355 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] 01:52:54 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 01:52:55 INFO - PROCESS | 1664 | RSS: Main: 272113664 01:52:55 INFO - PROCESS | 1664 | 01:55:57 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 01:55:57 INFO - PROCESS | 1664 | RSS: Main: 284606464 01:55:57 INFO - PROCESS | 1664 | 01:58:59 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 01:59:00 INFO - PROCESS | 1664 | RSS: Main: 284782592 01:59:00 INFO - PROCESS | 1664 | 02:02:01 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 02:02:02 INFO - PROCESS | 1664 | RSS: Main: 286072832 02:02:02 INFO - PROCESS | 1664 | 02:05:04 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 02:05:05 INFO - PROCESS | 1664 | RSS: Main: 291143680 02:05:05 INFO - PROCESS | 1664 | 02:08:07 INFO - PROCESS | 1664 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 02:08:08 INFO - PROCESS | 1664 | RSS: Main: 292073472 02:08:08 INFO - PROCESS | 1664 | 02:08:08 INFO - PROCESS | 1664 | __start_tp_report 02:08:08 INFO - PROCESS | 1664 | _x_x_mozilla_page_load 02:08:08 INFO - PROCESS | 1664 | _x_x_mozilla_page_load_details 02:08:08 INFO - PROCESS | 1664 | |i|pagename|runs| 02:08:08 INFO - PROCESS | 1664 | |0;dojo.html;3554.5556805399324;3570.7500474966764;3597.0467826026093;3619.8009109498967;3630.5643322801266;5719.428057194278;5821.767129314822;5894.469497745202;5899.262592175978;5917.467427931485;5809.535237181026;5882.294124705041;5895.263092113486;5958.553108516868;5972.104184372335;5019;5061.974690126544;5210.713410762407;5306.124489459235;5366.195070739382;4882.511748825124;5286.207068939651;5292.867678308054;5329.813456529022;5340.946590534084;4634.606058485033;5128.512791284822;5177.767000484987;5207.297014902978;5305.681659100466;5231.529162375405;5237.895242095175;5246.396664383607;5263.921041184385;5314.681119132864;5109.6167787415725;5183.585313174937;5217.426083130853;5226.529612334908;5248.475152484759;4733.219018861883;5688.402717714663;5701.71491425427;5787.681677507735;5805.896879592864;6181.289151747516;6182.381761823782;6189.473894718954;6193.659348735818;6221.844453888689;6113.4154954094565;6160.168377269056;6222.533310001768;6231.252249730016;6241.750329986795;5978.103284507271;5987.461128498456;5990.041593345044;5994.190784244159;6026.276846778371;6310.9368906311265;6353.841153971188;6363.300036995926;6369.108324834527;6374.649394283359;6120.538559592164;6141.324454310023;6154.753809847556;6189.257289125334;6211.16149319845;6135.294441139237;6156.753729850845;6201.627902325875;6214.223222097238;6222.564420490613;6145.938540614537;6160.722767475474;6199.411055949678;6203.0075187970615;6217.253929528486;6104.550104788525;6125.236813241546;6155.876882462415;6164.630122192682;6228.906566401508;4909.656324057281;4920.384951881015;4926.507349265116;4935.161022626162;4964.950350496449;4406.184855801623;4418.889527761831;4457.465104187453;4481.820727170942;4487.88780280489;5781.739821708034;5801.100829371454;5927.673977931255;5948.583599148018;5954.3152537458745;6198.504119670415;6233.501319894398;6236.937630623726;6255.655938923312;6259.123722678829;5059.747012649353;5886.705664716747;5982.611130276518;5998.25021872266;6007.609505382224;5388.245645609618;5422.91865622016;5465.371482279509;5486.945130548724;5512.5589952803675;5428.4028756836715;6453.580517266457;6472.644004579794;6476.740930362733;6504.178829927628;6097.948168432722;6175.289841668266;6193.4425901669065;6239.282482514569;6253.96873015632;6419.390157934989;6501.4798816095545;6532.5427220096035;6533.901991470037;6539.411452969255;5386.811461598825;6092.725827337692;6165.167702360124;6204.441600255818;6206.875862482815;6129.9701281150365;6165;6244.157038799885;6250.718717657625;6262.561620686508;6101.580494003484;6114.3277820888225;6140.508759299156;6193.287771906108;6198.535109866868;5128.692278463304;6012.939870601238;6108.664023478751;6181;6214.533909956681;5895.29256489224;6003.429674180946;6018.6689732063405;6060.2424696912885;6093.451589356979;6129.083728908156;6141.087130295657;6154.876902461836;6179.969100154471;6213.751449941951;6115.877682446415;6133.233345831771;6133.693315334304;6150.50795936333;6176.042713379434 02:08:08 INFO - PROCESS | 1664 | |1;ext.html;479.5851588376056;601.6750954484579;623.8346838087907;643.6427782580669;646.4602057282169;37115.0721231969;37846.62153378469;37874.8106259469;37925.620743792555;38197.809010954974;39297.803510982405;39721.60278397215;39776.403353949645;39846.00384990377;39948.80025599868;9347.457669484527;9525.5713492893;9537.1893389062;9549.47477888716;9587.952060239724;9377.343585948985;9456.527173641325;9502;9651.80696386072;9669.613215471372;9591.472469014201;9691.321607487478;9703.95148024259;9705.951470242675;9721;9615.61537538501;9635.90364096357;9647.228221742243;9699.806003879918;9712.854307185433;9550.283728720373;9619.038096190325;9633.421994680271;9689.934107248197;9714.90285097147;38499.61500384988;38552.80723596392;38867.41698874519;38902;38903.41644875301;2661.135131082406;3140.9685903140903;3229.7739158258933;3237.704918032806;3504.684578387957;26649;26827.32931676704;26839.865800670872;26986.730132698616;27362.726372736415;2707.147248616699;2748.4640495103463;2757.6139340492346;2759.779217662582;2832.178668186244;334314.3284283587;339410;339703;341490;341490.9999999975;63354.36645633485;64163;64209.03686444707;64311.35688643147;64317.678411607645;74355.25644743483;74370;74451.25548744551;75025;75195.24804751882;17385.304587816598;17411.390601328894;17598.296068157386;17671.558211044827;17684.64630707379;13119.934400327937;13163.47346106145;13241.073124881166;13241.536546220836;13288.003399745057;18574.535636609195;22064.117435302407;22096;22374.77625223727;22382.776172238067;9473.621055157855;9600.423974561409;9608.327417080738;9663.951680241555;9698;941.5715849288695;951.5432592355708;1010.2826992835022;1106.0543235533664;1131.7623299107115;29224.561631575543;29386.706132938398;29662.851685741865;29694.703052969628;29967.700322996927;1044.8537204791335;1105.1103861391657;1108.6640598079296;1162.3607016141088;1205.2166092040245;11950.462229199708;13381.264030478222;15007.624809379853;15134.545963621109;15370.462033828986;476150;530487;531529;532771;541132;57502.42497574971;57691.846163077345;58034.419655803744;58134.8373032537;58150.12774808381;1251.174225011488;1456.978145327821;1472.8232612086404;1491.5525342397239;1496.0799108548165;29110;29110.854445727637;29190.56214156747;29700.851495742383;30401.69598303989;51144.23283650674;51338;51475.742621286656;51713.48286517237;51806.74096629493;482998;491830;494462;500039;500087;33001.339973200884;33041.66958330386;33486.832565837016;33639.495407568415;33883.66116338805;44928.87677808081;45070.549294506636;45132.32301515545;46555;46569.76715116403;36110.4583431254;37627.87116386513;37736.62263377441;38069.619303806605;38388.42417363798;36375.90872273836;36606.816965915;36931.44602830906;37034.88895333144;37740.43389349217;36923.26153476969;36931.446028310136;40971.38542921918;41377.58622413858;42269.36595951125;36368;37196.81401592975;37345;38510;38534.80732596319;29441.705582943898;29704.851475742482;29745.405091898472;30020.84989575038;30217.697823021488 02:08:08 INFO - PROCESS | 1664 | |2;jquery.html;342.8645684954443;353.184144625914;365.0982074276536;369.64144779563816;371.12970085150323;19710.21159153634;20029.899850500744;20390.184392624276;21059.894700526514;21108.155673773068;19972.9001354993;20364.879931603755;20521.692174617354;20557.588848223026;20590.89704551479;5668.773249070043;5946.108083787423;5986.221791167142;5996.430339117798;5998.55010874184;4164.529286671208;4573.954260457403;5827.329857066428;6478.773242936498;6486.643234622094;5483.451654834505;6257.530685198628;6339.11252424661;6405.647689377082;6416.711247993828;5741.885162296751;6160.907586386208;6340.397662222128;6374.362563743635;6434.324395938429;5481.75332110052;5565.026120428909;5566;5570.916436253459;5574.86062848428;25358.239252822445;25526;25815.35461613456;25928.740712592822;26097.608535871976;1891.8202770736757;2103.295396042328;2152.3005023367314;2253.616885129532;2288.942776430586;14314.570562883131;14546.054506457047;14626.414943402251;14649.362499814022;14861.628459288497;1687.7130887749113;1747.9213435395438;1773.2286455391945;1781.8040015598274;1826.3242600237863;103160.48419757928;106157;106975;108536;112361.43819280934;11180.888191118147;11390.601328953448;11607.187496875138;11620.593279235356;11677;13848.861511384757;13865;13893.235872027135;13966.441342346192;13970.441182352592;8717;8730.650773969097;8786.648534058693;8793.340499462565;8863.689770857989;8216.671333146727;8509.893713817164;8968.820623587491;9053.456792592466;9084.137006984325;3784.508013958223;4324.740515569076;4482.417285752831;4534.342520334533;4554.7039442436135;1639.3442622950915;1913.808619138075;1919.65446219679;1952.3557226115631;1968.704694295867;823.880537322097;869.6911148721134;885.1767855893952;956.818204541135;1016.4561959351711;19314.227430902887;20083.598328033357;20109.798902011084;20115.39653810388;20320.59358812845;843.6709683223547;851.723189963252;936.9297302702324;1016.3596933931576;1096.572336788653;10473.755692258523;10881.292715973437;10917.727056823644;10930.508127134299;11073.390963497084;635722;637986;639251;656773;657227;107308;108398.45800771103;118849;122242;125736;859.7592674051276;1012.3875055591261;1023.9027292407359;1025.374521541859;1025.6051420203275;16825.41111061107;18028.909855450638;18039.729404058686;18648.881067136015;18932.905335473784;50047;52854.73572632112;53165;53680.73159634177;56097;72849.6357518209;72876;72944;73099;75682.6215868917;8095.595220239083;8247.546384948886;8269.635510141;8302.626381812954;8494.575271236537;12832.615021549369;13297.401616927455;13571.79642305386;13712.382942767399;13803.861961380258;11452.08383329315;11514.136439766884;11697.2981621103;11702.824457632973;11722.531098756295;11436.599719009795;11487.655370338904;11507.194496385508;11692.298462091961;11788.882111178778;11703;11715.414229288672;11862;12007.639770806889;12048.879511205127;8022.518648881086;8227.547484888388;8236.917630823615;8321.292690121407;8495.74512764618;8855.557222138996;11750.764984700429;11773.705657358634;11861.940690296493;11863.288202707865 02:08:08 INFO - PROCESS | 1664 | |3;mootools.html;1382.6888949986253;1629.4459883639563;1746.8777185597014;1838.4576549917772;1861.6835138026534;7396.778096657095;8101.635426405818;8169.550674712888;8349.330133973206;8672.956635216815;7879.487833290832;8407.822904793318;8819.162179592944;8839.02770695223;8936.508492032952;2264.7055882735303;2372.632242002492;2500.2249302716173;2504.9749502505015;2509.14689005738;2471.02394554151;2475.925722228336;2484.7887929526014;2505.4863752930605;2525.2929179829584;2482.714487833904;2509.9749002510016;2529.5067461844947;2535.2267558394774;2538;2486.86322252277;2490.775830175293;2493.5760920643534;2522.6846644169477;2527.2670925431785;2478.0954951442773;2504.3113143885394;2524.3184340228217;2527.9241622751347;2534.0497313507435;7677;8964.641414343418;8977.820443591092;8980.506072166028;9001.54992250385;5462.535684466825;5464.207689884985;5630.324361076656;5645.830625081254;5664.376918538957;3649.7810131392202;3764.021354447836;3786.6024067473068;3796.2597293527774;3798.8480460781534;1050.5062620568322;1068.2895874243618;1068.5618896252577;1083.3445765311951;1085.3596378136858;12036.398180091048;12254.632361029184;12299.508019679291;12301.446434910362;12336.383180841012;4913.434954980223;4956.603471722254;4979.402471703346;5017.573506251936;5031.144705400017;8686.91313086861;10293.588256469808;10324.380537167794;10360.585576577003;10367.896321036693;4814.566688997937;5457.7271136443815;5544.279243698374;5581.302337207849;5614.466625670555;4571.085782843445;4917.434495033045;5000.799968001239;5015.82444614444;5071.492850714899;3929.292727309112;3981.7411868228473;3998.960010399917;4011.2378648056774;4035.253478106501;1161.5179700424399;1345.9192448453125;1348.3460521646994;1350.567818298135;1352.6618345413647;1337.170954008521;1362.5980335800962;1380.7859781733848;1388.55566218809;1402.2217669193697;8284.337253019745;8290.958545207235;8384.287335576544;8392.580370981426;8394.832103358021;517.873121085329;520.5341219608505;528.0310629994004;528.3976267055483;530.9920351194735;6248.187735594343;6256.499480041586;6285.59143655661;6297.338779428185;6316.905246421307;10604.893951060545;10958.890411095947;10962.123030157569;11032.28290161137;11033.062189713964;10543.26197166191;10745.355278683304;10796.352218866894;10807.513661885234;10872.67381978542;8290.129536398712;8396.916030839735;8427.157284271647;8488.490690558587;8491.830163396697;6819.352161544645;7543.73596924105;7814.609269536614;7929.841403172019;7990.480618759762;8232.50604963704;9345;9468;9648.662296819577;9781.364211326241;9824.263180261652;9844.704658860246;10030.849537256801;10055.69832905014;10111.39331640104;7424.628768561658;7555.433342499445;7568.091828980558;7601.505902116345;7659.387249019954;8293.792655183668;8313.376496762647;8450.366222533457;8457.619407126816;8465.534395608302;7371.852562948819;7424.1462231844025;7474.887876681963;7593.468457208163;7636.465447418627;7283.162436319679;7307.817304567428;7331.816704582215;7336.853262934605;7391.778246652609;7468.10382754073;7540.283673051052;7597.012388389474;7616.35261002821;7629.626667199957;6983.546069505466;7065.187503437171;7137.750178743719;7150.427965762622;7201.3158749918675;7105.076340075757;7161.2122666507685;7163.283671632795;7239.8552028960175;7253.601051941982 02:08:08 INFO - PROCESS | 1664 | |4;prototype.html;271.83689786128326;311.8440779610195;337.1302040734904;337.23447773554034;339.8080084752116;5731.541476681866;6855.245922948472;6974.651267436627;6991.23096459389;7053.858922821541;5633.971830140854;6861.759838405656;6914.274001229874;6916.7579134730295;6983.4762392820485;4821.204501257288;4927.408710954691;5014.774335154909;5108.080545501817;5114.079465696173;4248.723832950864;4385.539518350575;4414.426124603813;4659.254519276917;5122.231665250224;4975.577075948549;5030.874228144289;5035.622328325372;5073.365829271341;5074.285257387299;5051.823186188466;5052.368453943257;5064.518870707258;5085;5086.21163719624;4118.794060296973;4207.831686732527;4341.4790225172865;4351.630111440531;4365.716228445141;6273.968630156865;6555.213374395055;6588.308227636125;6595.175603049619;6596.571222870498;5873.559483038789;5910.202122713465;5922.7038648067855;5930.318013428425;5942.64344139353;7391.852162956765;7408.962745215674;7418.2581741825925;7427.294407031323;7442.06974128234;3914.3149948759137;4003.899902502461;4488.438945131858;4706.1293660672545;4711.081339138835;7149.714011439536;7761.456698031084;7837.921620783776;7840.843183136362;7855.135935047083;4561.885952851205;4745.3593764842;4745.691530050535;4758.333833263277;4772.880677983008;4767.427908650915;4812.879678008007;4826.879328016757;4836.46798852126;4841.225403935354;4769.928451073237;5744.971275143597;5815.273090863642;5834.27071616048;5842;7377.26227377258;7386.409087273113;7424.814379640552;7448.106227252764;7455.403567714569;1664.8002239731309;1691.3150174179477;1693.170346530216;1693.187270110354;1694.898306101638;927.1794461901266;1030.9793304628363;1073.3184427888348;1074.897884700952;1095.200503632337;6906.309369063154;6956.2695916928;6981.127359080115;6982;6997.521586184846;7469.402447804163;7686.347435301437;7721.961390193013;7766.495177813424;7766.88349674744;6825.658717064127;6988.161420629557;7020.7893763187185;7053.68258428372;7072.504924655328;4069.8575549855614;4138.5654506276405;4141.52372477169;4158.771267580251;4161.417401563784;8174.019117705913;8204.466709663971;8223.424360294723;8224.958875205586;8236.094029656733;7821.452498325177;8075.434719569574;8086.878696819553;8119.634616442274;8128.227818357246;8183.058948220912;8205.712800052208;8231.382646301552;8274.627641756135;8282.378821588405;7839.490433121829;7845.3723702104835;7851;7851.293383595504;7860.764177074697;7610.619469026416;7628.1227658817725;7641.617919104134;7674.884876726742;7688.923110769045;7821.374290056896;8177.591120443835;8215.014198296243;8215.958920205361;8219.547924863951;4750.334953106499;4795.640326975421;4803.471618121934;4813.879653008703;4838.758062096811;7214.819629509304;7366.594837284001;7762.650680719494;7780.455368124177;7844.882326765217;6528.869422611616;7458.73894413693;7491.026166598307;7496.400287977058;7518.9849370334305;6880.621565813928;7437.739679111205;7460.0674915635545;7467.477276590586;7485.700571977278;7219.60292183935;7286.380657644159;7296.489245752747;7296.525725827804;7341.449391295568;7420.220876807857;7451.2921272479025;7457.589832559262;7471.850562988601;7494.025776649;7060.399866011447;7258.056452661121;7279.381252593377;7307.817304567428;7312.19565847767 02:08:08 INFO - PROCESS | 1664 | |5;yui.html;677.7018112030706;682.0281099433313;765.3991616580984;777.3975169243836;799.3006119645311;14897.925510372446;14917.92541037296;14975.700485990274;15082.698346033072;15083.773743393844;10432.217583681217;11695.532178712841;11831.881681183186;11866.52533898643;13808.309584520784;762.2910693055456;910.4764760262842;928.6239073175341;930.1303281431849;941.4633658814479;925.2829057480473;925.8055808280269;927.689224109924;928.9210417114554;934.8831396075491;950.8145911547216;986.9259805514615;995.6266400099962;995.6913356859361;998.181491177235;959.1224030012565;968.2834702320303;982.3614650477175;982.3909176310733;992.2211064314514;707.0737334092304;707.734599525178;723.1791916175179;726.6693654387241;738.2912404092078;14676.19280939548;14755.55733328002;14839.10965342083;14900.403983840633;15087.924560377238;12138.817917731241;12900.870991290061;12917.13228538074;12963.87036129636;13243.536476223286;10936.234463587472;11019.614313498989;11073.889261107366;11446.313221206754;11894.881051189464;3487.511748355232;3586.3903136466865;3683.5027271318563;3701.38927077032;3715.3869611514338;74262.5147497047;74861.62569187174;77366.22633773646;78486.6075669618;78993;9412.596958118089;9429.717108486757;9487.90512094884;9550;9767.902320976842;17455.21451534684;17677.911610441864;20070.09684564198;20283.087261072993;20479.897600511904;7427.145878223965;7456.888146677804;7464;7541.698332066766;7648.617569121521;4035.959640403617;4038.676905847525;4081.6530594899173;4095.3037983542868;4117.814698338582;3561.412366959423;3592.4611308303965;3593.1915319053005;3621.5292012038267;3625.637436256406;643.8197304754676;660.2572106380322;661.497262080822;668.2749217099405;673.8180691213345;511.5063963275457;546.5108727688696;559.8942089373455;578.9363170051291;623.5323507369473;7910.644021019068;8081.272685458337;8162.18378162179;8202.794930126794;8339.791505212297;566.4816692726109;588.9882202355928;588.9987022062511;598.7425407074912;609.8475381154711;3636.30910127075;3725.3666876631037;3796.981015094907;3869.8839034829;3883.301603755703;85378.57310713407;87026.56486717526;87478.12521874828;87619.24761504734;87753;75025;75368.8399602037;76599.61700191574;83538;84376;63351.683241583494;64413.677931610044;65608.34391656118;65718.0142297866;68584;8019.9198008019175;8246.628901699318;8260.710875119343;8265.917340826514;8302.70940517079;46609;48366.75816620894;48952.75523622359;49195;49359;62200.37799621946;62937;63703;64258.71482570416;64634.67682661556;10677.466126693478;10866.67399978002;10960.890391096305;11041.33751974884;11289.548418063514;11719.355435451133;11727.706807329543;11820.468078936297;11835.644930652094;12070.517179312728;11007.61473348429;11022.118230541697;11135.944320278346;11418.086553075567;11714.70713232176;11311.604093856675;11383.032442242502;11671.183017189054;11681.415929203336;11770.688950270542;10458.947705261426;10869.728256793327;10875.836862447228;11163.776724465302;11219.7756044877;9251.67619133327;9393.577289021874;9516.666916657883;9565;9613.471259080818;9317.648940903666;9388.342816003087;9418.340716150078;9507.429554226768;9531.618735250513 02:08:08 INFO - PROCESS | 1664 | __end_tp_report 02:08:08 INFO - PROCESS | 1664 | __start_cc_report 02:08:08 INFO - PROCESS | 1664 | _x_x_mozilla_cycle_collect,348 02:08:08 INFO - PROCESS | 1664 | __end_cc_report 02:08:08 INFO - PROCESS | 1664 | __startTimestamp1457431688213__endTimestamp 02:08:08 INFO - PROCESS | 1664 | 02:08:08 INFO - PROCESS | 1664 | ------- Summary: start ------- 02:08:08 INFO - PROCESS | 1664 | Number of tests: 6 02:08:08 INFO - PROCESS | 1664 | 02:08:08 INFO - PROCESS | 1664 | [#0] dojo.html Cycles:165 Average:5776.18 Median:6060.24 stddev:636.59 (10.5%) stddev-sans-first:614.22 02:08:08 INFO - PROCESS | 1664 | Values: 3554.6 3570.8 3597.0 3619.8 3630.6 5719.4 5821.8 5894.5 5899.3 5917.5 5809.5 5882.3 5895.3 5958.6 5972.1 5019.0 5062.0 5210.7 5306.1 5366.2 4882.5 5286.2 5292.9 5329.8 5340.9 4634.6 5128.5 5177.8 5207.3 5305.7 5231.5 5237.9 5246.4 5263.9 5314.7 5109.6 5183.6 5217.4 5226.5 5248.5 4733.2 5688.4 5701.7 5787.7 5805.9 6181.3 6182.4 6189.5 6193.7 6221.8 6113.4 6160.2 6222.5 6231.3 6241.8 5978.1 5987.5 5990.0 5994.2 6026.3 6310.9 6353.8 6363.3 6369.1 6374.6 6120.5 6141.3 6154.8 6189.3 6211.2 6135.3 6156.8 6201.6 6214.2 6222.6 6145.9 6160.7 6199.4 6203.0 6217.3 6104.6 6125.2 6155.9 6164.6 6228.9 4909.7 4920.4 4926.5 4935.2 4965.0 4406.2 4418.9 4457.5 4481.8 4487.9 5781.7 5801.1 5927.7 5948.6 5954.3 6198.5 6233.5 6236.9 6255.7 6259.1 5059.7 5886.7 5982.6 5998.3 6007.6 5388.2 5422.9 5465.4 5486.9 5512.6 5428.4 6453.6 6472.6 6476.7 6504.2 6097.9 6175.3 6193.4 6239.3 6254.0 6419.4 6501.5 6532.5 6533.9 6539.4 5386.8 6092.7 6165.2 6204.4 6206.9 6130.0 6165.0 6244.2 6250.7 6262.6 6101.6 6114.3 6140.5 6193.3 6198.5 5128.7 6012.9 6108.7 6181.0 6214.5 5895.3 6003.4 6018.7 6060.2 6093.5 6129.1 6141.1 6154.9 6180.0 6213.8 6115.9 6133.2 6133.7 6150.5 6176.0 02:08:08 INFO - PROCESS | 1664 | 02:08:08 INFO - PROCESS | 1664 | [#1] ext.html Cycles:180 Average:61135.30 Median:38133.71 stddev:121931.46 (319.7%) stddev-sans-first:122188.46 02:08:08 INFO - PROCESS | 1664 | Values: 479.6 601.7 623.8 643.6 646.5 37115.1 37846.6 37874.8 37925.6 38197.8 39297.8 39721.6 39776.4 39846.0 39948.8 9347.5 9525.6 9537.2 9549.5 9588.0 9377.3 9456.5 9502.0 9651.8 9669.6 9591.5 9691.3 9704.0 9706.0 9721.0 9615.6 9635.9 9647.2 9699.8 9712.9 9550.3 9619.0 9633.4 9689.9 9714.9 38499.6 38552.8 38867.4 38902.0 38903.4 2661.1 3141.0 3229.8 3237.7 3504.7 26649.0 26827.3 26839.9 26986.7 27362.7 2707.1 2748.5 2757.6 2759.8 2832.2 334314.3 339410.0 339703.0 341490.0 341491.0 63354.4 64163.0 64209.0 64311.4 64317.7 74355.3 74370.0 74451.3 75025.0 75195.2 17385.3 17411.4 17598.3 17671.6 17684.6 13119.9 13163.5 13241.1 13241.5 13288.0 18574.5 22064.1 22096.0 22374.8 22382.8 9473.6 9600.4 9608.3 9664.0 9698.0 941.6 951.5 1010.3 1106.1 1131.8 29224.6 29386.7 29662.9 29694.7 29967.7 1044.9 1105.1 1108.7 1162.4 1205.2 11950.5 13381.3 15007.6 15134.5 15370.5 476150.0 530487.0 531529.0 532771.0 541132.0 57502.4 57691.8 58034.4 58134.8 58150.1 1251.2 1457.0 1472.8 1491.6 1496.1 29110.0 29110.9 29190.6 29700.9 30401.7 51144.2 51338.0 51475.7 51713.5 51806.7 482998.0 491830.0 494462.0 500039.0 500087.0 33001.3 33041.7 33486.8 33639.5 33883.7 44928.9 45070.5 45132.3 46555.0 46569.8 36110.5 37627.9 37736.6 38069.6 38388.4 36375.9 36606.8 36931.4 37034.9 37740.4 36923.3 36931.4 40971.4 41377.6 42269.4 36368.0 37196.8 37345.0 38510.0 38534.8 29441.7 29704.9 29745.4 30020.8 30217.7 02:08:08 INFO - PROCESS | 1664 | 02:08:08 INFO - PROCESS | 1664 | [#2] jquery.html Cycles:180 Average:35779.40 Median:11581.60 stddev:106761.31 (921.8%) stddev-sans-first:107027.65 02:08:08 INFO - PROCESS | 1664 | Values: 342.9 353.2 365.1 369.6 371.1 19710.2 20029.9 20390.2 21059.9 21108.2 19972.9 20364.9 20521.7 20557.6 20590.9 5668.8 5946.1 5986.2 5996.4 5998.6 4164.5 4574.0 5827.3 6478.8 6486.6 5483.5 6257.5 6339.1 6405.6 6416.7 5741.9 6160.9 6340.4 6374.4 6434.3 5481.8 5565.0 5566.0 5570.9 5574.9 25358.2 25526.0 25815.4 25928.7 26097.6 1891.8 2103.3 2152.3 2253.6 2288.9 14314.6 14546.1 14626.4 14649.4 14861.6 1687.7 1747.9 1773.2 1781.8 1826.3 103160.5 106157.0 106975.0 108536.0 112361.4 11180.9 11390.6 11607.2 11620.6 11677.0 13848.9 13865.0 13893.2 13966.4 13970.4 8717.0 8730.7 8786.6 8793.3 8863.7 8216.7 8509.9 8968.8 9053.5 9084.1 3784.5 4324.7 4482.4 4534.3 4554.7 1639.3 1913.8 1919.7 1952.4 1968.7 823.9 869.7 885.2 956.8 1016.5 19314.2 20083.6 20109.8 20115.4 20320.6 843.7 851.7 936.9 1016.4 1096.6 10473.8 10881.3 10917.7 10930.5 11073.4 635722.0 637986.0 639251.0 656773.0 657227.0 107308.0 108398.5 118849.0 122242.0 125736.0 859.8 1012.4 1023.9 1025.4 1025.6 16825.4 18028.9 18039.7 18648.9 18932.9 50047.0 52854.7 53165.0 53680.7 56097.0 72849.6 72876.0 72944.0 73099.0 75682.6 8095.6 8247.5 8269.6 8302.6 8494.6 12832.6 13297.4 13571.8 13712.4 13803.9 11452.1 11514.1 11697.3 11702.8 11722.5 11436.6 11487.7 11507.2 11692.3 11788.9 11703.0 11715.4 11862.0 12007.6 12048.9 8022.5 8227.5 8236.9 8321.3 8495.7 8855.6 11750.8 11773.7 11861.9 11863.3 02:08:08 INFO - PROCESS | 1664 | 02:08:08 INFO - PROCESS | 1664 | [#3] mootools.html Cycles:180 Average:6083.39 Median:528.21 stddev:3213.05 (608.3%) stddev-sans-first:3202.63 02:08:08 INFO - PROCESS | 1664 | Values: 1382.7 1629.4 1746.9 1838.5 1861.7 7396.8 8101.6 8169.6 8349.3 8673.0 7879.5 8407.8 8819.2 8839.0 8936.5 2264.7 2372.6 2500.2 2505.0 2509.1 2471.0 2475.9 2484.8 2505.5 2525.3 2482.7 2510.0 2529.5 2535.2 2538.0 2486.9 2490.8 2493.6 2522.7 2527.3 2478.1 2504.3 2524.3 2527.9 2534.0 7677.0 8964.6 8977.8 8980.5 9001.5 5462.5 5464.2 5630.3 5645.8 5664.4 3649.8 3764.0 3786.6 3796.3 3798.8 1050.5 1068.3 1068.6 1083.3 1085.4 12036.4 12254.6 12299.5 12301.4 12336.4 4913.4 4956.6 4979.4 5017.6 5031.1 8686.9 10293.6 10324.4 10360.6 10367.9 4814.6 5457.7 5544.3 5581.3 5614.5 4571.1 4917.4 5000.8 5015.8 5071.5 3929.3 3981.7 3999.0 4011.2 4035.3 1161.5 1345.9 1348.3 1350.6 1352.7 1337.2 1362.6 1380.8 1388.6 1402.2 8284.3 8291.0 8384.3 8392.6 8394.8 517.9 520.5 528.0 528.4 531.0 6248.2 6256.5 6285.6 6297.3 6316.9 10604.9 10958.9 10962.1 11032.3 11033.1 10543.3 10745.4 10796.4 10807.5 10872.7 8290.1 8396.9 8427.2 8488.5 8491.8 6819.4 7543.7 7814.6 7929.8 7990.5 8232.5 9345.0 9468.0 9648.7 9781.4 9824.3 9844.7 10030.8 10055.7 10111.4 7424.6 7555.4 7568.1 7601.5 7659.4 8293.8 8313.4 8450.4 8457.6 8465.5 7371.9 7424.1 7474.9 7593.5 7636.5 7283.2 7307.8 7331.8 7336.9 7391.8 7468.1 7540.3 7597.0 7616.4 7629.6 6983.5 7065.2 7137.8 7150.4 7201.3 7105.1 7161.2 7163.3 7239.9 7253.6 02:08:08 INFO - PROCESS | 1664 | 02:08:08 INFO - PROCESS | 1664 | [#4] prototype.html Cycles:180 Average:6049.04 Median:6977.89 stddev:2008.06 (28.8%) stddev-sans-first:1966.32 02:08:08 INFO - PROCESS | 1664 | Values: 271.8 311.8 337.1 337.2 339.8 5731.5 6855.2 6974.7 6991.2 7053.9 5634.0 6861.8 6914.3 6916.8 6983.5 4821.2 4927.4 5014.8 5108.1 5114.1 4248.7 4385.5 4414.4 4659.3 5122.2 4975.6 5030.9 5035.6 5073.4 5074.3 5051.8 5052.4 5064.5 5085.0 5086.2 4118.8 4207.8 4341.5 4351.6 4365.7 6274.0 6555.2 6588.3 6595.2 6596.6 5873.6 5910.2 5922.7 5930.3 5942.6 7391.9 7409.0 7418.3 7427.3 7442.1 3914.3 4003.9 4488.4 4706.1 4711.1 7149.7 7761.5 7837.9 7840.8 7855.1 4561.9 4745.4 4745.7 4758.3 4772.9 4767.4 4812.9 4826.9 4836.5 4841.2 4769.9 5745.0 5815.3 5834.3 5842.0 7377.3 7386.4 7424.8 7448.1 7455.4 1664.8 1691.3 1693.2 1693.2 1694.9 927.2 1031.0 1073.3 1074.9 1095.2 6906.3 6956.3 6981.1 6982.0 6997.5 7469.4 7686.3 7722.0 7766.5 7766.9 6825.7 6988.2 7020.8 7053.7 7072.5 4069.9 4138.6 4141.5 4158.8 4161.4 8174.0 8204.5 8223.4 8225.0 8236.1 7821.5 8075.4 8086.9 8119.6 8128.2 8183.1 8205.7 8231.4 8274.6 8282.4 7839.5 7845.4 7851.0 7851.3 7860.8 7610.6 7628.1 7641.6 7674.9 7688.9 7821.4 8177.6 8215.0 8216.0 8219.5 4750.3 4795.6 4803.5 4813.9 4838.8 7214.8 7366.6 7762.7 7780.5 7844.9 6528.9 7458.7 7491.0 7496.4 7519.0 6880.6 7437.7 7460.1 7467.5 7485.7 7219.6 7286.4 7296.5 7296.5 7341.4 7420.2 7451.3 7457.6 7471.9 7494.0 7060.4 7258.1 7279.4 7307.8 7312.2 02:08:08 INFO - PROCESS | 1664 | 02:08:08 INFO - PROCESS | 1664 | [#5] yui.html Cycles:180 Average:17679.65 Median:31780.27 stddev:24555.04 (77.3%) stddev-sans-first:24590.73 02:08:08 INFO - PROCESS | 1664 | Values: 677.7 682.0 765.4 777.4 799.3 14897.9 14917.9 14975.7 15082.7 15083.8 10432.2 11695.5 11831.9 11866.5 13808.3 762.3 910.5 928.6 930.1 941.5 925.3 925.8 927.7 928.9 934.9 950.8 986.9 995.6 995.7 998.2 959.1 968.3 982.4 982.4 992.2 707.1 707.7 723.2 726.7 738.3 14676.2 14755.6 14839.1 14900.4 15087.9 12138.8 12900.9 12917.1 12963.9 13243.5 10936.2 11019.6 11073.9 11446.3 11894.9 3487.5 3586.4 3683.5 3701.4 3715.4 74262.5 74861.6 77366.2 78486.6 78993.0 9412.6 9429.7 9487.9 9550.0 9767.9 17455.2 17677.9 20070.1 20283.1 20479.9 7427.1 7456.9 7464.0 7541.7 7648.6 4036.0 4038.7 4081.7 4095.3 4117.8 3561.4 3592.5 3593.2 3621.5 3625.6 643.8 660.3 661.5 668.3 673.8 511.5 546.5 559.9 578.9 623.5 7910.6 8081.3 8162.2 8202.8 8339.8 566.5 589.0 589.0 598.7 609.8 3636.3 3725.4 3797.0 3869.9 3883.3 85378.6 87026.6 87478.1 87619.2 87753.0 75025.0 75368.8 76599.6 83538.0 84376.0 63351.7 64413.7 65608.3 65718.0 68584.0 8019.9 8246.6 8260.7 8265.9 8302.7 46609.0 48366.8 48952.8 49195.0 49359.0 62200.4 62937.0 63703.0 64258.7 64634.7 10677.5 10866.7 10960.9 11041.3 11289.5 11719.4 11727.7 11820.5 11835.6 12070.5 11007.6 11022.1 11135.9 11418.1 11714.7 11311.6 11383.0 11671.2 11681.4 11770.7 10458.9 10869.7 10875.8 11163.8 11219.8 9251.7 9393.6 9516.7 9565.0 9613.5 9317.6 9388.3 9418.3 9507.4 9531.6 02:08:08 INFO - PROCESS | 1664 | -------- Summary: end -------- 02:08:08 INFO - PROCESS | 1664 | 02:08:08 INFO - TEST-INFO | 1664: exit 0 02:08:08 INFO - TEST-OK | dromaeo_css | took 1110465ms 02:08:08 INFO - TEST-START | kraken 02:08:08 INFO - operating with platform_type : mac_ 02:08:08 INFO - Initialising browser for kraken test... 02:08:08 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpZXPpmz/profile http://localhost:49275/getInfo.html) 02:08:11 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 02:08:11 INFO - PROCESS | 1676 | colorDepth:24 02:08:11 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 02:08:11 INFO - PROCESS | 1676 | __metrics 02:08:11 ERROR - PROCESS | 1676 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 02:08:12 INFO - TEST-INFO | 1676: exit 0 02:08:12 INFO - Browser initialized. 02:08:12 INFO - Running cycle 1/1 for kraken test... 02:08:12 INFO - TEST-INFO | started process 1679 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/tmpZXPpmz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:24 INFO - PROCESS | 1679 | RSS: Main: 254091264 02:08:24 INFO - PROCESS | 1679 | 02:08:26 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 02:08:27 INFO - PROCESS | 1679 | RSS: Main: 268840960 02:08:27 INFO - PROCESS | 1679 | 02:08:30 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 02:08:30 INFO - PROCESS | 1679 | RSS: Main: 276307968 02:08:30 INFO - PROCESS | 1679 | 02:08:34 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 02:08:34 INFO - PROCESS | 1679 | RSS: Main: 279552000 02:08:34 INFO - PROCESS | 1679 | 02:08:36 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 02:08:37 INFO - PROCESS | 1679 | RSS: Main: 281550848 02:08:37 INFO - PROCESS | 1679 | 02:08:39 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:08:39 INFO - PROCESS | 1679 | RSS: Main: 282243072 02:08:39 INFO - PROCESS | 1679 | 02:08:42 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 02:08:43 INFO - PROCESS | 1679 | RSS: Main: 283484160 02:08:43 INFO - PROCESS | 1679 | 02:08:46 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 02:08:46 INFO - PROCESS | 1679 | RSS: Main: 283418624 02:08:46 INFO - PROCESS | 1679 | 02:08:49 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 02:08:50 INFO - PROCESS | 1679 | RSS: Main: 283820032 02:08:50 INFO - PROCESS | 1679 | 02:08:52 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:08:52 INFO - PROCESS | 1679 | RSS: Main: 282062848 02:08:52 INFO - PROCESS | 1679 | 02:08:54 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:08:55 INFO - PROCESS | 1679 | RSS: Main: 282533888 02:08:55 INFO - PROCESS | 1679 | 02:08:57 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:08:57 INFO - PROCESS | 1679 | RSS: Main: 282304512 02:08:57 INFO - PROCESS | 1679 | 02:09:00 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:09:01 INFO - PROCESS | 1679 | RSS: Main: 282685440 02:09:01 INFO - PROCESS | 1679 | 02:09:03 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:09:04 INFO - PROCESS | 1679 | RSS: Main: 282550272 02:09:04 INFO - PROCESS | 1679 | 02:09:05 INFO - PROCESS | 1679 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 02:09:06 INFO - PROCESS | 1679 | RSS: Main: 284471296 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | __start_tp_report 02:09:06 INFO - PROCESS | 1679 | _x_x_mozilla_page_load 02:09:06 INFO - PROCESS | 1679 | _x_x_mozilla_page_load_details 02:09:06 INFO - PROCESS | 1679 | |i|pagename|runs| 02:09:06 INFO - PROCESS | 1679 | |0;ai-astar;116;109;114;114;115;123;115;118;136;166 02:09:06 INFO - PROCESS | 1679 | |1;audio-beat-detection;149;126;144;152;119;164;163;146;163;124 02:09:06 INFO - PROCESS | 1679 | |2;audio-dft;196;195;196;236;250;196;197;197;198;185 02:09:06 INFO - PROCESS | 1679 | |3;audio-fft;68;70;76;119;76;79;80;77;120;57 02:09:06 INFO - PROCESS | 1679 | |4;audio-oscillator;86;88;119;78;80;81;117;78;81;119 02:09:06 INFO - PROCESS | 1679 | |5;imaging-gaussian-blur;114;90;93;86;90;85;125;86;88;85 02:09:06 INFO - PROCESS | 1679 | |6;imaging-darkroom;101;131;96;103;95;117;147;146;95;96 02:09:06 INFO - PROCESS | 1679 | |7;imaging-desaturate;98;134;93;127;148;93;95;89;135;102 02:09:06 INFO - PROCESS | 1679 | |8;json-parse-financial;58;55;56;55;54;56;56;64;58;54 02:09:06 INFO - PROCESS | 1679 | |9;json-stringify-tinderbox;63;73;103;80;71;71;73;68;68;67 02:09:06 INFO - PROCESS | 1679 | |10;stanford-crypto-aes;85;84;87;86;83;101;91;84;96;108 02:09:06 INFO - PROCESS | 1679 | |11;stanford-crypto-ccm;141;128;136;129;114;100;135;113;122;122 02:09:06 INFO - PROCESS | 1679 | |12;stanford-crypto-pbkdf2;130;142;140;137;142;134;140;143;140;142 02:09:06 INFO - PROCESS | 1679 | |13;stanford-crypto-sha256-iterative;66;67;65;66;69;65;68;67;69;59 02:09:06 INFO - PROCESS | 1679 | __end_tp_report 02:09:06 INFO - PROCESS | 1679 | __start_cc_report 02:09:06 INFO - PROCESS | 1679 | _x_x_mozilla_cycle_collect,898 02:09:06 INFO - PROCESS | 1679 | __end_cc_report 02:09:06 INFO - PROCESS | 1679 | __startTimestamp1457431746051__endTimestamp 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | ------- Summary: start ------- 02:09:06 INFO - PROCESS | 1679 | Number of tests: 14 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#0] ai-astar Cycles:10 Average:122.60 Median:117.00 stddev:16.92 (14.5%) stddev-sans-first:17.78 02:09:06 INFO - PROCESS | 1679 | Values: 116.0 109.0 114.0 114.0 115.0 123.0 115.0 118.0 136.0 166.0 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#1] audio-beat-detection Cycles:10 Average:145.00 Median:150.50 stddev:16.85 (11.2%) stddev-sans-first:17.81 02:09:06 INFO - PROCESS | 1679 | Values: 149.0 126.0 144.0 152.0 119.0 164.0 163.0 146.0 163.0 124.0 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#2] audio-dft Cycles:10 Average:204.60 Median:197.00 stddev:20.83 (10.6%) stddev-sans-first:21.86 02:09:06 INFO - PROCESS | 1679 | Values: 196.0 195.0 196.0 236.0 250.0 196.0 197.0 197.0 198.0 185.0 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#3] audio-fft Cycles:10 Average:82.20 Median:76.00 stddev:20.78 (27.3%) stddev-sans-first:21.40 02:09:06 INFO - PROCESS | 1679 | Values: 68.0 70.0 76.0 119.0 76.0 79.0 80.0 77.0 120.0 57.0 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:80.50 stddev:17.98 (22.3%) stddev-sans-first:18.90 02:09:06 INFO - PROCESS | 1679 | Values: 86.0 88.0 119.0 78.0 80.0 81.0 117.0 78.0 81.0 119.0 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#5] imaging-gaussian-blur Cycles:10 Average:94.20 Median:87.00 stddev:13.82 (15.9%) stddev-sans-first:12.67 02:09:06 INFO - PROCESS | 1679 | Values: 114.0 90.0 93.0 86.0 90.0 85.0 125.0 86.0 88.0 85.0 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#6] imaging-darkroom Cycles:10 Average:112.70 Median:121.00 stddev:21.22 (17.5%) stddev-sans-first:22.09 02:09:06 INFO - PROCESS | 1679 | Values: 101.0 131.0 96.0 103.0 95.0 117.0 147.0 146.0 95.0 96.0 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#7] imaging-desaturate Cycles:10 Average:111.40 Median:91.00 stddev:22.03 (24.2%) stddev-sans-first:22.82 02:09:06 INFO - PROCESS | 1679 | Values: 98.0 134.0 93.0 127.0 148.0 93.0 95.0 89.0 135.0 102.0 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#8] json-parse-financial Cycles:10 Average:56.60 Median:56.00 stddev:2.95 (5.3%) stddev-sans-first:3.09 02:09:06 INFO - PROCESS | 1679 | Values: 58.0 55.0 56.0 55.0 54.0 56.0 56.0 64.0 58.0 54.0 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#9] json-stringify-tinderbox Cycles:10 Average:73.70 Median:71.00 stddev:11.25 (15.8%) stddev-sans-first:11.24 02:09:06 INFO - PROCESS | 1679 | Values: 63.0 73.0 103.0 80.0 71.0 71.0 73.0 68.0 68.0 67.0 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:85.50 stddev:8.50 (9.9%) stddev-sans-first:8.78 02:09:06 INFO - PROCESS | 1679 | Values: 85.0 84.0 87.0 86.0 83.0 101.0 91.0 84.0 96.0 108.0 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:128.50 stddev:12.47 (9.7%) stddev-sans-first:11.61 02:09:06 INFO - PROCESS | 1679 | Values: 141.0 128.0 136.0 129.0 114.0 100.0 135.0 113.0 122.0 122.0 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.00 Median:141.00 stddev:4.16 (3.0%) stddev-sans-first:2.87 02:09:06 INFO - PROCESS | 1679 | Values: 130.0 142.0 140.0 137.0 142.0 134.0 140.0 143.0 140.0 142.0 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - PROCESS | 1679 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:67.00 stddev:2.88 (4.3%) stddev-sans-first:3.06 02:09:06 INFO - PROCESS | 1679 | Values: 66.0 67.0 65.0 66.0 69.0 65.0 68.0 67.0 69.0 59.0 02:09:06 INFO - PROCESS | 1679 | -------- Summary: end -------- 02:09:06 INFO - PROCESS | 1679 | 02:09:06 INFO - TEST-INFO | 1679: exit 0 02:09:06 INFO - TEST-OK | kraken | took 58038ms 02:09:06 INFO - SUITE-END | took 1168s 02:09:07 INFO - Completed test suite (00:19:28) 02:09:07 INFO - javascript benchmark 02:09:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3554.5556805399324, 3570.7500474966764, 3597.0467826026093, 3619.8009109498967, 3630.5643322801266, 5719.428057194278, 5821.767129314822, 5894.469497745202, 5899.262592175978, 5917.467427931485, 5809.535237181026, 5882.294124705041, 5895.263092113486, 5958.553108516868, 5972.104184372335, 5019.0, 5061.974690126544, 5210.713410762407, 5306.124489459235, 5366.195070739382, 4882.511748825124, 5286.207068939651, 5292.867678308054, 5329.813456529022, 5340.946590534084, 4634.606058485033, 5128.512791284822, 5177.767000484987, 5207.297014902978, 5305.681659100466, 5231.529162375405, 5237.895242095175, 5246.396664383607, 5263.921041184385, 5314.681119132864, 5109.6167787415725, 5183.585313174937, 5217.426083130853, 5226.529612334908, 5248.475152484759, 4733.219018861883, 5688.402717714663, 5701.71491425427, 5787.681677507735, 5805.896879592864, 6181.289151747516, 6182.381761823782, 6189.473894718954, 6193.659348735818, 6221.844453888689, 6113.4154954094565, 6160.168377269056, 6222.533310001768, 6231.252249730016, 6241.750329986795, 5978.103284507271, 5987.461128498456, 5990.041593345044, 5994.190784244159, 6026.276846778371, 6310.9368906311265, 6353.841153971188, 6363.300036995926, 6369.108324834527, 6374.649394283359, 6120.538559592164, 6141.324454310023, 6154.753809847556, 6189.257289125334, 6211.16149319845, 6135.294441139237, 6156.753729850845, 6201.627902325875, 6214.223222097238, 6222.564420490613, 6145.938540614537, 6160.722767475474, 6199.411055949678, 6203.0075187970615, 6217.253929528486, 6104.550104788525, 6125.236813241546, 6155.876882462415, 6164.630122192682, 6228.906566401508, 4909.656324057281, 4920.384951881015, 4926.507349265116, 4935.161022626162, 4964.950350496449, 4406.184855801623, 4418.889527761831, 4457.465104187453, 4481.820727170942, 4487.88780280489, 5781.739821708034, 5801.100829371454, 5927.673977931255, 5948.583599148018, 5954.3152537458745, 6198.504119670415, 6233.501319894398, 6236.937630623726, 6255.655938923312, 6259.123722678829, 5059.747012649353, 5886.705664716747, 5982.611130276518, 5998.25021872266, 6007.609505382224, 5388.245645609618, 5422.91865622016, 5465.371482279509, 5486.945130548724, 5512.5589952803675, 5428.4028756836715, 6453.580517266457, 6472.644004579794, 6476.740930362733, 6504.178829927628, 6097.948168432722, 6175.289841668266, 6193.4425901669065, 6239.282482514569, 6253.96873015632, 6419.390157934989, 6501.4798816095545, 6532.5427220096035, 6533.901991470037, 6539.411452969255, 5386.811461598825, 6092.725827337692, 6165.167702360124, 6204.441600255818, 6206.875862482815, 6129.9701281150365, 6165.0, 6244.157038799885, 6250.718717657625, 6262.561620686508, 6101.580494003484, 6114.3277820888225, 6140.508759299156, 6193.287771906108, 6198.535109866868, 5128.692278463304, 6012.939870601238, 6108.664023478751, 6181.0, 6214.533909956681, 5895.29256489224, 6003.429674180946, 6018.6689732063405, 6060.2424696912885, 6093.451589356979, 6129.083728908156, 6141.087130295657, 6154.876902461836, 6179.969100154471, 6213.751449941951, 6115.877682446415, 6133.233345831771, 6133.693315334304, 6150.50795936333, 6176.042713379434], "unit": "score", "name": "dojo.html", "value": 5738.382485794553}, {"lowerIsBetter": false, "replicates": [479.5851588376056, 601.6750954484579, 623.8346838087907, 643.6427782580669, 646.4602057282169, 37115.0721231969, 37846.62153378469, 37874.8106259469, 37925.620743792555, 38197.809010954974, 39297.803510982405, 39721.60278397215, 39776.403353949645, 39846.00384990377, 39948.80025599868, 9347.457669484527, 9525.5713492893, 9537.1893389062, 9549.47477888716, 9587.952060239724, 9377.343585948985, 9456.527173641325, 9502.0, 9651.80696386072, 9669.613215471372, 9591.472469014201, 9691.321607487478, 9703.95148024259, 9705.951470242675, 9721.0, 9615.61537538501, 9635.90364096357, 9647.228221742243, 9699.806003879918, 9712.854307185433, 9550.283728720373, 9619.038096190325, 9633.421994680271, 9689.934107248197, 9714.90285097147, 38499.61500384988, 38552.80723596392, 38867.41698874519, 38902.0, 38903.41644875301, 2661.135131082406, 3140.9685903140903, 3229.7739158258933, 3237.704918032806, 3504.684578387957, 26649.0, 26827.32931676704, 26839.865800670872, 26986.730132698616, 27362.726372736415, 2707.147248616699, 2748.4640495103463, 2757.6139340492346, 2759.779217662582, 2832.178668186244, 334314.3284283587, 339410.0, 339703.0, 341490.0, 341490.9999999975, 63354.36645633485, 64163.0, 64209.03686444707, 64311.35688643147, 64317.678411607645, 74355.25644743483, 74370.0, 74451.25548744551, 75025.0, 75195.24804751882, 17385.304587816598, 17411.390601328894, 17598.296068157386, 17671.558211044827, 17684.64630707379, 13119.934400327937, 13163.47346106145, 13241.073124881166, 13241.536546220836, 13288.003399745057, 18574.535636609195, 22064.117435302407, 22096.0, 22374.77625223727, 22382.776172238067, 9473.621055157855, 9600.423974561409, 9608.327417080738, 9663.951680241555, 9698.0, 941.5715849288695, 951.5432592355708, 1010.2826992835022, 1106.0543235533664, 1131.7623299107115, 29224.561631575543, 29386.706132938398, 29662.851685741865, 29694.703052969628, 29967.700322996927, 1044.8537204791335, 1105.1103861391657, 1108.6640598079296, 1162.3607016141088, 1205.2166092040245, 11950.462229199708, 13381.264030478222, 15007.624809379853, 15134.545963621109, 15370.462033828986, 476150.0, 530487.0, 531529.0, 532771.0, 541132.0, 57502.42497574971, 57691.846163077345, 58034.419655803744, 58134.8373032537, 58150.12774808381, 1251.174225011488, 1456.978145327821, 1472.8232612086404, 1491.5525342397239, 1496.0799108548165, 29110.0, 29110.854445727637, 29190.56214156747, 29700.851495742383, 30401.69598303989, 51144.23283650674, 51338.0, 51475.742621286656, 51713.48286517237, 51806.74096629493, 482998.0, 491830.0, 494462.0, 500039.0, 500087.0, 33001.339973200884, 33041.66958330386, 33486.832565837016, 33639.495407568415, 33883.66116338805, 44928.87677808081, 45070.549294506636, 45132.32301515545, 46555.0, 46569.76715116403, 36110.4583431254, 37627.87116386513, 37736.62263377441, 38069.619303806605, 38388.42417363798, 36375.90872273836, 36606.816965915, 36931.44602830906, 37034.88895333144, 37740.43389349217, 36923.26153476969, 36931.446028310136, 40971.38542921918, 41377.58622413858, 42269.36595951125, 36368.0, 37196.81401592975, 37345.0, 38510.0, 38534.80732596319, 29441.705582943898, 29704.851475742482, 29745.405091898472, 30020.84989575038, 30217.697823021488], "unit": "score", "name": "ext.html", "value": 20067.875919348022}, {"lowerIsBetter": false, "replicates": [342.8645684954443, 353.184144625914, 365.0982074276536, 369.64144779563816, 371.12970085150323, 19710.21159153634, 20029.899850500744, 20390.184392624276, 21059.894700526514, 21108.155673773068, 19972.9001354993, 20364.879931603755, 20521.692174617354, 20557.588848223026, 20590.89704551479, 5668.773249070043, 5946.108083787423, 5986.221791167142, 5996.430339117798, 5998.55010874184, 4164.529286671208, 4573.954260457403, 5827.329857066428, 6478.773242936498, 6486.643234622094, 5483.451654834505, 6257.530685198628, 6339.11252424661, 6405.647689377082, 6416.711247993828, 5741.885162296751, 6160.907586386208, 6340.397662222128, 6374.362563743635, 6434.324395938429, 5481.75332110052, 5565.026120428909, 5566.0, 5570.916436253459, 5574.86062848428, 25358.239252822445, 25526.0, 25815.35461613456, 25928.740712592822, 26097.608535871976, 1891.8202770736757, 2103.295396042328, 2152.3005023367314, 2253.616885129532, 2288.942776430586, 14314.570562883131, 14546.054506457047, 14626.414943402251, 14649.362499814022, 14861.628459288497, 1687.7130887749113, 1747.9213435395438, 1773.2286455391945, 1781.8040015598274, 1826.3242600237863, 103160.48419757928, 106157.0, 106975.0, 108536.0, 112361.43819280934, 11180.888191118147, 11390.601328953448, 11607.187496875138, 11620.593279235356, 11677.0, 13848.861511384757, 13865.0, 13893.235872027135, 13966.441342346192, 13970.441182352592, 8717.0, 8730.650773969097, 8786.648534058693, 8793.340499462565, 8863.689770857989, 8216.671333146727, 8509.893713817164, 8968.820623587491, 9053.456792592466, 9084.137006984325, 3784.508013958223, 4324.740515569076, 4482.417285752831, 4534.342520334533, 4554.7039442436135, 1639.3442622950915, 1913.808619138075, 1919.65446219679, 1952.3557226115631, 1968.704694295867, 823.880537322097, 869.6911148721134, 885.1767855893952, 956.818204541135, 1016.4561959351711, 19314.227430902887, 20083.598328033357, 20109.798902011084, 20115.39653810388, 20320.59358812845, 843.6709683223547, 851.723189963252, 936.9297302702324, 1016.3596933931576, 1096.572336788653, 10473.755692258523, 10881.292715973437, 10917.727056823644, 10930.508127134299, 11073.390963497084, 635722.0, 637986.0, 639251.0, 656773.0, 657227.0, 107308.0, 108398.45800771103, 118849.0, 122242.0, 125736.0, 859.7592674051276, 1012.3875055591261, 1023.9027292407359, 1025.374521541859, 1025.6051420203275, 16825.41111061107, 18028.909855450638, 18039.729404058686, 18648.881067136015, 18932.905335473784, 50047.0, 52854.73572632112, 53165.0, 53680.73159634177, 56097.0, 72849.6357518209, 72876.0, 72944.0, 73099.0, 75682.6215868917, 8095.595220239083, 8247.546384948886, 8269.635510141, 8302.626381812954, 8494.575271236537, 12832.615021549369, 13297.401616927455, 13571.79642305386, 13712.382942767399, 13803.861961380258, 11452.08383329315, 11514.136439766884, 11697.2981621103, 11702.824457632973, 11722.531098756295, 11436.599719009795, 11487.655370338904, 11507.194496385508, 11692.298462091961, 11788.882111178778, 11703.0, 11715.414229288672, 11862.0, 12007.639770806889, 12048.879511205127, 8022.518648881086, 8227.547484888388, 8236.917630823615, 8321.292690121407, 8495.74512764618, 8855.557222138996, 11750.764984700429, 11773.705657358634, 11861.940690296493, 11863.288202707865], "unit": "score", "name": "jquery.html", "value": 9633.538401438747}, {"lowerIsBetter": false, "replicates": [1382.6888949986253, 1629.4459883639563, 1746.8777185597014, 1838.4576549917772, 1861.6835138026534, 7396.778096657095, 8101.635426405818, 8169.550674712888, 8349.330133973206, 8672.956635216815, 7879.487833290832, 8407.822904793318, 8819.162179592944, 8839.02770695223, 8936.508492032952, 2264.7055882735303, 2372.632242002492, 2500.2249302716173, 2504.9749502505015, 2509.14689005738, 2471.02394554151, 2475.925722228336, 2484.7887929526014, 2505.4863752930605, 2525.2929179829584, 2482.714487833904, 2509.9749002510016, 2529.5067461844947, 2535.2267558394774, 2538.0, 2486.86322252277, 2490.775830175293, 2493.5760920643534, 2522.6846644169477, 2527.2670925431785, 2478.0954951442773, 2504.3113143885394, 2524.3184340228217, 2527.9241622751347, 2534.0497313507435, 7677.0, 8964.641414343418, 8977.820443591092, 8980.506072166028, 9001.54992250385, 5462.535684466825, 5464.207689884985, 5630.324361076656, 5645.830625081254, 5664.376918538957, 3649.7810131392202, 3764.021354447836, 3786.6024067473068, 3796.2597293527774, 3798.8480460781534, 1050.5062620568322, 1068.2895874243618, 1068.5618896252577, 1083.3445765311951, 1085.3596378136858, 12036.398180091048, 12254.632361029184, 12299.508019679291, 12301.446434910362, 12336.383180841012, 4913.434954980223, 4956.603471722254, 4979.402471703346, 5017.573506251936, 5031.144705400017, 8686.91313086861, 10293.588256469808, 10324.380537167794, 10360.585576577003, 10367.896321036693, 4814.566688997937, 5457.7271136443815, 5544.279243698374, 5581.302337207849, 5614.466625670555, 4571.085782843445, 4917.434495033045, 5000.799968001239, 5015.82444614444, 5071.492850714899, 3929.292727309112, 3981.7411868228473, 3998.960010399917, 4011.2378648056774, 4035.253478106501, 1161.5179700424399, 1345.9192448453125, 1348.3460521646994, 1350.567818298135, 1352.6618345413647, 1337.170954008521, 1362.5980335800962, 1380.7859781733848, 1388.55566218809, 1402.2217669193697, 8284.337253019745, 8290.958545207235, 8384.287335576544, 8392.580370981426, 8394.832103358021, 517.873121085329, 520.5341219608505, 528.0310629994004, 528.3976267055483, 530.9920351194735, 6248.187735594343, 6256.499480041586, 6285.59143655661, 6297.338779428185, 6316.905246421307, 10604.893951060545, 10958.890411095947, 10962.123030157569, 11032.28290161137, 11033.062189713964, 10543.26197166191, 10745.355278683304, 10796.352218866894, 10807.513661885234, 10872.67381978542, 8290.129536398712, 8396.916030839735, 8427.157284271647, 8488.490690558587, 8491.830163396697, 6819.352161544645, 7543.73596924105, 7814.609269536614, 7929.841403172019, 7990.480618759762, 8232.50604963704, 9345.0, 9468.0, 9648.662296819577, 9781.364211326241, 9824.263180261652, 9844.704658860246, 10030.849537256801, 10055.69832905014, 10111.39331640104, 7424.628768561658, 7555.433342499445, 7568.091828980558, 7601.505902116345, 7659.387249019954, 8293.792655183668, 8313.376496762647, 8450.366222533457, 8457.619407126816, 8465.534395608302, 7371.852562948819, 7424.1462231844025, 7474.887876681963, 7593.468457208163, 7636.465447418627, 7283.162436319679, 7307.817304567428, 7331.816704582215, 7336.853262934605, 7391.778246652609, 7468.10382754073, 7540.283673051052, 7597.012388389474, 7616.35261002821, 7629.626667199957, 6983.546069505466, 7065.187503437171, 7137.750178743719, 7150.427965762622, 7201.3158749918675, 7105.076340075757, 7161.2122666507685, 7163.283671632795, 7239.8552028960175, 7253.601051941982], "unit": "score", "name": "mootools.html", "value": 4894.1851517998375}, {"lowerIsBetter": false, "replicates": [271.83689786128326, 311.8440779610195, 337.1302040734904, 337.23447773554034, 339.8080084752116, 5731.541476681866, 6855.245922948472, 6974.651267436627, 6991.23096459389, 7053.858922821541, 5633.971830140854, 6861.759838405656, 6914.274001229874, 6916.7579134730295, 6983.4762392820485, 4821.204501257288, 4927.408710954691, 5014.774335154909, 5108.080545501817, 5114.079465696173, 4248.723832950864, 4385.539518350575, 4414.426124603813, 4659.254519276917, 5122.231665250224, 4975.577075948549, 5030.874228144289, 5035.622328325372, 5073.365829271341, 5074.285257387299, 5051.823186188466, 5052.368453943257, 5064.518870707258, 5085.0, 5086.21163719624, 4118.794060296973, 4207.831686732527, 4341.4790225172865, 4351.630111440531, 4365.716228445141, 6273.968630156865, 6555.213374395055, 6588.308227636125, 6595.175603049619, 6596.571222870498, 5873.559483038789, 5910.202122713465, 5922.7038648067855, 5930.318013428425, 5942.64344139353, 7391.852162956765, 7408.962745215674, 7418.2581741825925, 7427.294407031323, 7442.06974128234, 3914.3149948759137, 4003.899902502461, 4488.438945131858, 4706.1293660672545, 4711.081339138835, 7149.714011439536, 7761.456698031084, 7837.921620783776, 7840.843183136362, 7855.135935047083, 4561.885952851205, 4745.3593764842, 4745.691530050535, 4758.333833263277, 4772.880677983008, 4767.427908650915, 4812.879678008007, 4826.879328016757, 4836.46798852126, 4841.225403935354, 4769.928451073237, 5744.971275143597, 5815.273090863642, 5834.27071616048, 5842.0, 7377.26227377258, 7386.409087273113, 7424.814379640552, 7448.106227252764, 7455.403567714569, 1664.8002239731309, 1691.3150174179477, 1693.170346530216, 1693.187270110354, 1694.898306101638, 927.1794461901266, 1030.9793304628363, 1073.3184427888348, 1074.897884700952, 1095.200503632337, 6906.309369063154, 6956.2695916928, 6981.127359080115, 6982.0, 6997.521586184846, 7469.402447804163, 7686.347435301437, 7721.961390193013, 7766.495177813424, 7766.88349674744, 6825.658717064127, 6988.161420629557, 7020.7893763187185, 7053.68258428372, 7072.504924655328, 4069.8575549855614, 4138.5654506276405, 4141.52372477169, 4158.771267580251, 4161.417401563784, 8174.019117705913, 8204.466709663971, 8223.424360294723, 8224.958875205586, 8236.094029656733, 7821.452498325177, 8075.434719569574, 8086.878696819553, 8119.634616442274, 8128.227818357246, 8183.058948220912, 8205.712800052208, 8231.382646301552, 8274.627641756135, 8282.378821588405, 7839.490433121829, 7845.3723702104835, 7851.0, 7851.293383595504, 7860.764177074697, 7610.619469026416, 7628.1227658817725, 7641.617919104134, 7674.884876726742, 7688.923110769045, 7821.374290056896, 8177.591120443835, 8215.014198296243, 8215.958920205361, 8219.547924863951, 4750.334953106499, 4795.640326975421, 4803.471618121934, 4813.879653008703, 4838.758062096811, 7214.819629509304, 7366.594837284001, 7762.650680719494, 7780.455368124177, 7844.882326765217, 6528.869422611616, 7458.73894413693, 7491.026166598307, 7496.400287977058, 7518.9849370334305, 6880.621565813928, 7437.739679111205, 7460.0674915635545, 7467.477276590586, 7485.700571977278, 7219.60292183935, 7286.380657644159, 7296.489245752747, 7296.525725827804, 7341.449391295568, 7420.220876807857, 7451.2921272479025, 7457.589832559262, 7471.850562988601, 7494.025776649, 7060.399866011447, 7258.056452661121, 7279.381252593377, 7307.817304567428, 7312.19565847767], "unit": "score", "name": "prototype.html", "value": 5361.888941256458}, {"lowerIsBetter": false, "replicates": [677.7018112030706, 682.0281099433313, 765.3991616580984, 777.3975169243836, 799.3006119645311, 14897.925510372446, 14917.92541037296, 14975.700485990274, 15082.698346033072, 15083.773743393844, 10432.217583681217, 11695.532178712841, 11831.881681183186, 11866.52533898643, 13808.309584520784, 762.2910693055456, 910.4764760262842, 928.6239073175341, 930.1303281431849, 941.4633658814479, 925.2829057480473, 925.8055808280269, 927.689224109924, 928.9210417114554, 934.8831396075491, 950.8145911547216, 986.9259805514615, 995.6266400099962, 995.6913356859361, 998.181491177235, 959.1224030012565, 968.2834702320303, 982.3614650477175, 982.3909176310733, 992.2211064314514, 707.0737334092304, 707.734599525178, 723.1791916175179, 726.6693654387241, 738.2912404092078, 14676.19280939548, 14755.55733328002, 14839.10965342083, 14900.403983840633, 15087.924560377238, 12138.817917731241, 12900.870991290061, 12917.13228538074, 12963.87036129636, 13243.536476223286, 10936.234463587472, 11019.614313498989, 11073.889261107366, 11446.313221206754, 11894.881051189464, 3487.511748355232, 3586.3903136466865, 3683.5027271318563, 3701.38927077032, 3715.3869611514338, 74262.5147497047, 74861.62569187174, 77366.22633773646, 78486.6075669618, 78993.0, 9412.596958118089, 9429.717108486757, 9487.90512094884, 9550.0, 9767.902320976842, 17455.21451534684, 17677.911610441864, 20070.09684564198, 20283.087261072993, 20479.897600511904, 7427.145878223965, 7456.888146677804, 7464.0, 7541.698332066766, 7648.617569121521, 4035.959640403617, 4038.676905847525, 4081.6530594899173, 4095.3037983542868, 4117.814698338582, 3561.412366959423, 3592.4611308303965, 3593.1915319053005, 3621.5292012038267, 3625.637436256406, 643.8197304754676, 660.2572106380322, 661.497262080822, 668.2749217099405, 673.8180691213345, 511.5063963275457, 546.5108727688696, 559.8942089373455, 578.9363170051291, 623.5323507369473, 7910.644021019068, 8081.272685458337, 8162.18378162179, 8202.794930126794, 8339.791505212297, 566.4816692726109, 588.9882202355928, 588.9987022062511, 598.7425407074912, 609.8475381154711, 3636.30910127075, 3725.3666876631037, 3796.981015094907, 3869.8839034829, 3883.301603755703, 85378.57310713407, 87026.56486717526, 87478.12521874828, 87619.24761504734, 87753.0, 75025.0, 75368.8399602037, 76599.61700191574, 83538.0, 84376.0, 63351.683241583494, 64413.677931610044, 65608.34391656118, 65718.0142297866, 68584.0, 8019.9198008019175, 8246.628901699318, 8260.710875119343, 8265.917340826514, 8302.70940517079, 46609.0, 48366.75816620894, 48952.75523622359, 49195.0, 49359.0, 62200.37799621946, 62937.0, 63703.0, 64258.71482570416, 64634.67682661556, 10677.466126693478, 10866.67399978002, 10960.890391096305, 11041.33751974884, 11289.548418063514, 11719.355435451133, 11727.706807329543, 11820.468078936297, 11835.644930652094, 12070.517179312728, 11007.61473348429, 11022.118230541697, 11135.944320278346, 11418.086553075567, 11714.70713232176, 11311.604093856675, 11383.032442242502, 11671.183017189054, 11681.415929203336, 11770.688950270542, 10458.947705261426, 10869.728256793327, 10875.836862447228, 11163.776724465302, 11219.7756044877, 9251.67619133327, 9393.577289021874, 9516.666916657883, 9565.0, 9613.471259080818, 9317.648940903666, 9388.342816003087, 9418.340716150078, 9507.429554226768, 9531.618735250513], "unit": "score", "name": "yui.html", "value": 6845.345938080534}], "name": "dromaeo_css", "value": 7642.77067388065}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 109.0, 114.0, 114.0, 115.0, 123.0, 115.0, 118.0, 136.0, 166.0], "unit": "score", "name": "ai-astar", "value": 122.6}, {"lowerIsBetter": true, "replicates": [149.0, 126.0, 144.0, 152.0, 119.0, 164.0, 163.0, 146.0, 163.0, 124.0], "unit": "score", "name": "audio-beat-detection", "value": 145.0}, {"lowerIsBetter": true, "replicates": [196.0, 195.0, 196.0, 236.0, 250.0, 196.0, 197.0, 197.0, 198.0, 185.0], "unit": "score", "name": "audio-dft", "value": 204.6}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 76.0, 119.0, 76.0, 79.0, 80.0, 77.0, 120.0, 57.0], "unit": "score", "name": "audio-fft", "value": 82.2}, {"lowerIsBetter": true, "replicates": [86.0, 88.0, 119.0, 78.0, 80.0, 81.0, 117.0, 78.0, 81.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 92.7}, {"lowerIsBetter": true, "replicates": [114.0, 90.0, 93.0, 86.0, 90.0, 85.0, 125.0, 86.0, 88.0, 85.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.2}, {"lowerIsBetter": true, "replicates": [101.0, 131.0, 96.0, 103.0, 95.0, 117.0, 147.0, 146.0, 95.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 112.7}, {"lowerIsBetter": true, "replicates": [98.0, 134.0, 93.0, 127.0, 148.0, 93.0, 95.0, 89.0, 135.0, 102.0], "unit": "score", "name": "imaging-desaturate", "value": 111.4}, {"lowerIsBetter": true, "replicates": [58.0, 55.0, 56.0, 55.0, 54.0, 56.0, 56.0, 64.0, 58.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 56.6}, {"lowerIsBetter": true, "replicates": [63.0, 73.0, 103.0, 80.0, 71.0, 71.0, 73.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 73.7}, {"lowerIsBetter": true, "replicates": [85.0, 84.0, 87.0, 86.0, 83.0, 101.0, 91.0, 84.0, 96.0, 108.0], "unit": "score", "name": "stanford-crypto-aes", "value": 90.5}, {"lowerIsBetter": true, "replicates": [141.0, 128.0, 136.0, 129.0, 114.0, 100.0, 135.0, 113.0, 122.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [130.0, 142.0, 140.0, 137.0, 142.0, 134.0, 140.0, 143.0, 140.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 139.0}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 65.0, 66.0, 69.0, 65.0, 68.0, 67.0, 69.0, 59.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.1}], "name": "kraken", "value": 1515.3000000000002}]} 02:09:07 INFO - Return code: 0 02:09:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:09:07 ERROR - # TBPL SUCCESS # 02:09:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:09:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:09:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:09:07 INFO - 2016-03-08 02:09:07.384 screenresolution[1684:10393] starting screenresolution argv=screenresolution get 02:09:07 INFO - 2016-03-08 02:09:07.387 screenresolution[1684:10393] Display 0: 1600x1200x32@60 02:09:07 INFO - 2016-03-08 02:09:07.393 screenresolution[1685:10396] starting screenresolution argv=screenresolution list 02:09:07 INFO - Available Modes on Display 0 02:09:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:09:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:09:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:09:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:09:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:09:07 INFO - Intel Iris: 02:09:07 INFO - Chipset Model: Intel Iris 02:09:07 INFO - Type: GPU 02:09:07 INFO - Bus: Built-In 02:09:07 INFO - VRAM (Dynamic, Max): 1536 MB 02:09:07 INFO - Vendor: Intel (0x8086) 02:09:07 INFO - Device ID: 0x0a2e 02:09:07 INFO - Revision ID: 0x0009 02:09:07 INFO - Displays: 02:09:07 INFO - Display: 02:09:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:09:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:09:07 INFO - Display Serial Number: 1600x1200 60 02:09:07 INFO - Main Display: Yes 02:09:07 INFO - Mirror: Off 02:09:07 INFO - Online: Yes 02:09:07 INFO - Rotation: Supported 02:09:07 INFO - Return code: 0 02:09:07 INFO - Running post-action listener: _resource_record_post_action 02:09:07 INFO - Running post-run listener: _resource_record_post_run 02:09:08 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 39646720; Write bytes: 706378752; Read time: 498; Write time: 1898 02:09:08 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 386136576; Write bytes: 380507648; Read time: 29184; Write time: 705 02:09:08 INFO - run-tests - Wall time: 1171s; CPU: 54.0%; Read bytes: 38680064; Write bytes: 302511616; Read time: 417; Write time: 1141 02:09:08 INFO - Running post-run listener: _upload_blobber_files 02:09:08 INFO - Blob upload gear active. 02:09:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:09:08 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 02:09:08 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:09:08 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:09:09 INFO - (blobuploader) - INFO - Open directory for files ... 02:09:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:09:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:09:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:09:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:09:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:09:11 INFO - (blobuploader) - INFO - Done attempting. 02:09:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:09:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:09:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:09:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:09:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:09:12 INFO - (blobuploader) - INFO - Done attempting. 02:09:12 INFO - (blobuploader) - INFO - Iteration through files over. 02:09:12 INFO - Return code: 0 02:09:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:09:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:09:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31109ac453bbae7a9d7188dd25e78a9a7dbfd63da2c6093c898c50682ca35e5c1d868b6cfdd5defa0b03f68581e53ca0a99d1f2c8f9b67961acd337a71593bd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffa03d814172fcde943cd1686d74924d006bcb13c2bd535b8907f29de59ada08344383e23cf5ddb8284d2178461f09e713b420b60b3734842206a9316057b1bc"} 02:09:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:09:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:09:12 INFO - Contents: 02:09:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31109ac453bbae7a9d7188dd25e78a9a7dbfd63da2c6093c898c50682ca35e5c1d868b6cfdd5defa0b03f68581e53ca0a99d1f2c8f9b67961acd337a71593bd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffa03d814172fcde943cd1686d74924d006bcb13c2bd535b8907f29de59ada08344383e23cf5ddb8284d2178461f09e713b420b60b3734842206a9316057b1bc"} 02:09:12 INFO - Running post-run listener: copy_logs_to_upload_dir 02:09:12 INFO - Copying logs to upload dir... 02:09:12 INFO - mkdir: /builds/slave/test/build/upload/logs 02:09:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.786833 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-03-08 02:09:12.861746) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 02:09:12.865564) ========= 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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31109ac453bbae7a9d7188dd25e78a9a7dbfd63da2c6093c898c50682ca35e5c1d868b6cfdd5defa0b03f68581e53ca0a99d1f2c8f9b67961acd337a71593bd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffa03d814172fcde943cd1686d74924d006bcb13c2bd535b8907f29de59ada08344383e23cf5ddb8284d2178461f09e713b420b60b3734842206a9316057b1bc"} build_url:https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011294 build_url: 'https://queue.taskcluster.net/v1/task/XxjMYeulR7K08qK7PhQYwQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/31109ac453bbae7a9d7188dd25e78a9a7dbfd63da2c6093c898c50682ca35e5c1d868b6cfdd5defa0b03f68581e53ca0a99d1f2c8f9b67961acd337a71593bd1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ffa03d814172fcde943cd1686d74924d006bcb13c2bd535b8907f29de59ada08344383e23cf5ddb8284d2178461f09e713b420b60b3734842206a9316057b1bc"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-08 02:09:12.912306) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:09:12.912634) ========= 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.u8nDXjhjKs/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.RkGxTJOe3c/Listeners TMPDIR=/var/folders/kh/fb8m_90s3z33bzxps44y314800000w/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.005200 ========= master_lag: 0.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-08 02:09:13.081985) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 02:09:13.082328) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-08 02:09:13.082799) ========= ========= Total master_lag: 1.70 =========