builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0106 starttime: 1454298404.41 results: success (0) buildid: 20160131175325 builduid: 1e0142fa22774f1ca6cb9aa7d0813302 revision: 271c3cec24fe679423e849ca0c4d8f57235d497a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:44.405725) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:44.406129) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:44.406461) ========= 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.9rVd9wyDbm/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.rArCJu6COk/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005687 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:44.471323) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:44.471650) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:44.668020) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:44.668397) ========= 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.9rVd9wyDbm/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.rArCJu6COk/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.004733 ========= master_lag: 0.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:44.804782) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:44.805097) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:44.805488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:44.805803) ========= 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.9rVd9wyDbm/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.rArCJu6COk/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-01-31 19:46:44-- 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% 6.77M=0.002s 2016-01-31 19:46:45 (6.77 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187036 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:45.129121) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:45.129511) ========= 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.9rVd9wyDbm/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.rArCJu6COk/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.019081 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:45.239230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-31 19:46:45.244648) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 271c3cec24fe679423e849ca0c4d8f57235d497a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 271c3cec24fe679423e849ca0c4d8f57235d497a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9rVd9wyDbm/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.rArCJu6COk/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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-01-31 19:46:45,319 truncating revision to first 12 chars 2016-01-31 19:46:45,319 Setting DEBUG logging. 2016-01-31 19:46:45,319 attempt 1/10 2016-01-31 19:46:45,319 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/271c3cec24fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-31 19:46:46,540 unpacking tar archive at: mozilla-central-271c3cec24fe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.460309 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-31 19:46:46.735511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:46.735860) ========= echo 271c3cec24fe679423e849ca0c4d8f57235d497a in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'271c3cec24fe679423e849ca0c4d8f57235d497a'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9rVd9wyDbm/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.rArCJu6COk/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 271c3cec24fe679423e849ca0c4d8f57235d497a program finished with exit code 0 elapsedTime=0.004994 script_repo_revision: '271c3cec24fe679423e849ca0c4d8f57235d497a' ========= master_lag: 0.06 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:46.796742) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:46.797066) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-31 19:46:46.813924) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 22 secs) (at 2016-01-31 19:46:46.814248) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.9rVd9wyDbm/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.rArCJu6COk/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 19:46:46 INFO - MultiFileLogger online at 20160131 19:46:46 in /builds/slave/test 19:46:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:46:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:46:46 INFO - {'append_to_log': False, 19:46:46 INFO - 'base_work_dir': '/builds/slave/test', 19:46:46 INFO - 'blob_upload_branch': 'Firefox', 19:46:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:46:46 INFO - 'branch': 'Firefox', 19:46:46 INFO - 'buildbot_json_path': 'buildprops.json', 19:46:46 INFO - 'config_files': ('talos/mac_config.py',), 19:46:46 INFO - 'default_actions': ('clobber', 19:46:46 INFO - 'read-buildbot-config', 19:46:46 INFO - 'download-and-extract', 19:46:46 INFO - 'populate-webroot', 19:46:46 INFO - 'create-virtualenv', 19:46:46 INFO - 'install', 19:46:46 INFO - 'run-tests'), 19:46:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:46:46 INFO - 'download_minidump_stackwalk': True, 19:46:46 INFO - 'download_symbols': 'ondemand', 19:46:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:46:46 INFO - 'tooltool.py': '/tools/tooltool.py', 19:46:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:46:46 INFO - '/tools/misc-python/virtualenv.py')}, 19:46:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:46:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:46:46 INFO - 'installer_path': 'installer.exe', 19:46:46 INFO - 'log_level': 'info', 19:46:46 INFO - 'log_name': 'talos', 19:46:46 INFO - 'log_to_console': True, 19:46:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:46:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:46:46 INFO - 'opt_config_files': (), 19:46:46 INFO - 'pip_index': False, 19:46:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:46:46 INFO - 'cmd': ('bash', 19:46:46 INFO - '-c', 19:46:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:46:46 INFO - 'enabled': True, 19:46:46 INFO - 'halt_on_failure': False, 19:46:46 INFO - 'name': 'check_screen_resolution'},), 19:46:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:46:46 INFO - 'cmd': ('bash', 19:46:46 INFO - '-c', 19:46:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:46:46 INFO - 'enabled': True, 19:46:46 INFO - 'halt_on_failure': False, 19:46:46 INFO - 'name': 'check_screen_resolution'},), 19:46:46 INFO - 'run_cmd_checks_enabled': True, 19:46:46 INFO - 'sps_profile': False, 19:46:46 INFO - 'sps_profile_interval': 0, 19:46:46 INFO - 'suite': 'dromaeojs-e10s', 19:46:46 INFO - 'system_bits': '32', 19:46:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:46:46 INFO - 'title': 't-yosemite-r7-0106', 19:46:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:46:46 INFO - 'use_talos_json': True, 19:46:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:46:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:46:46 INFO - 'work_dir': 'build'} 19:46:46 INFO - ##### 19:46:46 INFO - ##### Running clobber step. 19:46:46 INFO - ##### 19:46:46 INFO - Running pre-action listener: _resource_record_pre_action 19:46:46 INFO - Running main action method: clobber 19:46:46 INFO - rmtree: /builds/slave/test/build 19:46:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:46:48 INFO - Running post-action listener: _resource_record_post_action 19:46:48 INFO - ##### 19:46:48 INFO - ##### Running read-buildbot-config step. 19:46:48 INFO - ##### 19:46:48 INFO - Running pre-action listener: _resource_record_pre_action 19:46:48 INFO - Running main action method: read_buildbot_config 19:46:48 INFO - Using buildbot properties: 19:46:48 INFO - { 19:46:48 INFO - "project": "", 19:46:48 INFO - "product": "firefox", 19:46:48 INFO - "script_repo_revision": "production", 19:46:48 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 19:46:48 INFO - "repository": "", 19:46:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 19:46:48 INFO - "buildid": "20160131175325", 19:46:48 INFO - "pgo_build": "False", 19:46:48 INFO - "basedir": "/builds/slave/test", 19:46:48 INFO - "buildnumber": 149, 19:46:48 INFO - "slavename": "t-yosemite-r7-0106", 19:46:48 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 19:46:48 INFO - "platform": "yosemite_r7", 19:46:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 19:46:48 INFO - "branch": "mozilla-central", 19:46:48 INFO - "repo_path": "mozilla-central", 19:46:48 INFO - "revision": "271c3cec24fe679423e849ca0c4d8f57235d497a", 19:46:48 INFO - "stage_platform": "macosx64", 19:46:48 INFO - "builduid": "1e0142fa22774f1ca6cb9aa7d0813302", 19:46:48 INFO - "slavebuilddir": "test" 19:46:48 INFO - } 19:46:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 19:46:48 INFO - Running post-action listener: _resource_record_post_action 19:46:48 INFO - ##### 19:46:48 INFO - ##### Running download-and-extract step. 19:46:48 INFO - ##### 19:46:48 INFO - Running pre-action listener: _resource_record_pre_action 19:46:48 INFO - Running main action method: download_and_extract 19:46:48 INFO - mkdir: /builds/slave/test/build/tests 19:46:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:46:48 INFO - https://queue.taskcluster.net/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:46:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/test_packages.json 19:46:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/test_packages.json 19:46:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:46:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:47:18 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/test_packages.json: timed out 19:47:18 INFO - retry: attempt #1 caught exception: timed out 19:47:18 INFO - retry: Failed, sleeping 30 seconds before retrying 19:47:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #2 19:48:02 INFO - Downloaded 1277 bytes. 19:48:02 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:48:02 INFO - Using the following test package requirements: 19:48:02 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:48:02 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:48:02 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 19:48:02 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:48:02 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 19:48:02 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:48:02 INFO - u'jsshell-mac.zip'], 19:48:02 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:48:02 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 19:48:02 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:48:02 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:48:02 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 19:48:02 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:48:02 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 19:48:02 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:48:02 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 19:48:02 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 19:48:02 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 19:48:02 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 19:48:02 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 19:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:02 INFO - https://queue.taskcluster.net/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:48:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:48:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:48:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:48:14 INFO - Downloaded 17114341 bytes. 19:48:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:48:14 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:48:17 INFO - Return code: 0 19:48:17 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 19:48:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:17 INFO - https://queue.taskcluster.net/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 19:48:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:48:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:48:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 19:48:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 19:48:18 INFO - Downloaded 17114341 bytes. 19:48:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:48:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 19:48:22 INFO - Return code: 0 19:48:22 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')]} 19:48:22 INFO - https://queue.taskcluster.net/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 19:48:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:48:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:48:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 19:48:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 19:48:22 INFO - Downloaded 10706582 bytes. 19:48:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 19:48:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 19:48:23 INFO - Return code: 0 19:48:23 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')]} 19:48:23 INFO - https://queue.taskcluster.net/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 19:48:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:48:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:48:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 19:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 19:48:26 INFO - Downloaded 111135470 bytes. 19:48:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:48:26 INFO - mkdir: /builds/slave/test/properties 19:48:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:48:26 INFO - Writing to file /builds/slave/test/properties/build_url 19:48:26 INFO - Contents: 19:48:26 INFO - build_url:https://queue.taskcluster.net/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 19:48:26 INFO - Running post-action listener: _resource_record_post_action 19:48:26 INFO - Running post-action listener: set_extra_try_arguments 19:48:26 INFO - ##### 19:48:26 INFO - ##### Running populate-webroot step. 19:48:26 INFO - ##### 19:48:26 INFO - Running pre-action listener: _resource_record_pre_action 19:48:26 INFO - Running main action method: populate_webroot 19:48:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:48:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:48:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:48:26 INFO - '--tppagecycles', 19:48:26 INFO - '7'], 19:48:26 INFO - 'tests': ['tsvgm']}}, 19:48:26 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:48:26 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:48:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:48:26 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 19:48:26 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:48:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:48:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:48:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:26 INFO - 'talos_options': ['--e10s'], 19:48:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:48:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:26 INFO - 'tests': ['damp', 'tps']}, 19:48:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:26 INFO - 'talos_options': ['--e10s'], 19:48:26 INFO - 'tests': ['damp', 'tps']}, 19:48:26 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:48:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:48:26 INFO - 'other': {'tests': ['a11yr', 19:48:26 INFO - 'ts_paint', 19:48:26 INFO - 'tpaint', 19:48:26 INFO - 'sessionrestore', 19:48:26 INFO - 'sessionrestore_no_auto_restore']}, 19:48:26 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:48:26 INFO - 'tests': ['a11yr', 19:48:26 INFO - 'ts_paint', 19:48:26 INFO - 'tpaint', 19:48:26 INFO - 'sessionrestore', 19:48:26 INFO - 'sessionrestore_no_auto_restore']}, 19:48:26 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:48:26 INFO - 'tests': ['a11yr', 19:48:26 INFO - 'ts_paint', 19:48:26 INFO - 'tpaint', 19:48:26 INFO - 'sessionrestore', 19:48:26 INFO - 'sessionrestore_no_auto_restore']}, 19:48:26 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:48:26 INFO - 'tests': ['a11yr', 19:48:26 INFO - 'ts_paint', 19:48:26 INFO - 'tpaint', 19:48:26 INFO - 'sessionrestore', 19:48:26 INFO - 'sessionrestore_no_auto_restore']}, 19:48:26 INFO - 'other_l64': {'tests': ['a11yr', 19:48:26 INFO - 'ts_paint', 19:48:26 INFO - 'tpaint', 19:48:26 INFO - 'sessionrestore', 19:48:26 INFO - 'sessionrestore_no_auto_restore']}, 19:48:26 INFO - 'other_nol64': {'tests': ['a11yr', 19:48:26 INFO - 'ts_paint', 19:48:26 INFO - 'tpaint', 19:48:26 INFO - 'sessionrestore', 19:48:26 INFO - 'sessionrestore_no_auto_restore']}, 19:48:26 INFO - 'svgr': {'tests': ['tsvgx', 19:48:26 INFO - 'tsvgr_opacity', 19:48:26 INFO - 'tart', 19:48:26 INFO - 'tscrollx', 19:48:26 INFO - 'cart']}, 19:48:26 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:48:26 INFO - 'tests': ['tsvgx', 19:48:26 INFO - 'tsvgr_opacity', 19:48:26 INFO - 'tart', 19:48:26 INFO - 'tscrollx', 19:48:26 INFO - 'cart']}, 19:48:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:26 INFO - 'tests': ['tp5o']}, 19:48:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:26 INFO - 'talos_options': ['--e10s'], 19:48:26 INFO - 'tests': ['tp5o']}, 19:48:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:26 INFO - 'talos_options': ['--xperf_path', 19:48:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:48:26 INFO - 'tests': ['tp5n']}, 19:48:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:48:26 INFO - 'talos_options': ['--e10s', 19:48:26 INFO - '--xperf_path', 19:48:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:48:26 INFO - 'tests': ['tp5n']}}, 19:48:26 INFO - 'talos.zip': {'path': '', 19:48:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:48:26 INFO - Running post-action listener: _resource_record_post_action 19:48:26 INFO - ##### 19:48:26 INFO - ##### Running create-virtualenv step. 19:48:26 INFO - ##### 19:48:26 INFO - Running pre-action listener: _resource_record_pre_action 19:48:26 INFO - Running main action method: create_virtualenv 19:48:26 INFO - Creating virtualenv /builds/slave/test/build/venv 19:48:26 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 19:48:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:48:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:48:26 INFO - Using real prefix '/tools/python27' 19:48:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:48:27 INFO - Installing distribute.............................................................................................................................................................................................done. 19:48:29 INFO - Installing pip.................done. 19:48:29 INFO - Return code: 0 19:48:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109ef7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830854eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d9cd30>, '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 0x109bffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d92b20>, '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.9rVd9wyDbm/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.rArCJu6COk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 19:48:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:48:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:48:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9rVd9wyDbm/Render', 19:48:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:48:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:48:29 INFO - 'HOME': '/Users/cltbld', 19:48:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:48:29 INFO - 'LOGNAME': 'cltbld', 19:48:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:29 INFO - 'MOZ_NO_REMOTE': '1', 19:48:29 INFO - 'NO_EM_RESTART': '1', 19:48:29 INFO - 'PAGER': '/bin/cat', 19:48:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:48:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:29 INFO - 'PWD': '/builds/slave/test', 19:48:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:48:29 INFO - 'SHELL': '/bin/bash', 19:48:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rArCJu6COk/Listeners', 19:48:29 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 19:48:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:48:29 INFO - 'USER': 'cltbld', 19:48:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:48:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:48:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:29 INFO - 'XPC_FLAGS': '0x0', 19:48:29 INFO - 'XPC_SERVICE_NAME': '0', 19:48:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:30 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 19:48:30 INFO - Cleaning up... 19:48:30 INFO - Return code: 0 19:48:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:48:30 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')]} 19:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:30 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')]} 19:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:30 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 0x109ef7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830854eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d9cd30>, '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 0x109bffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d92b20>, '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.9rVd9wyDbm/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.rArCJu6COk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 19:48:30 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 19:48:30 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 19:48:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9rVd9wyDbm/Render', 19:48:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:48:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:48:30 INFO - 'HOME': '/Users/cltbld', 19:48:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:48:30 INFO - 'LOGNAME': 'cltbld', 19:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:30 INFO - 'MOZ_NO_REMOTE': '1', 19:48:30 INFO - 'NO_EM_RESTART': '1', 19:48:30 INFO - 'PAGER': '/bin/cat', 19:48:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:30 INFO - 'PWD': '/builds/slave/test', 19:48:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:48:30 INFO - 'SHELL': '/bin/bash', 19:48:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rArCJu6COk/Listeners', 19:48:30 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 19:48:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:48:30 INFO - 'USER': 'cltbld', 19:48:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:48:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:30 INFO - 'XPC_FLAGS': '0x0', 19:48:30 INFO - 'XPC_SERVICE_NAME': '0', 19:48:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:30 INFO - Downloading/unpacking psutil>=0.7.1 19:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:48:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:48:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:48:33 INFO - Installing collected packages: psutil 19:48:33 INFO - Running setup.py install for psutil 19:48:33 INFO - building 'psutil._psutil_osx' extension 19:48:33 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 19:48:33 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 19:48:33 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 19:48:33 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 19:48:33 INFO - building 'psutil._psutil_posix' extension 19:48:33 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 19:48:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:48:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:48:34 INFO - ^ 19:48:34 INFO - 1 warning generated. 19:48:34 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 19:48:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:48:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:48:34 INFO - Successfully installed psutil 19:48:34 INFO - Cleaning up... 19:48:34 INFO - Return code: 0 19:48:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:34 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 0x109ef7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830854eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d9cd30>, '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 0x109bffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d92b20>, '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.9rVd9wyDbm/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.rArCJu6COk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 19:48:34 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 19:48:34 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 19:48:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9rVd9wyDbm/Render', 19:48:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:48:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:48:34 INFO - 'HOME': '/Users/cltbld', 19:48:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:48:34 INFO - 'LOGNAME': 'cltbld', 19:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:34 INFO - 'MOZ_NO_REMOTE': '1', 19:48:34 INFO - 'NO_EM_RESTART': '1', 19:48:34 INFO - 'PAGER': '/bin/cat', 19:48:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:34 INFO - 'PWD': '/builds/slave/test', 19:48:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:48:34 INFO - 'SHELL': '/bin/bash', 19:48:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rArCJu6COk/Listeners', 19:48:34 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 19:48:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:48:34 INFO - 'USER': 'cltbld', 19:48:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:48:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:34 INFO - 'XPC_FLAGS': '0x0', 19:48:34 INFO - 'XPC_SERVICE_NAME': '0', 19:48:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:48:34 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 19:48:34 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 19:48:34 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 19:48:34 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 19:48:34 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 19:48:34 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 19:48:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:48:36 INFO - Installing collected packages: mozsystemmonitor 19:48:36 INFO - Running setup.py install for mozsystemmonitor 19:48:37 INFO - Successfully installed mozsystemmonitor 19:48:37 INFO - Cleaning up... 19:48:37 INFO - Return code: 0 19:48:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:48: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')]} 19:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48: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')]} 19:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:37 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 0x109ef7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830854eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d9cd30>, '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 0x109bffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d92b20>, '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.9rVd9wyDbm/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.rArCJu6COk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 19:48:37 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 19:48:37 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 19:48:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9rVd9wyDbm/Render', 19:48:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:48:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:48:37 INFO - 'HOME': '/Users/cltbld', 19:48:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:48:37 INFO - 'LOGNAME': 'cltbld', 19:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:37 INFO - 'MOZ_NO_REMOTE': '1', 19:48:37 INFO - 'NO_EM_RESTART': '1', 19:48:37 INFO - 'PAGER': '/bin/cat', 19:48:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:37 INFO - 'PWD': '/builds/slave/test', 19:48:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:48:37 INFO - 'SHELL': '/bin/bash', 19:48:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rArCJu6COk/Listeners', 19:48:37 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 19:48:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:48:37 INFO - 'USER': 'cltbld', 19:48:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:48:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:37 INFO - 'XPC_FLAGS': '0x0', 19:48:37 INFO - 'XPC_SERVICE_NAME': '0', 19:48:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:37 INFO - Downloading/unpacking blobuploader==1.2.4 19:48:37 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 19:48:37 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 19:48:37 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 19:48:37 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 19:48:37 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 19:48:37 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 19:48:39 INFO - Downloading blobuploader-1.2.4.tar.gz 19:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:48:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:48: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 19:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48: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 19:48: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 19:48: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 19:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:48:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:48:40 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 19:48:40 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 19:48:40 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 19:48:40 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 19:48:40 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 19:48:40 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 19:48:40 INFO - Downloading docopt-0.6.1.tar.gz 19:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:48:40 INFO - Installing collected packages: blobuploader, requests, docopt 19:48:40 INFO - Running setup.py install for blobuploader 19:48:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:48:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:48:40 INFO - Running setup.py install for requests 19:48:41 INFO - Running setup.py install for docopt 19:48:41 INFO - Successfully installed blobuploader requests docopt 19:48:41 INFO - Cleaning up... 19:48:41 INFO - Return code: 0 19:48:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:48:41 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')]} 19:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:41 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')]} 19:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:41 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 0x109ef7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830854eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d9cd30>, '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 0x109bffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d92b20>, '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.9rVd9wyDbm/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.rArCJu6COk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 19:48:41 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 19:48:41 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 19:48:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9rVd9wyDbm/Render', 19:48:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:48:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:48:41 INFO - 'HOME': '/Users/cltbld', 19:48:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:48:41 INFO - 'LOGNAME': 'cltbld', 19:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:41 INFO - 'MOZ_NO_REMOTE': '1', 19:48:41 INFO - 'NO_EM_RESTART': '1', 19:48:41 INFO - 'PAGER': '/bin/cat', 19:48:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:41 INFO - 'PWD': '/builds/slave/test', 19:48:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:48:41 INFO - 'SHELL': '/bin/bash', 19:48:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rArCJu6COk/Listeners', 19:48:41 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 19:48:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:48:41 INFO - 'USER': 'cltbld', 19:48:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:48:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:41 INFO - 'XPC_FLAGS': '0x0', 19:48:41 INFO - 'XPC_SERVICE_NAME': '0', 19:48:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:48:41 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-d5yRbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:48:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-bAwWx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:48:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-irnWpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:48:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-u4Cdaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:48:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-0pnblG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:48:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-6fcHLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:48:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-tKwH9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:48:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-9BuInW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:48:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-jsXuya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:48:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-O3reZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:48:42 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-nK99rs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:48:43 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-d29nS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:48:43 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-MHRX2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:48:43 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-lpwAxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:48:43 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-D9_fbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:48:43 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-hmbY35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:48:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:48:43 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Aby3GT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:48:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:48:43 INFO - Running setup.py install for manifestparser 19:48:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:48:43 INFO - Running setup.py install for mozcrash 19:48:43 INFO - Running setup.py install for mozdebug 19:48:44 INFO - Running setup.py install for mozdevice 19:48:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:48:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:48:44 INFO - Running setup.py install for mozfile 19:48:44 INFO - Running setup.py install for mozhttpd 19:48:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:48:44 INFO - Running setup.py install for mozinfo 19:48:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:48:44 INFO - Running setup.py install for mozInstall 19:48:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:48:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:48:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:48:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:48:44 INFO - Running setup.py install for mozleak 19:48:44 INFO - Running setup.py install for mozlog 19:48:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:48:45 INFO - Running setup.py install for moznetwork 19:48:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:48:45 INFO - Running setup.py install for mozprocess 19:48:45 INFO - Running setup.py install for mozprofile 19:48:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:48:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:48:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:48:45 INFO - Running setup.py install for mozrunner 19:48:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:48:45 INFO - Running setup.py install for mozscreenshot 19:48:45 INFO - Running setup.py install for moztest 19:48:46 INFO - Running setup.py install for mozversion 19:48:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:48:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:48:46 INFO - Cleaning up... 19:48:46 INFO - Return code: 0 19:48:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:48: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')]} 19:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48: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')]} 19:48:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:46 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 0x109ef7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830854eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d9cd30>, '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 0x109bffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d92b20>, '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.9rVd9wyDbm/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.rArCJu6COk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 19:48:46 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 19:48:46 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 19:48:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9rVd9wyDbm/Render', 19:48:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:48:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:48:46 INFO - 'HOME': '/Users/cltbld', 19:48:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:48:46 INFO - 'LOGNAME': 'cltbld', 19:48:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:46 INFO - 'MOZ_NO_REMOTE': '1', 19:48:46 INFO - 'NO_EM_RESTART': '1', 19:48:46 INFO - 'PAGER': '/bin/cat', 19:48:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:48:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:46 INFO - 'PWD': '/builds/slave/test', 19:48:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:48:46 INFO - 'SHELL': '/bin/bash', 19:48:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rArCJu6COk/Listeners', 19:48:46 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 19:48:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:48:46 INFO - 'USER': 'cltbld', 19:48:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:48:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:48:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:46 INFO - 'XPC_FLAGS': '0x0', 19:48:46 INFO - 'XPC_SERVICE_NAME': '0', 19:48:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:48:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:48:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-gr133Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:48:46 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)) 19:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:48:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-2KRd9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:48:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:48:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-7tgljS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:48:46 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)) 19:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:48:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-y2lDy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:48:46 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)) 19:48:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:48:46 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-sHZHf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:48:47 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)) 19:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:48:47 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-MCn9Gv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:48:47 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)) 19:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:48:47 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-1oim02-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:48:47 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)) 19:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:48:47 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-xJvLeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:48:47 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)) 19:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:48:47 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-0c0U6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:48:47 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)) 19:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:48:47 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-1uQXhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:48:47 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)) 19:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:48:47 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-7GoO1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:48:47 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)) 19:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:48:47 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-CQ593S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:48:47 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)) 19:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:48:47 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-axtKnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:48:47 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)) 19:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:48:47 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-5tUVAo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:48:47 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)) 19:48:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:48:47 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-D99P0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:48:48 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)) 19:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:48:48 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-BmcXNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:48:48 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)) 19:48:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:48:48 INFO - Running setup.py (path:/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/pip-Dn8WA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:48:48 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)) 19:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:48:48 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)) 19:48:48 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)) 19:48:48 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)) 19:48:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:50 INFO - Downloading blessings-1.6.tar.gz 19:48:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:48:50 INFO - Installing collected packages: blessings 19:48:50 INFO - Running setup.py install for blessings 19:48:50 INFO - Successfully installed blessings 19:48:50 INFO - Cleaning up... 19:48:50 INFO - Return code: 0 19:48:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:48:51 INFO - Reading from file tmpfile_stdout 19:48:51 INFO - Current package versions: 19:48:51 INFO - blessings == 1.6 19:48:51 INFO - blobuploader == 1.2.4 19:48:51 INFO - docopt == 0.6.1 19:48:51 INFO - manifestparser == 1.1 19:48:51 INFO - mozInstall == 1.12 19:48:51 INFO - mozcrash == 0.16 19:48:51 INFO - mozdebug == 0.1 19:48:51 INFO - mozdevice == 0.48 19:48:51 INFO - mozfile == 1.2 19:48:51 INFO - mozhttpd == 0.7 19:48:51 INFO - mozinfo == 0.9 19:48:51 INFO - mozleak == 0.1 19:48:51 INFO - mozlog == 3.1 19:48:51 INFO - moznetwork == 0.27 19:48:51 INFO - mozprocess == 0.22 19:48:51 INFO - mozprofile == 0.28 19:48:51 INFO - mozrunner == 6.11 19:48:51 INFO - mozscreenshot == 0.1 19:48:51 INFO - mozsystemmonitor == 0.0 19:48:51 INFO - moztest == 0.7 19:48:51 INFO - mozversion == 1.4 19:48:51 INFO - psutil == 3.1.1 19:48:51 INFO - requests == 1.2.3 19:48:51 INFO - wsgiref == 0.1.2 19:48:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:48:51 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')]} 19:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:51 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')]} 19:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:51 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 0x109ef7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830854eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d9cd30>, '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 0x109bffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d92b20>, '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.9rVd9wyDbm/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.rArCJu6COk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 19:48:51 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 19:48:51 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 19:48:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9rVd9wyDbm/Render', 19:48:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:48:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:48:51 INFO - 'HOME': '/Users/cltbld', 19:48:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:48:51 INFO - 'LOGNAME': 'cltbld', 19:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:51 INFO - 'MOZ_NO_REMOTE': '1', 19:48:51 INFO - 'NO_EM_RESTART': '1', 19:48:51 INFO - 'PAGER': '/bin/cat', 19:48:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:51 INFO - 'PWD': '/builds/slave/test', 19:48:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:48:51 INFO - 'SHELL': '/bin/bash', 19:48:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rArCJu6COk/Listeners', 19:48:51 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 19:48:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:48:51 INFO - 'USER': 'cltbld', 19:48:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:48:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:51 INFO - 'XPC_FLAGS': '0x0', 19:48:51 INFO - 'XPC_SERVICE_NAME': '0', 19:48:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:51 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)) 19:48:51 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)) 19:48:51 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)) 19:48:51 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)) 19:48:51 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)) 19:48:51 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)) 19:48:51 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)) 19:48:51 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)) 19:48:51 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)) 19:48:51 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)) 19:48:51 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)) 19:48:51 INFO - Cleaning up... 19:48:51 INFO - Return code: 0 19:48:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:48:51 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')]} 19:48:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:51 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')]} 19:48:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:51 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 0x109ef7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830854eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d9cd30>, '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 0x109bffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d92b20>, '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.9rVd9wyDbm/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.rArCJu6COk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 19:48:51 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 19:48:51 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 19:48:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9rVd9wyDbm/Render', 19:48:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:48:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:48:51 INFO - 'HOME': '/Users/cltbld', 19:48:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:48:51 INFO - 'LOGNAME': 'cltbld', 19:48:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:51 INFO - 'MOZ_NO_REMOTE': '1', 19:48:51 INFO - 'NO_EM_RESTART': '1', 19:48:51 INFO - 'PAGER': '/bin/cat', 19:48:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:48:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:51 INFO - 'PWD': '/builds/slave/test', 19:48:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:48:51 INFO - 'SHELL': '/bin/bash', 19:48:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rArCJu6COk/Listeners', 19:48:51 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 19:48:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:48:51 INFO - 'USER': 'cltbld', 19:48:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:48:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:48:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:51 INFO - 'XPC_FLAGS': '0x0', 19:48:51 INFO - 'XPC_SERVICE_NAME': '0', 19:48:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:48:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:51 INFO - Downloading/unpacking jsonschema 19:48:51 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 19:48:51 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 19:48:51 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 19:48:51 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 19:48:51 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 19:48:51 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 19:48:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:48:53 INFO - Downloading/unpacking functools32 (from jsonschema) 19:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:54 INFO - Downloading functools32-3.2.3-2.tar.gz 19:48:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:48:54 INFO - warning: no files found matching '*.txt' 19:48:54 INFO - no previously-included directories found matching 'build' 19:48:54 INFO - no previously-included directories found matching 'dist' 19:48:54 INFO - no previously-included directories found matching '.git*' 19:48:54 INFO - Installing collected packages: jsonschema, functools32 19:48:54 INFO - Running setup.py install for functools32 19:48:54 INFO - warning: no files found matching '*.txt' 19:48:54 INFO - no previously-included directories found matching 'build' 19:48:54 INFO - no previously-included directories found matching 'dist' 19:48:54 INFO - no previously-included directories found matching '.git*' 19:48:54 INFO - Successfully installed jsonschema functools32 19:48:54 INFO - Cleaning up... 19:48:54 INFO - Return code: 0 19:48:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:54 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 0x109ef7a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109efe4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f830854eab0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109d9cd30>, '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 0x109bffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d92b20>, '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.9rVd9wyDbm/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.rArCJu6COk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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 19:48:54 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 19:48:54 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 19:48:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9rVd9wyDbm/Render', 19:48:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:48:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:48:54 INFO - 'HOME': '/Users/cltbld', 19:48:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:48:54 INFO - 'LOGNAME': 'cltbld', 19:48:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:54 INFO - 'MOZ_NO_REMOTE': '1', 19:48:54 INFO - 'NO_EM_RESTART': '1', 19:48:54 INFO - 'PAGER': '/bin/cat', 19:48:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:48:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:54 INFO - 'PWD': '/builds/slave/test', 19:48:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:48:54 INFO - 'SHELL': '/bin/bash', 19:48:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rArCJu6COk/Listeners', 19:48:54 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 19:48:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:48:54 INFO - 'USER': 'cltbld', 19:48:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:48:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:48:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:54 INFO - 'XPC_FLAGS': '0x0', 19:48:54 INFO - 'XPC_SERVICE_NAME': '0', 19:48:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:48:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:55 INFO - Downloading/unpacking flake8 19:48:55 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 19:48:55 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 19:48:55 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 19:48:55 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 19:48:55 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 19:48:55 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 19:48:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:48:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:48:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:48:58 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 19:48:58 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 19:48:58 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 19:48:58 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 19:48:58 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 19:48:58 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 19:48:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:48:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:48:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:48:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:48:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:48:58 INFO - no previously-included directories found matching 'docs/_build' 19:48:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:48:58 INFO - Running setup.py install for pep8 19:48:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:48:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:48:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:48:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:48:58 INFO - no previously-included directories found matching 'docs/_build' 19:48:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:48:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:48:58 INFO - Cleaning up... 19:48:58 INFO - Return code: 0 19:48:58 INFO - Running post-action listener: _resource_record_post_action 19:48:58 INFO - Running post-action listener: _start_resource_monitoring 19:48:58 INFO - Starting resource monitoring. 19:48:58 INFO - ##### 19:48:58 INFO - ##### Running install step. 19:48:58 INFO - ##### 19:48:58 INFO - Running pre-action listener: _resource_record_pre_action 19:48:58 INFO - Running main action method: install 19:48:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:48:59 INFO - Reading from file tmpfile_stdout 19:48:59 INFO - Detecting whether we're running mozinstall >=1.0... 19:48:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:48:59 INFO - Reading from file tmpfile_stdout 19:48:59 INFO - Output received: 19:48:59 INFO - Usage: mozinstall [options] installer 19:48:59 INFO - Options: 19:48:59 INFO - -h, --help show this help message and exit 19:48:59 INFO - -d DEST, --destination=DEST 19:48:59 INFO - Directory to install application into. [default: 19:48:59 INFO - "/builds/slave/test"] 19:48:59 INFO - --app=APP Application being installed. [default: firefox] 19:48:59 INFO - mkdir: /builds/slave/test/build/application 19:48:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 19:48:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 19:49:32 INFO - Reading from file tmpfile_stdout 19:49:32 INFO - Output received: 19:49:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 19:49:32 INFO - Running post-action listener: _resource_record_post_action 19:49:32 INFO - ##### 19:49:32 INFO - ##### Running run-tests step. 19:49:32 INFO - ##### 19:49:32 INFO - Running pre-action listener: _resource_record_pre_action 19:49:32 INFO - Running main action method: run_tests 19:49:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:49:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:49:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:49:32 INFO - 2016-01-31 19:49:32.899 screenresolution[1966:12857] starting screenresolution argv=screenresolution get 19:49:32 INFO - 2016-01-31 19:49:32.901 screenresolution[1966:12857] Display 0: 1600x1200x32@60 19:49:32 INFO - 2016-01-31 19:49:32.907 screenresolution[1967:12859] starting screenresolution argv=screenresolution list 19:49:32 INFO - Available Modes on Display 0 19:49:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:49:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:49:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:49:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:49:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:49:33 INFO - Intel Iris: 19:49:33 INFO - Chipset Model: Intel Iris 19:49:33 INFO - Type: GPU 19:49:33 INFO - Bus: Built-In 19:49:33 INFO - VRAM (Dynamic, Max): 1536 MB 19:49:33 INFO - Vendor: Intel (0x8086) 19:49:33 INFO - Device ID: 0x0a2e 19:49:33 INFO - Revision ID: 0x0009 19:49:33 INFO - Displays: 19:49:33 INFO - Display: 19:49:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:49:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:49:33 INFO - Display Serial Number: 1600x1200 60 19:49:33 INFO - Main Display: Yes 19:49:33 INFO - Mirror: Off 19:49:33 INFO - Online: Yes 19:49:33 INFO - Rotation: Supported 19:49:33 INFO - Return code: 0 19:49:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:49:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:49:33 INFO - Python 2.7.3 19:49:33 INFO - Return code: 0 19:49:33 INFO - grabbing minidump binary from tooltool 19:49:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:49:33 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 0x109d9cd30>, '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 0x109bffdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109d92b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:49:33 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 19:49:33 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 19:49:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:49:33 INFO - Return code: 0 19:49:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:49:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:49:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:49:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:49:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:49:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:49:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:49:34 INFO - Return code: 0 19:49:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:49:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0106 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:49:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.9rVd9wyDbm/Render', 19:49:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:49:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:49:34 INFO - 'HOME': '/Users/cltbld', 19:49:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:49:34 INFO - 'LOGNAME': 'cltbld', 19:49:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:49:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:49:34 INFO - 'MOZ_NO_REMOTE': '1', 19:49:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:49:34 INFO - 'NO_EM_RESTART': '1', 19:49:34 INFO - 'PAGER': '/bin/cat', 19:49:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:49:34 INFO - 'PWD': '/builds/slave/test', 19:49:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:49:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:49:34 INFO - 'SHELL': '/bin/bash', 19:49:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rArCJu6COk/Listeners', 19:49:34 INFO - 'TMPDIR': '/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/', 19:49:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:49:34 INFO - 'USER': 'cltbld', 19:49:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:49:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:49:34 INFO - 'XPC_FLAGS': '0x0', 19:49:34 INFO - 'XPC_SERVICE_NAME': '0', 19:49:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:49:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0106', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:49:34 INFO - mozversion application_buildid: 20160131175325 19:49:34 INFO - mozversion application_changeset: 271c3cec24fe679423e849ca0c4d8f57235d497a 19:49:34 INFO - mozversion application_display_name: Nightly 19:49:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:49:34 INFO - mozversion application_name: Firefox 19:49:34 INFO - mozversion application_remotingname: firefox 19:49:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:49:34 INFO - mozversion application_vendor: Mozilla 19:49:34 INFO - mozversion application_version: 47.0a1 19:49:34 INFO - mozversion platform_buildid: 20160131175325 19:49:34 INFO - mozversion platform_changeset: 271c3cec24fe679423e849ca0c4d8f57235d497a 19:49:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:49:34 INFO - mozversion platform_version: 47.0a1 19:49:34 INFO - using testdate: 1454298574 19:49:34 INFO - actual date: 1454298574 19:49:35 INFO - starting webserver on 'localhost:49749' 19:49:35 INFO - SUITE-START | Running 2 tests 19:49:35 INFO - TEST-START | dromaeo_css 19:49:35 INFO - operating with platform_type : mac_ 19:49:35 INFO - Initialising browser for dromaeo_css test... 19:49:35 INFO - TEST-INFO | started process 1985 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpxl4x6Q/profile http://localhost:49749/getInfo.html) 19:49:35 INFO - PROCESS | 1985 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 19:49:37 INFO - PROCESS | 1985 | __metrics Screen width/height:1600/1200 19:49:37 INFO - PROCESS | 1985 | colorDepth:24 19:49:37 INFO - PROCESS | 1985 | Browser inner width/height: 1024/689 19:49:37 INFO - PROCESS | 1985 | __metrics 19:49:38 INFO - PROCESS | 1985 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:49:38 INFO - TEST-INFO | 1985: exit 0 19:49:38 INFO - Browser initialized. 19:49:38 INFO - Running cycle 1/1 for dromaeo_css test... 19:49:38 INFO - TEST-INFO | started process 1989 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmpxl4x6Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:49:50 INFO - PROCESS | 1989 | RSS: Main: 256548864 19:49:50 INFO - PROCESS | 1989 | 19:50:40 INFO - PROCESS | 1989 | 1454298640325 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] 19:52:50 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49749/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49749/tests/dromaeo/cssquery-ext.html) 19:52:52 INFO - PROCESS | 1989 | RSS: Main: 270471168 19:52:52 INFO - PROCESS | 1989 | 19:55:54 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49749/tests/dromaeo/cssquery-ext.html (next: http://localhost:49749/tests/dromaeo/cssquery-jquery.html) 19:55:55 INFO - PROCESS | 1989 | RSS: Main: 282308608 19:55:55 INFO - PROCESS | 1989 | 19:58:57 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49749/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49749/tests/dromaeo/cssquery-mootools.html) 19:58:57 INFO - PROCESS | 1989 | RSS: Main: 283537408 19:58:57 INFO - PROCESS | 1989 | 20:01:59 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49749/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49749/tests/dromaeo/cssquery-prototype.html) 20:02:00 INFO - PROCESS | 1989 | RSS: Main: 285802496 20:02:00 INFO - PROCESS | 1989 | 20:05:02 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49749/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49749/tests/dromaeo/cssquery-yui.html) 20:05:03 INFO - PROCESS | 1989 | RSS: Main: 287899648 20:05:03 INFO - PROCESS | 1989 | 20:08:05 INFO - PROCESS | 1989 | Cycle 1(1): loaded http://localhost:49749/tests/dromaeo/cssquery-yui.html (next: http://localhost:49749/tests/dromaeo/cssquery-dojo.html) 20:08:05 INFO - PROCESS | 1989 | RSS: Main: 289726464 20:08:05 INFO - PROCESS | 1989 | 20:08:05 INFO - PROCESS | 1989 | __start_tp_report 20:08:05 INFO - PROCESS | 1989 | _x_x_mozilla_page_load 20:08:05 INFO - PROCESS | 1989 | _x_x_mozilla_page_load_details 20:08:05 INFO - PROCESS | 1989 | |i|pagename|runs| 20:08:05 INFO - PROCESS | 1989 | |0;dojo.html;3495.1262184453885;3524.506569080331;3537.6285490023565;3562.9465558016636;3570.8571657133716;5742.253507044078;5762.654240745558;5779.36426993031;5783.826485205445;5808.56435767317;5641.435856414357;5738.7417566209515;5762.3949485303965;5771.538276937846;5793.855153621151;5174.974125129378;5206.531412172903;5269.499397557245;5303.549198318147;5318.813841515548;5309.548688361494;5334.146536554152;5351.170568561879;5355.758990845402;5360.758765855527;5295.814646487393;5299.33758280215;5338.252644629735;5354.705491197982;5395.892082158354;4125.50493940726;5123.820666276662;5207.505286997729;5231.686098834044;5290.994711004935;5088.92366614501;5183.818566350197;5198;5199.688018718889;5199.922001169985;5505.642133261365;5536;5539.501444869981;5607.186957891083;5690.800821971211;6114.984399026647;6174.320824709278;6214.875702485971;6250.749970001195;6261.686915654199;6219.129321894939;6246.187995560548;6256.1866957295715;6274.717637706314;6288.3397243289255;5625.015622266169;5709.486146246774;5874.706264686792;5879.941200587982;5882.764689412418;6198;6275.748970041147;6279.811605651837;6297.905531417033;6305.432511074026;6163.537734669918;6191.9690401547705;6200.720967556381;6205.968970155211;6213.285472170758;5539.2522009529;5936;6184.196054512974;6257.061440783918;6259.561830671809;5150.793968241228;6237.532185086136;6249.187605611332;6262.436380725757;6272.466840318532;6204.007358822567;6272.686365681698;6274.968625156845;6275.3724627537795;6285.528585356025;4844.612431005511;4904.337914381513;4939.851804445872;4966.180580204298;4990.101781679333;4387.473503179639;4397.208502469586;4413.44831896013;4436.489803672619;4459.687821852439;5722.685252311079;5757;5774.480296773227;5776.797812076557;5790.797322093791;6181.227346581677;6186.1648677428875;6226.25284965807;6262.655553944577;6268;5788;5791.5656325775735;5794;5818.6217895836635;5822.010258256107;5308.991291654574;5385.838424847261;5431.402545720047;5448.618596698272;5456.563474921997;6283.654399008098;6297.27581328144;6395.040743888454;6396.168498095218;6402.9359706403275;6228.28374736893;6256.311805701278;6265.154204182377;6282.371762823681;6290.056491526308;6213.00591905293;6303.590266632654;6367;6381.298057213796;6386.712597933011;6118.588722523033;6166.352532983972;6229.719662615103;6231.408016238632;6262.53031022666;6222.502199823913;6264.655443950626;6265.906011409924;6269.49844012487;6275.748970041147;6005.519558435402;6053.818385448443;6098.817035488943;6118.112873633209;6141.201643786279;5956.404359564009;5970.820875373745;5977.760889564369;5982.760689572368;5992.730327135202;5361.35663720356;5838.795642152504;5849.678267695147;5856.531477481706;5864.589478736448;4499.482559505699;4876.756162191805;5986.461218490357;5988.580799344179;5996;5882.499987500939;5882.558808089496;5889.440503152194;5905.232319798399;5920.496757775637 20:08:05 INFO - PROCESS | 1989 | |1;ext.html;480.23882146797325;494.07114624505937;568.9431056894311;585.7991118207676;602.6052935327363;36882.077948051316;37157;37194.8140259299;37394;37401.25197496048;37223.51105955758;37719.81140094303;37759;37820.81089594555;37950.43074353887;7875.8031049223655;9196.034416386283;9227.861582076273;9406.811863762721;9461.621535138585;9350;9533;9588.616455341778;9621.903780962206;9651.855222171673;9599.280053995943;9662.855057174149;9684.322097453145;9703.951480242624;9723.611055557769;9593.088656577615;9620.903790962071;9663.758406039835;9670.468124253162;9685.70942871715;8082.515049097073;9499.24006079512;9551.379160354623;9566.995465476164;9585.472798996052;37048.814755926316;37346.62653373458;37724;37793.43309850354;37799;3167.2398624330226;3226.4998925166637;3316.3201543683485;3510.1926556891804;3622.9131260621707;27455.725442745515;28525.57211641827;28582.570871456344;28586.285342866388;28930.71069289301;2793.483205606969;2816.0566210319566;2882.783791215646;2891.7108289171124;3002;477005;477986;478650;479231;482232.58883705357;54413.183802242995;55483.445165547826;61709.07436388368;62359.688201559606;64137.67931160408;63823;64302;64363.67818160879;64472;64521;16493.58766030859;16520.75218871718;16542.669146617;16690.66618667644;16742.581435463966;11269.830952535718;12743.171693839871;12831.679208019874;12871.935640321739;12905;15896;17622.383216587357;18382.81617183811;19477.078438234377;19704.90147549253;8726.91273087261;8914.153155450222;8944.642214311485;8958.776030599156;8961.327900407496;968.1867231525553;991.9057689519484;1013.1692012549638;1034.3586976074882;1108.024938054507;29218;29332.560011599842;29475.705242947726;30104.795808167866;30109.849450752605;1068.9946550267355;1078.735709751116;1083.2092572422175;1092.0662833277593;1220.395904027512;14896.255187240595;14904.478343257933;15005.69988600222;15166.696666066617;15359.539213823604;525398;537347;543009;544967;545993;56614.15078773822;56817.14774278389;57050.14424783632;57069.714651426475;57131.42868571261;1247.9438425270885;1394.721055788826;1398.5594537720585;1439.647286414835;1442.1203066129654;28983;29103;29179;29713.960011399497;29802.552961705158;36874.63125368712;49369.753151234014;49601.51992400438;49630;49642.255366168814;484871;488446;490193.5490322526;490762.10046346876;492130.53934730095;31994.120529151558;32885;32930.341393171526;33126;33215;41012.33547307503;41971.950701232716;42757.35863962105;43482.56517434785;43957.78021109874;27845.721542785122;35090;36265.09337266589;36317.27365452729;36380.454293185096;33988.49017264693;34319.970400888014;35091;35324.76363327374;35419.468707969914;35711.82144089367;35713.46429803503;35850.207489624896;36797.81601091977;37060.25879482449;30311.393772124877;31825.68174318227;31993.200169995005;32106;32208.83895580507;22449.88775056114;24409.38976525601;24574.508509830062;24662;24816.627750584117 20:08:05 INFO - PROCESS | 1989 | |2;jquery.html;364.87229469685616;368.13488302489156;368.8524590163934;370.4091973302583;374.58421152520714;15345.769813452807;18720.719189212174;19182.808171918277;19352.612947741036;20056.8997155014;18401.355952541664;18901.810981890176;18908.621827563442;19163.616727665438;19202.135903884322;3999.640032397084;4280.72175308604;4892.87463883307;5107.4892510749;5228.738563071841;4092.85675001375;4906.754662266891;5888.97055514724;5905.852353691149;6025.307089684698;4989;5754.712264386785;6576.736930522773;6589.472842172639;6606.735730570771;5988.401159884021;5998.340182579913;6522.510811689119;6562.245341785708;6594.142761441006;4550.863474095782;5758.078707406795;5767.855803604902;5776.740046697867;5795.797147099831;18434.354797582153;23698.644520332207;23700.525989480113;24115.51768964611;24132;2072.9378118656464;2082.5730725201297;2119.194706011706;2138.807507324348;2670.8263962842548;9453.149216570542;9590.568424420917;9761.609535618567;9764.902350976541;9900.950495247549;1774.4587900690285;1776.8194931073363;1779.164340961648;1780.0565700178927;1794.5423916901236;84630.15369846285;95159.09681806395;96223;96568;97720;10885.83671244932;11213.551457941754;11245;11315.434228288552;11325.603603873826;13509.392077356542;13592.184468931895;13602.795958060637;13629.727405452033;13665.248411337472;7231.168415632164;8261.38039647029;8459.873101903477;8533.786655333543;8570.228679418757;8617.224449799549;8617.784555386166;8664.09027052163;8723.694670686495;8726.825463490695;3976.0457490202143;4154.750714957112;4172.874813755531;4328.220920234388;4447.310666846644;1682.175733890385;1845.8800177988655;1901.0684764465313;1927.0653732939513;1958.1286327584373;884.3014018925106;926.1849572376266;947.346331031586;989.5942663507927;1076.3864597179534;18311.267549297878;18425.447236582924;18498.907505462386;19210.80789192118;20241.493962651053;879.6481407436949;914.7027216154777;987.1362557761959;1027.7604879870535;1048.3028785857318;10353;10631.52158152885;10655.680329590125;10680.412577308167;10744.838827417596;614857;627411;636908;761716;767416;73739.63130184422;107180.46409767901;107405;110323;115355;947.7772723409993;1149.040551139791;1204.8132539456399;1237.3256575166736;1240.9193402428814;14688.485902993343;17406.39077632277;17667.469975900745;17986.820131798515;18250.452486425427;26136.8693156533;48586.27120593123;49643.75178124086;50202.74898625483;50591;51812.48187518077;68280;68752.6562367185;69687.3031269701;71650.64174679093;6471.514636402195;7515.210902855121;7658.73194438192;7742.419318551244;7752.341051010727;8200.466969646954;10511.18622562784;11195.38425386579;11382.260153090023;11859.466324015613;8431.620577073923;9551.952240239032;9973.304538228373;10172.542235599267;10531.736706582396;6340.651264180515;6909.343612356818;7109.933509973545;7698.114716807639;7708.922910771045;7807.6096195188875;7962.880556791769;8008.69237333546;8012.31895288907;8056.274935255855;10111.797764044532;10725.41010244444;10750.784984300426;10801;11228.326300422;9107.726768196964;10971.01260886524;11010.669679909615;11107.44462776874;11174.776504469703 20:08:05 INFO - PROCESS | 1989 | |3;mootools.html;1538.484607656435;1541.868941140003;1762.7355896615497;1771.4774141628227;1799.7930238022632;7777.805554861125;7875.527468351888;7986.201379862011;8712.303015758733;8716.433431826934;7163.283671632834;8265.83468330633;8368.539730314831;8500.91499085009;8526.317894568436;2438.975610243897;2471.4192164841247;2473.530029294437;2473.727889932106;2475.9133430329944;2424.9272521824373;2463.3964678653665;2466.0382450844186;2479.0827393864297;2481.0944005437977;2455.9631605525933;2458.7172475165407;2475.0718480569785;2477.7770000699934;2479.590867506859;2447.437089469423;2461.1755062054144;2473.789727873133;2483.1309041835393;2489.153687746175;2027.614753196888;2399.8560086394696;2400.387901085212;2401.891914863835;2449.5590793657134;7433.219511951275;8626.611802468904;8665.480071195685;8702.129787021311;8748.912510874874;5323.174907889244;5425.755840987165;5451.100568406208;5452.536534394581;5478.808241711561;3602.67575918166;3646.3072016316814;3731.0485826114436;3739.158689294914;3769.4722738816586;1047.6804574604741;1078.14826287233;1080.6487891435315;1090.2477290669412;1106.4744246482937;11241.213115081948;11464.968152866199;11521.07831373488;11536.192466527347;11625.534978600761;4866.416030076413;4877.756112194376;4880.877978050577;4884.8290309838985;4893.828715994923;9089.091090890857;9294.86057709135;9843.507824608741;9945.15466185368;9952.751181220527;5396.83809485716;5402.37872644643;5406.810761623325;5414.106672399089;5431.918521222185;4425.203463376559;4544.886377840514;4814.15752243363;4849.539293767087;4922.237053256751;3891.902702432405;3905.511811023622;3928.744631598994;3950.249452603996;3957.703172262092;1325.3307079924577;1326.6815964168723;1328.3756634381825;1330.2949436798513;1332.060897067565;1101.0090918173707;1120.4509790202742;1346.0510340210128;1363.222962911151;1381.3093453273364;7932.048154221415;8094.797630059295;8111.067227268822;8114.026316841899;8141.755747327589;512.9769160387791;523.6648544931247;527.2434057128033;531.1369025333832;532.5819231902938;5143.228515722672;6107.633541987495;6117;6182.845428864314;6194.659293738888;7777.922220777833;10369.481525923673;10481.266311358284;10533.367997919997;10549.84175237372;8517.679759637265;9983.550740216708;10375.325603835727;10417.5832966682;10439;8236.670533178605;8242.546659933761;8352.457090289112;8372.623231954576;8393.790155246168;7768.184340644151;7950.284474397101;8021;8057;8129.024517057991;9223.953880230556;9274.629014839331;9276.536173191178;9363.672271470467;9435.905640943503;9272.675456358995;9537.189338905993;9584.9041509584;9605.03949605034;9646.938836727813;6769.661516924036;6926.44588432914;7179.784606461814;7321.816954575965;7465.552066876005;7933.484323518953;7963.641636126504;7968.163342848918;7996.720114795954;8017.078036025931;7364.41084713211;7461.813454663677;7525.623718813928;7635.732749353746;7661.88507172404;6360.713767880549;7324.81687957784;7434.070741157356;7440.3675687567165;7447.92552074494;7512;7529.472936894584;7550.509216900884;7586.886196707164;7589.165191828784;6865.450763938973;6981.650917454209;6993.405560527209;7023.438124949889;7028.789136325919;7066.116735408074;7095.716171353088;7107;7141.143062832286;7145.535540189871 20:08:05 INFO - PROCESS | 1989 | |4;prototype.html;267.55452172133397;328.8980416071018;333.0674112485042;338.3334830384142;339.0506581571599;6675.866482670343;6806.591604503721;6810.795676129718;6860.794176174716;6965.930340696592;5895.938731028424;6603.504737144709;6682.231543372513;6842.21314548827;6898.551594146377;5068.493150684921;5070.847874563759;5077.263796749469;5077.41609714882;5081.644284900059;4932.408111026682;5079.212722028092;5086.872828179288;5100;5107.361579802525;4977.203647416414;4993.825216117437;5009.474005229453;5011.173156429203;5011.799528018875;4064.878053658395;4990.700557966516;5016.8996620067755;5016.971520838256;5022.673526220784;4089.754614723126;4179.1432756284885;4191.937120943188;4287.764172970486;4299.50555686097;6422.133012043361;6451.387118223761;6459.35286501939;6517.739290428377;6522.380373864476;5887.322957859816;5894.233749612566;5907.645541267538;5914.083317085859;5918.792842250544;7004.739146953546;7255.927440725578;7277.3814225790875;7284.635768211569;7291.5989620570845;4751.14479393709;4754.286856971447;4755.9286610700865;4756.120117778188;4767.308740232646;7673.194314596999;7695.345895598881;7704.3451306639;7704.61157041319;7705.614719264015;4733.786979585927;4812.422509298906;4844.128056949783;4846.5153484651255;4849.95150048495;4959.404871415453;4968.90062198754;4978.6763860348965;4985.925211121836;4988.401391833003;5872.383399743051;5895.587308888423;5902.173695682608;5906.497947674496;5916.053431451033;5633.464820842013;6142.6314421134875;6425.618492024238;7387.261273872569;7391;1531.663034132489;1593.8406159384201;1679.8236185200378;1683.1079527850259;1684.5620138763763;1060.3372891942536;1071.2287153249647;1081.6592773276393;1087.3367245979946;1087.374759513283;5481.862953426196;5547.472990065938;6724.025016372696;6748.089007983859;6749.831254218684;7545.170031296553;7565.356944659766;7589.810254743566;7590;7594.734184303523;6549.148610680581;6708.664566771642;6719;6720.630365329856;6723.562968407038;3906.4140378943384;3980.960190398059;3995.1210733638554;3999.5200575931076;4007.3788562772816;7907.644156012993;8080.8383832323025;8096.919030809617;8099.149589293157;8122.309603683635;7950.045994480699;7954.2841144296135;7976.601169941479;7978.242067003625;7982.800429989296;7828.2954534092205;8094.878576821352;8096.149904259968;8099.473534220257;8117.918820811835;7659.119201291923;7662.961685191538;7663.616819159131;7676.193999629959;7676.3091321779075;6116.204893363834;7277.59973201479;7508.061492313461;7540.585267810323;7559.886601700869;6504.869902602016;7729.806754831175;7973.681052757825;7980.561069141253;8107.513549187068;4756.357891684578;4794.880127996688;4804.975975120102;4814.807407703653;4824.204006339055;6892.86267765813;7203.171635261802;7694.653740581575;7699.692012319669;7711.652975616223;7382.889256661262;7400.185979542139;7408.259174082548;7415.8887616684715;7440.55356678601;7377.299156580117;7390.704371825282;7404.296591823768;7407.888881666887;7435.8141046474275;6908.861822763617;7128.180259270251;7228.49400541957;7229;7258.564486130849;7386.519876208029;7397.741079062207;7406.296401841816;7414.295641914009;7417.703291868264;7041.155061392666;7230.42156627458;7239.131304243314;7256.818579535554;7263.237360077116 20:08:05 INFO - PROCESS | 1989 | |5;yui.html;646.4085361893865;649.6264647827494;678.2064983968758;725.4377857160699;734.9853002939941;14869.702605947889;14891;15161.938664293504;15228.77156842647;17148.314067437317;15536.456224032161;15897.364105435769;16073.196340183002;16078.839211607881;16095.758563621555;698.8672152291074;706.9925356367182;864.416518849777;876.5003947749785;877.2674816528206;701.7193122750915;851.2551517422255;865.5326123893091;879.0330636300051;880.3529405886668;880.8194320164383;914.0128661046055;914.9862752058724;914.9908500914972;916.0930678628143;897.161154320709;897.4166791585457;906.428949761646;908;909.822584596004;524.6117872774158;594.088074805172;641.371455973149;670.1187937861696;674.8818956682561;12494.375281235902;14878.70242595142;14992.950493465461;15125.243737813176;15132.546023619308;12462.756703793313;12651.93674031624;12702.666220046855;12802.551910683174;13268.668283292898;8100.311473524757;10257.846132308021;10364.11904988077;10664;11327;3444.48332750087;3532.5937517185594;3588.6231945645854;3649.9270014599824;3713.8885833425043;76641.61679191624;77290;77351.99999999943;77421;77530.22469775287;9419.492881138985;9527.761805954906;9536.2371010319;9789.412635241908;10131.341462804894;20431.693524596845;20652;20681;20702.757834529977;20725.58548829015;7360.595167265852;7424.665890034961;7463.029806125169;7660.846783064308;7784.571848548384;4214.662826973835;4236.597523235288;4240.554741752072;4247.193033323659;4251.17102165081;3571.5535558055244;3601.6218297078954;3611.819409029538;3613.0244833894703;3626.401643728808;580.4601720399984;587.8089620873147;595.487880422836;628.3245511075612;664.5315052887703;519.1356391607931;594.3551246897078;598.9011813050798;614.8063360041573;618.4186864347499;8354.958225208835;8626.741197764077;8717.651293948298;8727.825443491221;8823.294136469067;507.87049302427647;577.7429044075346;597.3876776304236;628.8522197283635;634.4416913116428;4015.3374693175297;4047.1905618876344;4079.3676980068135;4148.191102734938;4361.563843615613;85854.57072714597;87518.24963500694;94068;94875.52562237145;95837.5208123955;67334.66332668305;77683.61158194173;81846.59076704578;82631;82843.343133137;71796.64101679459;72709;73133.26866731264;73621.6318918402;74464.62767686235;8867.73396798097;9054.909450905407;9082.954585227031;9129.5891684873;9246.260299176185;43043.7847810759;50432.24351634802;50825.729356764896;51454;52667.20999185092;68710.65644671745;70751.64624176847;70904;71277;71844.56310873858;10718.088962437969;11048.944755276172;11071.280366776135;11228.494717737558;11899.464524096264;11132.833007504732;11267.309903514539;11961.342126183143;11990.340531270864;12239.816402754144;9976.401415915068;11298.152638552307;11311.773764524827;11734.94132529332;11778.175527712978;11367.090632749194;11634.127440441831;11671.12466565028;11684.240524365889;12252.87747122553;9335.789510270888;10394.428306443218;11222.214444988773;11307.321560706385;12123.151379403356;9235.1688348049;9239.491827949527;9319.114684105;9836.409815411098;10198.490075496047;9018.549072546215;9087.091710740555;9518.619255229713;9802.26483013791;10127.442990635585 20:08:05 INFO - PROCESS | 1989 | __end_tp_report 20:08:05 INFO - PROCESS | 1989 | __start_cc_report 20:08:05 INFO - PROCESS | 1989 | _x_x_mozilla_cycle_collect,349 20:08:05 INFO - PROCESS | 1989 | __end_cc_report 20:08:05 INFO - PROCESS | 1989 | __startTimestamp1454299685736__endTimestamp 20:08:05 INFO - PROCESS | 1989 | 20:08:05 INFO - PROCESS | 1989 | ------- Summary: start ------- 20:08:05 INFO - PROCESS | 1989 | Number of tests: 6 20:08:05 INFO - PROCESS | 1989 | 20:08:05 INFO - PROCESS | 1989 | [#0] dojo.html Cycles:165 Average:5724.99 Median:5879.94 stddev:634.58 (10.8%) stddev-sans-first:611.94 20:08:05 INFO - PROCESS | 1989 | Values: 3495.1 3524.5 3537.6 3562.9 3570.9 5742.3 5762.7 5779.4 5783.8 5808.6 5641.4 5738.7 5762.4 5771.5 5793.9 5175.0 5206.5 5269.5 5303.5 5318.8 5309.5 5334.1 5351.2 5355.8 5360.8 5295.8 5299.3 5338.3 5354.7 5395.9 4125.5 5123.8 5207.5 5231.7 5291.0 5088.9 5183.8 5198.0 5199.7 5199.9 5505.6 5536.0 5539.5 5607.2 5690.8 6115.0 6174.3 6214.9 6250.7 6261.7 6219.1 6246.2 6256.2 6274.7 6288.3 5625.0 5709.5 5874.7 5879.9 5882.8 6198.0 6275.7 6279.8 6297.9 6305.4 6163.5 6192.0 6200.7 6206.0 6213.3 5539.3 5936.0 6184.2 6257.1 6259.6 5150.8 6237.5 6249.2 6262.4 6272.5 6204.0 6272.7 6275.0 6275.4 6285.5 4844.6 4904.3 4939.9 4966.2 4990.1 4387.5 4397.2 4413.4 4436.5 4459.7 5722.7 5757.0 5774.5 5776.8 5790.8 6181.2 6186.2 6226.3 6262.7 6268.0 5788.0 5791.6 5794.0 5818.6 5822.0 5309.0 5385.8 5431.4 5448.6 5456.6 6283.7 6297.3 6395.0 6396.2 6402.9 6228.3 6256.3 6265.2 6282.4 6290.1 6213.0 6303.6 6367.0 6381.3 6386.7 6118.6 6166.4 6229.7 6231.4 6262.5 6222.5 6264.7 6265.9 6269.5 6275.7 6005.5 6053.8 6098.8 6118.1 6141.2 5956.4 5970.8 5977.8 5982.8 5992.7 5361.4 5838.8 5849.7 5856.5 5864.6 4499.5 4876.8 5986.5 5988.6 5996.0 5882.5 5882.6 5889.4 5905.2 5920.5 20:08:05 INFO - PROCESS | 1989 | 20:08:05 INFO - PROCESS | 1989 | [#1] ext.html Cycles:180 Average:63914.86 Median:37108.63 stddev:133960.47 (361.0%) stddev-sans-first:134251.60 20:08:05 INFO - PROCESS | 1989 | Values: 480.2 494.1 568.9 585.8 602.6 36882.1 37157.0 37194.8 37394.0 37401.3 37223.5 37719.8 37759.0 37820.8 37950.4 7875.8 9196.0 9227.9 9406.8 9461.6 9350.0 9533.0 9588.6 9621.9 9651.9 9599.3 9662.9 9684.3 9704.0 9723.6 9593.1 9620.9 9663.8 9670.5 9685.7 8082.5 9499.2 9551.4 9567.0 9585.5 37048.8 37346.6 37724.0 37793.4 37799.0 3167.2 3226.5 3316.3 3510.2 3622.9 27455.7 28525.6 28582.6 28586.3 28930.7 2793.5 2816.1 2882.8 2891.7 3002.0 477005.0 477986.0 478650.0 479231.0 482232.6 54413.2 55483.4 61709.1 62359.7 64137.7 63823.0 64302.0 64363.7 64472.0 64521.0 16493.6 16520.8 16542.7 16690.7 16742.6 11269.8 12743.2 12831.7 12871.9 12905.0 15896.0 17622.4 18382.8 19477.1 19704.9 8726.9 8914.2 8944.6 8958.8 8961.3 968.2 991.9 1013.2 1034.4 1108.0 29218.0 29332.6 29475.7 30104.8 30109.8 1069.0 1078.7 1083.2 1092.1 1220.4 14896.3 14904.5 15005.7 15166.7 15359.5 525398.0 537347.0 543009.0 544967.0 545993.0 56614.2 56817.1 57050.1 57069.7 57131.4 1247.9 1394.7 1398.6 1439.6 1442.1 28983.0 29103.0 29179.0 29714.0 29802.6 36874.6 49369.8 49601.5 49630.0 49642.3 484871.0 488446.0 490193.5 490762.1 492130.5 31994.1 32885.0 32930.3 33126.0 33215.0 41012.3 41972.0 42757.4 43482.6 43957.8 27845.7 35090.0 36265.1 36317.3 36380.5 33988.5 34320.0 35091.0 35324.8 35419.5 35711.8 35713.5 35850.2 36797.8 37060.3 30311.4 31825.7 31993.2 32106.0 32208.8 22449.9 24409.4 24574.5 24662.0 24816.6 20:08:05 INFO - PROCESS | 1989 | 20:08:05 INFO - PROCESS | 1989 | [#2] jquery.html Cycles:180 Average:34829.41 Median:4163.81 stddev:112756.60 (2708.0%) stddev-sans-first:113043.21 20:08:05 INFO - PROCESS | 1989 | Values: 364.9 368.1 368.9 370.4 374.6 15345.8 18720.7 19182.8 19352.6 20056.9 18401.4 18901.8 18908.6 19163.6 19202.1 3999.6 4280.7 4892.9 5107.5 5228.7 4092.9 4906.8 5889.0 5905.9 6025.3 4989.0 5754.7 6576.7 6589.5 6606.7 5988.4 5998.3 6522.5 6562.2 6594.1 4550.9 5758.1 5767.9 5776.7 5795.8 18434.4 23698.6 23700.5 24115.5 24132.0 2072.9 2082.6 2119.2 2138.8 2670.8 9453.1 9590.6 9761.6 9764.9 9901.0 1774.5 1776.8 1779.2 1780.1 1794.5 84630.2 95159.1 96223.0 96568.0 97720.0 10885.8 11213.6 11245.0 11315.4 11325.6 13509.4 13592.2 13602.8 13629.7 13665.2 7231.2 8261.4 8459.9 8533.8 8570.2 8617.2 8617.8 8664.1 8723.7 8726.8 3976.0 4154.8 4172.9 4328.2 4447.3 1682.2 1845.9 1901.1 1927.1 1958.1 884.3 926.2 947.3 989.6 1076.4 18311.3 18425.4 18498.9 19210.8 20241.5 879.6 914.7 987.1 1027.8 1048.3 10353.0 10631.5 10655.7 10680.4 10744.8 614857.0 627411.0 636908.0 761716.0 767416.0 73739.6 107180.5 107405.0 110323.0 115355.0 947.8 1149.0 1204.8 1237.3 1240.9 14688.5 17406.4 17667.5 17986.8 18250.5 26136.9 48586.3 49643.8 50202.7 50591.0 51812.5 68280.0 68752.7 69687.3 71650.6 6471.5 7515.2 7658.7 7742.4 7752.3 8200.5 10511.2 11195.4 11382.3 11859.5 8431.6 9552.0 9973.3 10172.5 10531.7 6340.7 6909.3 7109.9 7698.1 7708.9 7807.6 7962.9 8008.7 8012.3 8056.3 10111.8 10725.4 10750.8 10801.0 11228.3 9107.7 10971.0 11010.7 11107.4 11174.8 20:08:05 INFO - PROCESS | 1989 | 20:08:05 INFO - PROCESS | 1989 | [#3] mootools.html Cycles:180 Average:5905.69 Median:5451.82 stddev:3067.45 (56.3%) stddev-sans-first:3058.50 20:08:05 INFO - PROCESS | 1989 | Values: 1538.5 1541.9 1762.7 1771.5 1799.8 7777.8 7875.5 7986.2 8712.3 8716.4 7163.3 8265.8 8368.5 8500.9 8526.3 2439.0 2471.4 2473.5 2473.7 2475.9 2424.9 2463.4 2466.0 2479.1 2481.1 2456.0 2458.7 2475.1 2477.8 2479.6 2447.4 2461.2 2473.8 2483.1 2489.2 2027.6 2399.9 2400.4 2401.9 2449.6 7433.2 8626.6 8665.5 8702.1 8748.9 5323.2 5425.8 5451.1 5452.5 5478.8 3602.7 3646.3 3731.0 3739.2 3769.5 1047.7 1078.1 1080.6 1090.2 1106.5 11241.2 11465.0 11521.1 11536.2 11625.5 4866.4 4877.8 4880.9 4884.8 4893.8 9089.1 9294.9 9843.5 9945.2 9952.8 5396.8 5402.4 5406.8 5414.1 5431.9 4425.2 4544.9 4814.2 4849.5 4922.2 3891.9 3905.5 3928.7 3950.2 3957.7 1325.3 1326.7 1328.4 1330.3 1332.1 1101.0 1120.5 1346.1 1363.2 1381.3 7932.0 8094.8 8111.1 8114.0 8141.8 513.0 523.7 527.2 531.1 532.6 5143.2 6107.6 6117.0 6182.8 6194.7 7777.9 10369.5 10481.3 10533.4 10549.8 8517.7 9983.6 10375.3 10417.6 10439.0 8236.7 8242.5 8352.5 8372.6 8393.8 7768.2 7950.3 8021.0 8057.0 8129.0 9224.0 9274.6 9276.5 9363.7 9435.9 9272.7 9537.2 9584.9 9605.0 9646.9 6769.7 6926.4 7179.8 7321.8 7465.6 7933.5 7963.6 7968.2 7996.7 8017.1 7364.4 7461.8 7525.6 7635.7 7661.9 6360.7 7324.8 7434.1 7440.4 7447.9 7512.0 7529.5 7550.5 7586.9 7589.2 6865.5 6981.7 6993.4 7023.4 7028.8 7066.1 7095.7 7107.0 7141.1 7145.5 20:08:05 INFO - PROCESS | 1989 | 20:08:05 INFO - PROCESS | 1989 | [#4] prototype.html Cycles:180 Average:5968.39 Median:6679.05 stddev:1930.39 (28.9%) stddev-sans-first:1887.79 20:08:05 INFO - PROCESS | 1989 | Values: 267.6 328.9 333.1 338.3 339.1 6675.9 6806.6 6810.8 6860.8 6965.9 5895.9 6603.5 6682.2 6842.2 6898.6 5068.5 5070.8 5077.3 5077.4 5081.6 4932.4 5079.2 5086.9 5100.0 5107.4 4977.2 4993.8 5009.5 5011.2 5011.8 4064.9 4990.7 5016.9 5017.0 5022.7 4089.8 4179.1 4191.9 4287.8 4299.5 6422.1 6451.4 6459.4 6517.7 6522.4 5887.3 5894.2 5907.6 5914.1 5918.8 7004.7 7255.9 7277.4 7284.6 7291.6 4751.1 4754.3 4755.9 4756.1 4767.3 7673.2 7695.3 7704.3 7704.6 7705.6 4733.8 4812.4 4844.1 4846.5 4850.0 4959.4 4968.9 4978.7 4985.9 4988.4 5872.4 5895.6 5902.2 5906.5 5916.1 5633.5 6142.6 6425.6 7387.3 7391.0 1531.7 1593.8 1679.8 1683.1 1684.6 1060.3 1071.2 1081.7 1087.3 1087.4 5481.9 5547.5 6724.0 6748.1 6749.8 7545.2 7565.4 7589.8 7590.0 7594.7 6549.1 6708.7 6719.0 6720.6 6723.6 3906.4 3981.0 3995.1 3999.5 4007.4 7907.6 8080.8 8096.9 8099.1 8122.3 7950.0 7954.3 7976.6 7978.2 7982.8 7828.3 8094.9 8096.1 8099.5 8117.9 7659.1 7663.0 7663.6 7676.2 7676.3 6116.2 7277.6 7508.1 7540.6 7559.9 6504.9 7729.8 7973.7 7980.6 8107.5 4756.4 4794.9 4805.0 4814.8 4824.2 6892.9 7203.2 7694.7 7699.7 7711.7 7382.9 7400.2 7408.3 7415.9 7440.6 7377.3 7390.7 7404.3 7407.9 7435.8 6908.9 7128.2 7228.5 7229.0 7258.6 7386.5 7397.7 7406.3 7414.3 7417.7 7041.2 7230.4 7239.1 7256.8 7263.2 20:08:05 INFO - PROCESS | 1989 | 20:08:05 INFO - PROCESS | 1989 | [#5] yui.html Cycles:180 Average:18422.62 Median:606.85 stddev:25775.85 (4247.5%) stddev-sans-first:25813.60 20:08:05 INFO - PROCESS | 1989 | Values: 646.4 649.6 678.2 725.4 735.0 14869.7 14891.0 15161.9 15228.8 17148.3 15536.5 15897.4 16073.2 16078.8 16095.8 698.9 707.0 864.4 876.5 877.3 701.7 851.3 865.5 879.0 880.4 880.8 914.0 915.0 915.0 916.1 897.2 897.4 906.4 908.0 909.8 524.6 594.1 641.4 670.1 674.9 12494.4 14878.7 14993.0 15125.2 15132.5 12462.8 12651.9 12702.7 12802.6 13268.7 8100.3 10257.8 10364.1 10664.0 11327.0 3444.5 3532.6 3588.6 3649.9 3713.9 76641.6 77290.0 77352.0 77421.0 77530.2 9419.5 9527.8 9536.2 9789.4 10131.3 20431.7 20652.0 20681.0 20702.8 20725.6 7360.6 7424.7 7463.0 7660.8 7784.6 4214.7 4236.6 4240.6 4247.2 4251.2 3571.6 3601.6 3611.8 3613.0 3626.4 580.5 587.8 595.5 628.3 664.5 519.1 594.4 598.9 614.8 618.4 8355.0 8626.7 8717.7 8727.8 8823.3 507.9 577.7 597.4 628.9 634.4 4015.3 4047.2 4079.4 4148.2 4361.6 85854.6 87518.2 94068.0 94875.5 95837.5 67334.7 77683.6 81846.6 82631.0 82843.3 71796.6 72709.0 73133.3 73621.6 74464.6 8867.7 9054.9 9083.0 9129.6 9246.3 43043.8 50432.2 50825.7 51454.0 52667.2 68710.7 70751.6 70904.0 71277.0 71844.6 10718.1 11048.9 11071.3 11228.5 11899.5 11132.8 11267.3 11961.3 11990.3 12239.8 9976.4 11298.2 11311.8 11734.9 11778.2 11367.1 11634.1 11671.1 11684.2 12252.9 9335.8 10394.4 11222.2 11307.3 12123.2 9235.2 9239.5 9319.1 9836.4 10198.5 9018.5 9087.1 9518.6 9802.3 10127.4 20:08:05 INFO - PROCESS | 1989 | -------- Summary: end -------- 20:08:05 INFO - PROCESS | 1989 | 20:08:06 INFO - TEST-INFO | 1989: exit 0 20:08:06 INFO - TEST-OK | dromaeo_css | took 1111131ms 20:08:06 INFO - TEST-START | kraken 20:08:06 INFO - operating with platform_type : mac_ 20:08:06 INFO - Initialising browser for kraken test... 20:08:06 INFO - TEST-INFO | started process 1994 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmppTaeZi/profile http://localhost:49749/getInfo.html) 20:08:06 INFO - PROCESS | 1994 | JavaScript warning: resource://gre/modules/AddonManager.jsm, line 692: Proxy.create and Proxy.createFunction are deprecated, use new Proxy instead 20:08:08 INFO - PROCESS | 1994 | __metrics Screen width/height:1600/1200 20:08:08 INFO - PROCESS | 1994 | colorDepth:24 20:08:08 INFO - PROCESS | 1994 | Browser inner width/height: 1024/689 20:08:08 INFO - PROCESS | 1994 | __metrics 20:08:09 INFO - PROCESS | 1994 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:08:09 INFO - TEST-INFO | 1994: exit 0 20:08:09 INFO - Browser initialized. 20:08:09 INFO - Running cycle 1/1 for kraken test... 20:08:09 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/tmppTaeZi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:08:21 INFO - PROCESS | 1997 | RSS: Main: 256380928 20:08:21 INFO - PROCESS | 1997 | 20:08:24 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49749/tests/kraken/driver.html?testName=audio-beat-detection) 20:08:24 INFO - PROCESS | 1997 | RSS: Main: 269742080 20:08:24 INFO - PROCESS | 1997 | 20:08:27 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49749/tests/kraken/driver.html?testName=audio-dft) 20:08:28 INFO - PROCESS | 1997 | RSS: Main: 276963328 20:08:28 INFO - PROCESS | 1997 | 20:08:31 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49749/tests/kraken/driver.html?testName=audio-fft) 20:08:32 INFO - PROCESS | 1997 | RSS: Main: 282079232 20:08:32 INFO - PROCESS | 1997 | 20:08:34 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49749/tests/kraken/driver.html?testName=audio-oscillator) 20:08:34 INFO - PROCESS | 1997 | RSS: Main: 283971584 20:08:34 INFO - PROCESS | 1997 | 20:08:36 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49749/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:08:37 INFO - PROCESS | 1997 | RSS: Main: 284819456 20:08:37 INFO - PROCESS | 1997 | 20:08:40 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49749/tests/kraken/driver.html?testName=imaging-darkroom) 20:08:40 INFO - PROCESS | 1997 | RSS: Main: 284205056 20:08:40 INFO - PROCESS | 1997 | 20:08:43 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49749/tests/kraken/driver.html?testName=imaging-desaturate) 20:08:44 INFO - PROCESS | 1997 | RSS: Main: 284098560 20:08:44 INFO - PROCESS | 1997 | 20:08:47 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49749/tests/kraken/driver.html?testName=json-parse-financial) 20:08:47 INFO - PROCESS | 1997 | RSS: Main: 284606464 20:08:47 INFO - PROCESS | 1997 | 20:08:49 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49749/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:08:50 INFO - PROCESS | 1997 | RSS: Main: 284143616 20:08:50 INFO - PROCESS | 1997 | 20:08:51 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:08:52 INFO - PROCESS | 1997 | RSS: Main: 282935296 20:08:52 INFO - PROCESS | 1997 | 20:08:54 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:08:55 INFO - PROCESS | 1997 | RSS: Main: 284180480 20:08:55 INFO - PROCESS | 1997 | 20:08:57 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:08:58 INFO - PROCESS | 1997 | RSS: Main: 283275264 20:08:58 INFO - PROCESS | 1997 | 20:09:00 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:09:01 INFO - PROCESS | 1997 | RSS: Main: 284655616 20:09:01 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | Cycle 1(1): loaded http://localhost:49749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49749/tests/kraken/driver.html?testName=ai-astar) 20:09:03 INFO - PROCESS | 1997 | RSS: Main: 284618752 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | __start_tp_report 20:09:03 INFO - PROCESS | 1997 | _x_x_mozilla_page_load 20:09:03 INFO - PROCESS | 1997 | _x_x_mozilla_page_load_details 20:09:03 INFO - PROCESS | 1997 | |i|pagename|runs| 20:09:03 INFO - PROCESS | 1997 | |0;ai-astar;117;105;114;113;115;126;112;111;116;96 20:09:03 INFO - PROCESS | 1997 | |1;audio-beat-detection;159;120;151;155;124;142;126;200;184;143 20:09:03 INFO - PROCESS | 1997 | |2;audio-dft;194;199;200;194;212;273;272;201;196;198 20:09:03 INFO - PROCESS | 1997 | |3;audio-fft;67;67;67;105;57;63;83;86;140;58 20:09:03 INFO - PROCESS | 1997 | |4;audio-oscillator;82;89;115;76;81;80;104;83;115;152 20:09:03 INFO - PROCESS | 1997 | |5;imaging-gaussian-blur;86;93;87;93;87;93;85;94;88;134 20:09:03 INFO - PROCESS | 1997 | |6;imaging-darkroom;95;96;97;95;97;95;119;95;154;134 20:09:03 INFO - PROCESS | 1997 | |7;imaging-desaturate;92;96;121;92;141;150;120;94;92;90 20:09:03 INFO - PROCESS | 1997 | |8;json-parse-financial;56;57;54;55;55;56;56;64;57;53 20:09:03 INFO - PROCESS | 1997 | |9;json-stringify-tinderbox;65;67;84;101;63;65;63;65;67;67 20:09:03 INFO - PROCESS | 1997 | |10;stanford-crypto-aes;85;86;85;84;81;85;83;87;87;83 20:09:03 INFO - PROCESS | 1997 | |11;stanford-crypto-ccm;131;135;125;123;120;124;125;121;129;125 20:09:03 INFO - PROCESS | 1997 | |12;stanford-crypto-pbkdf2;135;141;142;181;142;113;131;152;181;170 20:09:03 INFO - PROCESS | 1997 | |13;stanford-crypto-sha256-iterative;67;68;68;66;68;65;67;70;65;68 20:09:03 INFO - PROCESS | 1997 | __end_tp_report 20:09:03 INFO - PROCESS | 1997 | __start_cc_report 20:09:03 INFO - PROCESS | 1997 | _x_x_mozilla_cycle_collect,883 20:09:03 INFO - PROCESS | 1997 | __end_cc_report 20:09:03 INFO - PROCESS | 1997 | __startTimestamp1454299743369__endTimestamp 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | ------- Summary: start ------- 20:09:03 INFO - PROCESS | 1997 | Number of tests: 14 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#0] ai-astar Cycles:10 Average:112.50 Median:115.50 stddev:7.85 (6.8%) stddev-sans-first:8.15 20:09:03 INFO - PROCESS | 1997 | Values: 117.0 105.0 114.0 113.0 115.0 126.0 112.0 111.0 116.0 96.0 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#1] audio-beat-detection Cycles:10 Average:150.40 Median:153.00 stddev:25.88 (16.9%) stddev-sans-first:27.26 20:09:03 INFO - PROCESS | 1997 | Values: 159.0 120.0 151.0 155.0 124.0 142.0 126.0 200.0 184.0 143.0 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#2] audio-dft Cycles:10 Average:213.90 Median:200.50 stddev:31.30 (15.6%) stddev-sans-first:32.36 20:09:03 INFO - PROCESS | 1997 | Values: 194.0 199.0 200.0 194.0 212.0 273.0 272.0 201.0 196.0 198.0 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#3] audio-fft Cycles:10 Average:79.30 Median:67.00 stddev:25.98 (38.8%) stddev-sans-first:27.17 20:09:03 INFO - PROCESS | 1997 | Values: 67.0 67.0 67.0 105.0 57.0 63.0 83.0 86.0 140.0 58.0 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:80.50 stddev:24.01 (29.8%) stddev-sans-first:24.78 20:09:03 INFO - PROCESS | 1997 | Values: 82.0 89.0 115.0 76.0 81.0 80.0 104.0 83.0 115.0 152.0 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#5] imaging-gaussian-blur Cycles:10 Average:94.00 Median:90.50 stddev:14.46 (16.0%) stddev-sans-first:15.05 20:09:03 INFO - PROCESS | 1997 | Values: 86.0 93.0 87.0 93.0 87.0 93.0 85.0 94.0 88.0 134.0 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#6] imaging-darkroom Cycles:10 Average:107.70 Median:95.00 stddev:21.01 (22.1%) stddev-sans-first:21.78 20:09:03 INFO - PROCESS | 1997 | Values: 95.0 96.0 97.0 95.0 97.0 95.0 119.0 95.0 154.0 134.0 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#7] imaging-desaturate Cycles:10 Average:108.80 Median:92.00 stddev:22.59 (24.6%) stddev-sans-first:23.12 20:09:03 INFO - PROCESS | 1997 | Values: 92.0 96.0 121.0 92.0 141.0 150.0 120.0 94.0 92.0 90.0 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:2.98 (5.3%) stddev-sans-first:3.16 20:09:03 INFO - PROCESS | 1997 | Values: 56.0 57.0 54.0 55.0 55.0 56.0 56.0 64.0 57.0 53.0 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#9] json-stringify-tinderbox Cycles:10 Average:70.70 Median:66.00 stddev:12.26 (18.6%) stddev-sans-first:12.83 20:09:03 INFO - PROCESS | 1997 | Values: 65.0 67.0 84.0 101.0 63.0 65.0 63.0 65.0 67.0 67.0 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:85.00 stddev:1.90 (2.2%) stddev-sans-first:2.01 20:09:03 INFO - PROCESS | 1997 | Values: 85.0 86.0 85.0 84.0 81.0 85.0 83.0 87.0 87.0 83.0 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:125.00 stddev:4.61 (3.7%) stddev-sans-first:4.49 20:09:03 INFO - PROCESS | 1997 | Values: 131.0 135.0 125.0 123.0 120.0 124.0 125.0 121.0 129.0 125.0 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:147.00 stddev:22.30 (15.2%) stddev-sans-first:23.09 20:09:03 INFO - PROCESS | 1997 | Values: 135.0 141.0 142.0 181.0 142.0 113.0 131.0 152.0 181.0 170.0 20:09:03 INFO - PROCESS | 1997 | 20:09:03 INFO - PROCESS | 1997 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.55 (2.3%) stddev-sans-first:1.64 20:09:03 INFO - PROCESS | 1997 | Values: 67.0 68.0 68.0 66.0 68.0 65.0 67.0 70.0 65.0 68.0 20:09:03 INFO - PROCESS | 1997 | -------- Summary: end -------- 20:09:03 INFO - PROCESS | 1997 | 20:09:04 INFO - TEST-INFO | 1997: exit 0 20:09:04 INFO - TEST-OK | kraken | took 57799ms 20:09:04 INFO - SUITE-END | took 1168s 20:09:04 INFO - Completed test suite (00:19:29) 20:09:04 INFO - Working with test: dromaeo_css 20:09:04 INFO - Generating results file: dromaeo_css 20:09:04 INFO - Working with test: kraken 20:09:04 INFO - Generating results file: kraken 20:09:04 INFO - javascript benchmark 20:09:04 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:09:04 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 20:09:04 INFO - process_Request line: dromaeo_css 7466.51 graph.html#tests=[[72,1,61]] 20:09:04 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:09:04 INFO - process_Request line: kraken 1517.70 graph.html#tests=[[232,1,61]] 20:09:04 INFO - RETURN: dromaeo_css: 7466.51 20:09:04 INFO - RETURN: kraken: 1517.70 20:09:04 INFO - javascript benchmark 20:09:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3495.1262184453885, 3524.506569080331, 3537.6285490023565, 3562.9465558016636, 3570.8571657133716, 5742.253507044078, 5762.654240745558, 5779.36426993031, 5783.826485205445, 5808.56435767317, 5641.435856414357, 5738.7417566209515, 5762.3949485303965, 5771.538276937846, 5793.855153621151, 5174.974125129378, 5206.531412172903, 5269.499397557245, 5303.549198318147, 5318.813841515548, 5309.548688361494, 5334.146536554152, 5351.170568561879, 5355.758990845402, 5360.758765855527, 5295.814646487393, 5299.33758280215, 5338.252644629735, 5354.705491197982, 5395.892082158354, 4125.50493940726, 5123.820666276662, 5207.505286997729, 5231.686098834044, 5290.994711004935, 5088.92366614501, 5183.818566350197, 5198.0, 5199.688018718889, 5199.922001169985, 5505.642133261365, 5536.0, 5539.501444869981, 5607.186957891083, 5690.800821971211, 6114.984399026647, 6174.320824709278, 6214.875702485971, 6250.749970001195, 6261.686915654199, 6219.129321894939, 6246.187995560548, 6256.1866957295715, 6274.717637706314, 6288.3397243289255, 5625.015622266169, 5709.486146246774, 5874.706264686792, 5879.941200587982, 5882.764689412418, 6198.0, 6275.748970041147, 6279.811605651837, 6297.905531417033, 6305.432511074026, 6163.537734669918, 6191.9690401547705, 6200.720967556381, 6205.968970155211, 6213.285472170758, 5539.2522009529, 5936.0, 6184.196054512974, 6257.061440783918, 6259.561830671809, 5150.793968241228, 6237.532185086136, 6249.187605611332, 6262.436380725757, 6272.466840318532, 6204.007358822567, 6272.686365681698, 6274.968625156845, 6275.3724627537795, 6285.528585356025, 4844.612431005511, 4904.337914381513, 4939.851804445872, 4966.180580204298, 4990.101781679333, 4387.473503179639, 4397.208502469586, 4413.44831896013, 4436.489803672619, 4459.687821852439, 5722.685252311079, 5757.0, 5774.480296773227, 5776.797812076557, 5790.797322093791, 6181.227346581677, 6186.1648677428875, 6226.25284965807, 6262.655553944577, 6268.0, 5788.0, 5791.5656325775735, 5794.0, 5818.6217895836635, 5822.010258256107, 5308.991291654574, 5385.838424847261, 5431.402545720047, 5448.618596698272, 5456.563474921997, 6283.654399008098, 6297.27581328144, 6395.040743888454, 6396.168498095218, 6402.9359706403275, 6228.28374736893, 6256.311805701278, 6265.154204182377, 6282.371762823681, 6290.056491526308, 6213.00591905293, 6303.590266632654, 6367.0, 6381.298057213796, 6386.712597933011, 6118.588722523033, 6166.352532983972, 6229.719662615103, 6231.408016238632, 6262.53031022666, 6222.502199823913, 6264.655443950626, 6265.906011409924, 6269.49844012487, 6275.748970041147, 6005.519558435402, 6053.818385448443, 6098.817035488943, 6118.112873633209, 6141.201643786279, 5956.404359564009, 5970.820875373745, 5977.760889564369, 5982.760689572368, 5992.730327135202, 5361.35663720356, 5838.795642152504, 5849.678267695147, 5856.531477481706, 5864.589478736448, 4499.482559505699, 4876.756162191805, 5986.461218490357, 5988.580799344179, 5996.0, 5882.499987500939, 5882.558808089496, 5889.440503152194, 5905.232319798399, 5920.496757775637], "unit": "score", "name": "dojo.html", "value": 5687.435204305733}, {"lowerIsBetter": false, "replicates": [480.23882146797325, 494.07114624505937, 568.9431056894311, 585.7991118207676, 602.6052935327363, 36882.077948051316, 37157.0, 37194.8140259299, 37394.0, 37401.25197496048, 37223.51105955758, 37719.81140094303, 37759.0, 37820.81089594555, 37950.43074353887, 7875.8031049223655, 9196.034416386283, 9227.861582076273, 9406.811863762721, 9461.621535138585, 9350.0, 9533.0, 9588.616455341778, 9621.903780962206, 9651.855222171673, 9599.280053995943, 9662.855057174149, 9684.322097453145, 9703.951480242624, 9723.611055557769, 9593.088656577615, 9620.903790962071, 9663.758406039835, 9670.468124253162, 9685.70942871715, 8082.515049097073, 9499.24006079512, 9551.379160354623, 9566.995465476164, 9585.472798996052, 37048.814755926316, 37346.62653373458, 37724.0, 37793.43309850354, 37799.0, 3167.2398624330226, 3226.4998925166637, 3316.3201543683485, 3510.1926556891804, 3622.9131260621707, 27455.725442745515, 28525.57211641827, 28582.570871456344, 28586.285342866388, 28930.71069289301, 2793.483205606969, 2816.0566210319566, 2882.783791215646, 2891.7108289171124, 3002.0, 477005.0, 477986.0, 478650.0, 479231.0, 482232.58883705357, 54413.183802242995, 55483.445165547826, 61709.07436388368, 62359.688201559606, 64137.67931160408, 63823.0, 64302.0, 64363.67818160879, 64472.0, 64521.0, 16493.58766030859, 16520.75218871718, 16542.669146617, 16690.66618667644, 16742.581435463966, 11269.830952535718, 12743.171693839871, 12831.679208019874, 12871.935640321739, 12905.0, 15896.0, 17622.383216587357, 18382.81617183811, 19477.078438234377, 19704.90147549253, 8726.91273087261, 8914.153155450222, 8944.642214311485, 8958.776030599156, 8961.327900407496, 968.1867231525553, 991.9057689519484, 1013.1692012549638, 1034.3586976074882, 1108.024938054507, 29218.0, 29332.560011599842, 29475.705242947726, 30104.795808167866, 30109.849450752605, 1068.9946550267355, 1078.735709751116, 1083.2092572422175, 1092.0662833277593, 1220.395904027512, 14896.255187240595, 14904.478343257933, 15005.69988600222, 15166.696666066617, 15359.539213823604, 525398.0, 537347.0, 543009.0, 544967.0, 545993.0, 56614.15078773822, 56817.14774278389, 57050.14424783632, 57069.714651426475, 57131.42868571261, 1247.9438425270885, 1394.721055788826, 1398.5594537720585, 1439.647286414835, 1442.1203066129654, 28983.0, 29103.0, 29179.0, 29713.960011399497, 29802.552961705158, 36874.63125368712, 49369.753151234014, 49601.51992400438, 49630.0, 49642.255366168814, 484871.0, 488446.0, 490193.5490322526, 490762.10046346876, 492130.53934730095, 31994.120529151558, 32885.0, 32930.341393171526, 33126.0, 33215.0, 41012.33547307503, 41971.950701232716, 42757.35863962105, 43482.56517434785, 43957.78021109874, 27845.721542785122, 35090.0, 36265.09337266589, 36317.27365452729, 36380.454293185096, 33988.49017264693, 34319.970400888014, 35091.0, 35324.76363327374, 35419.468707969914, 35711.82144089367, 35713.46429803503, 35850.207489624896, 36797.81601091977, 37060.25879482449, 30311.393772124877, 31825.68174318227, 31993.200169995005, 32106.0, 32208.83895580507, 22449.88775056114, 24409.38976525601, 24574.508509830062, 24662.0, 24816.627750584117], "unit": "score", "name": "ext.html", "value": 19443.001391611513}, {"lowerIsBetter": false, "replicates": [364.87229469685616, 368.13488302489156, 368.8524590163934, 370.4091973302583, 374.58421152520714, 15345.769813452807, 18720.719189212174, 19182.808171918277, 19352.612947741036, 20056.8997155014, 18401.355952541664, 18901.810981890176, 18908.621827563442, 19163.616727665438, 19202.135903884322, 3999.640032397084, 4280.72175308604, 4892.87463883307, 5107.4892510749, 5228.738563071841, 4092.85675001375, 4906.754662266891, 5888.97055514724, 5905.852353691149, 6025.307089684698, 4989.0, 5754.712264386785, 6576.736930522773, 6589.472842172639, 6606.735730570771, 5988.401159884021, 5998.340182579913, 6522.510811689119, 6562.245341785708, 6594.142761441006, 4550.863474095782, 5758.078707406795, 5767.855803604902, 5776.740046697867, 5795.797147099831, 18434.354797582153, 23698.644520332207, 23700.525989480113, 24115.51768964611, 24132.0, 2072.9378118656464, 2082.5730725201297, 2119.194706011706, 2138.807507324348, 2670.8263962842548, 9453.149216570542, 9590.568424420917, 9761.609535618567, 9764.902350976541, 9900.950495247549, 1774.4587900690285, 1776.8194931073363, 1779.164340961648, 1780.0565700178927, 1794.5423916901236, 84630.15369846285, 95159.09681806395, 96223.0, 96568.0, 97720.0, 10885.83671244932, 11213.551457941754, 11245.0, 11315.434228288552, 11325.603603873826, 13509.392077356542, 13592.184468931895, 13602.795958060637, 13629.727405452033, 13665.248411337472, 7231.168415632164, 8261.38039647029, 8459.873101903477, 8533.786655333543, 8570.228679418757, 8617.224449799549, 8617.784555386166, 8664.09027052163, 8723.694670686495, 8726.825463490695, 3976.0457490202143, 4154.750714957112, 4172.874813755531, 4328.220920234388, 4447.310666846644, 1682.175733890385, 1845.8800177988655, 1901.0684764465313, 1927.0653732939513, 1958.1286327584373, 884.3014018925106, 926.1849572376266, 947.346331031586, 989.5942663507927, 1076.3864597179534, 18311.267549297878, 18425.447236582924, 18498.907505462386, 19210.80789192118, 20241.493962651053, 879.6481407436949, 914.7027216154777, 987.1362557761959, 1027.7604879870535, 1048.3028785857318, 10353.0, 10631.52158152885, 10655.680329590125, 10680.412577308167, 10744.838827417596, 614857.0, 627411.0, 636908.0, 761716.0, 767416.0, 73739.63130184422, 107180.46409767901, 107405.0, 110323.0, 115355.0, 947.7772723409993, 1149.040551139791, 1204.8132539456399, 1237.3256575166736, 1240.9193402428814, 14688.485902993343, 17406.39077632277, 17667.469975900745, 17986.820131798515, 18250.452486425427, 26136.8693156533, 48586.27120593123, 49643.75178124086, 50202.74898625483, 50591.0, 51812.48187518077, 68280.0, 68752.6562367185, 69687.3031269701, 71650.64174679093, 6471.514636402195, 7515.210902855121, 7658.73194438192, 7742.419318551244, 7752.341051010727, 8200.466969646954, 10511.18622562784, 11195.38425386579, 11382.260153090023, 11859.466324015613, 8431.620577073923, 9551.952240239032, 9973.304538228373, 10172.542235599267, 10531.736706582396, 6340.651264180515, 6909.343612356818, 7109.933509973545, 7698.114716807639, 7708.922910771045, 7807.6096195188875, 7962.880556791769, 8008.69237333546, 8012.31895288907, 8056.274935255855, 10111.797764044532, 10725.41010244444, 10750.784984300426, 10801.0, 11228.326300422, 9107.726768196964, 10971.01260886524, 11010.669679909615, 11107.44462776874, 11174.776504469703], "unit": "score", "name": "jquery.html", "value": 8960.393393750152}, {"lowerIsBetter": false, "replicates": [1538.484607656435, 1541.868941140003, 1762.7355896615497, 1771.4774141628227, 1799.7930238022632, 7777.805554861125, 7875.527468351888, 7986.201379862011, 8712.303015758733, 8716.433431826934, 7163.283671632834, 8265.83468330633, 8368.539730314831, 8500.91499085009, 8526.317894568436, 2438.975610243897, 2471.4192164841247, 2473.530029294437, 2473.727889932106, 2475.9133430329944, 2424.9272521824373, 2463.3964678653665, 2466.0382450844186, 2479.0827393864297, 2481.0944005437977, 2455.9631605525933, 2458.7172475165407, 2475.0718480569785, 2477.7770000699934, 2479.590867506859, 2447.437089469423, 2461.1755062054144, 2473.789727873133, 2483.1309041835393, 2489.153687746175, 2027.614753196888, 2399.8560086394696, 2400.387901085212, 2401.891914863835, 2449.5590793657134, 7433.219511951275, 8626.611802468904, 8665.480071195685, 8702.129787021311, 8748.912510874874, 5323.174907889244, 5425.755840987165, 5451.100568406208, 5452.536534394581, 5478.808241711561, 3602.67575918166, 3646.3072016316814, 3731.0485826114436, 3739.158689294914, 3769.4722738816586, 1047.6804574604741, 1078.14826287233, 1080.6487891435315, 1090.2477290669412, 1106.4744246482937, 11241.213115081948, 11464.968152866199, 11521.07831373488, 11536.192466527347, 11625.534978600761, 4866.416030076413, 4877.756112194376, 4880.877978050577, 4884.8290309838985, 4893.828715994923, 9089.091090890857, 9294.86057709135, 9843.507824608741, 9945.15466185368, 9952.751181220527, 5396.83809485716, 5402.37872644643, 5406.810761623325, 5414.106672399089, 5431.918521222185, 4425.203463376559, 4544.886377840514, 4814.15752243363, 4849.539293767087, 4922.237053256751, 3891.902702432405, 3905.511811023622, 3928.744631598994, 3950.249452603996, 3957.703172262092, 1325.3307079924577, 1326.6815964168723, 1328.3756634381825, 1330.2949436798513, 1332.060897067565, 1101.0090918173707, 1120.4509790202742, 1346.0510340210128, 1363.222962911151, 1381.3093453273364, 7932.048154221415, 8094.797630059295, 8111.067227268822, 8114.026316841899, 8141.755747327589, 512.9769160387791, 523.6648544931247, 527.2434057128033, 531.1369025333832, 532.5819231902938, 5143.228515722672, 6107.633541987495, 6117.0, 6182.845428864314, 6194.659293738888, 7777.922220777833, 10369.481525923673, 10481.266311358284, 10533.367997919997, 10549.84175237372, 8517.679759637265, 9983.550740216708, 10375.325603835727, 10417.5832966682, 10439.0, 8236.670533178605, 8242.546659933761, 8352.457090289112, 8372.623231954576, 8393.790155246168, 7768.184340644151, 7950.284474397101, 8021.0, 8057.0, 8129.024517057991, 9223.953880230556, 9274.629014839331, 9276.536173191178, 9363.672271470467, 9435.905640943503, 9272.675456358995, 9537.189338905993, 9584.9041509584, 9605.03949605034, 9646.938836727813, 6769.661516924036, 6926.44588432914, 7179.784606461814, 7321.816954575965, 7465.552066876005, 7933.484323518953, 7963.641636126504, 7968.163342848918, 7996.720114795954, 8017.078036025931, 7364.41084713211, 7461.813454663677, 7525.623718813928, 7635.732749353746, 7661.88507172404, 6360.713767880549, 7324.81687957784, 7434.070741157356, 7440.3675687567165, 7447.92552074494, 7512.0, 7529.472936894584, 7550.509216900884, 7586.886196707164, 7589.165191828784, 6865.450763938973, 6981.650917454209, 6993.405560527209, 7023.438124949889, 7028.789136325919, 7066.116735408074, 7095.716171353088, 7107.0, 7141.143062832286, 7145.535540189871], "unit": "score", "name": "mootools.html", "value": 4774.573164567976}, {"lowerIsBetter": false, "replicates": [267.55452172133397, 328.8980416071018, 333.0674112485042, 338.3334830384142, 339.0506581571599, 6675.866482670343, 6806.591604503721, 6810.795676129718, 6860.794176174716, 6965.930340696592, 5895.938731028424, 6603.504737144709, 6682.231543372513, 6842.21314548827, 6898.551594146377, 5068.493150684921, 5070.847874563759, 5077.263796749469, 5077.41609714882, 5081.644284900059, 4932.408111026682, 5079.212722028092, 5086.872828179288, 5100.0, 5107.361579802525, 4977.203647416414, 4993.825216117437, 5009.474005229453, 5011.173156429203, 5011.799528018875, 4064.878053658395, 4990.700557966516, 5016.8996620067755, 5016.971520838256, 5022.673526220784, 4089.754614723126, 4179.1432756284885, 4191.937120943188, 4287.764172970486, 4299.50555686097, 6422.133012043361, 6451.387118223761, 6459.35286501939, 6517.739290428377, 6522.380373864476, 5887.322957859816, 5894.233749612566, 5907.645541267538, 5914.083317085859, 5918.792842250544, 7004.739146953546, 7255.927440725578, 7277.3814225790875, 7284.635768211569, 7291.5989620570845, 4751.14479393709, 4754.286856971447, 4755.9286610700865, 4756.120117778188, 4767.308740232646, 7673.194314596999, 7695.345895598881, 7704.3451306639, 7704.61157041319, 7705.614719264015, 4733.786979585927, 4812.422509298906, 4844.128056949783, 4846.5153484651255, 4849.95150048495, 4959.404871415453, 4968.90062198754, 4978.6763860348965, 4985.925211121836, 4988.401391833003, 5872.383399743051, 5895.587308888423, 5902.173695682608, 5906.497947674496, 5916.053431451033, 5633.464820842013, 6142.6314421134875, 6425.618492024238, 7387.261273872569, 7391.0, 1531.663034132489, 1593.8406159384201, 1679.8236185200378, 1683.1079527850259, 1684.5620138763763, 1060.3372891942536, 1071.2287153249647, 1081.6592773276393, 1087.3367245979946, 1087.374759513283, 5481.862953426196, 5547.472990065938, 6724.025016372696, 6748.089007983859, 6749.831254218684, 7545.170031296553, 7565.356944659766, 7589.810254743566, 7590.0, 7594.734184303523, 6549.148610680581, 6708.664566771642, 6719.0, 6720.630365329856, 6723.562968407038, 3906.4140378943384, 3980.960190398059, 3995.1210733638554, 3999.5200575931076, 4007.3788562772816, 7907.644156012993, 8080.8383832323025, 8096.919030809617, 8099.149589293157, 8122.309603683635, 7950.045994480699, 7954.2841144296135, 7976.601169941479, 7978.242067003625, 7982.800429989296, 7828.2954534092205, 8094.878576821352, 8096.149904259968, 8099.473534220257, 8117.918820811835, 7659.119201291923, 7662.961685191538, 7663.616819159131, 7676.193999629959, 7676.3091321779075, 6116.204893363834, 7277.59973201479, 7508.061492313461, 7540.585267810323, 7559.886601700869, 6504.869902602016, 7729.806754831175, 7973.681052757825, 7980.561069141253, 8107.513549187068, 4756.357891684578, 4794.880127996688, 4804.975975120102, 4814.807407703653, 4824.204006339055, 6892.86267765813, 7203.171635261802, 7694.653740581575, 7699.692012319669, 7711.652975616223, 7382.889256661262, 7400.185979542139, 7408.259174082548, 7415.8887616684715, 7440.55356678601, 7377.299156580117, 7390.704371825282, 7404.296591823768, 7407.888881666887, 7435.8141046474275, 6908.861822763617, 7128.180259270251, 7228.49400541957, 7229.0, 7258.564486130849, 7386.519876208029, 7397.741079062207, 7406.296401841816, 7414.295641914009, 7417.703291868264, 7041.155061392666, 7230.42156627458, 7239.131304243314, 7256.818579535554, 7263.237360077116], "unit": "score", "name": "prototype.html", "value": 5312.5122534566335}, {"lowerIsBetter": false, "replicates": [646.4085361893865, 649.6264647827494, 678.2064983968758, 725.4377857160699, 734.9853002939941, 14869.702605947889, 14891.0, 15161.938664293504, 15228.77156842647, 17148.314067437317, 15536.456224032161, 15897.364105435769, 16073.196340183002, 16078.839211607881, 16095.758563621555, 698.8672152291074, 706.9925356367182, 864.416518849777, 876.5003947749785, 877.2674816528206, 701.7193122750915, 851.2551517422255, 865.5326123893091, 879.0330636300051, 880.3529405886668, 880.8194320164383, 914.0128661046055, 914.9862752058724, 914.9908500914972, 916.0930678628143, 897.161154320709, 897.4166791585457, 906.428949761646, 908.0, 909.822584596004, 524.6117872774158, 594.088074805172, 641.371455973149, 670.1187937861696, 674.8818956682561, 12494.375281235902, 14878.70242595142, 14992.950493465461, 15125.243737813176, 15132.546023619308, 12462.756703793313, 12651.93674031624, 12702.666220046855, 12802.551910683174, 13268.668283292898, 8100.311473524757, 10257.846132308021, 10364.11904988077, 10664.0, 11327.0, 3444.48332750087, 3532.5937517185594, 3588.6231945645854, 3649.9270014599824, 3713.8885833425043, 76641.61679191624, 77290.0, 77351.99999999943, 77421.0, 77530.22469775287, 9419.492881138985, 9527.761805954906, 9536.2371010319, 9789.412635241908, 10131.341462804894, 20431.693524596845, 20652.0, 20681.0, 20702.757834529977, 20725.58548829015, 7360.595167265852, 7424.665890034961, 7463.029806125169, 7660.846783064308, 7784.571848548384, 4214.662826973835, 4236.597523235288, 4240.554741752072, 4247.193033323659, 4251.17102165081, 3571.5535558055244, 3601.6218297078954, 3611.819409029538, 3613.0244833894703, 3626.401643728808, 580.4601720399984, 587.8089620873147, 595.487880422836, 628.3245511075612, 664.5315052887703, 519.1356391607931, 594.3551246897078, 598.9011813050798, 614.8063360041573, 618.4186864347499, 8354.958225208835, 8626.741197764077, 8717.651293948298, 8727.825443491221, 8823.294136469067, 507.87049302427647, 577.7429044075346, 597.3876776304236, 628.8522197283635, 634.4416913116428, 4015.3374693175297, 4047.1905618876344, 4079.3676980068135, 4148.191102734938, 4361.563843615613, 85854.57072714597, 87518.24963500694, 94068.0, 94875.52562237145, 95837.5208123955, 67334.66332668305, 77683.61158194173, 81846.59076704578, 82631.0, 82843.343133137, 71796.64101679459, 72709.0, 73133.26866731264, 73621.6318918402, 74464.62767686235, 8867.73396798097, 9054.909450905407, 9082.954585227031, 9129.5891684873, 9246.260299176185, 43043.7847810759, 50432.24351634802, 50825.729356764896, 51454.0, 52667.20999185092, 68710.65644671745, 70751.64624176847, 70904.0, 71277.0, 71844.56310873858, 10718.088962437969, 11048.944755276172, 11071.280366776135, 11228.494717737558, 11899.464524096264, 11132.833007504732, 11267.309903514539, 11961.342126183143, 11990.340531270864, 12239.816402754144, 9976.401415915068, 11298.152638552307, 11311.773764524827, 11734.94132529332, 11778.175527712978, 11367.090632749194, 11634.127440441831, 11671.12466565028, 11684.240524365889, 12252.87747122553, 9335.789510270888, 10394.428306443218, 11222.214444988773, 11307.321560706385, 12123.151379403356, 9235.1688348049, 9239.491827949527, 9319.114684105, 9836.409815411098, 10198.490075496047, 9018.549072546215, 9087.091710740555, 9518.619255229713, 9802.26483013791, 10127.442990635585], "unit": "score", "name": "yui.html", "value": 6893.377471105526}], "name": "dromaeo_css", "value": 7466.513930966979}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 105.0, 114.0, 113.0, 115.0, 126.0, 112.0, 111.0, 116.0, 96.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [159.0, 120.0, 151.0, 155.0, 124.0, 142.0, 126.0, 200.0, 184.0, 143.0], "unit": "score", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [194.0, 199.0, 200.0, 194.0, 212.0, 273.0, 272.0, 201.0, 196.0, 198.0], "unit": "score", "name": "audio-dft", "value": 213.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 105.0, 57.0, 63.0, 83.0, 86.0, 140.0, 58.0], "unit": "score", "name": "audio-fft", "value": 79.3}, {"lowerIsBetter": true, "replicates": [82.0, 89.0, 115.0, 76.0, 81.0, 80.0, 104.0, 83.0, 115.0, 152.0], "unit": "score", "name": "audio-oscillator", "value": 97.7}, {"lowerIsBetter": true, "replicates": [86.0, 93.0, 87.0, 93.0, 87.0, 93.0, 85.0, 94.0, 88.0, 134.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 94.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 95.0, 97.0, 95.0, 119.0, 95.0, 154.0, 134.0], "unit": "score", "name": "imaging-darkroom", "value": 107.7}, {"lowerIsBetter": true, "replicates": [92.0, 96.0, 121.0, 92.0, 141.0, 150.0, 120.0, 94.0, 92.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 108.8}, {"lowerIsBetter": true, "replicates": [56.0, 57.0, 54.0, 55.0, 55.0, 56.0, 56.0, 64.0, 57.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 56.3}, {"lowerIsBetter": true, "replicates": [65.0, 67.0, 84.0, 101.0, 63.0, 65.0, 63.0, 65.0, 67.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.7}, {"lowerIsBetter": true, "replicates": [85.0, 86.0, 85.0, 84.0, 81.0, 85.0, 83.0, 87.0, 87.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [131.0, 135.0, 125.0, 123.0, 120.0, 124.0, 125.0, 121.0, 129.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [135.0, 141.0, 142.0, 181.0, 142.0, 113.0, 131.0, 152.0, 181.0, 170.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 66.0, 68.0, 65.0, 67.0, 70.0, 65.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.2}], "name": "kraken", "value": 1517.6999999999998}]} 20:09:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1517.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7466.51"}}} 20:09:04 INFO - Return code: 0 20:09:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:09:04 INFO - # TBPL SUCCESS # 20:09:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:09:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:09:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:09:04 INFO - 2016-01-31 20:09:04.753 screenresolution[2002:15767] starting screenresolution argv=screenresolution get 20:09:04 INFO - 2016-01-31 20:09:04.755 screenresolution[2002:15767] Display 0: 1600x1200x32@60 20:09:04 INFO - 2016-01-31 20:09:04.760 screenresolution[2003:15770] starting screenresolution argv=screenresolution list 20:09:04 INFO - Available Modes on Display 0 20:09:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:09:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:09:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:09:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:09:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:09:04 INFO - Intel Iris: 20:09:04 INFO - Chipset Model: Intel Iris 20:09:04 INFO - Type: GPU 20:09:04 INFO - Bus: Built-In 20:09:04 INFO - VRAM (Dynamic, Max): 1536 MB 20:09:04 INFO - Vendor: Intel (0x8086) 20:09:04 INFO - Device ID: 0x0a2e 20:09:04 INFO - Revision ID: 0x0009 20:09:04 INFO - Displays: 20:09:04 INFO - Display: 20:09:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:09:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:09:04 INFO - Display Serial Number: 1600x1200 60 20:09:04 INFO - Main Display: Yes 20:09:04 INFO - Mirror: Off 20:09:04 INFO - Online: Yes 20:09:04 INFO - Rotation: Supported 20:09:04 INFO - Return code: 0 20:09:04 INFO - Running post-action listener: _resource_record_post_action 20:09:04 INFO - Running post-run listener: _resource_record_post_run 20:09:06 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 2375680; Write bytes: 710235136; Read time: 39; Write time: 2037 20:09:06 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 382323200; Write bytes: 376603136; Read time: 28560; Write time: 714 20:09:06 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 2375680; Write bytes: 303038976; Read time: 39; Write time: 1266 20:09:06 INFO - Running post-run listener: _upload_blobber_files 20:09:06 INFO - Blob upload gear active. 20:09:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:09:06 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 20:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:09:06 INFO - (blobuploader) - INFO - Open directory for files ... 20:09:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:09:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:09:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:09:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:09:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:09:07 INFO - (blobuploader) - INFO - Done attempting. 20:09:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:09:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:09:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:09:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:09:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:09:08 INFO - (blobuploader) - INFO - Done attempting. 20:09:08 INFO - (blobuploader) - INFO - Iteration through files over. 20:09:08 INFO - Return code: 0 20:09:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:09:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:09:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c37ad42ceefc7e099c9d05084d808e6b213906510bea82e673ed2d9be1e3fa8e22452808b5755bb99b25178d9423ef3ce90ff43474835b976f87db5d738b212c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a48ee3b05c616a30385b6a06b22a56d536d4cc42211b3916f27c52cae03832499381d0d7038c6e4d9891a10cb6d631f17b35adb1c73a55e79c0a52f33e50c760"} 20:09:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:09:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:09:08 INFO - Contents: 20:09:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c37ad42ceefc7e099c9d05084d808e6b213906510bea82e673ed2d9be1e3fa8e22452808b5755bb99b25178d9423ef3ce90ff43474835b976f87db5d738b212c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a48ee3b05c616a30385b6a06b22a56d536d4cc42211b3916f27c52cae03832499381d0d7038c6e4d9891a10cb6d631f17b35adb1c73a55e79c0a52f33e50c760"} 20:09:08 INFO - Running post-run listener: copy_logs_to_upload_dir 20:09:08 INFO - Copying logs to upload dir... 20:09:08 INFO - mkdir: /builds/slave/test/build/upload/logs 20:09:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1341.440425 ========= master_lag: 0.94 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 22 secs) (at 2016-01-31 20:09:09.194171) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-31 20:09:09.195346) ========= 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.9rVd9wyDbm/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.rArCJu6COk/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c37ad42ceefc7e099c9d05084d808e6b213906510bea82e673ed2d9be1e3fa8e22452808b5755bb99b25178d9423ef3ce90ff43474835b976f87db5d738b212c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a48ee3b05c616a30385b6a06b22a56d536d4cc42211b3916f27c52cae03832499381d0d7038c6e4d9891a10cb6d631f17b35adb1c73a55e79c0a52f33e50c760"} build_url:https://queue.taskcluster.net/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010596 build_url: 'https://queue.taskcluster.net/v1/task/SgjrFv9mTOSkPi_LegjmmA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c37ad42ceefc7e099c9d05084d808e6b213906510bea82e673ed2d9be1e3fa8e22452808b5755bb99b25178d9423ef3ce90ff43474835b976f87db5d738b212c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a48ee3b05c616a30385b6a06b22a56d536d4cc42211b3916f27c52cae03832499381d0d7038c6e4d9891a10cb6d631f17b35adb1c73a55e79c0a52f33e50c760"}' ========= master_lag: 0.99 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-31 20:09:10.193984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 20:09:10.194272) ========= 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.9rVd9wyDbm/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.rArCJu6COk/Listeners TMPDIR=/var/folders/yj/320nlnz57612b6dr2b3zmv8c00000w/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.005306 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-31 20:09:10.249328) ========= ========= Started reboot skipped (results: 3, elapsed: 4 secs) (at 2016-01-31 20:09:10.249630) ========= ========= Finished reboot skipped (results: 3, elapsed: 4 secs) (at 2016-01-31 20:09:14.940379) ========= ========= Total master_lag: 2.48 =========