builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0185 starttime: 1458736375.48 results: success (0) buildid: 20160323042823 builduid: fa9209e2017f4c7e8b56a9dc226eb9c8 revision: 767606cd6c63ee7fd056ca45ce00a65e3bb4ddca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.479251) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.479692) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.479977) ========= 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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.005059 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.506376) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.509690) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.529818) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.530139) ========= 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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.005602 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.579023) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.579301) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.582684) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.582960) ========= 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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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-23 05:32:55-- 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% 45.8M=0s 2016-03-23 05:32:55 (45.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097822 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.699581) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.699891) ========= 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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.026128 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:55.748354) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-23 05:32:55.751745) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 767606cd6c63ee7fd056ca45ce00a65e3bb4ddca --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 767606cd6c63ee7fd056ca45ce00a65e3bb4ddca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EQeFm8fmG4/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.sqqcYWnzC0/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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-23 05:32:55,831 truncating revision to first 12 chars 2016-03-23 05:32:55,831 Setting DEBUG logging. 2016-03-23 05:32:55,831 attempt 1/10 2016-03-23 05:32:55,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/767606cd6c63?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 05:32:56,900 unpacking tar archive at: fx-team-767606cd6c63/testing/mozharness/ program finished with exit code 0 elapsedTime=1.304264 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-23 05:32:57.072237) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:57.075614) ========= echo 767606cd6c63ee7fd056ca45ce00a65e3bb4ddca in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'767606cd6c63ee7fd056ca45ce00a65e3bb4ddca'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EQeFm8fmG4/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.sqqcYWnzC0/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 767606cd6c63ee7fd056ca45ce00a65e3bb4ddca program finished with exit code 0 elapsedTime=0.005147 script_repo_revision: '767606cd6c63ee7fd056ca45ce00a65e3bb4ddca' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:57.126422) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:57.129736) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 05:32:57.148983) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-03-23 05:32:57.149289) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EQeFm8fmG4/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.sqqcYWnzC0/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 05:32:57 INFO - MultiFileLogger online at 20160323 05:32:57 in /builds/slave/test 05:32:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:32:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:32:57 INFO - {'append_to_log': False, 05:32:57 INFO - 'base_work_dir': '/builds/slave/test', 05:32:57 INFO - 'blob_upload_branch': 'Fx-Team', 05:32:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:32:57 INFO - 'branch': 'Fx-Team', 05:32:57 INFO - 'buildbot_json_path': 'buildprops.json', 05:32:57 INFO - 'config_files': ('talos/mac_config.py',), 05:32:57 INFO - 'default_actions': ('clobber', 05:32:57 INFO - 'read-buildbot-config', 05:32:57 INFO - 'download-and-extract', 05:32:57 INFO - 'populate-webroot', 05:32:57 INFO - 'create-virtualenv', 05:32:57 INFO - 'install', 05:32:57 INFO - 'run-tests'), 05:32:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:32:57 INFO - 'download_minidump_stackwalk': True, 05:32:57 INFO - 'download_symbols': 'ondemand', 05:32:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:32:57 INFO - 'tooltool.py': '/tools/tooltool.py', 05:32:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:32:57 INFO - '/tools/misc-python/virtualenv.py')}, 05:32:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:32:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:32:57 INFO - 'installer_path': 'installer.exe', 05:32:57 INFO - 'log_level': 'info', 05:32:57 INFO - 'log_name': 'talos', 05:32:57 INFO - 'log_to_console': True, 05:32:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:32:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:32:57 INFO - 'opt_config_files': (), 05:32:57 INFO - 'pip_index': False, 05:32:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:57 INFO - 'cmd': ('bash', 05:32:57 INFO - '-c', 05:32:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:57 INFO - 'enabled': True, 05:32:57 INFO - 'halt_on_failure': False, 05:32:57 INFO - 'name': 'check_screen_resolution'},), 05:32:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:32:57 INFO - 'cmd': ('bash', 05:32:57 INFO - '-c', 05:32:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:32:57 INFO - 'enabled': True, 05:32:57 INFO - 'halt_on_failure': False, 05:32:57 INFO - 'name': 'check_screen_resolution'},), 05:32:57 INFO - 'run_cmd_checks_enabled': True, 05:32:57 INFO - 'sps_profile': False, 05:32:57 INFO - 'sps_profile_interval': 0, 05:32:57 INFO - 'suite': 'dromaeojs', 05:32:57 INFO - 'system_bits': '32', 05:32:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:32:57 INFO - 'title': 't-yosemite-r7-0185', 05:32:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:32:57 INFO - 'use_talos_json': True, 05:32:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:32:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:32:57 INFO - 'work_dir': 'build'} 05:32:57 INFO - ##### 05:32:57 INFO - ##### Running clobber step. 05:32:57 INFO - ##### 05:32:57 INFO - Running pre-action listener: _resource_record_pre_action 05:32:57 INFO - Running main action method: clobber 05:32:57 INFO - rmtree: /builds/slave/test/build 05:32:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:32:58 INFO - Running post-action listener: _resource_record_post_action 05:32:58 INFO - ##### 05:32:58 INFO - ##### Running read-buildbot-config step. 05:32:58 INFO - ##### 05:32:58 INFO - Running pre-action listener: _resource_record_pre_action 05:32:58 INFO - Running main action method: read_buildbot_config 05:32:58 INFO - Using buildbot properties: 05:32:58 INFO - { 05:32:58 INFO - "project": "", 05:32:58 INFO - "product": "firefox", 05:32:58 INFO - "script_repo_revision": "production", 05:32:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:32:58 INFO - "repository": "", 05:32:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:32:58 INFO - "buildid": "20160323042823", 05:32:58 INFO - "pgo_build": "False", 05:32:58 INFO - "basedir": "/builds/slave/test", 05:32:58 INFO - "buildnumber": 615, 05:32:58 INFO - "slavename": "t-yosemite-r7-0185", 05:32:58 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:32:58 INFO - "platform": "yosemite_r7", 05:32:58 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:32:58 INFO - "branch": "fx-team", 05:32:58 INFO - "repo_path": "integration/fx-team", 05:32:58 INFO - "revision": "767606cd6c63ee7fd056ca45ce00a65e3bb4ddca", 05:32:58 INFO - "stage_platform": "macosx64", 05:32:58 INFO - "builduid": "fa9209e2017f4c7e8b56a9dc226eb9c8", 05:32:58 INFO - "slavebuilddir": "test" 05:32:58 INFO - } 05:32:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:32:58 INFO - Running post-action listener: _resource_record_post_action 05:32:58 INFO - ##### 05:32:58 INFO - ##### Running download-and-extract step. 05:32:58 INFO - ##### 05:32:58 INFO - Running pre-action listener: _resource_record_pre_action 05:32:58 INFO - Running main action method: download_and_extract 05:32:58 INFO - mkdir: /builds/slave/test/build/tests 05:32:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:58 INFO - https://queue.taskcluster.net/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:32:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:32:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:32:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:32:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:33:00 INFO - Downloaded 1199 bytes. 05:33:00 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:33:00 INFO - Using the following test package requirements: 05:33:00 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:33:00 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:33:00 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:33:00 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:33:00 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:33:00 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:33:00 INFO - u'jsshell-mac.zip'], 05:33:00 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:33:00 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:33:00 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:33:00 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:33:00 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:33:00 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:33:00 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:33:00 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:33:00 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:33:00 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:33:00 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:33:00 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:33:00 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')]} 05:33:00 INFO - https://queue.taskcluster.net/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:33:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:33:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:33:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:33:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:33:02 INFO - Downloaded 17895703 bytes. 05:33:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:33:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:33:05 INFO - Return code: 0 05:33:05 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:05 INFO - https://queue.taskcluster.net/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:33:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:33:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:33:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:33:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:33:06 INFO - Downloaded 17895703 bytes. 05:33:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:33:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:33:09 INFO - Return code: 0 05:33:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:09 INFO - https://queue.taskcluster.net/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:33:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:33:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:33:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:33:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:33:10 INFO - Downloaded 10848120 bytes. 05:33:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:33:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:33:11 INFO - Return code: 0 05:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:11 INFO - https://queue.taskcluster.net/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:33:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:33:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:33:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:33:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:33:14 INFO - Downloaded 111328076 bytes. 05:33:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:33:14 INFO - mkdir: /builds/slave/test/properties 05:33:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:33:14 INFO - Writing to file /builds/slave/test/properties/build_url 05:33:14 INFO - Contents: 05:33:14 INFO - build_url:https://queue.taskcluster.net/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:33:16 INFO - Running post-action listener: _resource_record_post_action 05:33:16 INFO - Running post-action listener: set_extra_try_arguments 05:33:16 INFO - ##### 05:33:16 INFO - ##### Running populate-webroot step. 05:33:16 INFO - ##### 05:33:16 INFO - Running pre-action listener: _resource_record_pre_action 05:33:16 INFO - Running main action method: populate_webroot 05:33:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:33:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:33:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:33:16 INFO - '--tppagecycles', 05:33:16 INFO - '7'], 05:33:16 INFO - 'tests': ['tsvgm']}}, 05:33:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:33:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:33:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:33:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:33:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:33:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:33:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:16 INFO - 'talos_options': ['--e10s'], 05:33:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:33:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:16 INFO - 'tests': ['damp', 'tps']}, 05:33:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:16 INFO - 'talos_options': ['--e10s'], 05:33:16 INFO - 'tests': ['damp', 'tps']}, 05:33:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:33:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:33:16 INFO - 'other': {'tests': ['a11yr', 05:33:16 INFO - 'ts_paint', 05:33:16 INFO - 'tpaint', 05:33:16 INFO - 'sessionrestore', 05:33:16 INFO - 'sessionrestore_no_auto_restore', 05:33:16 INFO - 'tabpaint']}, 05:33:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:33:16 INFO - 'tests': ['a11yr', 05:33:16 INFO - 'ts_paint', 05:33:16 INFO - 'tpaint', 05:33:16 INFO - 'sessionrestore', 05:33:16 INFO - 'sessionrestore_no_auto_restore', 05:33:16 INFO - 'tabpaint']}, 05:33:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:33:16 INFO - 'tests': ['a11yr', 05:33:16 INFO - 'ts_paint', 05:33:16 INFO - 'tpaint', 05:33:16 INFO - 'sessionrestore', 05:33:16 INFO - 'sessionrestore_no_auto_restore', 05:33:16 INFO - 'tabpaint']}, 05:33:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:33:16 INFO - 'tests': ['a11yr', 05:33:16 INFO - 'ts_paint', 05:33:16 INFO - 'tpaint', 05:33:16 INFO - 'sessionrestore', 05:33:16 INFO - 'sessionrestore_no_auto_restore', 05:33:16 INFO - 'tabpaint']}, 05:33:16 INFO - 'other_l64': {'tests': ['a11yr', 05:33:16 INFO - 'ts_paint', 05:33:16 INFO - 'tpaint', 05:33:16 INFO - 'sessionrestore', 05:33:16 INFO - 'sessionrestore_no_auto_restore', 05:33:16 INFO - 'tabpaint']}, 05:33:16 INFO - 'other_nol64': {'tests': ['a11yr', 05:33:16 INFO - 'ts_paint', 05:33:16 INFO - 'tpaint', 05:33:16 INFO - 'sessionrestore', 05:33:16 INFO - 'sessionrestore_no_auto_restore', 05:33:16 INFO - 'tabpaint']}, 05:33:16 INFO - 'svgr': {'tests': ['tsvgx', 05:33:16 INFO - 'tsvgr_opacity', 05:33:16 INFO - 'tart', 05:33:16 INFO - 'tscrollx', 05:33:16 INFO - 'cart']}, 05:33:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:33:16 INFO - 'tests': ['tsvgx', 05:33:16 INFO - 'tsvgr_opacity', 05:33:16 INFO - 'tart', 05:33:16 INFO - 'tscrollx', 05:33:16 INFO - 'cart']}, 05:33:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:16 INFO - 'tests': ['tp5o']}, 05:33:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:16 INFO - 'talos_options': ['--e10s'], 05:33:16 INFO - 'tests': ['tp5o']}, 05:33:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:16 INFO - 'talos_options': ['--xperf_path', 05:33:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:16 INFO - 'tests': ['tp5n']}, 05:33:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:33:16 INFO - 'talos_options': ['--e10s', 05:33:16 INFO - '--xperf_path', 05:33:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:33:16 INFO - 'tests': ['tp5n']}}, 05:33:16 INFO - 'talos.zip': {'path': '', 05:33:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:33:16 INFO - Running post-action listener: _resource_record_post_action 05:33:16 INFO - ##### 05:33:16 INFO - ##### Running create-virtualenv step. 05:33:16 INFO - ##### 05:33:16 INFO - Running pre-action listener: _resource_record_pre_action 05:33:16 INFO - Running main action method: create_virtualenv 05:33:16 INFO - Creating virtualenv /builds/slave/test/build/venv 05:33:16 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:33:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:33:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:33:16 INFO - Using real prefix '/tools/python27' 05:33:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:33:16 INFO - Installing distribute.............................................................................................................................................................................................done. 05:33:19 INFO - Installing pip.................done. 05:33:19 INFO - Return code: 0 05:33:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101693a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29257af10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101532e00>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10152db20>, '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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 05:33:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:33:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:33:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EQeFm8fmG4/Render', 05:33:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:19 INFO - 'HOME': '/Users/cltbld', 05:33:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:19 INFO - 'LOGNAME': 'cltbld', 05:33:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:19 INFO - 'MOZ_NO_REMOTE': '1', 05:33:19 INFO - 'NO_EM_RESTART': '1', 05:33:19 INFO - 'PAGER': '/bin/cat', 05:33:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:19 INFO - 'PWD': '/builds/slave/test', 05:33:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:19 INFO - 'SHELL': '/bin/bash', 05:33:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqqcYWnzC0/Listeners', 05:33:19 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 05:33:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:19 INFO - 'USER': 'cltbld', 05:33:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:19 INFO - 'XPC_FLAGS': '0x0', 05:33:19 INFO - 'XPC_SERVICE_NAME': '0', 05:33:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:33:20 INFO - Cleaning up... 05:33:20 INFO - Return code: 0 05:33:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:33: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')]} 05:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33: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')]} 05:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101693a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29257af10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101532e00>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10152db20>, '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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 05:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:33:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EQeFm8fmG4/Render', 05:33:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:20 INFO - 'HOME': '/Users/cltbld', 05:33:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:20 INFO - 'LOGNAME': 'cltbld', 05:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:20 INFO - 'MOZ_NO_REMOTE': '1', 05:33:20 INFO - 'NO_EM_RESTART': '1', 05:33:20 INFO - 'PAGER': '/bin/cat', 05:33:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:20 INFO - 'PWD': '/builds/slave/test', 05:33:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:20 INFO - 'SHELL': '/bin/bash', 05:33:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqqcYWnzC0/Listeners', 05:33:20 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 05:33:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:20 INFO - 'USER': 'cltbld', 05:33:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:20 INFO - 'XPC_FLAGS': '0x0', 05:33:20 INFO - 'XPC_SERVICE_NAME': '0', 05:33:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:20 INFO - Downloading/unpacking psutil>=0.7.1 05:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:33:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:22 INFO - Installing collected packages: psutil 05:33:22 INFO - Running setup.py install for psutil 05:33:23 INFO - building 'psutil._psutil_osx' extension 05:33:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:33:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:33:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:33:23 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 05:33:23 INFO - building 'psutil._psutil_posix' extension 05:33:23 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 05:33:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:33:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:33:23 INFO - ^ 05:33:23 INFO - 1 warning generated. 05:33:23 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 05:33:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:33:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:33:24 INFO - Successfully installed psutil 05:33:24 INFO - Cleaning up... 05:33:24 INFO - Return code: 0 05:33:24 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101693a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29257af10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101532e00>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10152db20>, '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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 05:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:33:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EQeFm8fmG4/Render', 05:33:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:24 INFO - 'HOME': '/Users/cltbld', 05:33:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:24 INFO - 'LOGNAME': 'cltbld', 05:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:24 INFO - 'MOZ_NO_REMOTE': '1', 05:33:24 INFO - 'NO_EM_RESTART': '1', 05:33:24 INFO - 'PAGER': '/bin/cat', 05:33:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:24 INFO - 'PWD': '/builds/slave/test', 05:33:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:24 INFO - 'SHELL': '/bin/bash', 05:33:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqqcYWnzC0/Listeners', 05:33:24 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 05:33:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:24 INFO - 'USER': 'cltbld', 05:33:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:24 INFO - 'XPC_FLAGS': '0x0', 05:33:24 INFO - 'XPC_SERVICE_NAME': '0', 05:33:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:24 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:27 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:33:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:33:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:33:27 INFO - Installing collected packages: mozsystemmonitor 05:33:27 INFO - Running setup.py install for mozsystemmonitor 05:33:27 INFO - Successfully installed mozsystemmonitor 05:33:27 INFO - Cleaning up... 05:33:27 INFO - Return code: 0 05:33:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101693a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29257af10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101532e00>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10152db20>, '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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 05:33:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:33:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:33:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EQeFm8fmG4/Render', 05:33:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:27 INFO - 'HOME': '/Users/cltbld', 05:33:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:27 INFO - 'LOGNAME': 'cltbld', 05:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:27 INFO - 'MOZ_NO_REMOTE': '1', 05:33:27 INFO - 'NO_EM_RESTART': '1', 05:33:27 INFO - 'PAGER': '/bin/cat', 05:33:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:27 INFO - 'PWD': '/builds/slave/test', 05:33:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:27 INFO - 'SHELL': '/bin/bash', 05:33:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqqcYWnzC0/Listeners', 05:33:27 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 05:33:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:27 INFO - 'USER': 'cltbld', 05:33:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:27 INFO - 'XPC_FLAGS': '0x0', 05:33:27 INFO - 'XPC_SERVICE_NAME': '0', 05:33:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:27 INFO - Downloading/unpacking blobuploader==1.2.4 05:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:30 INFO - Downloading blobuploader-1.2.4.tar.gz 05:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:33:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:33: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 05:33: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 05:33: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 05:33: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 05:33: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 05:33: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 05:33:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:33:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:31 INFO - Downloading docopt-0.6.1.tar.gz 05:33:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:33:31 INFO - Installing collected packages: blobuploader, requests, docopt 05:33:31 INFO - Running setup.py install for blobuploader 05:33:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:33:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:33:31 INFO - Running setup.py install for requests 05:33:32 INFO - Running setup.py install for docopt 05:33:32 INFO - Successfully installed blobuploader requests docopt 05:33:32 INFO - Cleaning up... 05:33:32 INFO - Return code: 0 05:33:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:32 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')]} 05:33:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:32 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')]} 05:33:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:32 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 0x101693a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29257af10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101532e00>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10152db20>, '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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 05:33:32 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 05:33:32 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 05:33:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EQeFm8fmG4/Render', 05:33:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:32 INFO - 'HOME': '/Users/cltbld', 05:33:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:32 INFO - 'LOGNAME': 'cltbld', 05:33:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:32 INFO - 'MOZ_NO_REMOTE': '1', 05:33:32 INFO - 'NO_EM_RESTART': '1', 05:33:32 INFO - 'PAGER': '/bin/cat', 05:33:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:32 INFO - 'PWD': '/builds/slave/test', 05:33:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:32 INFO - 'SHELL': '/bin/bash', 05:33:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqqcYWnzC0/Listeners', 05:33:32 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 05:33:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:32 INFO - 'USER': 'cltbld', 05:33:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:32 INFO - 'XPC_FLAGS': '0x0', 05:33:32 INFO - 'XPC_SERVICE_NAME': '0', 05:33:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:32 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-HKg0oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:32 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-LntDG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:32 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ipY4hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:33 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-zN9tmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:33 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-3STyba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:33 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-kEpj_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:33 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-jO1sAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:33 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-3A0WOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:33 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-Y0t_yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:33 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-swlh7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:33 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-7pgqWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:33 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-3kg9df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:34 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-_ZoCxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:34 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-s8cbXh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:34 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-f_SYMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:34 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-q7Lk1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:34 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-ij687V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:33:34 INFO - Running setup.py install for manifestparser 05:33:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:33:34 INFO - Running setup.py install for mozcrash 05:33:34 INFO - Running setup.py install for mozdebug 05:33:34 INFO - Running setup.py install for mozdevice 05:33:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:33:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:33:35 INFO - Running setup.py install for mozfile 05:33:35 INFO - Running setup.py install for mozhttpd 05:33:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:33:35 INFO - Running setup.py install for mozinfo 05:33:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:33:35 INFO - Running setup.py install for mozInstall 05:33:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:33:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:33:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:33:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:33:35 INFO - Running setup.py install for mozleak 05:33:35 INFO - Running setup.py install for mozlog 05:33:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Running setup.py install for moznetwork 05:33:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Running setup.py install for mozprocess 05:33:36 INFO - Running setup.py install for mozprofile 05:33:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Running setup.py install for mozrunner 05:33:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:33:36 INFO - Running setup.py install for mozscreenshot 05:33:36 INFO - Running setup.py install for moztest 05:33:36 INFO - Running setup.py install for mozversion 05:33:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:33:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:33:37 INFO - Cleaning up... 05:33:37 INFO - Return code: 0 05:33:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:37 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')]} 05:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:37 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')]} 05:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:37 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 0x101693a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29257af10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101532e00>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10152db20>, '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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 05:33:37 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 05:33:37 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 05:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EQeFm8fmG4/Render', 05:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:37 INFO - 'HOME': '/Users/cltbld', 05:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:37 INFO - 'LOGNAME': 'cltbld', 05:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:37 INFO - 'MOZ_NO_REMOTE': '1', 05:33:37 INFO - 'NO_EM_RESTART': '1', 05:33:37 INFO - 'PAGER': '/bin/cat', 05:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:37 INFO - 'PWD': '/builds/slave/test', 05:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:37 INFO - 'SHELL': '/bin/bash', 05:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqqcYWnzC0/Listeners', 05:33:37 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 05:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:37 INFO - 'USER': 'cltbld', 05:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:37 INFO - 'XPC_FLAGS': '0x0', 05:33:37 INFO - 'XPC_SERVICE_NAME': '0', 05:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:33:37 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-lFAUO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:33:37 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)) 05:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:33:37 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-DO69qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:33:37 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)) 05:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:33:37 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-VHKqL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:33:37 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-vOFMhO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:33:37 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-3PfTuy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:33:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:33:37 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-gPwmH3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:33:38 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)) 05:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:33:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-m8fJ9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:33:38 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)) 05:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:33:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-krGlNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:33:38 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)) 05:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:33:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-RRFRMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:33:38 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)) 05:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:33:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-rOoo5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:33:38 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)) 05:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:33:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-QRsRKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:33:38 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)) 05:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:33:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-b4Nah1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:33:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-xY4w17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:33:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-B1dEnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-rsl5MV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:33:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:33:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:33:38 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-lkRufh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:33:39 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)) 05:33:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:33:39 INFO - Running setup.py (path:/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/pip-QdGO_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:33:39 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)) 05:33:39 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)) 05:33:39 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)) 05:33:39 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)) 05:33:39 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)) 05:33:39 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)) 05:33:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:33:39 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 05:33: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 05:33:39 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 05:33:39 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 05:33:39 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 05:33: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 05:33:41 INFO - Downloading blessings-1.6.tar.gz 05:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:33:41 INFO - Installing collected packages: blessings 05:33:41 INFO - Running setup.py install for blessings 05:33:41 INFO - Successfully installed blessings 05:33:41 INFO - Cleaning up... 05:33:41 INFO - Return code: 0 05:33:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:33:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:42 INFO - Reading from file tmpfile_stdout 05:33:42 INFO - Current package versions: 05:33:42 INFO - blessings == 1.6 05:33:42 INFO - blobuploader == 1.2.4 05:33:42 INFO - docopt == 0.6.1 05:33:42 INFO - manifestparser == 1.1 05:33:42 INFO - mozInstall == 1.12 05:33:42 INFO - mozcrash == 0.17 05:33:42 INFO - mozdebug == 0.1 05:33:42 INFO - mozdevice == 0.48 05:33:42 INFO - mozfile == 1.2 05:33:42 INFO - mozhttpd == 0.7 05:33:42 INFO - mozinfo == 0.9 05:33:42 INFO - mozleak == 0.1 05:33:42 INFO - mozlog == 3.1 05:33:42 INFO - moznetwork == 0.27 05:33:42 INFO - mozprocess == 0.22 05:33:42 INFO - mozprofile == 0.28 05:33:42 INFO - mozrunner == 6.11 05:33:42 INFO - mozscreenshot == 0.1 05:33:42 INFO - mozsystemmonitor == 0.0 05:33:42 INFO - moztest == 0.7 05:33:42 INFO - mozversion == 1.4 05:33:42 INFO - psutil == 3.1.1 05:33:42 INFO - requests == 1.2.3 05:33:42 INFO - wsgiref == 0.1.2 05:33:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101693a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29257af10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101532e00>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10152db20>, '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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 05:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:33:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EQeFm8fmG4/Render', 05:33:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:42 INFO - 'HOME': '/Users/cltbld', 05:33:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:42 INFO - 'LOGNAME': 'cltbld', 05:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:42 INFO - 'MOZ_NO_REMOTE': '1', 05:33:42 INFO - 'NO_EM_RESTART': '1', 05:33:42 INFO - 'PAGER': '/bin/cat', 05:33:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:42 INFO - 'PWD': '/builds/slave/test', 05:33:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:42 INFO - 'SHELL': '/bin/bash', 05:33:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqqcYWnzC0/Listeners', 05:33:42 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 05:33:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:42 INFO - 'USER': 'cltbld', 05:33:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:42 INFO - 'XPC_FLAGS': '0x0', 05:33:42 INFO - 'XPC_SERVICE_NAME': '0', 05:33:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:33:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:33:42 INFO - Cleaning up... 05:33:42 INFO - Return code: 0 05:33:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101693a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29257af10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101532e00>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10152db20>, '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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 05:33:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:33:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:33:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EQeFm8fmG4/Render', 05:33:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:42 INFO - 'HOME': '/Users/cltbld', 05:33:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:42 INFO - 'LOGNAME': 'cltbld', 05:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:42 INFO - 'MOZ_NO_REMOTE': '1', 05:33:42 INFO - 'NO_EM_RESTART': '1', 05:33:42 INFO - 'PAGER': '/bin/cat', 05:33:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:42 INFO - 'PWD': '/builds/slave/test', 05:33:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:42 INFO - 'SHELL': '/bin/bash', 05:33:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqqcYWnzC0/Listeners', 05:33:42 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 05:33:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:42 INFO - 'USER': 'cltbld', 05:33:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:42 INFO - 'XPC_FLAGS': '0x0', 05:33:42 INFO - 'XPC_SERVICE_NAME': '0', 05:33:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:42 INFO - Downloading/unpacking jsonschema 05:33: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 05:33: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 05:33: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 05:33: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 05:33: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 05:33: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 05:33:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:33:45 INFO - Downloading/unpacking functools32 (from jsonschema) 05:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:45 INFO - Downloading functools32-3.2.3-2.tar.gz 05:33:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:33:46 INFO - warning: no files found matching '*.txt' 05:33:46 INFO - no previously-included directories found matching 'build' 05:33:46 INFO - no previously-included directories found matching 'dist' 05:33:46 INFO - no previously-included directories found matching '.git*' 05:33:46 INFO - Installing collected packages: jsonschema, functools32 05:33:46 INFO - Running setup.py install for functools32 05:33:46 INFO - warning: no files found matching '*.txt' 05:33:46 INFO - no previously-included directories found matching 'build' 05:33:46 INFO - no previously-included directories found matching 'dist' 05:33:46 INFO - no previously-included directories found matching '.git*' 05:33:46 INFO - Successfully installed jsonschema functools32 05:33:46 INFO - Cleaning up... 05:33:46 INFO - Return code: 0 05:33:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:33:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101693a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1016a3420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29257af10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101532e00>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10152db20>, '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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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 05:33:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:33:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EQeFm8fmG4/Render', 05:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:46 INFO - 'HOME': '/Users/cltbld', 05:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:46 INFO - 'LOGNAME': 'cltbld', 05:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:46 INFO - 'MOZ_NO_REMOTE': '1', 05:33:46 INFO - 'NO_EM_RESTART': '1', 05:33:46 INFO - 'PAGER': '/bin/cat', 05:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:46 INFO - 'PWD': '/builds/slave/test', 05:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:46 INFO - 'SHELL': '/bin/bash', 05:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqqcYWnzC0/Listeners', 05:33:46 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 05:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:46 INFO - 'USER': 'cltbld', 05:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:46 INFO - 'XPC_FLAGS': '0x0', 05:33:46 INFO - 'XPC_SERVICE_NAME': '0', 05:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:33:46 INFO - Downloading/unpacking flake8 05:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:33:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:33:50 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:33:50 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:33: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 05:33: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 05:33: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 05:33: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 05:33: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 05:33: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 05:33:50 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:33:50 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:33: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 05:33: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 05:33: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 05:33: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 05:33: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 05:33: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 05:33:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:33: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 05:33: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 05:33: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 05:33: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 05:33: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 05:33: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 05:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:33:51 INFO - no previously-included directories found matching 'docs/_build' 05:33:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:33:51 INFO - Running setup.py install for pep8 05:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:33:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:33:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:33:51 INFO - no previously-included directories found matching 'docs/_build' 05:33:51 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:33:51 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:33:51 INFO - Cleaning up... 05:33:51 INFO - Return code: 0 05:33:51 INFO - Running post-action listener: _resource_record_post_action 05:33:51 INFO - Running post-action listener: _start_resource_monitoring 05:33:51 INFO - Starting resource monitoring. 05:33:51 INFO - ##### 05:33:51 INFO - ##### Running install step. 05:33:51 INFO - ##### 05:33:51 INFO - Running pre-action listener: _resource_record_pre_action 05:33:51 INFO - Running main action method: install 05:33:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:33:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:33:52 INFO - Reading from file tmpfile_stdout 05:33:52 INFO - Detecting whether we're running mozinstall >=1.0... 05:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:33:52 INFO - Reading from file tmpfile_stdout 05:33:52 INFO - Output received: 05:33:52 INFO - Usage: mozinstall [options] installer 05:33:52 INFO - Options: 05:33:52 INFO - -h, --help show this help message and exit 05:33:52 INFO - -d DEST, --destination=DEST 05:33:52 INFO - Directory to install application into. [default: 05:33:52 INFO - "/builds/slave/test"] 05:33:52 INFO - --app=APP Application being installed. [default: firefox] 05:33:52 INFO - mkdir: /builds/slave/test/build/application 05:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:34:25 INFO - Reading from file tmpfile_stdout 05:34:25 INFO - Output received: 05:34:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:34:25 INFO - Running post-action listener: _resource_record_post_action 05:34:25 INFO - ##### 05:34:25 INFO - ##### Running run-tests step. 05:34:25 INFO - ##### 05:34:25 INFO - Running pre-action listener: _resource_record_pre_action 05:34:25 INFO - Running main action method: run_tests 05:34:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:34:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:34:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:34:25 INFO - 2016-03-23 05:34:25.992 screenresolution[1645:7523] starting screenresolution argv=screenresolution get 05:34:25 INFO - 2016-03-23 05:34:25.994 screenresolution[1645:7523] Display 0: 1600x1200x32@60 05:34:26 INFO - 2016-03-23 05:34:26.000 screenresolution[1646:7525] starting screenresolution argv=screenresolution list 05:34:26 INFO - Available Modes on Display 0 05:34:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:34:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:34:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:34:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:34:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:34:26 INFO - Intel Iris: 05:34:26 INFO - Chipset Model: Intel Iris 05:34:26 INFO - Type: GPU 05:34:26 INFO - Bus: Built-In 05:34:26 INFO - VRAM (Dynamic, Max): 1536 MB 05:34:26 INFO - Vendor: Intel (0x8086) 05:34:26 INFO - Device ID: 0x0a2e 05:34:26 INFO - Revision ID: 0x0009 05:34:26 INFO - Displays: 05:34:26 INFO - Display: 05:34:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:34:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:34:26 INFO - Display Serial Number: 1600x1200 60 05:34:26 INFO - Main Display: Yes 05:34:26 INFO - Mirror: Off 05:34:26 INFO - Online: Yes 05:34:26 INFO - Rotation: Supported 05:34:26 INFO - Return code: 0 05:34:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:34:26 INFO - Python 2.7.3 05:34:26 INFO - Return code: 0 05:34:26 INFO - grabbing minidump binary from tooltool 05:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:34:26 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 0x101532e00>, '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 0x10135bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10152db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:34:26 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 05:34:26 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 05:34:26 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:34:26 INFO - Return code: 0 05:34:26 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:34:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:34:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:34:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:34:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:34:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:34:27 INFO - Return code: 0 05:34:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0185 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:34:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EQeFm8fmG4/Render', 05:34:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:34:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:34:27 INFO - 'HOME': '/Users/cltbld', 05:34:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:34:27 INFO - 'LOGNAME': 'cltbld', 05:34:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:34:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:34:27 INFO - 'MOZ_NO_REMOTE': '1', 05:34:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:34:27 INFO - 'NO_EM_RESTART': '1', 05:34:27 INFO - 'PAGER': '/bin/cat', 05:34:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:34:27 INFO - 'PWD': '/builds/slave/test', 05:34:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:34:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:34:27 INFO - 'SHELL': '/bin/bash', 05:34:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sqqcYWnzC0/Listeners', 05:34:27 INFO - 'TMPDIR': '/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/', 05:34:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:34:27 INFO - 'USER': 'cltbld', 05:34:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:34:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:34:27 INFO - 'XPC_FLAGS': '0x0', 05:34:27 INFO - 'XPC_SERVICE_NAME': '0', 05:34:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:34:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0185', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:34:27 INFO - mozversion application_buildid: 20160323042823 05:34:27 INFO - mozversion application_changeset: 767606cd6c63ee7fd056ca45ce00a65e3bb4ddca 05:34:27 INFO - mozversion application_display_name: Nightly 05:34:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:34:27 INFO - mozversion application_name: Firefox 05:34:27 INFO - mozversion application_remotingname: firefox 05:34:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:34:27 INFO - mozversion application_vendor: Mozilla 05:34:27 INFO - mozversion application_version: 48.0a1 05:34:27 INFO - mozversion platform_buildid: 20160323042823 05:34:27 INFO - mozversion platform_changeset: 767606cd6c63ee7fd056ca45ce00a65e3bb4ddca 05:34:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:34:27 INFO - mozversion platform_version: 48.0a1 05:34:27 INFO - using testdate: 1458736467 05:34:27 INFO - actual date: 1458736467 05:34:27 INFO - starting webserver on 'localhost:49276' 05:34:27 INFO - SUITE-START | Running 2 tests 05:34:27 INFO - TEST-START | dromaeo_css 05:34:27 INFO - operating with platform_type : mac_ 05:34:27 INFO - Initialising browser for dromaeo_css test... 05:34:27 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpUPNsgf/profile http://localhost:49276/getInfo.html) 05:34:30 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 05:34:30 INFO - PROCESS | 1664 | colorDepth:24 05:34:30 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 05:34:30 INFO - PROCESS | 1664 | __metrics 05:34:30 INFO - PROCESS | 1664 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:34:30 ERROR - PROCESS | 1664 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:34:30 INFO - TEST-INFO | 1664: exit 0 05:34:30 INFO - Browser initialized. 05:34:30 INFO - Running cycle 1/1 for dromaeo_css test... 05:34:30 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmpUPNsgf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:42 INFO - PROCESS | 1667 | RSS: Main: 245841920 05:34:42 INFO - PROCESS | 1667 | 05:35:34 INFO - PROCESS | 1667 | 1458736534196 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] 05:37:43 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 05:37:45 INFO - PROCESS | 1667 | RSS: Main: 359505920 05:37:45 INFO - PROCESS | 1667 | 05:40:47 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 05:40:48 INFO - PROCESS | 1667 | RSS: Main: 378085376 05:40:48 INFO - PROCESS | 1667 | 05:43:50 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 05:43:50 INFO - PROCESS | 1667 | RSS: Main: 380649472 05:43:50 INFO - PROCESS | 1667 | 05:46:52 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 05:46:53 INFO - PROCESS | 1667 | RSS: Main: 340201472 05:46:53 INFO - PROCESS | 1667 | 05:49:56 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 05:49:57 INFO - PROCESS | 1667 | RSS: Main: 341602304 05:49:57 INFO - PROCESS | 1667 | 05:53:00 INFO - PROCESS | 1667 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 05:53:00 INFO - PROCESS | 1667 | RSS: Main: 408764416 05:53:00 INFO - PROCESS | 1667 | 05:53:00 INFO - PROCESS | 1667 | __start_tp_report 05:53:00 INFO - PROCESS | 1667 | _x_x_mozilla_page_load 05:53:00 INFO - PROCESS | 1667 | _x_x_mozilla_page_load_details 05:53:00 INFO - PROCESS | 1667 | |i|pagename|runs| 05:53:00 INFO - PROCESS | 1667 | |0;dojo.html;2851.971480285197;3467.0638927489576;3472.4270495368264;3485.895423137307;3529.4352903535423;5520.309961254843;5601.327840659122;5611.691356975365;5623.522000629946;5645.887082258358;5610.523105536025;5755.194272801811;5755.942440575593;5795.3335366432875;5800.53595712343;5074.644774865761;5097.209932460474;5123.513266239701;5139.948600513984;5190.351206099238;5185.922211166836;5198.168293073109;5214.504622060917;5226.163813789794;5239.79040838366;5085.313482679828;5167.664101833407;5184.963007398516;5199.376074871039;5210.687358758468;5182.274481572583;5191.039657663345;5205.219217117425;5215.608829337777;5221.895562088775;5093;5153.536181743623;5164.690118592896;5186.974065129651;5190.7404629768735;5609.0184217761725;5613.21415001896;5619.747111379957;5628.662280263156;5629.296337957755;6079.179310793031;6157.815265542041;6159.938400616026;6164.321924588292;6168.506519478431;6141;6218.68906554675;6232.968835155841;6244.157038799749;6253.843653908643;5674.3190817101795;5751.827445176651;5754.654720716729;5756.942430575725;5760.596758226926;6153.4154255345675;6194.5354098442795;6271.905921411182;6279.277883043417;6293.244810622755;6092.1775560299675;6120.265568131853;6121.326654068049;6122.908156377658;6133.3866613339205;6215.96892015537;6218.751249949952;6241.032639940817;6254.749810007549;6259.71831267594;6011;6122.357152499013;6122.754043469155;6137.754489820357;6192.164057852222;6185.969070154621;6196.81409557714;6199.194104766441;6201.286852012076;6207.720652570645;4844.4186697596515;4862.9544647900875;4864.124457597666;4870.8782280442565;4901.264810278487;4278;4347.695661303678;4364.6290065344165;4410.07388448423;4425.579569940915;5631.746571404296;5662.943370566324;5672.4894759471845;5674.687892165971;5678.5741069419955;6172.135900973867;6210.937890621036;6226.59527130735;6233.875322493524;6240.687965601702;5417.322834645669;5567.359753628384;5590.552755779528;5664.405237450009;5677.37548869624;5315.149576067888;5320.441353657888;5322.361316642027;5328.733563321896;5339.519443250126;6332.620042797447;6349.333320001426;6350.587211831216;6364.777232796922;6371.23545174582;6100.8779824404155;6114.266954506099;6196.318404975539;6207.410296021871;6256.562040657111;6278.843028924313;6303.054541818764;6322.873542529215;6337.366263373626;6340.270868850142;5117.61617878668;6112.694365281807;6151.569390142647;6157.815265542041;6178.567500275118;6063.6664983426335;6068.271807383142;6101.429060711369;6189;6214.161088253028;4633.258678611541;6008.279006519246;6098.146259523759;6105.3177277530895;6116.548817443993;6070.7875224366935;6085.908711369421;6087.4521293083835;6087.482563981934;6096.969515152396;5726.828195154152;5829.3004839417845;5852.795152169653;5943.524518038633;5971;6073;6081.331053584014;6100.359462256399;6106.969465152646;6116.418940200674;5848.239728835224;5901.409859014064;5918.585699001029;5931.9406805931385;5935.495482883831 05:53:00 INFO - PROCESS | 1667 | |1;ext.html;492.8743170491524;502.5376653478799;579.189135210705;634.3371177119909;644.1979735229639;30061.69938300619;39129.21741565167;39649.2070158597;39767.40348894769;39812.8056158315;42098;42569.78715106428;42587.78706106473;42599.78700106503;42715.582753379735;9533.570989305463;9706.61173553057;9759.707208783748;9760.02399760022;9775.560099795526;9626.085521875411;9762.511874406287;9776.120149186572;9778;9806.11744942955;9773.218142548614;9794.559244833965;9804.656837010705;9811.607535698564;9822.017798220193;9683.709488715349;9783.217342612574;9792.853107203433;9836.360636558673;9845.803083938352;9518.38244482766;9622.51887405627;9627.759306017335;9637.37357071788;9661.951690241503;38787.41818872719;39031.829045128405;39293.60706392928;39302.820915372584;39374.60625393738;3200.727938125262;3229.0958531611186;3399.3031428557088;3589.407747721649;3836.865709700175;28464.573031404547;28509;28532.286692832844;28569.57145642817;28718.425631487462;2261.819054475638;2405.8195635327247;2732.2076597786618;2766.9446611067865;2840.7301306376066;468639.7928217522;470600;471463;471635;471649;50834;63388.683056585345;63617;63876;64024.03963940545;72474;73911.63044184852;74032;74169.25830741624;74207.62896185485;16906.492805215865;17057.829421705625;17153.341232109044;17232.569185770204;17252.827471725373;12926.353682316034;12970.156939798882;13005.089643725038;13008.674783130307;13015.414306356237;20858.269960551308;21162.894185528974;21188.576228475653;21215.575688486453;21743.565128697337;7641.529705122454;9528.333016688764;9545.522723863918;9568.282378821616;9624.133827955518;943.5376665434026;986.8223719730518;1058.116472745251;1122.820348744197;1133.387970495923;29054.983075592252;29262.561061583667;29526;29884.40231195364;29946;1058.4229498047853;1106.8893110689028;1215.8358621586149;1228.729679470515;1259.2570383473612;14823.70352592942;14940.103593784408;14957.626059348604;15095.32071056805;15152.772708409382;510458;515162;515626;515895;517372;58890.705546471996;59072.40927590755;59251.70374148102;59308;59318.703406482695;1257.9559715409916;1331.940062697181;1441.0921119694526;1473.4474572035488;1560.0639616230171;23372.6494102592;28431.156884311404;28467.857660711565;29006.854965725037;29178.41643167167;44809.775951120035;56470.717646411504;57005.14492282536;57149;57172.71413642905;386830;389719;394519;394625;394986;36493.635063649024;40771.38842917299;41477;43543.56456435522;43563.78218108889;43194.784026079666;43213.3517997224;43326.133477330906;44445.77777111223;44487.77756111199;34766.65233347634;35959;37624.683136090105;37901.43147852839;38573.80713096417;36532.63467365292;36552;36974;37119.62880371162;37322.44016339703;36106;36691.71578994722;36994.44508332323;37423.43864841975;37500.06249843776;31446.68553314529;31874.690947958974;31966.041018769472;32207.35585288328;32316.83841580777;21265;23693.900634302227;24872.50254994854;25193.49613007693;25324.36689082714 05:53:00 INFO - PROCESS | 1667 | |2;jquery.html;344.4867147949555;346.54083339575067;349.9562554680665;355.04847010013157;357.26047082539156;19476.90261548692;19960.60078798425;20830.375088747325;21361.465963350925;21364.57270854582;14252.857471425283;16009.919950400232;20859.184010158624;20898.477538061517;20919.581608367822;5081.390233172025;5825.330087039981;5957.523398128161;6026.945284575204;6040.033594624861;4200.411942328076;4420.07178492517;5995.850103747398;6320.74717011319;6607.867842643144;6528.477721782246;6530.869382612344;6541;6547.017947307918;6547.6071435713775;6249.375062493759;6561.77033803817;6563.967180164069;6566.967165164144;6571.342865713438;3707.9073023174365;5130.20481825314;5464.863378415532;5481.342238931314;5540.365592150285;22218.222362217406;23455.4136146596;23659.526809463714;25375.873120634464;25381.61927571088;2150.9569808603896;2170.848040637156;2406.0793538697135;2561.2828408045775;2652.310399296197;14245.501407450689;14310.141391516543;14381.856181438261;15100.169490678009;15136.394544218218;1719.2091637846606;1752.1789918231636;1757.4639734880857;1782.679117758803;1782.97325540117;94657.90065745027;97269.5409568857;97450.58922937664;99744;99918.00081999159;9832.311738178401;9919.256055795844;10150.903974287765;10157.644482443078;10288.228382871164;12290.20113692607;12377.752444951051;12406.193597416139;12415.130940834055;12421.130520863633;8279.95952728665;8397.664093436317;8434;8492.70275540353;8499;7333.413326933939;8092.190780921978;8542.273906717874;8883.511406872554;8903.51030693305;6079.118527813531;6082.847928801815;6091;6091.66495842724;6093.878122437526;1549.9767503487458;1607.7025750236244;1692.5768557860536;1712.6745918275487;1740.808511063782;936.1153709744362;960.9903900961041;970.6179236135645;983.1053741095569;1005.2862467647906;20322.08550615226;20522.38432847017;20638.484037898874;20789;20900.954952252327;979.8334283171878;998.8662867645274;1028.1158203944601;1056.3820165203288;1060.2419270221674;11240.200245584214;11276.661700149009;11352.772944541228;11356.375399353115;11373.658790236306;529245;551224;555440;592131;609790;93858.59212111824;94803.52598236964;95239.52380238054;96086;96313.51843240739;1048.8112139814755;1059.2161800267747;1067.2262609608126;1067.3809190669392;1070.855434516346;15072.095674259579;17749.911250443663;18308.908455457637;18352.990585517924;18430;33582.832085839415;45839.77080114711;46293.53706463027;46381.76809115933;47947;44775.55224447714;62950;62992.37007629865;63270.36729632645;63403;7254.331503754272;7368.300011498899;7447.70209191648;7569.735059273119;7716.112647045662;8718.276519880708;10787.67636970892;12394.380280986095;12525.37373131358;12774.68063298425;10449.268551201647;10609.681709548726;10794.622188223375;10905.727356816144;10965.61620343284;10608.840867386842;10699.94650026776;10764.3541387517;10791.676249712522;10905.890941090487;10668.359898406121;10743.516541755796;10832.891671083189;11000.724981875517;11010.119190464904;7349.8162545936775;7380.889286660597;7446.664900079401;7466.775996720107;7709.575973321521;9332.53337333117;9608.66369677058;10316.226283028653;10787.67636970892;11046 05:53:00 INFO - PROCESS | 1667 | |3;mootools.html;1435.2823588205897;1596.8083829940408;1618.9190540472973;1912.9617407651847;2053.579016301658;7938.722144724936;8520.147985201484;8669.86995195071;8692.956535217323;8695.260902823251;8346.207110324525;8628;8630;8644.870326945102;8647.956760216206;2156.1590979518;2399.6040653292184;2432.2460037388423;2460.7416221296776;2466.2971053249826;2463.470353873917;2470.110760126353;2472.987635061831;2473.863937483438;2479.3429741118616;2381.7380088190284;2403.8677872716994;2426.7694569015916;2428.562858685436;2430.9513809723794;2154.149111101114;2384.7734465225776;2392.234484964812;2445.6820613320156;2451.36264571211;2388.3551441110976;2421.5762241607827;2425.357280320716;2426.866522341288;2426.9878650606634;8517.61670724819;8597.355198360085;8606.87089693655;8608.096149904233;8609.5695215239;5045.4702256262935;5130.9743451282875;5200.427952925175;5350.866228344284;5361.973190134064;3200.2959348943195;3504.7721898076543;3623.7644553103964;3626.365386057456;3628.6915612172997;997.1474389397106;997.4015590645627;1020.0870221152102;1021;1029.25893356783;11621.76756464866;11633.476493557726;11638.883611163948;11646.068314534732;11651.242669226473;4530.70550414222;4730.361401210793;4773.212419950669;4784.162771514971;4852.8544143675745;9865.506724663737;9927.106560409598;9946.254030947708;9949;9951.004899509991;5352.5450336721815;5375.9462405376225;5379.327584051994;5384.407715151408;5387.757550910218;4327.567243275647;4515.029268707243;4691.671582989158;4857.878553036202;4863.051704917578;3786.4320351946876;3843.8078096095082;3873.0898238913833;3892.649661530476;3903.33643280643;1247.7754004279318;1260.174585646403;1262.9179103358251;1271.1038717703996;1271.110222844013;1345.6299517632729;1373.6428528582442;1374.6425929258464;1386.0851837787013;1406.704592035684;7997.520148791091;8118.066422361386;8131.390145739093;8133.10535841057;8146.714864979697;485.19699896670363;486.2875886825817;494.1426624805959;494.4042428873271;501.36326864881397;6133.877322453526;6194.721237544231;6197.25632924052;6208.099825525273;6209.720562574605;9937.80124397508;10259.17926565873;10292.897071029343;10370.27408081427;10415.270931034755;10070.244731645156;10178.13485853696;10292.02225788564;10310.948445257725;10336.5348559315;8129.983752030996;8224.588770561328;8360.247577718035;8376.664933402717;8394.538300393415;7742.148363680103;7991.880121798294;8045.798855028671;8135.674573017013;8155.959220203861;9312.953435233052;9334.346595738232;9383.483908385104;9429.746737375595;9440.716778496657;9621.615135394506;9814.607415703293;9897.851532227167;9908.009199080034;9986.051325124101;6758.695858686273;6978.685959131953;7194.316539928698;7481.88777168332;7608.087029556488;8148.1037085919315;8163.877541836996;8192.221738934792;8211.794705132419;8224.712135075244;7142.071530700976;7229.277072292729;7230.096237970254;7356.190819010012;7409.110906691231;7141.821454463472;7196.640167991684;7254.854902901807;7309.744158954411;7492.288232617892;7633.618319084135;7733.651985660546;7743.574103424366;7743.728969486041;7746.883796743166;5910.7340169693325;6909.689063992233;6981.162260528769;7033.261507541839;7044.36600705939;6869.450443964371;6912.308769123048;6913.723451062102;6917.377436030782;6936.549124306904 05:53:00 INFO - PROCESS | 1667 | |4;prototype.html;291.873035229675;310.1068921506063;316.7988327412093;316.8304956848087;324.2590680295525;6364.395382438666;6593.109930159427;6598.538102332838;6609.173853268341;6615.404613584777;6481.773137940173;6527.379898909608;6559.376859198381;6597.109390232317;6598.10925525054;4113.136241389312;4334.111507141044;4584.724916505003;4775.928361074578;4797.664163508538;4572.359869618256;4597.540245975392;4609.285560738074;4631.583157515823;4633.351330813689;4565.634749220071;4566.949601591636;4570.451545814507;4570.451545814507;4598.678092533524;4473.306637471197;4556.635469162459;4572.474165470963;4578.221702310615;4627.953720462786;3929.6659783918403;3948.4077388391684;3949.980250098731;3954.683625309968;3960.5445373782095;6117.877642447171;6149.108379284979;6166.691665416712;6200;6216.098665693495;5417.295751552273;5433.782648694048;5434.755436005389;5454.509094181503;5455.563554915637;6934.965325173393;6938.548994315353;6941.930580694179;6945;7085.291470852925;4259.403683484315;4440.4005459263235;4458.398116254297;4474.552544745499;4494.056248187884;7223.422126229889;7341.853162936764;7383.815404614874;7433.182349941502;7443.813904652373;4523.411956445641;4534.251848444969;4534.841280555164;4535;4539.364488971481;4577.924187815861;4597.770111494412;4599.747013914267;4601.4248218972625;4612.884677883013;5497.8075767347955;5499.202615620713;5500.724963751796;5505.834824955257;5509.972450137724;6758.526903116833;6999.475039371966;7021.156431645192;7059;7070.257622949619;1579.7630355446775;1589.6423304756338;1597.7922870026823;1598.3686443854613;1604.6549991751829;1009.9747506312401;1013.2198207380276;1026.9178465722725;1031.1080915008463;1039.4646756920192;6222.875542489125;6396.840078998062;6464;6467.805965820939;6539.215294164731;7176.246494118147;7206.423486121098;7333.449991250571;7339.559626422431;7353.669084891193;6525.1517302750335;6552.312007239171;6553.737850486023;6558.1802274715665;6560.015997600302;3843.3466310727244;3882.2623701496627;3883;3883.0874744435037;3897.2595206910596;7322.0847394075745;7634.809129771689;7683.308502234714;7685.769426917202;7697.961510192413;7545.73589924361;7560.432967527458;7567.810804729926;7590.734324298623;7595.468317217852;7644.6942122315595;7647.808804779925;7654.2345765423015;7655.540667559964;7663.808404789814;7292.161401438902;7301.904714292686;7323.304286092813;7335.046443962464;7344.559326440431;6969.686364113526;7211.495195336276;7237.384822289953;7239.4932354734665;7240.601766902871;7591.278828511283;7650.349720273839;7656.272654097852;7672.462927595015;7684.269994350528;3728.3661777498432;4468.4414448193975;4505.144022635689;4517.5030746617185;4528.184926713223;5697.401772813795;6111.724972376165;7212.954121652226;7251.5286506376915;7298.087739032621;6773.390394864486;7057.858842823012;7090.787276381717;7113;7118;7062.4703147263135;7102.360787528941;7108.893366599608;7110.644467776487;7127.251638578082;6901.413379862768;6922.203946546211;6924.549904256207;6927.099477067949;6943.027976083454;6854.794356169323;7079.858402831812;7098.361147496544;7110.964445177741;7111.679974401268;6625.768098116543;6798.490113241625;6900.378965893094;6947.5831450113155;6969.059177011039 05:53:00 INFO - PROCESS | 1667 | |5;yui.html;660.2077506991609;767.3477544087526;771.1055175995846;780.6955287437901;782.3819182845552;14969.251537423126;15205.847941520582;15208;15220.467283645088;15230.695386092271;15662.686746265068;16215;16230.513084607452;16242.675146497062;16245.675086498262;750.5984298400357;920.5949382271813;926.0600490502146;929.2333824594702;929.6932012435914;753.6307209467349;759.7758661194961;936.3679516326487;936.442816524167;941.3269512298705;985.2708995343465;987.4865070163511;987.6247026130061;987.9851802222972;998.1415982255255;775.5579319787723;951.7906060666643;979.1236843025488;980.6469670918464;991.6628346362236;714.3856283596103;714.4962801225124;715.8210447388153;718.7089228862319;722.1334398721555;15353.846461535353;15495.767563486557;15498.5350439487;15512.767308490382;15532.61168470786;10182.236332275035;12321.691957701129;12369.13416060876;12413.75172496545;12487.331439497917;10077.395356278646;10107.545160467796;10149.797004059878;10363.378197308186;10468.47657617116;3421.4012547804036;3456.550648415715;3469.6356882527225;3491;3704.666580007812;74140;75458.49083018364;75633.86549201766;75937.48125037523;76599;9400.858987115198;9414.717558473258;9557.90442095584;9596.808063838824;10374.948125259325;21406;21675.458113547287;21683.457913552287;21686.132554697637;21720.891395543236;7323.633818309063;7484.288992545699;7670.156282808886;7736.303732664087;7855.607219638995;3576.7675101118866;3993.6805055595482;4074.1647962167685;4120.546739858613;4153.937690934638;3610.5306310180035;3630.727695422801;3652.9817350913077;3660.9450858237146;3664.2305115925956;620.404411764711;635.7425242776591;661.566673828643;661.9437347825392;682.4233522673333;486.8661118192455;531.3437904188324;541.2746623206642;586.7242396073839;628.8144997225738;7991;8100.2304781045705;8243.375858685014;8292.668293268202;8305.211004954519;536.940936496985;566.3119310038323;602.0547740048082;618.2858798088215;629.1726379810534;3788.507494025814;3791.090138366772;3854.402567602026;3860.536735591691;3882.0877093882914;90120.54939725259;91059.54470227606;92834.53582732043;93364;93725.53137234406;79062.81405778803;79311;79497.60251198823;79954.20045799468;80485.39029219383;59606.10590841141;60885.391146088856;69868.30131698618;70022.9496557552;70339.64830175816;7714.807129821799;7724.92275077242;7730.497517661334;7749.690012399441;7810.906473093885;50464.99070018506;50572.24141637952;50785;50970;51144.488555113974;63813.6809315969;68223.27106915668;69070.96393554;69285.96071059039;70639.58720825658;9986.550605222637;10016.949915250378;10021.849672255068;10212.591496340063;10359.015893490106;10893.346399216072;10913.508892099715;11027.338359698444;11239.494222759831;11734;8557.272047795514;10402.11582015507;10438.164946804085;10687.038166565046;11234.494447749707;10043.34718243341;10297.3821570706;10678.359298442118;10685.252032357661;11184.496697648789;9782.217422606316;9958;10032.448215348226;10045.146162576262;10362.533685983997;8765.649374025223;8812.95593522054;8939.150780675825;9024.774380640536;9060.320475964461;8286.834263314578;8319.500829950222;8384.958075209584;8751.431156974777;8871.806871418605 05:53:00 INFO - PROCESS | 1667 | __end_tp_report 05:53:00 INFO - PROCESS | 1667 | __start_cc_report 05:53:00 INFO - PROCESS | 1667 | _x_x_mozilla_cycle_collect,1043 05:53:00 INFO - PROCESS | 1667 | __end_cc_report 05:53:00 INFO - PROCESS | 1667 | __startTimestamp1458737580266__endTimestamp 05:53:00 INFO - PROCESS | 1667 | 05:53:00 INFO - PROCESS | 1667 | ------- Summary: start ------- 05:53:00 INFO - PROCESS | 1667 | Number of tests: 6 05:53:00 INFO - PROCESS | 1667 | 05:53:00 INFO - PROCESS | 1667 | [#0] dojo.html Cycles:165 Average:5693.73 Median:5918.59 stddev:646.32 (10.9%) stddev-sans-first:608.65 05:53:00 INFO - PROCESS | 1667 | Values: 2852.0 3467.1 3472.4 3485.9 3529.4 5520.3 5601.3 5611.7 5623.5 5645.9 5610.5 5755.2 5755.9 5795.3 5800.5 5074.6 5097.2 5123.5 5139.9 5190.4 5185.9 5198.2 5214.5 5226.2 5239.8 5085.3 5167.7 5185.0 5199.4 5210.7 5182.3 5191.0 5205.2 5215.6 5221.9 5093.0 5153.5 5164.7 5187.0 5190.7 5609.0 5613.2 5619.7 5628.7 5629.3 6079.2 6157.8 6159.9 6164.3 6168.5 6141.0 6218.7 6233.0 6244.2 6253.8 5674.3 5751.8 5754.7 5756.9 5760.6 6153.4 6194.5 6271.9 6279.3 6293.2 6092.2 6120.3 6121.3 6122.9 6133.4 6216.0 6218.8 6241.0 6254.7 6259.7 6011.0 6122.4 6122.8 6137.8 6192.2 6186.0 6196.8 6199.2 6201.3 6207.7 4844.4 4863.0 4864.1 4870.9 4901.3 4278.0 4347.7 4364.6 4410.1 4425.6 5631.7 5662.9 5672.5 5674.7 5678.6 6172.1 6210.9 6226.6 6233.9 6240.7 5417.3 5567.4 5590.6 5664.4 5677.4 5315.1 5320.4 5322.4 5328.7 5339.5 6332.6 6349.3 6350.6 6364.8 6371.2 6100.9 6114.3 6196.3 6207.4 6256.6 6278.8 6303.1 6322.9 6337.4 6340.3 5117.6 6112.7 6151.6 6157.8 6178.6 6063.7 6068.3 6101.4 6189.0 6214.2 4633.3 6008.3 6098.1 6105.3 6116.5 6070.8 6085.9 6087.5 6087.5 6097.0 5726.8 5829.3 5852.8 5943.5 5971.0 6073.0 6081.3 6100.4 6107.0 6116.4 5848.2 5901.4 5918.6 5931.9 5935.5 05:53:00 INFO - PROCESS | 1667 | 05:53:00 INFO - PROCESS | 1667 | [#1] ext.html Cycles:180 Average:61604.21 Median:39298.21 stddev:122578.41 (311.9%) stddev-sans-first:122836.40 05:53:00 INFO - PROCESS | 1667 | Values: 492.9 502.5 579.2 634.3 644.2 30061.7 39129.2 39649.2 39767.4 39812.8 42098.0 42569.8 42587.8 42599.8 42715.6 9533.6 9706.6 9759.7 9760.0 9775.6 9626.1 9762.5 9776.1 9778.0 9806.1 9773.2 9794.6 9804.7 9811.6 9822.0 9683.7 9783.2 9792.9 9836.4 9845.8 9518.4 9622.5 9627.8 9637.4 9662.0 38787.4 39031.8 39293.6 39302.8 39374.6 3200.7 3229.1 3399.3 3589.4 3836.9 28464.6 28509.0 28532.3 28569.6 28718.4 2261.8 2405.8 2732.2 2766.9 2840.7 468639.8 470600.0 471463.0 471635.0 471649.0 50834.0 63388.7 63617.0 63876.0 64024.0 72474.0 73911.6 74032.0 74169.3 74207.6 16906.5 17057.8 17153.3 17232.6 17252.8 12926.4 12970.2 13005.1 13008.7 13015.4 20858.3 21162.9 21188.6 21215.6 21743.6 7641.5 9528.3 9545.5 9568.3 9624.1 943.5 986.8 1058.1 1122.8 1133.4 29055.0 29262.6 29526.0 29884.4 29946.0 1058.4 1106.9 1215.8 1228.7 1259.3 14823.7 14940.1 14957.6 15095.3 15152.8 510458.0 515162.0 515626.0 515895.0 517372.0 58890.7 59072.4 59251.7 59308.0 59318.7 1258.0 1331.9 1441.1 1473.4 1560.1 23372.6 28431.2 28467.9 29006.9 29178.4 44809.8 56470.7 57005.1 57149.0 57172.7 386830.0 389719.0 394519.0 394625.0 394986.0 36493.6 40771.4 41477.0 43543.6 43563.8 43194.8 43213.4 43326.1 44445.8 44487.8 34766.7 35959.0 37624.7 37901.4 38573.8 36532.6 36552.0 36974.0 37119.6 37322.4 36106.0 36691.7 36994.4 37423.4 37500.1 31446.7 31874.7 31966.0 32207.4 32316.8 21265.0 23693.9 24872.5 25193.5 25324.4 05:53:00 INFO - PROCESS | 1667 | 05:53:00 INFO - PROCESS | 1667 | [#2] jquery.html Cycles:180 Average:31788.31 Median:345.51 stddev:93737.91 (27130.0%) stddev-sans-first:93971.13 05:53:00 INFO - PROCESS | 1667 | Values: 344.5 346.5 350.0 355.0 357.3 19476.9 19960.6 20830.4 21361.5 21364.6 14252.9 16009.9 20859.2 20898.5 20919.6 5081.4 5825.3 5957.5 6026.9 6040.0 4200.4 4420.1 5995.9 6320.7 6607.9 6528.5 6530.9 6541.0 6547.0 6547.6 6249.4 6561.8 6564.0 6567.0 6571.3 3707.9 5130.2 5464.9 5481.3 5540.4 22218.2 23455.4 23659.5 25375.9 25381.6 2151.0 2170.8 2406.1 2561.3 2652.3 14245.5 14310.1 14381.9 15100.2 15136.4 1719.2 1752.2 1757.5 1782.7 1783.0 94657.9 97269.5 97450.6 99744.0 99918.0 9832.3 9919.3 10150.9 10157.6 10288.2 12290.2 12377.8 12406.2 12415.1 12421.1 8280.0 8397.7 8434.0 8492.7 8499.0 7333.4 8092.2 8542.3 8883.5 8903.5 6079.1 6082.8 6091.0 6091.7 6093.9 1550.0 1607.7 1692.6 1712.7 1740.8 936.1 961.0 970.6 983.1 1005.3 20322.1 20522.4 20638.5 20789.0 20901.0 979.8 998.9 1028.1 1056.4 1060.2 11240.2 11276.7 11352.8 11356.4 11373.7 529245.0 551224.0 555440.0 592131.0 609790.0 93858.6 94803.5 95239.5 96086.0 96313.5 1048.8 1059.2 1067.2 1067.4 1070.9 15072.1 17749.9 18308.9 18353.0 18430.0 33582.8 45839.8 46293.5 46381.8 47947.0 44775.6 62950.0 62992.4 63270.4 63403.0 7254.3 7368.3 7447.7 7569.7 7716.1 8718.3 10787.7 12394.4 12525.4 12774.7 10449.3 10609.7 10794.6 10905.7 10965.6 10608.8 10699.9 10764.4 10791.7 10905.9 10668.4 10743.5 10832.9 11000.7 11010.1 7349.8 7380.9 7446.7 7466.8 7709.6 9332.5 9608.7 10316.2 10787.7 11046.0 05:53:00 INFO - PROCESS | 1667 | 05:53:00 INFO - PROCESS | 1667 | [#3] mootools.html Cycles:180 Average:5949.70 Median:5386.08 stddev:3145.87 (58.4%) stddev-sans-first:3136.39 05:53:00 INFO - PROCESS | 1667 | Values: 1435.3 1596.8 1618.9 1913.0 2053.6 7938.7 8520.1 8669.9 8693.0 8695.3 8346.2 8628.0 8630.0 8644.9 8648.0 2156.2 2399.6 2432.2 2460.7 2466.3 2463.5 2470.1 2473.0 2473.9 2479.3 2381.7 2403.9 2426.8 2428.6 2431.0 2154.1 2384.8 2392.2 2445.7 2451.4 2388.4 2421.6 2425.4 2426.9 2427.0 8517.6 8597.4 8606.9 8608.1 8609.6 5045.5 5131.0 5200.4 5350.9 5362.0 3200.3 3504.8 3623.8 3626.4 3628.7 997.1 997.4 1020.1 1021.0 1029.3 11621.8 11633.5 11638.9 11646.1 11651.2 4530.7 4730.4 4773.2 4784.2 4852.9 9865.5 9927.1 9946.3 9949.0 9951.0 5352.5 5375.9 5379.3 5384.4 5387.8 4327.6 4515.0 4691.7 4857.9 4863.1 3786.4 3843.8 3873.1 3892.6 3903.3 1247.8 1260.2 1262.9 1271.1 1271.1 1345.6 1373.6 1374.6 1386.1 1406.7 7997.5 8118.1 8131.4 8133.1 8146.7 485.2 486.3 494.1 494.4 501.4 6133.9 6194.7 6197.3 6208.1 6209.7 9937.8 10259.2 10292.9 10370.3 10415.3 10070.2 10178.1 10292.0 10310.9 10336.5 8130.0 8224.6 8360.2 8376.7 8394.5 7742.1 7991.9 8045.8 8135.7 8156.0 9313.0 9334.3 9383.5 9429.7 9440.7 9621.6 9814.6 9897.9 9908.0 9986.1 6758.7 6978.7 7194.3 7481.9 7608.1 8148.1 8163.9 8192.2 8211.8 8224.7 7142.1 7229.3 7230.1 7356.2 7409.1 7141.8 7196.6 7254.9 7309.7 7492.3 7633.6 7733.7 7743.6 7743.7 7746.9 5910.7 6909.7 6981.2 7033.3 7044.4 6869.5 6912.3 6913.7 6917.4 6936.5 05:53:00 INFO - PROCESS | 1667 | 05:53:00 INFO - PROCESS | 1667 | [#4] prototype.html Cycles:180 Average:5704.61 Median:6545.76 stddev:1880.49 (28.7%) stddev-sans-first:1841.36 05:53:00 INFO - PROCESS | 1667 | Values: 291.9 310.1 316.8 316.8 324.3 6364.4 6593.1 6598.5 6609.2 6615.4 6481.8 6527.4 6559.4 6597.1 6598.1 4113.1 4334.1 4584.7 4775.9 4797.7 4572.4 4597.5 4609.3 4631.6 4633.4 4565.6 4566.9 4570.5 4570.5 4598.7 4473.3 4556.6 4572.5 4578.2 4628.0 3929.7 3948.4 3950.0 3954.7 3960.5 6117.9 6149.1 6166.7 6200.0 6216.1 5417.3 5433.8 5434.8 5454.5 5455.6 6935.0 6938.5 6941.9 6945.0 7085.3 4259.4 4440.4 4458.4 4474.6 4494.1 7223.4 7341.9 7383.8 7433.2 7443.8 4523.4 4534.3 4534.8 4535.0 4539.4 4577.9 4597.8 4599.7 4601.4 4612.9 5497.8 5499.2 5500.7 5505.8 5510.0 6758.5 6999.5 7021.2 7059.0 7070.3 1579.8 1589.6 1597.8 1598.4 1604.7 1010.0 1013.2 1026.9 1031.1 1039.5 6222.9 6396.8 6464.0 6467.8 6539.2 7176.2 7206.4 7333.4 7339.6 7353.7 6525.2 6552.3 6553.7 6558.2 6560.0 3843.3 3882.3 3883.0 3883.1 3897.3 7322.1 7634.8 7683.3 7685.8 7698.0 7545.7 7560.4 7567.8 7590.7 7595.5 7644.7 7647.8 7654.2 7655.5 7663.8 7292.2 7301.9 7323.3 7335.0 7344.6 6969.7 7211.5 7237.4 7239.5 7240.6 7591.3 7650.3 7656.3 7672.5 7684.3 3728.4 4468.4 4505.1 4517.5 4528.2 5697.4 6111.7 7213.0 7251.5 7298.1 6773.4 7057.9 7090.8 7113.0 7118.0 7062.5 7102.4 7108.9 7110.6 7127.3 6901.4 6922.2 6924.5 6927.1 6943.0 6854.8 7079.9 7098.4 7111.0 7111.7 6625.8 6798.5 6900.4 6947.6 6969.1 05:53:00 INFO - PROCESS | 1667 | 05:53:00 INFO - PROCESS | 1667 | [#5] yui.html Cycles:180 Average:17997.26 Median:32224.71 stddev:25358.79 (78.7%) stddev-sans-first:25396.52 05:53:00 INFO - PROCESS | 1667 | Values: 660.2 767.3 771.1 780.7 782.4 14969.3 15205.8 15208.0 15220.5 15230.7 15662.7 16215.0 16230.5 16242.7 16245.7 750.6 920.6 926.1 929.2 929.7 753.6 759.8 936.4 936.4 941.3 985.3 987.5 987.6 988.0 998.1 775.6 951.8 979.1 980.6 991.7 714.4 714.5 715.8 718.7 722.1 15353.8 15495.8 15498.5 15512.8 15532.6 10182.2 12321.7 12369.1 12413.8 12487.3 10077.4 10107.5 10149.8 10363.4 10468.5 3421.4 3456.6 3469.6 3491.0 3704.7 74140.0 75458.5 75633.9 75937.5 76599.0 9400.9 9414.7 9557.9 9596.8 10374.9 21406.0 21675.5 21683.5 21686.1 21720.9 7323.6 7484.3 7670.2 7736.3 7855.6 3576.8 3993.7 4074.2 4120.5 4153.9 3610.5 3630.7 3653.0 3660.9 3664.2 620.4 635.7 661.6 661.9 682.4 486.9 531.3 541.3 586.7 628.8 7991.0 8100.2 8243.4 8292.7 8305.2 536.9 566.3 602.1 618.3 629.2 3788.5 3791.1 3854.4 3860.5 3882.1 90120.5 91059.5 92834.5 93364.0 93725.5 79062.8 79311.0 79497.6 79954.2 80485.4 59606.1 60885.4 69868.3 70022.9 70339.6 7714.8 7724.9 7730.5 7749.7 7810.9 50465.0 50572.2 50785.0 50970.0 51144.5 63813.7 68223.3 69071.0 69286.0 70639.6 9986.6 10016.9 10021.8 10212.6 10359.0 10893.3 10913.5 11027.3 11239.5 11734.0 8557.3 10402.1 10438.2 10687.0 11234.5 10043.3 10297.4 10678.4 10685.3 11184.5 9782.2 9958.0 10032.4 10045.1 10362.5 8765.6 8813.0 8939.2 9024.8 9060.3 8286.8 8319.5 8385.0 8751.4 8871.8 05:53:00 INFO - PROCESS | 1667 | -------- Summary: end -------- 05:53:00 INFO - PROCESS | 1667 | 05:53:00 INFO - TEST-INFO | 1667: exit 0 05:53:00 INFO - TEST-OK | dromaeo_css | took 1113086ms 05:53:00 INFO - TEST-START | kraken 05:53:00 INFO - operating with platform_type : mac_ 05:53:00 INFO - Initialising browser for kraken test... 05:53:00 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmphDUAcp/profile http://localhost:49276/getInfo.html) 05:53:02 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 05:53:02 INFO - PROCESS | 1676 | colorDepth:24 05:53:02 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 05:53:02 INFO - PROCESS | 1676 | __metrics 05:53:03 INFO - PROCESS | 1676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:53:03 ERROR - PROCESS | 1676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:53:03 INFO - TEST-INFO | 1676: exit 0 05:53:03 INFO - Browser initialized. 05:53:03 INFO - Running cycle 1/1 for kraken test... 05:53:03 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/tmphDUAcp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:15 INFO - PROCESS | 1678 | RSS: Main: 245800960 05:53:15 INFO - PROCESS | 1678 | 05:53:18 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 05:53:18 INFO - PROCESS | 1678 | RSS: Main: 292487168 05:53:18 INFO - PROCESS | 1678 | 05:53:21 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 05:53:21 INFO - PROCESS | 1678 | RSS: Main: 303353856 05:53:21 INFO - PROCESS | 1678 | 05:53:25 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 05:53:25 INFO - PROCESS | 1678 | RSS: Main: 290410496 05:53:25 INFO - PROCESS | 1678 | 05:53:27 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 05:53:28 INFO - PROCESS | 1678 | RSS: Main: 293974016 05:53:28 INFO - PROCESS | 1678 | 05:53:30 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:53:31 INFO - PROCESS | 1678 | RSS: Main: 292900864 05:53:31 INFO - PROCESS | 1678 | 05:53:33 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 05:53:34 INFO - PROCESS | 1678 | RSS: Main: 294625280 05:53:34 INFO - PROCESS | 1678 | 05:53:37 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 05:53:37 INFO - PROCESS | 1678 | RSS: Main: 294572032 05:53:37 INFO - PROCESS | 1678 | 05:53:40 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 05:53:41 INFO - PROCESS | 1678 | RSS: Main: 293576704 05:53:41 INFO - PROCESS | 1678 | 05:53:42 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:53:43 INFO - PROCESS | 1678 | RSS: Main: 327176192 05:53:43 INFO - PROCESS | 1678 | 05:53:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:53:45 INFO - PROCESS | 1678 | RSS: Main: 327147520 05:53:45 INFO - PROCESS | 1678 | 05:53:47 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:53:48 INFO - PROCESS | 1678 | RSS: Main: 332492800 05:53:48 INFO - PROCESS | 1678 | 05:53:51 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:53:51 INFO - PROCESS | 1678 | RSS: Main: 333885440 05:53:51 INFO - PROCESS | 1678 | 05:53:54 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:53:54 INFO - PROCESS | 1678 | RSS: Main: 335360000 05:53:54 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 05:53:56 INFO - PROCESS | 1678 | RSS: Main: 395804672 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | __start_tp_report 05:53:56 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 05:53:56 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 05:53:56 INFO - PROCESS | 1678 | |i|pagename|runs| 05:53:56 INFO - PROCESS | 1678 | |0;ai-astar;110;106;109;110;112;108;116;111;114;111 05:53:56 INFO - PROCESS | 1678 | |1;audio-beat-detection;158;123;152;195;120;138;137;121;160;120 05:53:56 INFO - PROCESS | 1678 | |2;audio-dft;186;181;184;183;184;183;191;260;182;181 05:53:56 INFO - PROCESS | 1678 | |3;audio-fft;76;72;85;76;55;60;58;79;77;55 05:53:56 INFO - PROCESS | 1678 | |4;audio-oscillator;96;89;126;81;78;89;113;78;78;115 05:53:56 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;88;85;89;86;87;85;88;86;88;84 05:53:56 INFO - PROCESS | 1678 | |6;imaging-darkroom;92;93;93;93;93;93;93;97;93;94 05:53:56 INFO - PROCESS | 1678 | |7;imaging-desaturate;87;86;85;85;85;86;86;84;86;85 05:53:56 INFO - PROCESS | 1678 | |8;json-parse-financial;55;58;55;55;56;56;55;65;57;53 05:53:56 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;63;64;75;81;99;66;67;66;66;67 05:53:56 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;83;85;80;101;108;107;109;81;83;83 05:53:56 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;122;127;123;128;114;120;124;120;119;121 05:53:56 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;136;126;141;139;137;126;138;138;137;136 05:53:56 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;67;66;65;68;67;67;67;65;67;65 05:53:56 INFO - PROCESS | 1678 | __end_tp_report 05:53:56 INFO - PROCESS | 1678 | __start_cc_report 05:53:56 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1215 05:53:56 INFO - PROCESS | 1678 | __end_cc_report 05:53:56 INFO - PROCESS | 1678 | __startTimestamp1458737636591__endTimestamp 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | ------- Summary: start ------- 05:53:56 INFO - PROCESS | 1678 | Number of tests: 14 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:110.70 Median:111.00 stddev:2.87 (2.6%) stddev-sans-first:3.03 05:53:56 INFO - PROCESS | 1678 | Values: 110.0 106.0 109.0 110.0 112.0 108.0 116.0 111.0 114.0 111.0 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:145.00 stddev:24.26 (16.7%) stddev-sans-first:25.07 05:53:56 INFO - PROCESS | 1678 | Values: 158.0 123.0 152.0 195.0 120.0 138.0 137.0 121.0 160.0 120.0 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:191.50 Median:184.00 stddev:24.25 (13.2%) stddev-sans-first:25.63 05:53:56 INFO - PROCESS | 1678 | Values: 186.0 181.0 184.0 183.0 184.0 183.0 191.0 260.0 182.0 181.0 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:69.30 Median:76.00 stddev:11.16 (14.7%) stddev-sans-first:11.57 05:53:56 INFO - PROCESS | 1678 | Values: 76.0 72.0 85.0 76.0 55.0 60.0 58.0 79.0 77.0 55.0 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:94.30 Median:79.50 stddev:17.69 (22.3%) stddev-sans-first:18.75 05:53:56 INFO - PROCESS | 1678 | Values: 96.0 89.0 126.0 81.0 78.0 89.0 113.0 78.0 78.0 115.0 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:87.50 stddev:1.65 (1.9%) stddev-sans-first:1.67 05:53:56 INFO - PROCESS | 1678 | Values: 88.0 85.0 89.0 86.0 87.0 85.0 88.0 86.0 88.0 84.0 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.00 stddev:1.35 (1.5%) stddev-sans-first:1.33 05:53:56 INFO - PROCESS | 1678 | Values: 92.0 93.0 93.0 93.0 93.0 93.0 93.0 97.0 93.0 94.0 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:0.85 (1.0%) stddev-sans-first:0.71 05:53:56 INFO - PROCESS | 1678 | Values: 87.0 86.0 85.0 85.0 85.0 86.0 86.0 84.0 86.0 85.0 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:56.00 stddev:3.27 (5.8%) stddev-sans-first:3.43 05:53:56 INFO - PROCESS | 1678 | Values: 55.0 58.0 55.0 55.0 56.0 56.0 55.0 65.0 57.0 53.0 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:67.00 stddev:11.15 (16.6%) stddev-sans-first:11.40 05:53:56 INFO - PROCESS | 1678 | Values: 63.0 64.0 75.0 81.0 99.0 66.0 67.0 66.0 66.0 67.0 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:82.00 stddev:12.51 (15.3%) stddev-sans-first:12.84 05:53:56 INFO - PROCESS | 1678 | Values: 83.0 85.0 80.0 101.0 108.0 107.0 109.0 81.0 83.0 83.0 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:122.50 stddev:4.05 (3.3%) stddev-sans-first:4.29 05:53:56 INFO - PROCESS | 1678 | Values: 122.0 127.0 123.0 128.0 114.0 120.0 124.0 120.0 119.0 121.0 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.40 Median:137.50 stddev:5.17 (3.8%) stddev-sans-first:5.48 05:53:56 INFO - PROCESS | 1678 | Values: 136.0 126.0 141.0 139.0 137.0 126.0 138.0 138.0 137.0 136.0 05:53:56 INFO - PROCESS | 1678 | 05:53:56 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.12 05:53:56 INFO - PROCESS | 1678 | Values: 67.0 66.0 65.0 68.0 67.0 67.0 67.0 65.0 67.0 65.0 05:53:56 INFO - PROCESS | 1678 | -------- Summary: end -------- 05:53:56 INFO - PROCESS | 1678 | 05:53:57 INFO - TEST-INFO | 1678: exit 0 05:53:57 INFO - TEST-OK | kraken | took 56516ms 05:53:57 INFO - SUITE-END | took 1169s 05:53:57 INFO - Completed test suite (00:19:30) 05:53:57 INFO - javascript benchmark 05:53:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2851.971480285197, 3467.0638927489576, 3472.4270495368264, 3485.895423137307, 3529.4352903535423, 5520.309961254843, 5601.327840659122, 5611.691356975365, 5623.522000629946, 5645.887082258358, 5610.523105536025, 5755.194272801811, 5755.942440575593, 5795.3335366432875, 5800.53595712343, 5074.644774865761, 5097.209932460474, 5123.513266239701, 5139.948600513984, 5190.351206099238, 5185.922211166836, 5198.168293073109, 5214.504622060917, 5226.163813789794, 5239.79040838366, 5085.313482679828, 5167.664101833407, 5184.963007398516, 5199.376074871039, 5210.687358758468, 5182.274481572583, 5191.039657663345, 5205.219217117425, 5215.608829337777, 5221.895562088775, 5093.0, 5153.536181743623, 5164.690118592896, 5186.974065129651, 5190.7404629768735, 5609.0184217761725, 5613.21415001896, 5619.747111379957, 5628.662280263156, 5629.296337957755, 6079.179310793031, 6157.815265542041, 6159.938400616026, 6164.321924588292, 6168.506519478431, 6141.0, 6218.68906554675, 6232.968835155841, 6244.157038799749, 6253.843653908643, 5674.3190817101795, 5751.827445176651, 5754.654720716729, 5756.942430575725, 5760.596758226926, 6153.4154255345675, 6194.5354098442795, 6271.905921411182, 6279.277883043417, 6293.244810622755, 6092.1775560299675, 6120.265568131853, 6121.326654068049, 6122.908156377658, 6133.3866613339205, 6215.96892015537, 6218.751249949952, 6241.032639940817, 6254.749810007549, 6259.71831267594, 6011.0, 6122.357152499013, 6122.754043469155, 6137.754489820357, 6192.164057852222, 6185.969070154621, 6196.81409557714, 6199.194104766441, 6201.286852012076, 6207.720652570645, 4844.4186697596515, 4862.9544647900875, 4864.124457597666, 4870.8782280442565, 4901.264810278487, 4278.0, 4347.695661303678, 4364.6290065344165, 4410.07388448423, 4425.579569940915, 5631.746571404296, 5662.943370566324, 5672.4894759471845, 5674.687892165971, 5678.5741069419955, 6172.135900973867, 6210.937890621036, 6226.59527130735, 6233.875322493524, 6240.687965601702, 5417.322834645669, 5567.359753628384, 5590.552755779528, 5664.405237450009, 5677.37548869624, 5315.149576067888, 5320.441353657888, 5322.361316642027, 5328.733563321896, 5339.519443250126, 6332.620042797447, 6349.333320001426, 6350.587211831216, 6364.777232796922, 6371.23545174582, 6100.8779824404155, 6114.266954506099, 6196.318404975539, 6207.410296021871, 6256.562040657111, 6278.843028924313, 6303.054541818764, 6322.873542529215, 6337.366263373626, 6340.270868850142, 5117.61617878668, 6112.694365281807, 6151.569390142647, 6157.815265542041, 6178.567500275118, 6063.6664983426335, 6068.271807383142, 6101.429060711369, 6189.0, 6214.161088253028, 4633.258678611541, 6008.279006519246, 6098.146259523759, 6105.3177277530895, 6116.548817443993, 6070.7875224366935, 6085.908711369421, 6087.4521293083835, 6087.482563981934, 6096.969515152396, 5726.828195154152, 5829.3004839417845, 5852.795152169653, 5943.524518038633, 5971.0, 6073.0, 6081.331053584014, 6100.359462256399, 6106.969465152646, 6116.418940200674, 5848.239728835224, 5901.409859014064, 5918.585699001029, 5931.9406805931385, 5935.495482883831], "unit": "score", "name": "dojo.html", "value": 5652.515686625839}, {"lowerIsBetter": false, "replicates": [492.8743170491524, 502.5376653478799, 579.189135210705, 634.3371177119909, 644.1979735229639, 30061.69938300619, 39129.21741565167, 39649.2070158597, 39767.40348894769, 39812.8056158315, 42098.0, 42569.78715106428, 42587.78706106473, 42599.78700106503, 42715.582753379735, 9533.570989305463, 9706.61173553057, 9759.707208783748, 9760.02399760022, 9775.560099795526, 9626.085521875411, 9762.511874406287, 9776.120149186572, 9778.0, 9806.11744942955, 9773.218142548614, 9794.559244833965, 9804.656837010705, 9811.607535698564, 9822.017798220193, 9683.709488715349, 9783.217342612574, 9792.853107203433, 9836.360636558673, 9845.803083938352, 9518.38244482766, 9622.51887405627, 9627.759306017335, 9637.37357071788, 9661.951690241503, 38787.41818872719, 39031.829045128405, 39293.60706392928, 39302.820915372584, 39374.60625393738, 3200.727938125262, 3229.0958531611186, 3399.3031428557088, 3589.407747721649, 3836.865709700175, 28464.573031404547, 28509.0, 28532.286692832844, 28569.57145642817, 28718.425631487462, 2261.819054475638, 2405.8195635327247, 2732.2076597786618, 2766.9446611067865, 2840.7301306376066, 468639.7928217522, 470600.0, 471463.0, 471635.0, 471649.0, 50834.0, 63388.683056585345, 63617.0, 63876.0, 64024.03963940545, 72474.0, 73911.63044184852, 74032.0, 74169.25830741624, 74207.62896185485, 16906.492805215865, 17057.829421705625, 17153.341232109044, 17232.569185770204, 17252.827471725373, 12926.353682316034, 12970.156939798882, 13005.089643725038, 13008.674783130307, 13015.414306356237, 20858.269960551308, 21162.894185528974, 21188.576228475653, 21215.575688486453, 21743.565128697337, 7641.529705122454, 9528.333016688764, 9545.522723863918, 9568.282378821616, 9624.133827955518, 943.5376665434026, 986.8223719730518, 1058.116472745251, 1122.820348744197, 1133.387970495923, 29054.983075592252, 29262.561061583667, 29526.0, 29884.40231195364, 29946.0, 1058.4229498047853, 1106.8893110689028, 1215.8358621586149, 1228.729679470515, 1259.2570383473612, 14823.70352592942, 14940.103593784408, 14957.626059348604, 15095.32071056805, 15152.772708409382, 510458.0, 515162.0, 515626.0, 515895.0, 517372.0, 58890.705546471996, 59072.40927590755, 59251.70374148102, 59308.0, 59318.703406482695, 1257.9559715409916, 1331.940062697181, 1441.0921119694526, 1473.4474572035488, 1560.0639616230171, 23372.6494102592, 28431.156884311404, 28467.857660711565, 29006.854965725037, 29178.41643167167, 44809.775951120035, 56470.717646411504, 57005.14492282536, 57149.0, 57172.71413642905, 386830.0, 389719.0, 394519.0, 394625.0, 394986.0, 36493.635063649024, 40771.38842917299, 41477.0, 43543.56456435522, 43563.78218108889, 43194.784026079666, 43213.3517997224, 43326.133477330906, 44445.77777111223, 44487.77756111199, 34766.65233347634, 35959.0, 37624.683136090105, 37901.43147852839, 38573.80713096417, 36532.63467365292, 36552.0, 36974.0, 37119.62880371162, 37322.44016339703, 36106.0, 36691.71578994722, 36994.44508332323, 37423.43864841975, 37500.06249843776, 31446.68553314529, 31874.690947958974, 31966.041018769472, 32207.35585288328, 32316.83841580777, 21265.0, 23693.900634302227, 24872.50254994854, 25193.49613007693, 25324.36689082714], "unit": "score", "name": "ext.html", "value": 20024.678832027665}, {"lowerIsBetter": false, "replicates": [344.4867147949555, 346.54083339575067, 349.9562554680665, 355.04847010013157, 357.26047082539156, 19476.90261548692, 19960.60078798425, 20830.375088747325, 21361.465963350925, 21364.57270854582, 14252.857471425283, 16009.919950400232, 20859.184010158624, 20898.477538061517, 20919.581608367822, 5081.390233172025, 5825.330087039981, 5957.523398128161, 6026.945284575204, 6040.033594624861, 4200.411942328076, 4420.07178492517, 5995.850103747398, 6320.74717011319, 6607.867842643144, 6528.477721782246, 6530.869382612344, 6541.0, 6547.017947307918, 6547.6071435713775, 6249.375062493759, 6561.77033803817, 6563.967180164069, 6566.967165164144, 6571.342865713438, 3707.9073023174365, 5130.20481825314, 5464.863378415532, 5481.342238931314, 5540.365592150285, 22218.222362217406, 23455.4136146596, 23659.526809463714, 25375.873120634464, 25381.61927571088, 2150.9569808603896, 2170.848040637156, 2406.0793538697135, 2561.2828408045775, 2652.310399296197, 14245.501407450689, 14310.141391516543, 14381.856181438261, 15100.169490678009, 15136.394544218218, 1719.2091637846606, 1752.1789918231636, 1757.4639734880857, 1782.679117758803, 1782.97325540117, 94657.90065745027, 97269.5409568857, 97450.58922937664, 99744.0, 99918.00081999159, 9832.311738178401, 9919.256055795844, 10150.903974287765, 10157.644482443078, 10288.228382871164, 12290.20113692607, 12377.752444951051, 12406.193597416139, 12415.130940834055, 12421.130520863633, 8279.95952728665, 8397.664093436317, 8434.0, 8492.70275540353, 8499.0, 7333.413326933939, 8092.190780921978, 8542.273906717874, 8883.511406872554, 8903.51030693305, 6079.118527813531, 6082.847928801815, 6091.0, 6091.66495842724, 6093.878122437526, 1549.9767503487458, 1607.7025750236244, 1692.5768557860536, 1712.6745918275487, 1740.808511063782, 936.1153709744362, 960.9903900961041, 970.6179236135645, 983.1053741095569, 1005.2862467647906, 20322.08550615226, 20522.38432847017, 20638.484037898874, 20789.0, 20900.954952252327, 979.8334283171878, 998.8662867645274, 1028.1158203944601, 1056.3820165203288, 1060.2419270221674, 11240.200245584214, 11276.661700149009, 11352.772944541228, 11356.375399353115, 11373.658790236306, 529245.0, 551224.0, 555440.0, 592131.0, 609790.0, 93858.59212111824, 94803.52598236964, 95239.52380238054, 96086.0, 96313.51843240739, 1048.8112139814755, 1059.2161800267747, 1067.2262609608126, 1067.3809190669392, 1070.855434516346, 15072.095674259579, 17749.911250443663, 18308.908455457637, 18352.990585517924, 18430.0, 33582.832085839415, 45839.77080114711, 46293.53706463027, 46381.76809115933, 47947.0, 44775.55224447714, 62950.0, 62992.37007629865, 63270.36729632645, 63403.0, 7254.331503754272, 7368.300011498899, 7447.70209191648, 7569.735059273119, 7716.112647045662, 8718.276519880708, 10787.67636970892, 12394.380280986095, 12525.37373131358, 12774.68063298425, 10449.268551201647, 10609.681709548726, 10794.622188223375, 10905.727356816144, 10965.61620343284, 10608.840867386842, 10699.94650026776, 10764.3541387517, 10791.676249712522, 10905.890941090487, 10668.359898406121, 10743.516541755796, 10832.891671083189, 11000.724981875517, 11010.119190464904, 7349.8162545936775, 7380.889286660597, 7446.664900079401, 7466.775996720107, 7709.575973321521, 9332.53337333117, 9608.66369677058, 10316.226283028653, 10787.67636970892, 11046.0], "unit": "score", "name": "jquery.html", "value": 9247.004765377962}, {"lowerIsBetter": false, "replicates": [1435.2823588205897, 1596.8083829940408, 1618.9190540472973, 1912.9617407651847, 2053.579016301658, 7938.722144724936, 8520.147985201484, 8669.86995195071, 8692.956535217323, 8695.260902823251, 8346.207110324525, 8628.0, 8630.0, 8644.870326945102, 8647.956760216206, 2156.1590979518, 2399.6040653292184, 2432.2460037388423, 2460.7416221296776, 2466.2971053249826, 2463.470353873917, 2470.110760126353, 2472.987635061831, 2473.863937483438, 2479.3429741118616, 2381.7380088190284, 2403.8677872716994, 2426.7694569015916, 2428.562858685436, 2430.9513809723794, 2154.149111101114, 2384.7734465225776, 2392.234484964812, 2445.6820613320156, 2451.36264571211, 2388.3551441110976, 2421.5762241607827, 2425.357280320716, 2426.866522341288, 2426.9878650606634, 8517.61670724819, 8597.355198360085, 8606.87089693655, 8608.096149904233, 8609.5695215239, 5045.4702256262935, 5130.9743451282875, 5200.427952925175, 5350.866228344284, 5361.973190134064, 3200.2959348943195, 3504.7721898076543, 3623.7644553103964, 3626.365386057456, 3628.6915612172997, 997.1474389397106, 997.4015590645627, 1020.0870221152102, 1021.0, 1029.25893356783, 11621.76756464866, 11633.476493557726, 11638.883611163948, 11646.068314534732, 11651.242669226473, 4530.70550414222, 4730.361401210793, 4773.212419950669, 4784.162771514971, 4852.8544143675745, 9865.506724663737, 9927.106560409598, 9946.254030947708, 9949.0, 9951.004899509991, 5352.5450336721815, 5375.9462405376225, 5379.327584051994, 5384.407715151408, 5387.757550910218, 4327.567243275647, 4515.029268707243, 4691.671582989158, 4857.878553036202, 4863.051704917578, 3786.4320351946876, 3843.8078096095082, 3873.0898238913833, 3892.649661530476, 3903.33643280643, 1247.7754004279318, 1260.174585646403, 1262.9179103358251, 1271.1038717703996, 1271.110222844013, 1345.6299517632729, 1373.6428528582442, 1374.6425929258464, 1386.0851837787013, 1406.704592035684, 7997.520148791091, 8118.066422361386, 8131.390145739093, 8133.10535841057, 8146.714864979697, 485.19699896670363, 486.2875886825817, 494.1426624805959, 494.4042428873271, 501.36326864881397, 6133.877322453526, 6194.721237544231, 6197.25632924052, 6208.099825525273, 6209.720562574605, 9937.80124397508, 10259.17926565873, 10292.897071029343, 10370.27408081427, 10415.270931034755, 10070.244731645156, 10178.13485853696, 10292.02225788564, 10310.948445257725, 10336.5348559315, 8129.983752030996, 8224.588770561328, 8360.247577718035, 8376.664933402717, 8394.538300393415, 7742.148363680103, 7991.880121798294, 8045.798855028671, 8135.674573017013, 8155.959220203861, 9312.953435233052, 9334.346595738232, 9383.483908385104, 9429.746737375595, 9440.716778496657, 9621.615135394506, 9814.607415703293, 9897.851532227167, 9908.009199080034, 9986.051325124101, 6758.695858686273, 6978.685959131953, 7194.316539928698, 7481.88777168332, 7608.087029556488, 8148.1037085919315, 8163.877541836996, 8192.221738934792, 8211.794705132419, 8224.712135075244, 7142.071530700976, 7229.277072292729, 7230.096237970254, 7356.190819010012, 7409.110906691231, 7141.821454463472, 7196.640167991684, 7254.854902901807, 7309.744158954411, 7492.288232617892, 7633.618319084135, 7733.651985660546, 7743.574103424366, 7743.728969486041, 7746.883796743166, 5910.7340169693325, 6909.689063992233, 6981.162260528769, 7033.261507541839, 7044.36600705939, 6869.450443964371, 6912.308769123048, 6913.723451062102, 6917.377436030782, 6936.549124306904], "unit": "score", "name": "mootools.html", "value": 4771.612670451751}, {"lowerIsBetter": false, "replicates": [291.873035229675, 310.1068921506063, 316.7988327412093, 316.8304956848087, 324.2590680295525, 6364.395382438666, 6593.109930159427, 6598.538102332838, 6609.173853268341, 6615.404613584777, 6481.773137940173, 6527.379898909608, 6559.376859198381, 6597.109390232317, 6598.10925525054, 4113.136241389312, 4334.111507141044, 4584.724916505003, 4775.928361074578, 4797.664163508538, 4572.359869618256, 4597.540245975392, 4609.285560738074, 4631.583157515823, 4633.351330813689, 4565.634749220071, 4566.949601591636, 4570.451545814507, 4570.451545814507, 4598.678092533524, 4473.306637471197, 4556.635469162459, 4572.474165470963, 4578.221702310615, 4627.953720462786, 3929.6659783918403, 3948.4077388391684, 3949.980250098731, 3954.683625309968, 3960.5445373782095, 6117.877642447171, 6149.108379284979, 6166.691665416712, 6200.0, 6216.098665693495, 5417.295751552273, 5433.782648694048, 5434.755436005389, 5454.509094181503, 5455.563554915637, 6934.965325173393, 6938.548994315353, 6941.930580694179, 6945.0, 7085.291470852925, 4259.403683484315, 4440.4005459263235, 4458.398116254297, 4474.552544745499, 4494.056248187884, 7223.422126229889, 7341.853162936764, 7383.815404614874, 7433.182349941502, 7443.813904652373, 4523.411956445641, 4534.251848444969, 4534.841280555164, 4535.0, 4539.364488971481, 4577.924187815861, 4597.770111494412, 4599.747013914267, 4601.4248218972625, 4612.884677883013, 5497.8075767347955, 5499.202615620713, 5500.724963751796, 5505.834824955257, 5509.972450137724, 6758.526903116833, 6999.475039371966, 7021.156431645192, 7059.0, 7070.257622949619, 1579.7630355446775, 1589.6423304756338, 1597.7922870026823, 1598.3686443854613, 1604.6549991751829, 1009.9747506312401, 1013.2198207380276, 1026.9178465722725, 1031.1080915008463, 1039.4646756920192, 6222.875542489125, 6396.840078998062, 6464.0, 6467.805965820939, 6539.215294164731, 7176.246494118147, 7206.423486121098, 7333.449991250571, 7339.559626422431, 7353.669084891193, 6525.1517302750335, 6552.312007239171, 6553.737850486023, 6558.1802274715665, 6560.015997600302, 3843.3466310727244, 3882.2623701496627, 3883.0, 3883.0874744435037, 3897.2595206910596, 7322.0847394075745, 7634.809129771689, 7683.308502234714, 7685.769426917202, 7697.961510192413, 7545.73589924361, 7560.432967527458, 7567.810804729926, 7590.734324298623, 7595.468317217852, 7644.6942122315595, 7647.808804779925, 7654.2345765423015, 7655.540667559964, 7663.808404789814, 7292.161401438902, 7301.904714292686, 7323.304286092813, 7335.046443962464, 7344.559326440431, 6969.686364113526, 7211.495195336276, 7237.384822289953, 7239.4932354734665, 7240.601766902871, 7591.278828511283, 7650.349720273839, 7656.272654097852, 7672.462927595015, 7684.269994350528, 3728.3661777498432, 4468.4414448193975, 4505.144022635689, 4517.5030746617185, 4528.184926713223, 5697.401772813795, 6111.724972376165, 7212.954121652226, 7251.5286506376915, 7298.087739032621, 6773.390394864486, 7057.858842823012, 7090.787276381717, 7113.0, 7118.0, 7062.4703147263135, 7102.360787528941, 7108.893366599608, 7110.644467776487, 7127.251638578082, 6901.413379862768, 6922.203946546211, 6924.549904256207, 6927.099477067949, 6943.027976083454, 6854.794356169323, 7079.858402831812, 7098.361147496544, 7110.964445177741, 7111.679974401268, 6625.768098116543, 6798.490113241625, 6900.378965893094, 6947.5831450113155, 6969.059177011039], "unit": "score", "name": "prototype.html", "value": 5067.581946341537}, {"lowerIsBetter": false, "replicates": [660.2077506991609, 767.3477544087526, 771.1055175995846, 780.6955287437901, 782.3819182845552, 14969.251537423126, 15205.847941520582, 15208.0, 15220.467283645088, 15230.695386092271, 15662.686746265068, 16215.0, 16230.513084607452, 16242.675146497062, 16245.675086498262, 750.5984298400357, 920.5949382271813, 926.0600490502146, 929.2333824594702, 929.6932012435914, 753.6307209467349, 759.7758661194961, 936.3679516326487, 936.442816524167, 941.3269512298705, 985.2708995343465, 987.4865070163511, 987.6247026130061, 987.9851802222972, 998.1415982255255, 775.5579319787723, 951.7906060666643, 979.1236843025488, 980.6469670918464, 991.6628346362236, 714.3856283596103, 714.4962801225124, 715.8210447388153, 718.7089228862319, 722.1334398721555, 15353.846461535353, 15495.767563486557, 15498.5350439487, 15512.767308490382, 15532.61168470786, 10182.236332275035, 12321.691957701129, 12369.13416060876, 12413.75172496545, 12487.331439497917, 10077.395356278646, 10107.545160467796, 10149.797004059878, 10363.378197308186, 10468.47657617116, 3421.4012547804036, 3456.550648415715, 3469.6356882527225, 3491.0, 3704.666580007812, 74140.0, 75458.49083018364, 75633.86549201766, 75937.48125037523, 76599.0, 9400.858987115198, 9414.717558473258, 9557.90442095584, 9596.808063838824, 10374.948125259325, 21406.0, 21675.458113547287, 21683.457913552287, 21686.132554697637, 21720.891395543236, 7323.633818309063, 7484.288992545699, 7670.156282808886, 7736.303732664087, 7855.607219638995, 3576.7675101118866, 3993.6805055595482, 4074.1647962167685, 4120.546739858613, 4153.937690934638, 3610.5306310180035, 3630.727695422801, 3652.9817350913077, 3660.9450858237146, 3664.2305115925956, 620.404411764711, 635.7425242776591, 661.566673828643, 661.9437347825392, 682.4233522673333, 486.8661118192455, 531.3437904188324, 541.2746623206642, 586.7242396073839, 628.8144997225738, 7991.0, 8100.2304781045705, 8243.375858685014, 8292.668293268202, 8305.211004954519, 536.940936496985, 566.3119310038323, 602.0547740048082, 618.2858798088215, 629.1726379810534, 3788.507494025814, 3791.090138366772, 3854.402567602026, 3860.536735591691, 3882.0877093882914, 90120.54939725259, 91059.54470227606, 92834.53582732043, 93364.0, 93725.53137234406, 79062.81405778803, 79311.0, 79497.60251198823, 79954.20045799468, 80485.39029219383, 59606.10590841141, 60885.391146088856, 69868.30131698618, 70022.9496557552, 70339.64830175816, 7714.807129821799, 7724.92275077242, 7730.497517661334, 7749.690012399441, 7810.906473093885, 50464.99070018506, 50572.24141637952, 50785.0, 50970.0, 51144.488555113974, 63813.6809315969, 68223.27106915668, 69070.96393554, 69285.96071059039, 70639.58720825658, 9986.550605222637, 10016.949915250378, 10021.849672255068, 10212.591496340063, 10359.015893490106, 10893.346399216072, 10913.508892099715, 11027.338359698444, 11239.494222759831, 11734.0, 8557.272047795514, 10402.11582015507, 10438.164946804085, 10687.038166565046, 11234.494447749707, 10043.34718243341, 10297.3821570706, 10678.359298442118, 10685.252032357661, 11184.496697648789, 9782.217422606316, 9958.0, 10032.448215348226, 10045.146162576262, 10362.533685983997, 8765.649374025223, 8812.95593522054, 8939.150780675825, 9024.774380640536, 9060.320475964461, 8286.834263314578, 8319.500829950222, 8384.958075209584, 8751.431156974777, 8871.806871418605], "unit": "score", "name": "yui.html", "value": 6793.863592776019}], "name": "dromaeo_css", "value": 7457.123140289724}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 109.0, 110.0, 112.0, 108.0, 116.0, 111.0, 114.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [158.0, 123.0, 152.0, 195.0, 120.0, 138.0, 137.0, 121.0, 160.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 142.4}, {"lowerIsBetter": true, "replicates": [186.0, 181.0, 184.0, 183.0, 184.0, 183.0, 191.0, 260.0, 182.0, 181.0], "unit": "score", "name": "audio-dft", "value": 191.5}, {"lowerIsBetter": true, "replicates": [76.0, 72.0, 85.0, 76.0, 55.0, 60.0, 58.0, 79.0, 77.0, 55.0], "unit": "score", "name": "audio-fft", "value": 69.3}, {"lowerIsBetter": true, "replicates": [96.0, 89.0, 126.0, 81.0, 78.0, 89.0, 113.0, 78.0, 78.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 94.3}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 89.0, 86.0, 87.0, 85.0, 88.0, 86.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 86.6}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 93.0, 93.0, 93.0, 93.0, 93.0, 97.0, 93.0, 94.0], "unit": "score", "name": "imaging-darkroom", "value": 93.4}, {"lowerIsBetter": true, "replicates": [87.0, 86.0, 85.0, 85.0, 85.0, 86.0, 86.0, 84.0, 86.0, 85.0], "unit": "score", "name": "imaging-desaturate", "value": 85.5}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 55.0, 55.0, 56.0, 56.0, 55.0, 65.0, 57.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.5}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 75.0, 81.0, 99.0, 66.0, 67.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.4}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 80.0, 101.0, 108.0, 107.0, 109.0, 81.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 92.0}, {"lowerIsBetter": true, "replicates": [122.0, 127.0, 123.0, 128.0, 114.0, 120.0, 124.0, 120.0, 119.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [136.0, 126.0, 141.0, 139.0, 137.0, 126.0, 138.0, 138.0, 137.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.4}, {"lowerIsBetter": true, "replicates": [67.0, 66.0, 65.0, 68.0, 67.0, 67.0, 67.0, 65.0, 67.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.4}], "name": "kraken", "value": 1417.2}]} 05:53:57 INFO - Return code: 0 05:53:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:53:57 ERROR - # TBPL SUCCESS # 05:53:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:57 INFO - 2016-03-23 05:53:57.887 screenresolution[1682:9766] starting screenresolution argv=screenresolution get 05:53:57 INFO - 2016-03-23 05:53:57.889 screenresolution[1682:9766] Display 0: 1600x1200x32@60 05:53:57 INFO - 2016-03-23 05:53:57.895 screenresolution[1683:9769] starting screenresolution argv=screenresolution list 05:53:57 INFO - Available Modes on Display 0 05:53:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:58 INFO - Intel Iris: 05:53:58 INFO - Chipset Model: Intel Iris 05:53:58 INFO - Type: GPU 05:53:58 INFO - Bus: Built-In 05:53:58 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:58 INFO - Vendor: Intel (0x8086) 05:53:58 INFO - Device ID: 0x0a2e 05:53:58 INFO - Revision ID: 0x0009 05:53:58 INFO - Displays: 05:53:58 INFO - Display: 05:53:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:58 INFO - Display Serial Number: 1600x1200 60 05:53:58 INFO - Main Display: Yes 05:53:58 INFO - Mirror: Off 05:53:58 INFO - Online: Yes 05:53:58 INFO - Rotation: Supported 05:53:58 INFO - Return code: 0 05:53:58 INFO - Running post-action listener: _resource_record_post_action 05:53:58 INFO - Running post-run listener: _resource_record_post_run 05:53:59 INFO - Total resource usage - Wall time: 1205s; CPU: 53.0%; Read bytes: 39151104; Write bytes: 704747008; Read time: 429; Write time: 2017 05:53:59 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400415232; Write bytes: 394196480; Read time: 30312; Write time: 708 05:53:59 INFO - run-tests - Wall time: 1172s; CPU: 52.0%; Read bytes: 37336576; Write bytes: 299532288; Read time: 410; Write time: 1276 05:53:59 INFO - Running post-run listener: _upload_blobber_files 05:53:59 INFO - Blob upload gear active. 05:53:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:59 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 05:53:59 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:53:59 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:53:59 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:53:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:54:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:00 INFO - (blobuploader) - INFO - Done attempting. 05:54:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:54:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:54:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:54:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:54:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:54:01 INFO - (blobuploader) - INFO - Done attempting. 05:54:01 INFO - (blobuploader) - INFO - Iteration through files over. 05:54:01 INFO - Return code: 0 05:54:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:54:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:54:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f19c15461675a3647ed1b060803c4b7b69da9ed5865517de93b42cafee39f20a24825c1957107d8b58d93c9ca669a5b96d0f1d35713fed0fa8fb7f907d6a81f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57c309696a51d4d9d36bbb4f970aa9cb836649a2e6ab1cafd3e1c4487af3f141bf242886c6d4a1240919c18f1836522e9c2c50282dc4c4d4edaa2f373536ce0e"} 05:54:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:54:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:54:01 INFO - Contents: 05:54:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f19c15461675a3647ed1b060803c4b7b69da9ed5865517de93b42cafee39f20a24825c1957107d8b58d93c9ca669a5b96d0f1d35713fed0fa8fb7f907d6a81f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57c309696a51d4d9d36bbb4f970aa9cb836649a2e6ab1cafd3e1c4487af3f141bf242886c6d4a1240919c18f1836522e9c2c50282dc4c4d4edaa2f373536ce0e"} 05:54:01 INFO - Running post-run listener: copy_logs_to_upload_dir 05:54:01 INFO - Copying logs to upload dir... 05:54:01 INFO - mkdir: /builds/slave/test/build/upload/logs 05:54:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.227631 ========= master_lag: 12.54 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-03-23 05:54:13.917313) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-23 05:54:13.922316) ========= 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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f19c15461675a3647ed1b060803c4b7b69da9ed5865517de93b42cafee39f20a24825c1957107d8b58d93c9ca669a5b96d0f1d35713fed0fa8fb7f907d6a81f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57c309696a51d4d9d36bbb4f970aa9cb836649a2e6ab1cafd3e1c4487af3f141bf242886c6d4a1240919c18f1836522e9c2c50282dc4c4d4edaa2f373536ce0e"} build_url:https://queue.taskcluster.net/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/E-fMWo_QTHi9EDyGyW7fpA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f19c15461675a3647ed1b060803c4b7b69da9ed5865517de93b42cafee39f20a24825c1957107d8b58d93c9ca669a5b96d0f1d35713fed0fa8fb7f907d6a81f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/57c309696a51d4d9d36bbb4f970aa9cb836649a2e6ab1cafd3e1c4487af3f141bf242886c6d4a1240919c18f1836522e9c2c50282dc4c4d4edaa2f373536ce0e"}' ========= master_lag: 1.53 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-03-23 05:54:15.461486) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-03-23 05:54:15.461812) ========= 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.EQeFm8fmG4/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.sqqcYWnzC0/Listeners TMPDIR=/var/folders/20/njkrv4s17fqcj6nxkzq4cqm000000w/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.005377 ========= master_lag: 6.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 6 secs) (at 2016-03-23 05:54:21.551073) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 05:54:21.551344) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 05:54:22.074170) ========= ========= Total master_lag: 20.32 =========