builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0081 starttime: 1493743637.37 results: success (0) buildid: 20170502080721 builduid: db67a1ffd09f4f0fae36e212b9e7e1c1 revision: bfc7b187005cabbc828ed9f5b61daf139c3cfd90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:17.368507) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:17.368943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:17.369212) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:17.395877) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:17.396212) ========= 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.BllhYNqU7i/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.8q3jxm0YqO/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 --2017-05-02 09:47:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.83M=0.001s 2017-05-02 09:47:17 (8.83 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097982 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:17.519648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:17.519970) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BllhYNqU7i/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.8q3jxm0YqO/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.029994 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:17.572120) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:17.572480) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev bfc7b187005cabbc828ed9f5b61daf139c3cfd90 --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 bfc7b187005cabbc828ed9f5b61daf139c3cfd90 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.BllhYNqU7i/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.8q3jxm0YqO/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 2017-05-02 09:47:17,622 truncating revision to first 12 chars 2017-05-02 09:47:17,622 Setting DEBUG logging. 2017-05-02 09:47:17,622 attempt 1/10 2017-05-02 09:47:17,622 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/bfc7b187005c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-02 09:47:18,324 unpacking tar archive at: mozilla-central-bfc7b187005c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.975173 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:18.572027) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:18.572447) ========= script_repo_revision: bfc7b187005cabbc828ed9f5b61daf139c3cfd90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:18.572838) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:18.573195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-02 09:47:18.593733) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-05-02 09:47:18.594023) ========= /tools/buildbot/bin/python -u 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', '-u', '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.BllhYNqU7i/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.8q3jxm0YqO/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 09:47:18 INFO - MultiFileLogger online at 20170502 09:47:18 in /builds/slave/test 09:47:18 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 09:47:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:47:18 INFO - {'append_to_log': False, 09:47:18 INFO - 'base_work_dir': '/builds/slave/test', 09:47:18 INFO - 'blob_upload_branch': 'Firefox', 09:47:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:47:18 INFO - 'branch': 'Firefox', 09:47:18 INFO - 'buildbot_json_path': 'buildprops.json', 09:47:18 INFO - 'config_files': ('talos/mac_config.py',), 09:47:18 INFO - 'default_actions': ('clobber', 09:47:18 INFO - 'read-buildbot-config', 09:47:18 INFO - 'download-and-extract', 09:47:18 INFO - 'populate-webroot', 09:47:18 INFO - 'create-virtualenv', 09:47:18 INFO - 'install', 09:47:18 INFO - 'run-tests'), 09:47:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:47:18 INFO - 'download_minidump_stackwalk': True, 09:47:18 INFO - 'download_symbols': 'ondemand', 09:47:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:47:18 INFO - 'tooltool.py': '/tools/tooltool.py', 09:47:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:47:18 INFO - '/tools/misc-python/virtualenv.py')}, 09:47:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:47:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:47:18 INFO - 'gecko_profile': False, 09:47:18 INFO - 'gecko_profile_interval': 0, 09:47:18 INFO - 'installer_path': 'installer.exe', 09:47:18 INFO - 'log_level': 'info', 09:47:18 INFO - 'log_name': 'talos', 09:47:18 INFO - 'log_to_console': True, 09:47:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:47:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:47:18 INFO - 'opt_config_files': (), 09:47:18 INFO - 'pip_index': False, 09:47:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:47:18 INFO - 'cmd': ('bash', 09:47:18 INFO - '-c', 09:47:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:47:18 INFO - 'enabled': True, 09:47:18 INFO - 'halt_on_failure': False, 09:47:18 INFO - 'name': 'check_screen_resolution'},), 09:47:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:47:18 INFO - 'cmd': ('bash', 09:47:18 INFO - '-c', 09:47:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:47:18 INFO - 'enabled': True, 09:47:18 INFO - 'halt_on_failure': False, 09:47:18 INFO - 'name': 'check_screen_resolution'},), 09:47:18 INFO - 'run_cmd_checks_enabled': True, 09:47:18 INFO - 'suite': 'dromaeojs-e10s', 09:47:18 INFO - 'system_bits': '32', 09:47:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:47:18 INFO - 'title': 't-yosemite-r7-0081', 09:47:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:47:18 INFO - 'use_talos_json': True, 09:47:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:47:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:47:18 INFO - 'work_dir': 'build'} 09:47:18 INFO - [mozharness: 2017-05-02 16:47:18.756063Z] Running clobber step. 09:47:18 INFO - Running pre-action listener: _resource_record_pre_action 09:47:18 INFO - Running main action method: clobber 09:47:18 INFO - rmtree: /builds/slave/test/build 09:47:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:47:21 INFO - Running post-action listener: _resource_record_post_action 09:47:21 INFO - [mozharness: 2017-05-02 16:47:21.297319Z] Finished clobber step (success) 09:47:21 INFO - [mozharness: 2017-05-02 16:47:21.297443Z] Running read-buildbot-config step. 09:47:21 INFO - Running pre-action listener: _resource_record_pre_action 09:47:21 INFO - Running main action method: read_buildbot_config 09:47:21 INFO - Using buildbot properties: 09:47:21 INFO - { 09:47:21 INFO - "project": "", 09:47:21 INFO - "product": "firefox", 09:47:21 INFO - "script_repo_revision": "production", 09:47:21 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:47:21 INFO - "repository": "", 09:47:21 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:47:21 INFO - "buildid": "20170502080721", 09:47:21 INFO - "pgo_build": "False", 09:47:21 INFO - "basedir": "/builds/slave/test", 09:47:21 INFO - "buildnumber": 59, 09:47:21 INFO - "slavename": "t-yosemite-r7-0081", 09:47:21 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:47:21 INFO - "platform": "yosemite_r7", 09:47:21 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:47:21 INFO - "branch": "mozilla-central", 09:47:21 INFO - "repo_path": "mozilla-central", 09:47:21 INFO - "revision": "bfc7b187005cabbc828ed9f5b61daf139c3cfd90", 09:47:21 INFO - "stage_platform": "macosx64", 09:47:21 INFO - "builduid": "db67a1ffd09f4f0fae36e212b9e7e1c1", 09:47:21 INFO - "slavebuilddir": "test" 09:47:21 INFO - } 09:47:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:47:21 INFO - Running post-action listener: _resource_record_post_action 09:47:21 INFO - [mozharness: 2017-05-02 16:47:21.300504Z] Finished read-buildbot-config step (success) 09:47:21 INFO - [mozharness: 2017-05-02 16:47:21.300636Z] Running download-and-extract step. 09:47:21 INFO - Running pre-action listener: _resource_record_pre_action 09:47:21 INFO - Running main action method: download_and_extract 09:47:21 INFO - mkdir: /builds/slave/test/build/tests 09:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:47:21 INFO - trying https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:47:21 INFO - Downloading https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:47:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 09:47:22 INFO - Downloaded 1325 bytes. 09:47:22 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:47:22 INFO - Using the following test package requirements: 09:47:22 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:47:22 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:47:22 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:47:22 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:47:22 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:47:22 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:47:22 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:47:22 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:47:22 INFO - u'jsshell-mac.zip'], 09:47:22 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:47:22 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:47:22 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:47:22 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:47:22 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:47:22 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:47:22 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:47:22 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:47:22 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:47:22 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:47:22 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:47:22 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:47:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:47:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:47:22 INFO - Fetch https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:47:24 INFO - Content-Length response header: 52699504 09:47:24 INFO - Bytes received: 52699504 09:47:40 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 09:47:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:47:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:47:40 INFO - Fetch https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:47:42 INFO - Content-Length response header: 52699504 09:47:42 INFO - Bytes received: 52699504 09:47:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:47:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:47:58 INFO - Fetch https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:48:00 INFO - Content-Length response header: 14408811 09:48:00 INFO - Bytes received: 14408811 09:48:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:00 INFO - trying https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:48:00 INFO - Downloading https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:48:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 09:48:02 INFO - Downloaded 71246927 bytes. 09:48:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:48:02 INFO - mkdir: /builds/slave/test/properties 09:48:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:48:02 INFO - Writing to file /builds/slave/test/properties/build_url 09:48:02 INFO - Contents: 09:48:02 INFO - build_url:https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:48:03 INFO - Running post-action listener: _resource_record_post_action 09:48:03 INFO - Running post-action listener: set_extra_try_arguments 09:48:03 INFO - [mozharness: 2017-05-02 16:48:03.229310Z] Finished download-and-extract step (success) 09:48:03 INFO - [mozharness: 2017-05-02 16:48:03.229451Z] Running populate-webroot step. 09:48:03 INFO - Running pre-action listener: _resource_record_pre_action 09:48:03 INFO - Running main action method: populate_webroot 09:48:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:48:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:48:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:48:03 INFO - '--tppagecycles', 09:48:03 INFO - '7'], 09:48:03 INFO - 'tests': ['tsvgm']}}, 09:48:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:48:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:48:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:48:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:48:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:48:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:48:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:48:03 INFO - 'talos_options': ['--disable-e10s'], 09:48:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:48:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:48:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:48:03 INFO - 'talos_options': ['--disable-e10s'], 09:48:03 INFO - 'tests': ['damp', 'tps']}, 09:48:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:48:03 INFO - 'tests': ['damp', 'tps']}, 09:48:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:48:03 INFO - 'tests': ['dromaeo_dom']}, 09:48:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:48:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:48:03 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:48:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:48:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:48:03 INFO - 'tests': ['a11yr', 09:48:03 INFO - 'ts_paint', 09:48:03 INFO - 'tpaint', 09:48:03 INFO - 'sessionrestore', 09:48:03 INFO - 'sessionrestore_no_auto_restore', 09:48:03 INFO - 'tabpaint']}, 09:48:03 INFO - 'other-e10s': {'tests': ['a11yr', 09:48:03 INFO - 'ts_paint', 09:48:03 INFO - 'tpaint', 09:48:03 INFO - 'sessionrestore', 09:48:03 INFO - 'sessionrestore_no_auto_restore', 09:48:03 INFO - 'tabpaint']}, 09:48:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:48:03 INFO - 'ts_paint', 09:48:03 INFO - 'tpaint', 09:48:03 INFO - 'sessionrestore', 09:48:03 INFO - 'sessionrestore_no_auto_restore', 09:48:03 INFO - 'tabpaint']}, 09:48:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:48:03 INFO - 'ts_paint', 09:48:03 INFO - 'tpaint', 09:48:03 INFO - 'sessionrestore', 09:48:03 INFO - 'sessionrestore_no_auto_restore', 09:48:03 INFO - 'tabpaint']}, 09:48:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:48:03 INFO - 'tests': ['a11yr', 09:48:03 INFO - 'ts_paint', 09:48:03 INFO - 'tpaint', 09:48:03 INFO - 'sessionrestore', 09:48:03 INFO - 'sessionrestore_no_auto_restore', 09:48:03 INFO - 'tabpaint']}, 09:48:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:48:03 INFO - 'tests': ['a11yr', 09:48:03 INFO - 'ts_paint', 09:48:03 INFO - 'tpaint', 09:48:03 INFO - 'sessionrestore', 09:48:03 INFO - 'sessionrestore_no_auto_restore', 09:48:03 INFO - 'tabpaint']}, 09:48:03 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:48:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:48:03 INFO - 'bloom_basic_ref']}, 09:48:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:48:03 INFO - 'tests': ['tsvgx', 09:48:03 INFO - 'tsvgr_opacity', 09:48:03 INFO - 'tart', 09:48:03 INFO - 'tscrollx', 09:48:03 INFO - 'cart', 09:48:03 INFO - 'tsvg_static']}, 09:48:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:48:03 INFO - 'tsvgr_opacity', 09:48:03 INFO - 'tart', 09:48:03 INFO - 'tscrollx', 09:48:03 INFO - 'cart', 09:48:03 INFO - 'tsvg_static']}, 09:48:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:48:03 INFO - 'talos_options': ['--disable-e10s'], 09:48:03 INFO - 'tests': ['tp5o']}, 09:48:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:48:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:48:03 INFO - 'talos_options': ['--disable-e10s', 09:48:03 INFO - '--xperf_path', 09:48:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:03 INFO - 'tests': ['tp5n']}, 09:48:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:48:03 INFO - 'talos_options': ['--xperf_path', 09:48:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:48:03 INFO - 'tests': ['tp5n']}}, 09:48:03 INFO - 'talos.zip': {'path': '', 09:48:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:48:03 INFO - Running post-action listener: _resource_record_post_action 09:48:03 INFO - [mozharness: 2017-05-02 16:48:03.248571Z] Finished populate-webroot step (success) 09:48:03 INFO - [mozharness: 2017-05-02 16:48:03.248698Z] Running create-virtualenv step. 09:48:03 INFO - Running pre-action listener: _resource_record_pre_action 09:48:03 INFO - Running main action method: create_virtualenv 09:48:03 INFO - Creating virtualenv /builds/slave/test/build/venv 09:48:03 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 09:48:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:48:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:48:03 INFO - Using real prefix '/tools/python27' 09:48:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:48:04 INFO - Installing distribute.............................................................................................................................................................................................done. 09:48:06 INFO - Installing pip.................done. 09:48:06 INFO - Return code: 0 09:48:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:48:07 INFO - Reading from file tmpfile_stdout 09:48:07 INFO - Output received: 09:48:07 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:48:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d225b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d228768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8900d626f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d003d30>, '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 0x10cf29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cff8be8>, '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.BllhYNqU7i/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.8q3jxm0YqO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 09:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:48:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BllhYNqU7i/Render', 09:48:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:07 INFO - 'HOME': '/Users/cltbld', 09:48:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:07 INFO - 'LOGNAME': 'cltbld', 09:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:07 INFO - 'MOZ_NO_REMOTE': '1', 09:48:07 INFO - 'NO_EM_RESTART': '1', 09:48:07 INFO - 'PAGER': '/bin/cat', 09:48:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:07 INFO - 'PWD': '/builds/slave/test', 09:48:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:07 INFO - 'SHELL': '/bin/bash', 09:48:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8q3jxm0YqO/Listeners', 09:48:07 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 09:48:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:07 INFO - 'USER': 'cltbld', 09:48:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:07 INFO - 'XPC_FLAGS': '0x0', 09:48:07 INFO - 'XPC_SERVICE_NAME': '0', 09:48:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:07 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 09:48:07 INFO - Cleaning up... 09:48:07 INFO - Return code: 0 09:48:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d225b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d228768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8900d626f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d003d30>, '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 0x10cf29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cff8be8>, '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.BllhYNqU7i/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.8q3jxm0YqO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 09:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:48:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BllhYNqU7i/Render', 09:48:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:07 INFO - 'HOME': '/Users/cltbld', 09:48:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:07 INFO - 'LOGNAME': 'cltbld', 09:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:07 INFO - 'MOZ_NO_REMOTE': '1', 09:48:07 INFO - 'NO_EM_RESTART': '1', 09:48:07 INFO - 'PAGER': '/bin/cat', 09:48:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:07 INFO - 'PWD': '/builds/slave/test', 09:48:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:07 INFO - 'SHELL': '/bin/bash', 09:48:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8q3jxm0YqO/Listeners', 09:48:07 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 09:48:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:07 INFO - 'USER': 'cltbld', 09:48:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:07 INFO - 'XPC_FLAGS': '0x0', 09:48:07 INFO - 'XPC_SERVICE_NAME': '0', 09:48:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:07 INFO - Downloading/unpacking psutil>=3.1.1 09:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:48:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:11 INFO - Installing collected packages: psutil 09:48:11 INFO - Running setup.py install for psutil 09:48:11 INFO - building 'psutil._psutil_osx' extension 09:48:11 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 09:48:11 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 09:48:11 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 09:48:12 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 09:48:12 INFO - building 'psutil._psutil_posix' extension 09:48:12 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 09:48:12 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:48:12 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:48:12 INFO - ^ 09:48:12 INFO - 1 warning generated. 09:48:12 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 09:48:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:48:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:48:12 INFO - Successfully installed psutil 09:48:12 INFO - Cleaning up... 09:48:12 INFO - Return code: 0 09:48:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:12 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d225b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d228768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8900d626f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d003d30>, '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 0x10cf29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cff8be8>, '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.BllhYNqU7i/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.8q3jxm0YqO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 09:48:12 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.3'] in /builds/slave/test/build 09:48:12 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.3 09:48:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BllhYNqU7i/Render', 09:48:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:12 INFO - 'HOME': '/Users/cltbld', 09:48:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:12 INFO - 'LOGNAME': 'cltbld', 09:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:12 INFO - 'MOZ_NO_REMOTE': '1', 09:48:12 INFO - 'NO_EM_RESTART': '1', 09:48:12 INFO - 'PAGER': '/bin/cat', 09:48:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:12 INFO - 'PWD': '/builds/slave/test', 09:48:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:12 INFO - 'SHELL': '/bin/bash', 09:48:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8q3jxm0YqO/Listeners', 09:48:12 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 09:48:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:12 INFO - 'USER': 'cltbld', 09:48:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:12 INFO - 'XPC_FLAGS': '0x0', 09:48:12 INFO - 'XPC_SERVICE_NAME': '0', 09:48:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:48:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:48:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:48:15 INFO - Installing collected packages: mozsystemmonitor 09:48:15 INFO - Running setup.py install for mozsystemmonitor 09:48:15 INFO - Successfully installed mozsystemmonitor 09:48:15 INFO - Cleaning up... 09:48:15 INFO - Return code: 0 09:48:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:48:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:16 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:16 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d225b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d228768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8900d626f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d003d30>, '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 0x10cf29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cff8be8>, '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.BllhYNqU7i/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.8q3jxm0YqO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 09:48:16 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==2.5.1'] in /builds/slave/test/build 09:48:16 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==2.5.1 09:48:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BllhYNqU7i/Render', 09:48:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:16 INFO - 'HOME': '/Users/cltbld', 09:48:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:16 INFO - 'LOGNAME': 'cltbld', 09:48:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:16 INFO - 'MOZ_NO_REMOTE': '1', 09:48:16 INFO - 'NO_EM_RESTART': '1', 09:48:16 INFO - 'PAGER': '/bin/cat', 09:48:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:16 INFO - 'PWD': '/builds/slave/test', 09:48:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:16 INFO - 'SHELL': '/bin/bash', 09:48:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8q3jxm0YqO/Listeners', 09:48:16 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 09:48:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:16 INFO - 'USER': 'cltbld', 09:48:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:16 INFO - 'XPC_FLAGS': '0x0', 09:48:16 INFO - 'XPC_SERVICE_NAME': '0', 09:48:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:16 INFO - Downloading/unpacking jsonschema==2.5.1 09:48:16 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 09:48:16 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 09:48:16 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 09:48:16 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 09:48:16 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 09:48:16 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 09:48:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:48:19 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:48:19 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 09:48:19 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 09:48:19 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 09:48:19 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 09:48:19 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 09:48:19 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 09:48:20 INFO - Downloading functools32-3.2.3-2.tar.gz 09:48:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:48:20 INFO - warning: no files found matching '*.txt' 09:48:20 INFO - no previously-included directories found matching 'build' 09:48:20 INFO - no previously-included directories found matching 'dist' 09:48:20 INFO - no previously-included directories found matching '.git*' 09:48:20 INFO - Installing collected packages: jsonschema, functools32 09:48:20 INFO - Running setup.py install for functools32 09:48:20 INFO - warning: no files found matching '*.txt' 09:48:20 INFO - no previously-included directories found matching 'build' 09:48:20 INFO - no previously-included directories found matching 'dist' 09:48:20 INFO - no previously-included directories found matching '.git*' 09:48:20 INFO - Successfully installed jsonschema functools32 09:48:20 INFO - Cleaning up... 09:48:20 INFO - Return code: 0 09:48:20 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d225b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d228768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8900d626f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d003d30>, '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 0x10cf29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cff8be8>, '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.BllhYNqU7i/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.8q3jxm0YqO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 09:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:48:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BllhYNqU7i/Render', 09:48:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:20 INFO - 'HOME': '/Users/cltbld', 09:48:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:20 INFO - 'LOGNAME': 'cltbld', 09:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:20 INFO - 'MOZ_NO_REMOTE': '1', 09:48:20 INFO - 'NO_EM_RESTART': '1', 09:48:20 INFO - 'PAGER': '/bin/cat', 09:48:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:20 INFO - 'PWD': '/builds/slave/test', 09:48:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:20 INFO - 'SHELL': '/bin/bash', 09:48:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8q3jxm0YqO/Listeners', 09:48:20 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 09:48:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:20 INFO - 'USER': 'cltbld', 09:48:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:20 INFO - 'XPC_FLAGS': '0x0', 09:48:20 INFO - 'XPC_SERVICE_NAME': '0', 09:48:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:20 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:48:20 INFO - Cleaning up... 09:48:20 INFO - Return code: 0 09:48:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d225b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d228768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8900d626f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d003d30>, '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 0x10cf29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cff8be8>, '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.BllhYNqU7i/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.8q3jxm0YqO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 09:48:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:48:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:48:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BllhYNqU7i/Render', 09:48:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:20 INFO - 'HOME': '/Users/cltbld', 09:48:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:20 INFO - 'LOGNAME': 'cltbld', 09:48:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:20 INFO - 'MOZ_NO_REMOTE': '1', 09:48:20 INFO - 'NO_EM_RESTART': '1', 09:48:20 INFO - 'PAGER': '/bin/cat', 09:48:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:20 INFO - 'PWD': '/builds/slave/test', 09:48:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:20 INFO - 'SHELL': '/bin/bash', 09:48:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8q3jxm0YqO/Listeners', 09:48:20 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 09:48:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:20 INFO - 'USER': 'cltbld', 09:48:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:20 INFO - 'XPC_FLAGS': '0x0', 09:48:20 INFO - 'XPC_SERVICE_NAME': '0', 09:48:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:20 INFO - Downloading/unpacking blobuploader==1.2.4 09:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:23 INFO - Downloading blobuploader-1.2.4.tar.gz 09:48:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:48:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:48:23 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 09:48:23 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 09:48:23 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 09:48:23 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 09:48:23 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 09:48:23 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 09:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:48:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:24 INFO - Downloading docopt-0.6.1.tar.gz 09:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:48:24 INFO - Installing collected packages: blobuploader, requests, docopt 09:48:24 INFO - Running setup.py install for blobuploader 09:48:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:48:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:48:25 INFO - Running setup.py install for requests 09:48:25 INFO - Running setup.py install for docopt 09:48:25 INFO - Successfully installed blobuploader requests docopt 09:48:25 INFO - Cleaning up... 09:48:25 INFO - Return code: 0 09:48:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:25 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 0x10d225b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d228768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8900d626f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d003d30>, '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 0x10cf29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cff8be8>, '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.BllhYNqU7i/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.8q3jxm0YqO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 09:48:25 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 09:48:25 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 09:48:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BllhYNqU7i/Render', 09:48:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:25 INFO - 'HOME': '/Users/cltbld', 09:48:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:25 INFO - 'LOGNAME': 'cltbld', 09:48:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:25 INFO - 'MOZ_NO_REMOTE': '1', 09:48:25 INFO - 'NO_EM_RESTART': '1', 09:48:25 INFO - 'PAGER': '/bin/cat', 09:48:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:25 INFO - 'PWD': '/builds/slave/test', 09:48:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:25 INFO - 'SHELL': '/bin/bash', 09:48:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8q3jxm0YqO/Listeners', 09:48:25 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 09:48:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:25 INFO - 'USER': 'cltbld', 09:48:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:25 INFO - 'XPC_FLAGS': '0x0', 09:48:25 INFO - 'XPC_SERVICE_NAME': '0', 09:48:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:26 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-FWwHXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:26 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-QTHn2T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:26 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-XP9LcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:26 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-DZKTUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:26 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-syZyvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:26 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-ARUFaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:26 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-EZiOQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:26 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-NWHak5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:26 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-S6mDoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:26 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-O5OaQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:27 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-4kDbvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:27 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-dOgl8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:27 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-3ZRsIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:27 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-XOwM2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:27 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-hDCvvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:27 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-L7b_6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:27 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-u_A_ku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:48:27 INFO - Running setup.py install for manifestparser 09:48:27 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:48:27 INFO - Running setup.py install for mozcrash 09:48:28 INFO - Running setup.py install for mozdebug 09:48:28 INFO - Running setup.py install for mozdevice 09:48:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:48:28 INFO - Running setup.py install for mozfile 09:48:28 INFO - Running setup.py install for mozhttpd 09:48:28 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:48:28 INFO - Running setup.py install for mozinfo 09:48:28 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:48:28 INFO - Running setup.py install for mozInstall 09:48:28 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:48:28 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:48:28 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:48:28 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:48:28 INFO - Running setup.py install for mozleak 09:48:29 INFO - Running setup.py install for mozlog 09:48:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:48:29 INFO - Running setup.py install for moznetwork 09:48:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:48:29 INFO - Running setup.py install for mozprocess 09:48:29 INFO - Running setup.py install for mozprofile 09:48:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:48:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:48:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:48:29 INFO - Running setup.py install for mozrunner 09:48:29 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:48:29 INFO - Running setup.py install for mozscreenshot 09:48:30 INFO - Running setup.py install for moztest 09:48:30 INFO - Running setup.py install for mozversion 09:48:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:48:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:48:30 INFO - Cleaning up... 09:48:30 INFO - Return code: 0 09:48:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:30 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 0x10d225b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d228768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8900d626f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d003d30>, '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 0x10cf29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cff8be8>, '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.BllhYNqU7i/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.8q3jxm0YqO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 09:48:30 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 09:48:30 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 09:48:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BllhYNqU7i/Render', 09:48:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:30 INFO - 'HOME': '/Users/cltbld', 09:48:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:30 INFO - 'LOGNAME': 'cltbld', 09:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:30 INFO - 'MOZ_NO_REMOTE': '1', 09:48:30 INFO - 'NO_EM_RESTART': '1', 09:48:30 INFO - 'PAGER': '/bin/cat', 09:48:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:30 INFO - 'PWD': '/builds/slave/test', 09:48:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:30 INFO - 'SHELL': '/bin/bash', 09:48:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8q3jxm0YqO/Listeners', 09:48:30 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 09:48:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:30 INFO - 'USER': 'cltbld', 09:48:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:30 INFO - 'XPC_FLAGS': '0x0', 09:48:30 INFO - 'XPC_SERVICE_NAME': '0', 09:48:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:48:30 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-Iuh3ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:48:30 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)) 09:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:48:30 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-gvk3v3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:48:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 09:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:48:30 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-Ee3j0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:48:30 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)) 09:48:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:48:30 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-VnPW7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 09:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:48:31 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-RRpzZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:48:31 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)) 09:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:48:31 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-0cb2hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:48:31 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)) 09:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:48:31 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-_OGWo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:48:31 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)) 09:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:48:31 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-gHnkhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:48:31 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)) 09:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:48:31 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-Gh9ka5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:48:31 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)) 09:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:48:31 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-MM0yrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 09:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:48:31 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-ctlELZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:48:31 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)) 09:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:48:31 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-wj6Ryj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 09:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:48:31 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-mYn2CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:48:31 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)) 09:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:48:31 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-k2Croz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 09:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:32 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-403fz1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:48:32 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)) 09:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:48:32 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-9wKCJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 09:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:48:32 INFO - Running setup.py (path:/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/pip-u5Uz6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:48:32 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)) 09:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:48:32 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)) 09:48:32 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:48:32 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:48:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:34 INFO - Downloading blessings-1.6.tar.gz 09:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:48:35 INFO - Installing collected packages: blessings 09:48:35 INFO - Running setup.py install for blessings 09:48:35 INFO - Successfully installed blessings 09:48:35 INFO - Cleaning up... 09:48:35 INFO - Return code: 0 09:48:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:48:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:35 INFO - Reading from file tmpfile_stdout 09:48:35 INFO - Current package versions: 09:48:35 INFO - blessings == 1.6 09:48:35 INFO - blobuploader == 1.2.4 09:48:35 INFO - docopt == 0.6.1 09:48:35 INFO - functools32 == 3.2.3-2 09:48:35 INFO - jsonschema == 2.5.1 09:48:35 INFO - manifestparser == 1.1 09:48:35 INFO - mozInstall == 1.12 09:48:35 INFO - mozcrash == 1.0 09:48:35 INFO - mozdebug == 0.1 09:48:35 INFO - mozdevice == 0.50 09:48:35 INFO - mozfile == 1.2 09:48:35 INFO - mozhttpd == 0.7 09:48:35 INFO - mozinfo == 0.9 09:48:35 INFO - mozleak == 0.1 09:48:35 INFO - mozlog == 3.4 09:48:35 INFO - moznetwork == 0.27 09:48:35 INFO - mozprocess == 0.25 09:48:35 INFO - mozprofile == 0.28 09:48:35 INFO - mozrunner == 6.13 09:48:35 INFO - mozscreenshot == 0.1 09:48:35 INFO - mozsystemmonitor == 0.3 09:48:35 INFO - moztest == 0.8 09:48:35 INFO - mozversion == 1.4 09:48:35 INFO - psutil == 3.1.1 09:48:35 INFO - requests == 1.2.3 09:48:35 INFO - wsgiref == 0.1.2 09:48:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:35 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 0x10d225b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d228768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8900d626f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d003d30>, '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 0x10cf29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cff8be8>, '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.BllhYNqU7i/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.8q3jxm0YqO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 09:48:35 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 09:48:35 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 09:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BllhYNqU7i/Render', 09:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:35 INFO - 'HOME': '/Users/cltbld', 09:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:35 INFO - 'LOGNAME': 'cltbld', 09:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:35 INFO - 'MOZ_NO_REMOTE': '1', 09:48:35 INFO - 'NO_EM_RESTART': '1', 09:48:35 INFO - 'PAGER': '/bin/cat', 09:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:35 INFO - 'PWD': '/builds/slave/test', 09:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:35 INFO - 'SHELL': '/bin/bash', 09:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8q3jxm0YqO/Listeners', 09:48:35 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 09:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:35 INFO - 'USER': 'cltbld', 09:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:35 INFO - 'XPC_FLAGS': '0x0', 09:48:35 INFO - 'XPC_SERVICE_NAME': '0', 09:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:35 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)) 09:48:35 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)) 09:48:35 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)) 09:48:35 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)) 09:48:35 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)) 09:48:35 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)) 09:48:35 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)) 09:48:35 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)) 09:48:35 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)) 09:48:35 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)) 09:48:35 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)) 09:48:35 INFO - Cleaning up... 09:48:35 INFO - Return code: 0 09:48:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:48:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:48:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:48:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d225b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d228768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8900d626f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d003d30>, '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 0x10cf29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cff8be8>, '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.BllhYNqU7i/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.8q3jxm0YqO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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 09:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:48:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BllhYNqU7i/Render', 09:48:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:35 INFO - 'HOME': '/Users/cltbld', 09:48:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:35 INFO - 'LOGNAME': 'cltbld', 09:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:35 INFO - 'MOZ_NO_REMOTE': '1', 09:48:35 INFO - 'NO_EM_RESTART': '1', 09:48:35 INFO - 'PAGER': '/bin/cat', 09:48:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:35 INFO - 'PWD': '/builds/slave/test', 09:48:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:35 INFO - 'SHELL': '/bin/bash', 09:48:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8q3jxm0YqO/Listeners', 09:48:35 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 09:48:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:35 INFO - 'USER': 'cltbld', 09:48:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:35 INFO - 'XPC_FLAGS': '0x0', 09:48:35 INFO - 'XPC_SERVICE_NAME': '0', 09:48:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:48:36 INFO - Cleaning up... 09:48:36 INFO - Return code: 0 09:48:36 INFO - Running post-action listener: _resource_record_post_action 09:48:36 INFO - Running post-action listener: _start_resource_monitoring 09:48:36 INFO - Starting resource monitoring. 09:48:36 INFO - [mozharness: 2017-05-02 16:48:36.257134Z] Finished create-virtualenv step (success) 09:48:36 INFO - [mozharness: 2017-05-02 16:48:36.258091Z] Running install step. 09:48:36 INFO - Running pre-action listener: _resource_record_pre_action 09:48:36 INFO - Running main action method: install 09:48:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:36 INFO - Reading from file tmpfile_stdout 09:48:36 INFO - Detecting whether we're running mozinstall >=1.0... 09:48:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:48:36 INFO - Reading from file tmpfile_stdout 09:48:36 INFO - Output received: 09:48:36 INFO - Usage: mozinstall [options] installer 09:48:36 INFO - Options: 09:48:36 INFO - -h, --help show this help message and exit 09:48:36 INFO - -d DEST, --destination=DEST 09:48:36 INFO - Directory to install application into. [default: 09:48:36 INFO - "/builds/slave/test"] 09:48:36 INFO - --app=APP Application being installed. [default: firefox] 09:48:36 INFO - mkdir: /builds/slave/test/build/application 09:48:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 09:48:56 INFO - Reading from file tmpfile_stdout 09:48:56 INFO - Output received: 09:48:56 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:48:56 INFO - Running post-action listener: _resource_record_post_action 09:48:56 INFO - [mozharness: 2017-05-02 16:48:56.442589Z] Finished install step (success) 09:48:56 INFO - [mozharness: 2017-05-02 16:48:56.442713Z] Running run-tests step. 09:48:56 INFO - Running pre-action listener: _resource_record_pre_action 09:48:56 INFO - Running main action method: run_tests 09:48:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:48:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:48:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:48:56 INFO - 2017-05-02 09:48:56.457 screenresolution[1622:7476] starting screenresolution argv=screenresolution get 09:48:56 INFO - 2017-05-02 09:48:56.459 screenresolution[1622:7476] Display 0: 1600x1200x32@60 09:48:56 INFO - 2017-05-02 09:48:56.465 screenresolution[1623:7479] starting screenresolution argv=screenresolution list 09:48:56 INFO - Available Modes on Display 0 09:48:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:48:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:48:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:48:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:48:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:48:56 INFO - Intel Iris: 09:48:56 INFO - Chipset Model: Intel Iris 09:48:56 INFO - Type: GPU 09:48:56 INFO - Bus: Built-In 09:48:56 INFO - VRAM (Dynamic, Max): 1536 MB 09:48:56 INFO - Vendor: Intel (0x8086) 09:48:56 INFO - Device ID: 0x0a2e 09:48:56 INFO - Revision ID: 0x0009 09:48:56 INFO - Displays: 09:48:56 INFO - Display: 09:48:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:48:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:48:56 INFO - Display Serial Number: 1600x1200 60 09:48:56 INFO - Main Display: Yes 09:48:56 INFO - Mirror: Off 09:48:56 INFO - Online: Yes 09:48:56 INFO - Rotation: Supported 09:48:56 INFO - Return code: 0 09:48:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:48:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:48:56 INFO - Python 2.7.3 09:48:56 INFO - Return code: 0 09:48:56 INFO - grabbing minidump binary from tooltool 09:48:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:48:56 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d003d30>, '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 0x10cf29db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cff8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:48:56 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 09:48:56 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 09:48:56 INFO - Calling ['/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'] with output_timeout 600 09:48:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:48:56 INFO - Return code: 0 09:48:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:48:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:48:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:48:56 INFO - ENV: RUST_BACKTRACE is now 1 09:48:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:48:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:48:56 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/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0081', '--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 09:48:56 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/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0081 --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 09:48:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.BllhYNqU7i/Render', 09:48:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:56 INFO - 'HOME': '/Users/cltbld', 09:48:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:56 INFO - 'LOGNAME': 'cltbld', 09:48:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:48:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:48:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:56 INFO - 'MOZ_NO_REMOTE': '1', 09:48:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:48:56 INFO - 'NO_EM_RESTART': '1', 09:48:56 INFO - 'PAGER': '/bin/cat', 09:48:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:56 INFO - 'PWD': '/builds/slave/test', 09:48:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:48:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:56 INFO - 'RUST_BACKTRACE': '1', 09:48:56 INFO - 'SHELL': '/bin/bash', 09:48:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8q3jxm0YqO/Listeners', 09:48:56 INFO - 'TMPDIR': '/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/', 09:48:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:56 INFO - 'USER': 'cltbld', 09:48:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:56 INFO - 'XPC_FLAGS': '0x0', 09:48:56 INFO - 'XPC_SERVICE_NAME': '0', 09:48:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:56 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/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0081', '--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 09:48:57 INFO - mozversion application_buildid: 20170502080721 09:48:57 INFO - mozversion application_changeset: bfc7b187005cabbc828ed9f5b61daf139c3cfd90 09:48:57 INFO - mozversion application_display_name: Nightly 09:48:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:48:57 INFO - mozversion application_name: Firefox 09:48:57 INFO - mozversion application_remotingname: firefox 09:48:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:48:57 INFO - mozversion application_vendor: Mozilla 09:48:57 INFO - mozversion application_version: 55.0a1 09:48:57 INFO - mozversion platform_buildid: 20170502080721 09:48:57 INFO - mozversion platform_changeset: bfc7b187005cabbc828ed9f5b61daf139c3cfd90 09:48:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:48:57 INFO - mozversion platform_version: 55.0a1 09:48:57 INFO - using testdate: 1493743737 09:48:57 INFO - actual date: 1493743737 09:48:57 INFO - starting webserver on 'localhost:49233' 09:48:57 INFO - SUITE-START | Running 2 tests 09:48:57 INFO - TEST-START | dromaeo_css 09:48:57 INFO - operating with platform_type : mac_ 09:48:57 INFO - Initialising browser for dromaeo_css test... 09:48:57 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmphq_RzF/profile http://localhost:49233/getInfo.html) 09:48:59 INFO - PID 1633 | 2017-05-02 09:48:59.865 plugin-container[1635:7665] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 09:48:59 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:48:59 INFO - PID 1633 | 2017-05-02 09:48:59.870 plugin-container[1635:7665] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9c0b, name = 'com.apple.CFPasteboardClient' 09:48:59 INFO - PID 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:48:59 INFO - PID 1633 | 2017-05-02 09:48:59.870 plugin-container[1635:7665] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:49:00 INFO - PID 1633 | __metrics Screen width/height:1600/1200 09:49:00 INFO - PID 1633 | colorDepth:24 09:49:00 INFO - PID 1633 | Browser inner width/height: 1024/689 09:49:00 INFO - PID 1633 | __metrics 09:49:01 INFO - TEST-INFO | 1633: exit 0 09:49:01 INFO - Browser initialized. 09:49:01 INFO - Running cycle 1/1 for dromaeo_css test... 09:49:01 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmphq_RzF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:49:03 INFO - PID 1636 | 2017-05-02 09:49:03.433 plugin-container[1637:7797] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 09:49:03 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:49:03 INFO - PID 1636 | 2017-05-02 09:49:03.434 plugin-container[1637:7797] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4417, name = 'com.apple.CFPasteboardClient' 09:49:03 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:49:03 INFO - PID 1636 | 2017-05-02 09:49:03.434 plugin-container[1637:7797] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:49:13 INFO - PID 1636 | RSS: Main: 250929152 09:49:13 INFO - PID 1636 | 09:52:16 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49233/tests/dromaeo/cssquery-ext.html) 09:52:18 INFO - PID 1636 | RSS: Main: 253812736 09:52:18 INFO - PID 1636 | 09:54:01 INFO - PID 1636 | ************************* 09:54:01 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 09:54:01 INFO - PID 1636 | 09:54:01 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:54:01 INFO - PID 1636 | Full stack: 09:54:01 INFO - PID 1636 | ************************* 09:54:01 INFO - PID 1636 | ************************* 09:54:01 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 09:54:01 INFO - PID 1636 | 09:54:01 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:54:01 INFO - PID 1636 | Full stack: 09:54:01 INFO - PID 1636 | ************************* 09:54:01 INFO - PID 1636 | ************************* 09:54:01 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 09:54:01 INFO - PID 1636 | 09:54:01 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:54:01 INFO - PID 1636 | Full stack: 09:54:01 INFO - PID 1636 | ************************* 09:54:01 INFO - PID 1636 | ************************* 09:54:01 INFO - PID 1636 | A coding exception was thrown and uncaught in a Task. 09:54:01 INFO - PID 1636 | 09:54:01 ERROR - PID 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:54:01 INFO - PID 1636 | Full stack: 09:54:01 INFO - PID 1636 | ************************* 09:55:20 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-ext.html (next: http://localhost:49233/tests/dromaeo/cssquery-jquery.html) 09:55:21 INFO - PID 1636 | RSS: Main: 258940928 09:55:21 INFO - PID 1636 | 09:58:22 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49233/tests/dromaeo/cssquery-mootools.html) 09:58:23 INFO - PID 1636 | RSS: Main: 269000704 09:58:23 INFO - PID 1636 | 10:01:25 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49233/tests/dromaeo/cssquery-prototype.html) 10:01:25 INFO - PID 1636 | RSS: Main: 261505024 10:01:25 INFO - PID 1636 | 10:04:28 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49233/tests/dromaeo/cssquery-yui.html) 10:04:29 INFO - PID 1636 | RSS: Main: 270663680 10:04:29 INFO - PID 1636 | 10:07:31 INFO - PID 1636 | Cycle 1(1): loaded http://localhost:49233/tests/dromaeo/cssquery-yui.html (next: http://localhost:49233/tests/dromaeo/cssquery-dojo.html) 10:07:31 INFO - PID 1636 | RSS: Main: 265302016 10:07:31 INFO - PID 1636 | 10:07:31 INFO - PID 1636 | __start_tp_report 10:07:31 INFO - PID 1636 | _x_x_mozilla_page_load 10:07:31 INFO - PID 1636 | _x_x_mozilla_page_load_details 10:07:31 INFO - PID 1636 | |i|pagename|runs| 10:07:31 INFO - PID 1636 | |0;dojo.html;3663.395539735942;3666.578343490499;3681.4293784463407;3707.7219208559363;3709.2581483703266;6155.507559395249;6262.9060564091515;6275.905861412082;6369.980803071509;6382.26603940547;6246;6252.531060170494;6273.404026617464;6367.6497792621385;6368.808935731924;5455.672659640434;5481.808136715215;5494.615376923617;5507.284053073095;5524.66851988882;5558.555315574744;5626.54987600993;5643.520300774439;5676.574256930726;5707.828765137032;4692.953070469286;5533.00405926933;5576.219329293902;5613.915791263134;5632.239647647577;5350.117230656937;5538.778448862041;5560.77756889724;5588.580856435743;5603.327600687943;5478.58910581704;5513.972430137864;5543.085390910495;5566.916496252559;5573.8606534836545;5513.062779327524;5566.582506312043;6276.717547710364;6300.180976473029;6318.652474113922;6506.674666266667;6619.3380661933425;6780.559263647847;6818.863622727567;6834.931650683479;6865.0732151159955;6878.071460352839;6885.449164066863;6910.689018994158;6917.550359226634;6324.241091069009;6334.018227174795;6393.6163830170335;6398.744050237985;6420.6468644225015;6798.830029249309;6922.446204303644;7023.200043783145;7047.119110111236;7056.823579410453;6563.868722625521;6634.86730265392;6676.198856137295;6683.131192944983;6709.094272273181;6890.483213758988;6898.482613803984;6899.379055884894;6908.92911598703;6910.412614927687;6541.345865413516;6737.562058466184;6748.527603067836;6789.898151527731;6850.520463567602;5795.1017592273265;6278.905816412666;6552.9344706553275;6750.527463077636;6847.075644787989;5384.596155288369;5395.73021348931;5398.433164517669;5407.972960135174;5415.133578627479;4733.36099626546;4753.287006948916;4772.164871147535;4797.040591881638;4853.490383509751;6090.056041313604;6320;6338.239411270677;6339.207599050119;6391.616503009835;6948.131483564554;6948.756793512202;6949.5830250184135;6964.199117101497;6973.302669732986;6394.232692076887;6411.551191416556;6419.775307864203;6428.5178611604315;6435.774747883802;5387.649802762808;5884.588078834526;6026.0659597762415;6029.397060293935;6098.573099882966;5545.500904918576;6084.124454299869;6997.195322537973;7001.159860816734;7148.928510714826;6697.062411262525;6748;6921.861562768817;6939.271376505394;6978.057962175244;5901.350851406256;6120.724567394567;6202.968985155046;6314.400131987454;6943.993120997326;6756.391924726799;6771.322867713189;6774.153230846145;6791.762288319885;6809;6440.549161558646;6621.966890165519;6665.233498147775;6741.797746067626;6777.254502004677;6625.536212465274;6679.666016699242;6690.063391125149;6693.9624358224555;6711.530192886451;6659.933400666125;6665.466762658879;6671.532992690659;6674.629312197309;6700.46396288286;6286;6401.551891367746;6433.678316084271;6470.094186813756;6520.706568204537;5610.270664813548;6631.867362652816;6666.766663166766;6687.933120668926;6701.1623547056615;6454.935450645434;6493.383128602775;6499.6750162492635;6503.479721622164;6513.185851768529 10:07:31 INFO - PID 1636 | |1;ext.html;813.1989989859989;1153.4982282707024;1204.7048473124082;1279.3858947705096;1304.8956083513315;36901.81549092254;37728.43407348892;37744;37868.43197352042;37895.810520947394;37520.249595008085;37910.620893791056;37913.43129853048;37934.43098353527;38075.23849523015;8291.378146638996;8467.449615774955;8530.317574594017;8539.914600854005;8548.70079547216;8466.957665211665;8499;8561.0582835888;8568.785780355478;8570.700025499109;8479.788005299855;8494.320454363637;8557.529335886555;8567.485950842938;8570.828583428327;7219.675114619855;8539.914600853974;8540.78648033798;8554.52950087745;8576.742697719079;8362.749117526484;8374.748757537283;8416.537090460022;8429.915700843036;8465.703700370519;36935.445968310494;37044.259114817556;37112.88661340137;37116.257674846354;37151.81424092889;3634.27314537091;3670.3026424979435;3671.284099600579;3671.3758661027423;3681.245344704329;30585.541216881764;30587.69412305893;30675.2331191722;30698.618562164756;30708;3122.687731226882;3167.9683203168133;3169.429502689515;3191.9361612767616;3206.8396580170897;239383.80308098524;281504;282830;283401;284232;39455;47323.76338118287;47847.17222622182;47962.561123166364;47990.28014579784;50134.49865501298;50233.995320093396;50286.994260114596;50471;50517;14244.501442449464;14365.497207597684;14411.92794036023;14419;14476.638084047983;11608.361540115375;11636.3600001999;11783.587574434854;11789.88210117905;11811.409429528489;10882.72793180161;11062.336259824437;11732.354720490284;13520.459181632821;13539.59381218565;4916.631252656065;5921.200637913913;5921.67430791302;5933.554983376264;5938.168656388109;1017.7252141921788;1058.7829494953517;1059.1897198643044;1103.4979084516526;1105.3478447715886;24344.75655243425;24525.63211551828;24647.630285545732;24904;25314.240572782845;965.4545181972304;976.9888165748416;1159.0437888741822;1189.0903458853984;1191.2316555821446;11752.58865939688;12126.696832579257;12689.555865544662;12715.427805748763;12723.872761272454;310297;310584;310662;310832;310981;40268.59731402707;43498.7825060879;54217.45782542124;54553.72723136359;54663.18005229925;1511.3878879054;1524.8246451658201;1558.7350150474447;1564.233525572484;1581.264711908945;20314.492137696674;21655;21660.241891533722;23903.521929560964;24202.51594968126;39445.60554394534;39521.60478395294;39721;39787.60212397839;39888.40167397433;268389;269656;270112.49437528435;270168;270464;35047.47428788519;35200.29599408049;35511.28977420489;36738;36813.63186368102;44987;45262;45911;46223.76888115538;46268.537314626425;30605.387892241586;30714;31304;31382.686173137976;31779.52330714995;30614;30796.53805192969;31279;31635.36729265448;31751.206219844687;29880.22819366583;37229.62770372262;37473.62526374702;37745.62254377421;37903.62096379111;29956.700432996262;30493.54259686062;30521.694783052775;31656.36687266288;31959.520607191374;23882.880585596962;24643.137490187757;24845.378865528506;24849.1302804401;25091.114521830223 10:07:31 INFO - PID 1636 | |2;jquery.html;432.5631112576299;434.4959846577969;436.63977218794463;444.4954976102124;462.9814807407704;19556.41330760078;21188.576228475442;21658.24196153133;21801.454963625878;22118.894055297213;19549.609007819836;21161.62449440789;21921.780782192214;22372.552548949054;22452.66321005182;5010.899782004358;5056.519630635093;6174.907376389336;6223.315435302113;6224.906626400585;5084.2373643953515;6007.669578173199;6279.0581412788215;6302.527310451712;6326.715297811609;6085.513158947274;6284.968575157118;6286.182796236506;6298.559100862942;6300.7794727184555;6174.969125154368;6275.811725648238;6283;6288.3082860885725;6303;5482.972585137089;5549.278593782782;5613.66318020916;5618.85952851182;5646.322441307028;27627.585586216224;28173.718262817314;28424.14727558156;28814.135575932756;28911.56632650512;2185.1259496201487;2187.147012665062;2248.3704562722464;2253.853499522526;2260.08466571039;17932;18014.819851801447;18050.4584862453;18623.97568133752;18719.438416847515;2166.3392665237097;2173.8260939124834;2217.079911836586;2220.589190999654;2222.288867562381;164627;166743;167229.16385418116;168143;168261;11581.88418115808;12622.305773182563;12813.103082784115;12884.80672789909;13005.154664946747;16399.91800041016;16538.751918721227;16573;16577.751333730004;16585.25366358517;8774.166454186841;9106.635734570544;9125.133112354315;9268.497505673566;9292.72121836346;8724.302055835518;8730.039695633475;8813.647454101892;8929.241014513838;8957.014728379872;7916.920830791733;8014.15851335613;8014.519128852287;8041.236082572146;8099.757007289791;2098.1712223671566;2156.784321567831;2180.705604743371;2195.7145571075657;2197.0662468451164;909.727081875448;918.5177781664679;970.1414248390225;976.1653786012856;982.0457289993005;19293;20104.698429523276;20801.895990520254;20855.8957205213;21058.684119738216;895.6506962284584;1006.864073350103;1030.9896901031043;1035.9015893490257;1039.7712503249272;10381.532831022621;10571.418571978615;10667.466626668636;10681.412522311348;10734.141268698486;482171;538383;550002;559336;560581;103244;109028;123204;124553;126013;1010.7473131717071;1192.8568571771443;1221.0536833953756;1228.2200802490484;1231.199720181889;16846.66306673884;17807.643847123243;17839.018853963156;17965;18148.909255454168;54704.90590188094;55490.72254638863;55714.72142639261;56091.15863261973;56614.71692641675;57233;57604.847903042544;58587;62208.534975803195;75308.62345688237;8436.32509399259;8747.387682862138;8841.292696584129;8954.552272386225;9242.953785231031;13796.931015344859;14417.567472975827;14554.636134096732;14575.927120364331;14784;11952.957592066508;12136.029117670741;12211.511539538675;12252.019838412727;12310.692232694255;11548.769024619292;11603.593874214363;11658.242214256046;11906.821397679216;11950.282983021047;11313.094952403624;12399.94600458971;12428.005759539396;12450;12538.247705137721;8471.576421178794;8640.703894415636;8773;8971.282297416321;9173.312001599774;10059.748506287402;11345.943270283597;12201;12297.692557686129;12306.630801075982 10:07:31 INFO - PID 1636 | |3;mootools.html;1243.97512049759;1316.6050184944513;1322.7896474725621;1482.1922052481395;1490.932908019139;11353.886461135386;11854.288742675435;11886.7622647547;11889.048876089913;12214.816777748341;11888.346140962243;12044.81932771009;12070.215435996675;12073.154879158463;12089.758204835898;2536.251805717318;2566.486702659466;2573.3566608347915;2579.0328626764963;2582.328594565417;2133.8506304558687;2498.1256560203965;2535.8351707138977;2538.1750930947514;2554.9397000244876;2499.850008999457;2516.7609077137645;2551.1963731424544;2552.7064387595387;2555.654986576816;2123.182574708733;2138.2088627207954;2476.158106243877;2499.46261553765;2531.5569775289437;2450.154696629678;2531.8227724059325;2533.9746602534105;2538.4161642822255;2557.7825884799813;10005.199584033333;10065.798684026351;11765.352905590189;11879.406029698566;11933.582324618597;6592.307807680172;6811.318868113149;6843.486738494633;6845.555038922504;6850.794476165723;4027.677785777131;4319.978400108011;4406.030673251879;4406.581374769392;4420.093880754438;1269.8984081273477;1271.5168236070326;1286.7812471879708;1317.038561849855;1317.1241124652095;13710.862891371058;15981.44064957721;16546.172691365384;16583.419580314632;16639.584010399714;5527.723613819293;5545.223668686387;5718.170865224519;5720.256366672306;5780.826575202751;9955.50222488887;11875.940620297017;11951.92432681063;11964.58123965657;11967.521299147937;6621.635810030398;6625.701843417058;6629.86740265192;6638.767643132467;6647.501437392215;6028.698565071729;6102.115193296947;6219.47134493564;6255.530835187379;6287.811365659038;4291.399204111427;4453.421055262795;4486.1252055849445;4511.729296242236;4530.320451932236;1252.7431876465484;1268.6828292926768;1269.8666640002853;1281.1096288079696;1285.3573213393304;798.141997352848;812.8333691593209;835.6406745099544;839.9328053755685;864.1703964194318;6189.597676151036;6201.96899015502;6328.6202827830475;6361.713722882481;6405.775797847053;595.9314678811905;599.9400059993966;609.9908501372483;619.8791235708993;629.4209327418786;3910.921781564353;4016.3975403689096;4389.62688171509;4502.414686090853;4575.970406658475;14469.421223150955;14636.560903172922;15009.849901501064;15110.622234444007;15141.470048548248;14472.565823025116;14824.258787060604;15010;15012.624684382978;15048.623784405478;7293.598852063187;8490.533020683923;8728.738137855875;8730.86903696445;8745.693900713444;6309.90535141964;6573.498964803412;6842.213145488134;7168.784936451915;7190.101237345332;11891.643250702493;12426.937865310978;12799.936000319938;12844.743105137659;12906.870931290567;12857.03572232105;12896.161749486253;12963;13035.739285214433;13132.080754347104;9264.258859291376;9407.858882116638;9601.135897768954;9608.75978100553;9655.662051828152;11134.27627204229;11282.887171128184;11290.209685322277;11307.491162897853;11317.660470185907;9029.097090290918;9230.861537077084;9305.581248843953;9404.38871473352;9424.811503770023;7415.8887616684715;7619.161892191743;8037.598120094089;9017.413868098552;9352.953235233781;7525.134609519975;8097.554634495159;8379.120192379713;8457.915420845959;8474.576271186539;6087.208662873798;6180.536459765445;6275.5607107503865;6292.622442653455;6358.364163583605;6038.547108966933;6165.290991536031;6328.145700330397;6328.7342531494805;6361.14124593174 10:07:31 INFO - PID 1636 | |4;prototype.html;379.3910773208999;392.2860394082771;416.17597157627887;417.3909578574597;422.92175947449704;6329.905051424233;6394.552381333308;6464.083430729116;6471.805845824632;6518.54370194086;6184.226971628546;6283.654399008053;6309.1482649842255;6314.579219675571;6316.810495685137;3917.196974620196;4000.4599379083743;4478.865634030984;4544.954550454486;4579.129965306581;4343.891402714926;4551.635869130479;4553.635709143261;4584.724916505021;4591.196540605398;4158.6465150462245;4495.483019452772;4502.189605870942;4523.977380113095;4530.411046563942;4163.292240319122;4193.077522944947;4463.375127482155;4530.983712248051;4558.635309175258;3806.3909774435956;3859.903502412434;3872.9225415491533;3886.6696330811915;3890.5720370759195;6160.599561028519;6165.568410211287;6166;6171.7531298748;6190.938090619081;5443.1835224716215;5462.306684927685;5464.972675136639;5467.289252397163;5493;5860.941390586082;6637.435817955479;6676.799696009079;6827.112475378169;6853.348931851466;3903.609639036102;4340.08858139791;4415.66882483815;4424.137293227822;4455.955440445587;6153.84615384619;6571.751367240209;7047.506674532733;7241.601711905843;7261.310175533369;4143.901866005511;4437.955620443819;4458.4426946631675;4460.464744230713;4482.955170448319;3994.4807175067053;4514.45826500822;4561;4577.359169716243;4610.216263235258;5221.6344855859725;5400.027994960867;5458.4541545845095;5463.72681365938;5469.56243500519;6255.718492667841;6813.454923606099;6821.658917054127;6833.214180369222;6850.554713943678;1490.5690537084304;1520.1639098495782;1531.7702344648392;1557.3069983857301;1561.6486290584755;996.496769131584;1001.0890090018194;1001.8447140693058;1003.6286573967678;1011.2819897872592;6420.486361091102;6433;6437.195350581177;6466.644334561644;6478.611283323015;5973.940260597426;6389.5846769960735;7049.506534542636;7056.682449289794;7062.258462861429;6156.353582873823;6414.198225221848;6461.127747753993;6461.415433826413;6462.676866156673;3617.2584620152807;3643.7995910224663;3673.7061035117126;3706.8887933362043;3726.7018638508853;6155.138280640714;7215.927840721631;7245.456590755714;7300.890486642705;7303.269673032654;5130.153524668388;6201.937980620226;6213.347598502182;6716.406722403491;7201.451687887129;5481.369642491165;6308.990561510228;6730.360615741497;7137.250588688321;7211.495195336276;6407.807765767035;6963.2340442552295;7001.649917504206;7043.605174240783;7095.645217738989;6914.654267286515;6934.306569343025;6975;6992.405645520188;7016.719331226898;6275.023367639179;7234.6020968847215;7272.073080536451;7389.408847292097;7401.59291238987;4777.617790576676;4863.732494712684;4978.477259887804;5124.385073791169;5133;6259.96870015647;6516.924707423412;7141.392981596622;7167.498275120692;7198.316159964795;6095.902737507291;6137.84655383619;6286.145587051922;6535.954247320406;6795.7961261162245;5879.7060146993335;6083.27000759894;6203.286622038523;6879;6898.241193468814;5197.506236907488;5878.2358293421585;6542.509311801538;6627.9337206627315;6648.501362397743;5709.65742055478;6806.965965170142;6829;6851.417629501549;6882.8967565485555;5225.6603320784025;6386.680665966776;6609.735610575523;6641.302663220292;6673.899891501728 10:07:31 INFO - PID 1636 | |5;yui.html;842.2714352085447;848.5460278750868;855.6064210463187;874.1826392323178;894.6510860764301;16357.75463368049;16725.414610488635;16801.075940823266;18372.816271837277;19111.426657200307;15267.770983435257;17736.733948990775;18223.27106915725;18286.908565457154;18645;997.306871724152;1002.8044531316397;1031.6647089695841;1035.1718625099927;1041.4740556019199;1012.7974405118969;1021.1116328793922;1024.5491983527224;1026.1329176845554;1030.1655658916302;1084.0243780597445;1085.7448499602588;1089.1776708585007;1091.6561283195808;1095.2333366643343;1078.0620859851902;1080.2600218850073;1082.5453309609943;1084.2139448899563;1088.216484131424;766.7891329884327;782.2998416417331;790.7785819970418;798.9800254993613;800.7357572001225;16691.83308166915;16803.91598042014;16837.663246734995;16998.575035624086;17000.57498562546;17089.658206835793;17171.055591942437;17467.388641397618;17563.824361756346;17681.911590442094;13926.09480383782;14072.71854562903;14191.574252772434;14342.569722908225;14343.28283585827;3453.8445769940413;3510.2452972611013;3515.5078289039557;3519.1554027033585;3526.770759900624;87407.56296218542;105535.4723226379;129781;130159;131218;13419.060665753499;13717.657058573415;13736.244506552235;13759;13764.793528097087;24936.875315623667;25714.228573142835;25855.836487358116;26228.60657090145;26302.736972630028;7976.242256985577;8073.798155046054;8084.434089613788;8085.110637829834;8095.83808323842;3609.0796846803896;3657.524521812147;3663.19409729859;3667.3582123128344;3687.1335236219466;4190.224808410393;4373.934390984138;4393.978030109829;4402.207602631493;4413.492448368414;915.3455279475207;928.5960607135918;962.9518524073908;963.017721923634;965.0831709875646;582.9856050472148;658.2956236826645;660.1220376898713;664.9800505984829;690.7133539581118;11219.495122719498;11628.94185529067;11873.168878178618;12149.635510934686;12212;613.9171211886428;643.6009674002148;659.5020759326677;661.1009027722293;662.1888186971019;5525.778968841281;5632.464915832989;5648.068068768689;5701.629394089371;5714.200011998323;96929;104862;113678;114321;116001;81126;83398.332033359;84247.26021918355;97687;101595;76103;76643.23356766472;77130.6143469279;77839.832402514;78325;12273.447694853574;12873.871261287268;12896.226226426445;12901.225926444444;12914.160579562298;38743.675379477325;39185.804070979466;39229.60770392259;40002.39996399998;40862.18275634411;35507.401311700305;37619.811900941415;48966.51033489619;49523;49913;14009.579712608638;15458.304376303318;16255.187240637684;16535;16597.41909033178;17044.829551704323;17839.73240401421;17871.821281787536;17872.374466893598;17994.730079049088;16074.598135046717;16176.94849834757;16813.07528085967;16905.577360566083;16923.91538042302;13818.930905345409;16426.42507512231;16592.004479731255;16765.83234167643;16856.494305170865;14826.555203343916;14876.107433554022;14977.550673479813;15067.397304107713;15106.773398398813;11425.31448113116;11585.246958947642;11629.18595698293;11744.412779360828;11871.050315974873;13181.209127452383;13260.138091024053;13292.268925209206;13294.800577991144;13314.267715275753 10:07:31 INFO - PID 1636 | __end_tp_report 10:07:31 INFO - PID 1636 | __start_cc_report 10:07:31 INFO - PID 1636 | _x_x_mozilla_cycle_collect,420 10:07:31 INFO - PID 1636 | __end_cc_report 10:07:31 INFO - PID 1636 | __startTimestamp1493744851314__endTimestamp 10:07:31 INFO - PID 1636 | 10:07:31 INFO - PID 1636 | ------- Summary: start ------- 10:07:31 INFO - PID 1636 | Number of tests: 6 10:07:31 INFO - PID 1636 | 10:07:31 INFO - PID 1636 | [#0] dojo.html Cycles:165 Average:6217.20 Median:6419.78 stddev:731.30 (11.4%) stddev-sans-first:705.57 10:07:31 INFO - PID 1636 | Values: 3663.4 3666.6 3681.4 3707.7 3709.3 6155.5 6262.9 6275.9 6370.0 6382.3 6246.0 6252.5 6273.4 6367.6 6368.8 5455.7 5481.8 5494.6 5507.3 5524.7 5558.6 5626.5 5643.5 5676.6 5707.8 4693.0 5533.0 5576.2 5613.9 5632.2 5350.1 5538.8 5560.8 5588.6 5603.3 5478.6 5514.0 5543.1 5566.9 5573.9 5513.1 5566.6 6276.7 6300.2 6318.7 6506.7 6619.3 6780.6 6818.9 6834.9 6865.1 6878.1 6885.4 6910.7 6917.6 6324.2 6334.0 6393.6 6398.7 6420.6 6798.8 6922.4 7023.2 7047.1 7056.8 6563.9 6634.9 6676.2 6683.1 6709.1 6890.5 6898.5 6899.4 6908.9 6910.4 6541.3 6737.6 6748.5 6789.9 6850.5 5795.1 6278.9 6552.9 6750.5 6847.1 5384.6 5395.7 5398.4 5408.0 5415.1 4733.4 4753.3 4772.2 4797.0 4853.5 6090.1 6320.0 6338.2 6339.2 6391.6 6948.1 6948.8 6949.6 6964.2 6973.3 6394.2 6411.6 6419.8 6428.5 6435.8 5387.6 5884.6 6026.1 6029.4 6098.6 5545.5 6084.1 6997.2 7001.2 7148.9 6697.1 6748.0 6921.9 6939.3 6978.1 5901.4 6120.7 6203.0 6314.4 6944.0 6756.4 6771.3 6774.2 6791.8 6809.0 6440.5 6622.0 6665.2 6741.8 6777.3 6625.5 6679.7 6690.1 6694.0 6711.5 6659.9 6665.5 6671.5 6674.6 6700.5 6286.0 6401.6 6433.7 6470.1 6520.7 5610.3 6631.9 6666.8 6687.9 6701.2 6454.9 6493.4 6499.7 6503.5 6513.2 10:07:31 INFO - PID 1636 | 10:07:31 INFO - PID 1636 | [#1] ext.html Cycles:180 Average:43791.39 Median:17575.73 stddev:74752.84 (425.3%) stddev-sans-first:74892.90 10:07:31 INFO - PID 1636 | Values: 813.2 1153.5 1204.7 1279.4 1304.9 36901.8 37728.4 37744.0 37868.4 37895.8 37520.2 37910.6 37913.4 37934.4 38075.2 8291.4 8467.4 8530.3 8539.9 8548.7 8467.0 8499.0 8561.1 8568.8 8570.7 8479.8 8494.3 8557.5 8567.5 8570.8 7219.7 8539.9 8540.8 8554.5 8576.7 8362.7 8374.7 8416.5 8429.9 8465.7 36935.4 37044.3 37112.9 37116.3 37151.8 3634.3 3670.3 3671.3 3671.4 3681.2 30585.5 30587.7 30675.2 30698.6 30708.0 3122.7 3168.0 3169.4 3191.9 3206.8 239383.8 281504.0 282830.0 283401.0 284232.0 39455.0 47323.8 47847.2 47962.6 47990.3 50134.5 50234.0 50287.0 50471.0 50517.0 14244.5 14365.5 14411.9 14419.0 14476.6 11608.4 11636.4 11783.6 11789.9 11811.4 10882.7 11062.3 11732.4 13520.5 13539.6 4916.6 5921.2 5921.7 5933.6 5938.2 1017.7 1058.8 1059.2 1103.5 1105.3 24344.8 24525.6 24647.6 24904.0 25314.2 965.5 977.0 1159.0 1189.1 1191.2 11752.6 12126.7 12689.6 12715.4 12723.9 310297.0 310584.0 310662.0 310832.0 310981.0 40268.6 43498.8 54217.5 54553.7 54663.2 1511.4 1524.8 1558.7 1564.2 1581.3 20314.5 21655.0 21660.2 23903.5 24202.5 39445.6 39521.6 39721.0 39787.6 39888.4 268389.0 269656.0 270112.5 270168.0 270464.0 35047.5 35200.3 35511.3 36738.0 36813.6 44987.0 45262.0 45911.0 46223.8 46268.5 30605.4 30714.0 31304.0 31382.7 31779.5 30614.0 30796.5 31279.0 31635.4 31751.2 29880.2 37229.6 37473.6 37745.6 37903.6 29956.7 30493.5 30521.7 31656.4 31959.5 23882.9 24643.1 24845.4 24849.1 25091.1 10:07:31 INFO - PID 1636 | 10:07:31 INFO - PID 1636 | [#2] jquery.html Cycles:180 Average:34814.21 Median:12167.99 stddev:91569.54 (752.5%) stddev-sans-first:91790.03 10:07:31 INFO - PID 1636 | Values: 432.6 434.5 436.6 444.5 463.0 19556.4 21188.6 21658.2 21801.5 22118.9 19549.6 21161.6 21921.8 22372.6 22452.7 5010.9 5056.5 6174.9 6223.3 6224.9 5084.2 6007.7 6279.1 6302.5 6326.7 6085.5 6285.0 6286.2 6298.6 6300.8 6175.0 6275.8 6283.0 6288.3 6303.0 5483.0 5549.3 5613.7 5618.9 5646.3 27627.6 28173.7 28424.1 28814.1 28911.6 2185.1 2187.1 2248.4 2253.9 2260.1 17932.0 18014.8 18050.5 18624.0 18719.4 2166.3 2173.8 2217.1 2220.6 2222.3 164627.0 166743.0 167229.2 168143.0 168261.0 11581.9 12622.3 12813.1 12884.8 13005.2 16399.9 16538.8 16573.0 16577.8 16585.3 8774.2 9106.6 9125.1 9268.5 9292.7 8724.3 8730.0 8813.6 8929.2 8957.0 7916.9 8014.2 8014.5 8041.2 8099.8 2098.2 2156.8 2180.7 2195.7 2197.1 909.7 918.5 970.1 976.2 982.0 19293.0 20104.7 20801.9 20855.9 21058.7 895.7 1006.9 1031.0 1035.9 1039.8 10381.5 10571.4 10667.5 10681.4 10734.1 482171.0 538383.0 550002.0 559336.0 560581.0 103244.0 109028.0 123204.0 124553.0 126013.0 1010.7 1192.9 1221.1 1228.2 1231.2 16846.7 17807.6 17839.0 17965.0 18148.9 54704.9 55490.7 55714.7 56091.2 56614.7 57233.0 57604.8 58587.0 62208.5 75308.6 8436.3 8747.4 8841.3 8954.6 9243.0 13796.9 14417.6 14554.6 14575.9 14784.0 11953.0 12136.0 12211.5 12252.0 12310.7 11548.8 11603.6 11658.2 11906.8 11950.3 11313.1 12399.9 12428.0 12450.0 12538.2 8471.6 8640.7 8773.0 8971.3 9173.3 10059.7 11345.9 12201.0 12297.7 12306.6 10:07:31 INFO - PID 1636 | 10:07:31 INFO - PID 1636 | [#3] mootools.html Cycles:180 Average:7066.00 Median:4022.04 stddev:4417.44 (109.8%) stddev-sans-first:4408.16 10:07:31 INFO - PID 1636 | Values: 1244.0 1316.6 1322.8 1482.2 1490.9 11353.9 11854.3 11886.8 11889.0 12214.8 11888.3 12044.8 12070.2 12073.2 12089.8 2536.3 2566.5 2573.4 2579.0 2582.3 2133.9 2498.1 2535.8 2538.2 2554.9 2499.9 2516.8 2551.2 2552.7 2555.7 2123.2 2138.2 2476.2 2499.5 2531.6 2450.2 2531.8 2534.0 2538.4 2557.8 10005.2 10065.8 11765.4 11879.4 11933.6 6592.3 6811.3 6843.5 6845.6 6850.8 4027.7 4320.0 4406.0 4406.6 4420.1 1269.9 1271.5 1286.8 1317.0 1317.1 13710.9 15981.4 16546.2 16583.4 16639.6 5527.7 5545.2 5718.2 5720.3 5780.8 9955.5 11875.9 11951.9 11964.6 11967.5 6621.6 6625.7 6629.9 6638.8 6647.5 6028.7 6102.1 6219.5 6255.5 6287.8 4291.4 4453.4 4486.1 4511.7 4530.3 1252.7 1268.7 1269.9 1281.1 1285.4 798.1 812.8 835.6 839.9 864.2 6189.6 6202.0 6328.6 6361.7 6405.8 595.9 599.9 610.0 619.9 629.4 3910.9 4016.4 4389.6 4502.4 4576.0 14469.4 14636.6 15009.8 15110.6 15141.5 14472.6 14824.3 15010.0 15012.6 15048.6 7293.6 8490.5 8728.7 8730.9 8745.7 6309.9 6573.5 6842.2 7168.8 7190.1 11891.6 12426.9 12799.9 12844.7 12906.9 12857.0 12896.2 12963.0 13035.7 13132.1 9264.3 9407.9 9601.1 9608.8 9655.7 11134.3 11282.9 11290.2 11307.5 11317.7 9029.1 9230.9 9305.6 9404.4 9424.8 7415.9 7619.2 8037.6 9017.4 9353.0 7525.1 8097.6 8379.1 8457.9 8474.6 6087.2 6180.5 6275.6 6292.6 6358.4 6038.5 6165.3 6328.1 6328.7 6361.1 10:07:31 INFO - PID 1636 | 10:07:31 INFO - PID 1636 | [#4] prototype.html Cycles:180 Average:5425.51 Median:6165.78 stddev:1721.65 (27.9%) stddev-sans-first:1684.30 10:07:31 INFO - PID 1636 | Values: 379.4 392.3 416.2 417.4 422.9 6329.9 6394.6 6464.1 6471.8 6518.5 6184.2 6283.7 6309.1 6314.6 6316.8 3917.2 4000.5 4478.9 4545.0 4579.1 4343.9 4551.6 4553.6 4584.7 4591.2 4158.6 4495.5 4502.2 4524.0 4530.4 4163.3 4193.1 4463.4 4531.0 4558.6 3806.4 3859.9 3872.9 3886.7 3890.6 6160.6 6165.6 6166.0 6171.8 6190.9 5443.2 5462.3 5465.0 5467.3 5493.0 5860.9 6637.4 6676.8 6827.1 6853.3 3903.6 4340.1 4415.7 4424.1 4456.0 6153.8 6571.8 7047.5 7241.6 7261.3 4143.9 4438.0 4458.4 4460.5 4483.0 3994.5 4514.5 4561.0 4577.4 4610.2 5221.6 5400.0 5458.5 5463.7 5469.6 6255.7 6813.5 6821.7 6833.2 6850.6 1490.6 1520.2 1531.8 1557.3 1561.6 996.5 1001.1 1001.8 1003.6 1011.3 6420.5 6433.0 6437.2 6466.6 6478.6 5973.9 6389.6 7049.5 7056.7 7062.3 6156.4 6414.2 6461.1 6461.4 6462.7 3617.3 3643.8 3673.7 3706.9 3726.7 6155.1 7215.9 7245.5 7300.9 7303.3 5130.2 6201.9 6213.3 6716.4 7201.5 5481.4 6309.0 6730.4 7137.3 7211.5 6407.8 6963.2 7001.6 7043.6 7095.6 6914.7 6934.3 6975.0 6992.4 7016.7 6275.0 7234.6 7272.1 7389.4 7401.6 4777.6 4863.7 4978.5 5124.4 5133.0 6260.0 6516.9 7141.4 7167.5 7198.3 6095.9 6137.8 6286.1 6536.0 6795.8 5879.7 6083.3 6203.3 6879.0 6898.2 5197.5 5878.2 6542.5 6627.9 6648.5 5709.7 6807.0 6829.0 6851.4 6882.9 5225.7 6386.7 6609.7 6641.3 6673.9 10:07:31 INFO - PID 1636 | 10:07:31 INFO - PID 1636 | [#5] yui.html Cycles:180 Average:21214.47 Median:17515.61 stddev:29758.66 (169.9%) stddev-sans-first:29802.83 10:07:31 INFO - PID 1636 | Values: 842.3 848.5 855.6 874.2 894.7 16357.8 16725.4 16801.1 18372.8 19111.4 15267.8 17736.7 18223.3 18286.9 18645.0 997.3 1002.8 1031.7 1035.2 1041.5 1012.8 1021.1 1024.5 1026.1 1030.2 1084.0 1085.7 1089.2 1091.7 1095.2 1078.1 1080.3 1082.5 1084.2 1088.2 766.8 782.3 790.8 799.0 800.7 16691.8 16803.9 16837.7 16998.6 17000.6 17089.7 17171.1 17467.4 17563.8 17681.9 13926.1 14072.7 14191.6 14342.6 14343.3 3453.8 3510.2 3515.5 3519.2 3526.8 87407.6 105535.5 129781.0 130159.0 131218.0 13419.1 13717.7 13736.2 13759.0 13764.8 24936.9 25714.2 25855.8 26228.6 26302.7 7976.2 8073.8 8084.4 8085.1 8095.8 3609.1 3657.5 3663.2 3667.4 3687.1 4190.2 4373.9 4394.0 4402.2 4413.5 915.3 928.6 963.0 963.0 965.1 583.0 658.3 660.1 665.0 690.7 11219.5 11628.9 11873.2 12149.6 12212.0 613.9 643.6 659.5 661.1 662.2 5525.8 5632.5 5648.1 5701.6 5714.2 96929.0 104862.0 113678.0 114321.0 116001.0 81126.0 83398.3 84247.3 97687.0 101595.0 76103.0 76643.2 77130.6 77839.8 78325.0 12273.4 12873.9 12896.2 12901.2 12914.2 38743.7 39185.8 39229.6 40002.4 40862.2 35507.4 37619.8 48966.5 49523.0 49913.0 14009.6 15458.3 16255.2 16535.0 16597.4 17044.8 17839.7 17871.8 17872.4 17994.7 16074.6 16176.9 16813.1 16905.6 16923.9 13818.9 16426.4 16592.0 16765.8 16856.5 14826.6 14876.1 14977.6 15067.4 15106.8 11425.3 11585.2 11629.2 11744.4 11871.1 13181.2 13260.1 13292.3 13294.8 13314.3 10:07:31 INFO - PID 1636 | -------- Summary: end -------- 10:07:31 INFO - PID 1636 | 10:07:31 INFO - TEST-INFO | 1636: exit 0 10:07:31 INFO - TEST-OK | dromaeo_css | took 1114882ms 10:07:31 INFO - TEST-START | kraken 10:07:31 INFO - operating with platform_type : mac_ 10:07:31 INFO - Initialising browser for kraken test... 10:07:31 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpfNUJuH/profile http://localhost:49233/getInfo.html) 10:07:34 INFO - PID 1649 | 2017-05-02 10:07:34.782 plugin-container[1650:10229] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9237, name = 'com.apple.tsm.portname' 10:07:34 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:07:34 INFO - PID 1649 | 2017-05-02 10:07:34.784 plugin-container[1650:10229] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4317, name = 'com.apple.CFPasteboardClient' 10:07:34 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:07:34 INFO - PID 1649 | 2017-05-02 10:07:34.784 plugin-container[1650:10229] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:07:34 INFO - PID 1649 | __metrics Screen width/height:1600/1200 10:07:34 INFO - PID 1649 | colorDepth:24 10:07:34 INFO - PID 1649 | Browser inner width/height: 1024/689 10:07:34 INFO - PID 1649 | __metrics 10:07:35 INFO - TEST-INFO | 1649: exit 0 10:07:35 INFO - Browser initialized. 10:07:35 INFO - Running cycle 1/1 for kraken test... 10:07:35 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/T/tmpfNUJuH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:38 INFO - PID 1651 | 2017-05-02 10:07:38.018 plugin-container[1652:10355] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x954b, name = 'com.apple.tsm.portname' 10:07:38 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:07:38 INFO - PID 1651 | 2017-05-02 10:07:38.018 plugin-container[1652:10355] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 10:07:38 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 10:07:38 INFO - PID 1651 | 2017-05-02 10:07:38.018 plugin-container[1652:10355] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 10:07:47 INFO - PID 1651 | RSS: Main: 234602496 10:07:47 INFO - PID 1651 | 10:07:50 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49233/tests/kraken/driver.html?testName=audio-beat-detection) 10:07:51 INFO - PID 1651 | RSS: Main: 248012800 10:07:51 INFO - PID 1651 | 10:07:54 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49233/tests/kraken/driver.html?testName=audio-dft) 10:07:54 INFO - PID 1651 | RSS: Main: 256212992 10:07:54 INFO - PID 1651 | 10:07:58 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49233/tests/kraken/driver.html?testName=audio-fft) 10:07:58 INFO - PID 1651 | RSS: Main: 258695168 10:07:58 INFO - PID 1651 | 10:08:00 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49233/tests/kraken/driver.html?testName=audio-oscillator) 10:08:01 INFO - PID 1651 | RSS: Main: 260820992 10:08:01 INFO - PID 1651 | 10:08:03 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49233/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:08:04 INFO - PID 1651 | RSS: Main: 261472256 10:08:04 INFO - PID 1651 | 10:08:06 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49233/tests/kraken/driver.html?testName=imaging-darkroom) 10:08:07 INFO - PID 1651 | RSS: Main: 267563008 10:08:07 INFO - PID 1651 | 10:08:10 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49233/tests/kraken/driver.html?testName=imaging-desaturate) 10:08:11 INFO - PID 1651 | RSS: Main: 268525568 10:08:11 INFO - PID 1651 | 10:08:14 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49233/tests/kraken/driver.html?testName=json-parse-financial) 10:08:15 INFO - PID 1651 | RSS: Main: 267739136 10:08:15 INFO - PID 1651 | 10:08:16 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49233/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:08:17 INFO - PID 1651 | RSS: Main: 267313152 10:08:17 INFO - PID 1651 | 10:08:19 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:08:19 INFO - PID 1651 | RSS: Main: 267382784 10:08:19 INFO - PID 1651 | 10:08:22 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:22 INFO - PID 1651 | RSS: Main: 267067392 10:08:22 INFO - PID 1651 | 10:08:25 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:26 INFO - PID 1651 | RSS: Main: 267214848 10:08:26 INFO - PID 1651 | 10:08:29 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:30 INFO - PID 1651 | RSS: Main: 267354112 10:08:30 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49233/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49233/tests/kraken/driver.html?testName=ai-astar) 10:08:32 INFO - PID 1651 | RSS: Main: 268840960 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | __start_tp_report 10:08:32 INFO - PID 1651 | _x_x_mozilla_page_load 10:08:32 INFO - PID 1651 | _x_x_mozilla_page_load_details 10:08:32 INFO - PID 1651 | |i|pagename|runs| 10:08:32 INFO - PID 1651 | |0;ai-astar;102;115;121;116;117;113;113;115;115;116 10:08:32 INFO - PID 1651 | |1;audio-beat-detection;149;124;110;151;109;110;110;113;152;142 10:08:32 INFO - PID 1651 | |2;audio-dft;183;237;271;222;219;279;277;199;198;202 10:08:32 INFO - PID 1651 | |3;audio-fft;83;60;62;89;65;51;93;50;81;63 10:08:32 INFO - PID 1651 | |4;audio-oscillator;85;69;83;72;72;95;85;70;72;91 10:08:32 INFO - PID 1651 | |5;imaging-gaussian-blur;92;90;89;89;109;95;88;93;95;90 10:08:32 INFO - PID 1651 | |6;imaging-darkroom;97;96;96;138;97;96;97;97;100;117 10:08:32 INFO - PID 1651 | |7;imaging-desaturate;101;90;96;149;91;127;90;93;92;88 10:08:32 INFO - PID 1651 | |8;json-parse-financial;51;50;52;52;52;59;76;73;74;76 10:08:32 INFO - PID 1651 | |9;json-stringify-tinderbox;56;65;61;80;90;87;65;58;59;55 10:08:32 INFO - PID 1651 | |10;stanford-crypto-aes;83;98;79;92;104;105;73;95;103;107 10:08:32 INFO - PID 1651 | |11;stanford-crypto-ccm;124;144;150;138;145;140;144;152;191;137 10:08:32 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;235;187;183;186;185;184;187;227;214;183 10:08:32 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;70;69;69;68;70;79;96;90;90;77 10:08:32 INFO - PID 1651 | __end_tp_report 10:08:32 INFO - PID 1651 | __start_cc_report 10:08:32 INFO - PID 1651 | _x_x_mozilla_cycle_collect,993 10:08:32 INFO - PID 1651 | __end_cc_report 10:08:32 INFO - PID 1651 | __startTimestamp1493744912255__endTimestamp 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | ------- Summary: start ------- 10:08:32 INFO - PID 1651 | Number of tests: 14 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.50 stddev:4.88 (4.2%) stddev-sans-first:2.40 10:08:32 INFO - PID 1651 | Values: 102.0 115.0 121.0 116.0 117.0 113.0 113.0 115.0 115.0 116.0 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:127.00 Median:133.00 stddev:19.17 (14.4%) stddev-sans-first:18.60 10:08:32 INFO - PID 1651 | Values: 149.0 124.0 110.0 151.0 109.0 110.0 110.0 113.0 152.0 142.0 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:228.70 Median:229.50 stddev:35.72 (15.6%) stddev-sans-first:33.85 10:08:32 INFO - PID 1651 | Values: 183.0 237.0 271.0 222.0 219.0 279.0 277.0 199.0 198.0 202.0 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:69.70 Median:73.00 stddev:15.56 (21.3%) stddev-sans-first:15.74 10:08:32 INFO - PID 1651 | Values: 83.0 60.0 62.0 89.0 65.0 51.0 93.0 50.0 81.0 63.0 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:79.40 Median:84.00 stddev:9.51 (11.3%) stddev-sans-first:9.87 10:08:32 INFO - PID 1651 | Values: 85.0 69.0 83.0 72.0 72.0 95.0 85.0 70.0 72.0 91.0 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:93.00 Median:91.00 stddev:6.15 (6.8%) stddev-sans-first:6.51 10:08:32 INFO - PID 1651 | Values: 92.0 90.0 89.0 89.0 109.0 95.0 88.0 93.0 95.0 90.0 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:103.10 Median:96.50 stddev:13.83 (14.3%) stddev-sans-first:14.49 10:08:32 INFO - PID 1651 | Values: 97.0 96.0 96.0 138.0 97.0 96.0 97.0 97.0 100.0 117.0 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:101.70 Median:90.50 stddev:20.16 (22.3%) stddev-sans-first:21.38 10:08:32 INFO - PID 1651 | Values: 101.0 90.0 96.0 149.0 91.0 127.0 90.0 93.0 92.0 88.0 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:66.00 stddev:11.68 (17.7%) stddev-sans-first:11.76 10:08:32 INFO - PID 1651 | Values: 51.0 50.0 52.0 52.0 52.0 59.0 76.0 73.0 74.0 76.0 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:65.00 stddev:13.12 (20.2%) stddev-sans-first:13.22 10:08:32 INFO - PID 1651 | Values: 56.0 65.0 61.0 80.0 90.0 87.0 65.0 58.0 59.0 55.0 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:93.90 Median:81.00 stddev:11.92 (14.7%) stddev-sans-first:11.97 10:08:32 INFO - PID 1651 | Values: 83.0 98.0 79.0 92.0 104.0 105.0 73.0 95.0 103.0 107.0 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:144.50 stddev:17.48 (12.1%) stddev-sans-first:16.53 10:08:32 INFO - PID 1651 | Values: 124.0 144.0 150.0 138.0 145.0 140.0 144.0 152.0 191.0 137.0 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.10 Median:187.00 stddev:20.16 (10.8%) stddev-sans-first:16.06 10:08:32 INFO - PID 1651 | Values: 235.0 187.0 183.0 186.0 185.0 184.0 187.0 227.0 214.0 183.0 10:08:32 INFO - PID 1651 | 10:08:32 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.80 Median:78.00 stddev:10.56 (13.5%) stddev-sans-first:10.82 10:08:32 INFO - PID 1651 | Values: 70.0 69.0 69.0 68.0 70.0 79.0 96.0 90.0 90.0 77.0 10:08:32 INFO - PID 1651 | -------- Summary: end -------- 10:08:32 INFO - PID 1651 | 10:08:33 INFO - TEST-INFO | 1651: exit 0 10:08:33 INFO - TEST-OK | kraken | took 61387ms 10:08:33 INFO - SUITE-END | took 1176s 10:08:33 INFO - Completed test suite (00:19:36) 10:08:33 INFO - javascript benchmark 10:08:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7908.931718113484, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3663.395539735942, 3666.578343490499, 3681.4293784463407, 3707.7219208559363, 3709.2581483703266, 6155.507559395249, 6262.9060564091515, 6275.905861412082, 6369.980803071509, 6382.26603940547, 6246.0, 6252.531060170494, 6273.404026617464, 6367.6497792621385, 6368.808935731924, 5455.672659640434, 5481.808136715215, 5494.615376923617, 5507.284053073095, 5524.66851988882, 5558.555315574744, 5626.54987600993, 5643.520300774439, 5676.574256930726, 5707.828765137032, 4692.953070469286, 5533.00405926933, 5576.219329293902, 5613.915791263134, 5632.239647647577, 5350.117230656937, 5538.778448862041, 5560.77756889724, 5588.580856435743, 5603.327600687943, 5478.58910581704, 5513.972430137864, 5543.085390910495, 5566.916496252559, 5573.8606534836545, 5513.062779327524, 5566.582506312043, 6276.717547710364, 6300.180976473029, 6318.652474113922, 6506.674666266667, 6619.3380661933425, 6780.559263647847, 6818.863622727567, 6834.931650683479, 6865.0732151159955, 6878.071460352839, 6885.449164066863, 6910.689018994158, 6917.550359226634, 6324.241091069009, 6334.018227174795, 6393.6163830170335, 6398.744050237985, 6420.6468644225015, 6798.830029249309, 6922.446204303644, 7023.200043783145, 7047.119110111236, 7056.823579410453, 6563.868722625521, 6634.86730265392, 6676.198856137295, 6683.131192944983, 6709.094272273181, 6890.483213758988, 6898.482613803984, 6899.379055884894, 6908.92911598703, 6910.412614927687, 6541.345865413516, 6737.562058466184, 6748.527603067836, 6789.898151527731, 6850.520463567602, 5795.1017592273265, 6278.905816412666, 6552.9344706553275, 6750.527463077636, 6847.075644787989, 5384.596155288369, 5395.73021348931, 5398.433164517669, 5407.972960135174, 5415.133578627479, 4733.36099626546, 4753.287006948916, 4772.164871147535, 4797.040591881638, 4853.490383509751, 6090.056041313604, 6320.0, 6338.239411270677, 6339.207599050119, 6391.616503009835, 6948.131483564554, 6948.756793512202, 6949.5830250184135, 6964.199117101497, 6973.302669732986, 6394.232692076887, 6411.551191416556, 6419.775307864203, 6428.5178611604315, 6435.774747883802, 5387.649802762808, 5884.588078834526, 6026.0659597762415, 6029.397060293935, 6098.573099882966, 5545.500904918576, 6084.124454299869, 6997.195322537973, 7001.159860816734, 7148.928510714826, 6697.062411262525, 6748.0, 6921.861562768817, 6939.271376505394, 6978.057962175244, 5901.350851406256, 6120.724567394567, 6202.968985155046, 6314.400131987454, 6943.993120997326, 6756.391924726799, 6771.322867713189, 6774.153230846145, 6791.762288319885, 6809.0, 6440.549161558646, 6621.966890165519, 6665.233498147775, 6741.797746067626, 6777.254502004677, 6625.536212465274, 6679.666016699242, 6690.063391125149, 6693.9624358224555, 6711.530192886451, 6659.933400666125, 6665.466762658879, 6671.532992690659, 6674.629312197309, 6700.46396288286, 6286.0, 6401.551891367746, 6433.678316084271, 6470.094186813756, 6520.706568204537, 5610.270664813548, 6631.867362652816, 6666.766663166766, 6687.933120668926, 6701.1623547056615, 6454.935450645434, 6493.383128602775, 6499.6750162492635, 6503.479721622164, 6513.185851768529], "value": 6170.638345958027, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [813.1989989859989, 1153.4982282707024, 1204.7048473124082, 1279.3858947705096, 1304.8956083513315, 36901.81549092254, 37728.43407348892, 37744.0, 37868.43197352042, 37895.810520947394, 37520.249595008085, 37910.620893791056, 37913.43129853048, 37934.43098353527, 38075.23849523015, 8291.378146638996, 8467.449615774955, 8530.317574594017, 8539.914600854005, 8548.70079547216, 8466.957665211665, 8499.0, 8561.0582835888, 8568.785780355478, 8570.700025499109, 8479.788005299855, 8494.320454363637, 8557.529335886555, 8567.485950842938, 8570.828583428327, 7219.675114619855, 8539.914600853974, 8540.78648033798, 8554.52950087745, 8576.742697719079, 8362.749117526484, 8374.748757537283, 8416.537090460022, 8429.915700843036, 8465.703700370519, 36935.445968310494, 37044.259114817556, 37112.88661340137, 37116.257674846354, 37151.81424092889, 3634.27314537091, 3670.3026424979435, 3671.284099600579, 3671.3758661027423, 3681.245344704329, 30585.541216881764, 30587.69412305893, 30675.2331191722, 30698.618562164756, 30708.0, 3122.687731226882, 3167.9683203168133, 3169.429502689515, 3191.9361612767616, 3206.8396580170897, 239383.80308098524, 281504.0, 282830.0, 283401.0, 284232.0, 39455.0, 47323.76338118287, 47847.17222622182, 47962.561123166364, 47990.28014579784, 50134.49865501298, 50233.995320093396, 50286.994260114596, 50471.0, 50517.0, 14244.501442449464, 14365.497207597684, 14411.92794036023, 14419.0, 14476.638084047983, 11608.361540115375, 11636.3600001999, 11783.587574434854, 11789.88210117905, 11811.409429528489, 10882.72793180161, 11062.336259824437, 11732.354720490284, 13520.459181632821, 13539.59381218565, 4916.631252656065, 5921.200637913913, 5921.67430791302, 5933.554983376264, 5938.168656388109, 1017.7252141921788, 1058.7829494953517, 1059.1897198643044, 1103.4979084516526, 1105.3478447715886, 24344.75655243425, 24525.63211551828, 24647.630285545732, 24904.0, 25314.240572782845, 965.4545181972304, 976.9888165748416, 1159.0437888741822, 1189.0903458853984, 1191.2316555821446, 11752.58865939688, 12126.696832579257, 12689.555865544662, 12715.427805748763, 12723.872761272454, 310297.0, 310584.0, 310662.0, 310832.0, 310981.0, 40268.59731402707, 43498.7825060879, 54217.45782542124, 54553.72723136359, 54663.18005229925, 1511.3878879054, 1524.8246451658201, 1558.7350150474447, 1564.233525572484, 1581.264711908945, 20314.492137696674, 21655.0, 21660.241891533722, 23903.521929560964, 24202.51594968126, 39445.60554394534, 39521.60478395294, 39721.0, 39787.60212397839, 39888.40167397433, 268389.0, 269656.0, 270112.49437528435, 270168.0, 270464.0, 35047.47428788519, 35200.29599408049, 35511.28977420489, 36738.0, 36813.63186368102, 44987.0, 45262.0, 45911.0, 46223.76888115538, 46268.537314626425, 30605.387892241586, 30714.0, 31304.0, 31382.686173137976, 31779.52330714995, 30614.0, 30796.53805192969, 31279.0, 31635.36729265448, 31751.206219844687, 29880.22819366583, 37229.62770372262, 37473.62526374702, 37745.62254377421, 37903.62096379111, 29956.700432996262, 30493.54259686062, 30521.694783052775, 31656.36687266288, 31959.520607191374, 23882.880585596962, 24643.137490187757, 24845.378865528506, 24849.1302804401, 25091.114521830223], "value": 17553.223129459297, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.5631112576299, 434.4959846577969, 436.63977218794463, 444.4954976102124, 462.9814807407704, 19556.41330760078, 21188.576228475442, 21658.24196153133, 21801.454963625878, 22118.894055297213, 19549.609007819836, 21161.62449440789, 21921.780782192214, 22372.552548949054, 22452.66321005182, 5010.899782004358, 5056.519630635093, 6174.907376389336, 6223.315435302113, 6224.906626400585, 5084.2373643953515, 6007.669578173199, 6279.0581412788215, 6302.527310451712, 6326.715297811609, 6085.513158947274, 6284.968575157118, 6286.182796236506, 6298.559100862942, 6300.7794727184555, 6174.969125154368, 6275.811725648238, 6283.0, 6288.3082860885725, 6303.0, 5482.972585137089, 5549.278593782782, 5613.66318020916, 5618.85952851182, 5646.322441307028, 27627.585586216224, 28173.718262817314, 28424.14727558156, 28814.135575932756, 28911.56632650512, 2185.1259496201487, 2187.147012665062, 2248.3704562722464, 2253.853499522526, 2260.08466571039, 17932.0, 18014.819851801447, 18050.4584862453, 18623.97568133752, 18719.438416847515, 2166.3392665237097, 2173.8260939124834, 2217.079911836586, 2220.589190999654, 2222.288867562381, 164627.0, 166743.0, 167229.16385418116, 168143.0, 168261.0, 11581.88418115808, 12622.305773182563, 12813.103082784115, 12884.80672789909, 13005.154664946747, 16399.91800041016, 16538.751918721227, 16573.0, 16577.751333730004, 16585.25366358517, 8774.166454186841, 9106.635734570544, 9125.133112354315, 9268.497505673566, 9292.72121836346, 8724.302055835518, 8730.039695633475, 8813.647454101892, 8929.241014513838, 8957.014728379872, 7916.920830791733, 8014.15851335613, 8014.519128852287, 8041.236082572146, 8099.757007289791, 2098.1712223671566, 2156.784321567831, 2180.705604743371, 2195.7145571075657, 2197.0662468451164, 909.727081875448, 918.5177781664679, 970.1414248390225, 976.1653786012856, 982.0457289993005, 19293.0, 20104.698429523276, 20801.895990520254, 20855.8957205213, 21058.684119738216, 895.6506962284584, 1006.864073350103, 1030.9896901031043, 1035.9015893490257, 1039.7712503249272, 10381.532831022621, 10571.418571978615, 10667.466626668636, 10681.412522311348, 10734.141268698486, 482171.0, 538383.0, 550002.0, 559336.0, 560581.0, 103244.0, 109028.0, 123204.0, 124553.0, 126013.0, 1010.7473131717071, 1192.8568571771443, 1221.0536833953756, 1228.2200802490484, 1231.199720181889, 16846.66306673884, 17807.643847123243, 17839.018853963156, 17965.0, 18148.909255454168, 54704.90590188094, 55490.72254638863, 55714.72142639261, 56091.15863261973, 56614.71692641675, 57233.0, 57604.847903042544, 58587.0, 62208.534975803195, 75308.62345688237, 8436.32509399259, 8747.387682862138, 8841.292696584129, 8954.552272386225, 9242.953785231031, 13796.931015344859, 14417.567472975827, 14554.636134096732, 14575.927120364331, 14784.0, 11952.957592066508, 12136.029117670741, 12211.511539538675, 12252.019838412727, 12310.692232694255, 11548.769024619292, 11603.593874214363, 11658.242214256046, 11906.821397679216, 11950.282983021047, 11313.094952403624, 12399.94600458971, 12428.005759539396, 12450.0, 12538.247705137721, 8471.576421178794, 8640.703894415636, 8773.0, 8971.282297416321, 9173.312001599774, 10059.748506287402, 11345.943270283597, 12201.0, 12297.692557686129, 12306.630801075982], "value": 10396.575130264697, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1243.97512049759, 1316.6050184944513, 1322.7896474725621, 1482.1922052481395, 1490.932908019139, 11353.886461135386, 11854.288742675435, 11886.7622647547, 11889.048876089913, 12214.816777748341, 11888.346140962243, 12044.81932771009, 12070.215435996675, 12073.154879158463, 12089.758204835898, 2536.251805717318, 2566.486702659466, 2573.3566608347915, 2579.0328626764963, 2582.328594565417, 2133.8506304558687, 2498.1256560203965, 2535.8351707138977, 2538.1750930947514, 2554.9397000244876, 2499.850008999457, 2516.7609077137645, 2551.1963731424544, 2552.7064387595387, 2555.654986576816, 2123.182574708733, 2138.2088627207954, 2476.158106243877, 2499.46261553765, 2531.5569775289437, 2450.154696629678, 2531.8227724059325, 2533.9746602534105, 2538.4161642822255, 2557.7825884799813, 10005.199584033333, 10065.798684026351, 11765.352905590189, 11879.406029698566, 11933.582324618597, 6592.307807680172, 6811.318868113149, 6843.486738494633, 6845.555038922504, 6850.794476165723, 4027.677785777131, 4319.978400108011, 4406.030673251879, 4406.581374769392, 4420.093880754438, 1269.8984081273477, 1271.5168236070326, 1286.7812471879708, 1317.038561849855, 1317.1241124652095, 13710.862891371058, 15981.44064957721, 16546.172691365384, 16583.419580314632, 16639.584010399714, 5527.723613819293, 5545.223668686387, 5718.170865224519, 5720.256366672306, 5780.826575202751, 9955.50222488887, 11875.940620297017, 11951.92432681063, 11964.58123965657, 11967.521299147937, 6621.635810030398, 6625.701843417058, 6629.86740265192, 6638.767643132467, 6647.501437392215, 6028.698565071729, 6102.115193296947, 6219.47134493564, 6255.530835187379, 6287.811365659038, 4291.399204111427, 4453.421055262795, 4486.1252055849445, 4511.729296242236, 4530.320451932236, 1252.7431876465484, 1268.6828292926768, 1269.8666640002853, 1281.1096288079696, 1285.3573213393304, 798.141997352848, 812.8333691593209, 835.6406745099544, 839.9328053755685, 864.1703964194318, 6189.597676151036, 6201.96899015502, 6328.6202827830475, 6361.713722882481, 6405.775797847053, 595.9314678811905, 599.9400059993966, 609.9908501372483, 619.8791235708993, 629.4209327418786, 3910.921781564353, 4016.3975403689096, 4389.62688171509, 4502.414686090853, 4575.970406658475, 14469.421223150955, 14636.560903172922, 15009.849901501064, 15110.622234444007, 15141.470048548248, 14472.565823025116, 14824.258787060604, 15010.0, 15012.624684382978, 15048.623784405478, 7293.598852063187, 8490.533020683923, 8728.738137855875, 8730.86903696445, 8745.693900713444, 6309.90535141964, 6573.498964803412, 6842.213145488134, 7168.784936451915, 7190.101237345332, 11891.643250702493, 12426.937865310978, 12799.936000319938, 12844.743105137659, 12906.870931290567, 12857.03572232105, 12896.161749486253, 12963.0, 13035.739285214433, 13132.080754347104, 9264.258859291376, 9407.858882116638, 9601.135897768954, 9608.75978100553, 9655.662051828152, 11134.27627204229, 11282.887171128184, 11290.209685322277, 11307.491162897853, 11317.660470185907, 9029.097090290918, 9230.861537077084, 9305.581248843953, 9404.38871473352, 9424.811503770023, 7415.8887616684715, 7619.161892191743, 8037.598120094089, 9017.413868098552, 9352.953235233781, 7525.134609519975, 8097.554634495159, 8379.120192379713, 8457.915420845959, 8474.576271186539, 6087.208662873798, 6180.536459765445, 6275.5607107503865, 6292.622442653455, 6358.364163583605, 6038.547108966933, 6165.290991536031, 6328.145700330397, 6328.7342531494805, 6361.14124593174], "value": 5324.608241017026, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3910773208999, 392.2860394082771, 416.17597157627887, 417.3909578574597, 422.92175947449704, 6329.905051424233, 6394.552381333308, 6464.083430729116, 6471.805845824632, 6518.54370194086, 6184.226971628546, 6283.654399008053, 6309.1482649842255, 6314.579219675571, 6316.810495685137, 3917.196974620196, 4000.4599379083743, 4478.865634030984, 4544.954550454486, 4579.129965306581, 4343.891402714926, 4551.635869130479, 4553.635709143261, 4584.724916505021, 4591.196540605398, 4158.6465150462245, 4495.483019452772, 4502.189605870942, 4523.977380113095, 4530.411046563942, 4163.292240319122, 4193.077522944947, 4463.375127482155, 4530.983712248051, 4558.635309175258, 3806.3909774435956, 3859.903502412434, 3872.9225415491533, 3886.6696330811915, 3890.5720370759195, 6160.599561028519, 6165.568410211287, 6166.0, 6171.7531298748, 6190.938090619081, 5443.1835224716215, 5462.306684927685, 5464.972675136639, 5467.289252397163, 5493.0, 5860.941390586082, 6637.435817955479, 6676.799696009079, 6827.112475378169, 6853.348931851466, 3903.609639036102, 4340.08858139791, 4415.66882483815, 4424.137293227822, 4455.955440445587, 6153.84615384619, 6571.751367240209, 7047.506674532733, 7241.601711905843, 7261.310175533369, 4143.901866005511, 4437.955620443819, 4458.4426946631675, 4460.464744230713, 4482.955170448319, 3994.4807175067053, 4514.45826500822, 4561.0, 4577.359169716243, 4610.216263235258, 5221.6344855859725, 5400.027994960867, 5458.4541545845095, 5463.72681365938, 5469.56243500519, 6255.718492667841, 6813.454923606099, 6821.658917054127, 6833.214180369222, 6850.554713943678, 1490.5690537084304, 1520.1639098495782, 1531.7702344648392, 1557.3069983857301, 1561.6486290584755, 996.496769131584, 1001.0890090018194, 1001.8447140693058, 1003.6286573967678, 1011.2819897872592, 6420.486361091102, 6433.0, 6437.195350581177, 6466.644334561644, 6478.611283323015, 5973.940260597426, 6389.5846769960735, 7049.506534542636, 7056.682449289794, 7062.258462861429, 6156.353582873823, 6414.198225221848, 6461.127747753993, 6461.415433826413, 6462.676866156673, 3617.2584620152807, 3643.7995910224663, 3673.7061035117126, 3706.8887933362043, 3726.7018638508853, 6155.138280640714, 7215.927840721631, 7245.456590755714, 7300.890486642705, 7303.269673032654, 5130.153524668388, 6201.937980620226, 6213.347598502182, 6716.406722403491, 7201.451687887129, 5481.369642491165, 6308.990561510228, 6730.360615741497, 7137.250588688321, 7211.495195336276, 6407.807765767035, 6963.2340442552295, 7001.649917504206, 7043.605174240783, 7095.645217738989, 6914.654267286515, 6934.306569343025, 6975.0, 6992.405645520188, 7016.719331226898, 6275.023367639179, 7234.6020968847215, 7272.073080536451, 7389.408847292097, 7401.59291238987, 4777.617790576676, 4863.732494712684, 4978.477259887804, 5124.385073791169, 5133.0, 6259.96870015647, 6516.924707423412, 7141.392981596622, 7167.498275120692, 7198.316159964795, 6095.902737507291, 6137.84655383619, 6286.145587051922, 6535.954247320406, 6795.7961261162245, 5879.7060146993335, 6083.27000759894, 6203.286622038523, 6879.0, 6898.241193468814, 5197.506236907488, 5878.2358293421585, 6542.509311801538, 6627.9337206627315, 6648.501362397743, 5709.65742055478, 6806.965965170142, 6829.0, 6851.417629501549, 6882.8967565485555, 5225.6603320784025, 6386.680665966776, 6609.735610575523, 6641.302663220292, 6673.899891501728], "value": 4883.581296293953, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [842.2714352085447, 848.5460278750868, 855.6064210463187, 874.1826392323178, 894.6510860764301, 16357.75463368049, 16725.414610488635, 16801.075940823266, 18372.816271837277, 19111.426657200307, 15267.770983435257, 17736.733948990775, 18223.27106915725, 18286.908565457154, 18645.0, 997.306871724152, 1002.8044531316397, 1031.6647089695841, 1035.1718625099927, 1041.4740556019199, 1012.7974405118969, 1021.1116328793922, 1024.5491983527224, 1026.1329176845554, 1030.1655658916302, 1084.0243780597445, 1085.7448499602588, 1089.1776708585007, 1091.6561283195808, 1095.2333366643343, 1078.0620859851902, 1080.2600218850073, 1082.5453309609943, 1084.2139448899563, 1088.216484131424, 766.7891329884327, 782.2998416417331, 790.7785819970418, 798.9800254993613, 800.7357572001225, 16691.83308166915, 16803.91598042014, 16837.663246734995, 16998.575035624086, 17000.57498562546, 17089.658206835793, 17171.055591942437, 17467.388641397618, 17563.824361756346, 17681.911590442094, 13926.09480383782, 14072.71854562903, 14191.574252772434, 14342.569722908225, 14343.28283585827, 3453.8445769940413, 3510.2452972611013, 3515.5078289039557, 3519.1554027033585, 3526.770759900624, 87407.56296218542, 105535.4723226379, 129781.0, 130159.0, 131218.0, 13419.060665753499, 13717.657058573415, 13736.244506552235, 13759.0, 13764.793528097087, 24936.875315623667, 25714.228573142835, 25855.836487358116, 26228.60657090145, 26302.736972630028, 7976.242256985577, 8073.798155046054, 8084.434089613788, 8085.110637829834, 8095.83808323842, 3609.0796846803896, 3657.524521812147, 3663.19409729859, 3667.3582123128344, 3687.1335236219466, 4190.224808410393, 4373.934390984138, 4393.978030109829, 4402.207602631493, 4413.492448368414, 915.3455279475207, 928.5960607135918, 962.9518524073908, 963.017721923634, 965.0831709875646, 582.9856050472148, 658.2956236826645, 660.1220376898713, 664.9800505984829, 690.7133539581118, 11219.495122719498, 11628.94185529067, 11873.168878178618, 12149.635510934686, 12212.0, 613.9171211886428, 643.6009674002148, 659.5020759326677, 661.1009027722293, 662.1888186971019, 5525.778968841281, 5632.464915832989, 5648.068068768689, 5701.629394089371, 5714.200011998323, 96929.0, 104862.0, 113678.0, 114321.0, 116001.0, 81126.0, 83398.332033359, 84247.26021918355, 97687.0, 101595.0, 76103.0, 76643.23356766472, 77130.6143469279, 77839.832402514, 78325.0, 12273.447694853574, 12873.871261287268, 12896.226226426445, 12901.225926444444, 12914.160579562298, 38743.675379477325, 39185.804070979466, 39229.60770392259, 40002.39996399998, 40862.18275634411, 35507.401311700305, 37619.811900941415, 48966.51033489619, 49523.0, 49913.0, 14009.579712608638, 15458.304376303318, 16255.187240637684, 16535.0, 16597.41909033178, 17044.829551704323, 17839.73240401421, 17871.821281787536, 17872.374466893598, 17994.730079049088, 16074.598135046717, 16176.94849834757, 16813.07528085967, 16905.577360566083, 16923.91538042302, 13818.930905345409, 16426.42507512231, 16592.004479731255, 16765.83234167643, 16856.494305170865, 14826.555203343916, 14876.107433554022, 14977.550673479813, 15067.397304107713, 15106.773398398813, 11425.31448113116, 11585.246958947642, 11629.18595698293, 11744.412779360828, 11871.050315974873, 13181.209127452383, 13260.138091024053, 13292.268925209206, 13294.800577991144, 13314.267715275753], "value": 8357.44903306948, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1561.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 121.0, 116.0, 117.0, 113.0, 113.0, 115.0, 115.0, 116.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 110.0, 151.0, 109.0, 110.0, 110.0, 113.0, 152.0, 142.0], "value": 127.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 237.0, 271.0, 222.0, 219.0, 279.0, 277.0, 199.0, 198.0, 202.0], "value": 228.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 62.0, 89.0, 65.0, 51.0, 93.0, 50.0, 81.0, 63.0], "value": 69.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 83.0, 72.0, 72.0, 95.0, 85.0, 70.0, 72.0, 91.0], "value": 79.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 89.0, 89.0, 109.0, 95.0, 88.0, 93.0, 95.0, 90.0], "value": 93.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 138.0, 97.0, 96.0, 97.0, 97.0, 100.0, 117.0], "value": 103.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 90.0, 96.0, 149.0, 91.0, 127.0, 90.0, 93.0, 92.0, 88.0], "value": 101.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 52.0, 52.0, 52.0, 59.0, 76.0, 73.0, 74.0, 76.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 65.0, 61.0, 80.0, 90.0, 87.0, 65.0, 58.0, 59.0, 55.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 98.0, 79.0, 92.0, 104.0, 105.0, 73.0, 95.0, 103.0, 107.0], "value": 93.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 144.0, 150.0, 138.0, 145.0, 140.0, 144.0, 152.0, 191.0, 137.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [235.0, 187.0, 183.0, 186.0, 185.0, 184.0, 187.0, 227.0, 214.0, 183.0], "value": 197.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 68.0, 70.0, 79.0, 96.0, 90.0, 90.0, 77.0], "value": 77.8, "unit": "score"}]}]} 10:08:33 INFO - Return code: 0 10:08:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:08:33 ERROR - # TBPL SUCCESS # 10:08:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:08:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:08:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:08:33 INFO - 2017-05-02 10:08:33.620 screenresolution[1657:10754] starting screenresolution argv=screenresolution get 10:08:33 INFO - 2017-05-02 10:08:33.622 screenresolution[1657:10754] Display 0: 1600x1200x32@60 10:08:33 INFO - 2017-05-02 10:08:33.629 screenresolution[1658:10757] starting screenresolution argv=screenresolution list 10:08:33 INFO - Available Modes on Display 0 10:08:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:08:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:08:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:08:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:08:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:08:33 INFO - Intel Iris: 10:08:33 INFO - Chipset Model: Intel Iris 10:08:33 INFO - Type: GPU 10:08:33 INFO - Bus: Built-In 10:08:33 INFO - VRAM (Dynamic, Max): 1536 MB 10:08:33 INFO - Vendor: Intel (0x8086) 10:08:33 INFO - Device ID: 0x0a2e 10:08:33 INFO - Revision ID: 0x0009 10:08:33 INFO - Displays: 10:08:33 INFO - Display: 10:08:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:08:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:08:33 INFO - Display Serial Number: 1600x1200 60 10:08:33 INFO - Main Display: Yes 10:08:33 INFO - Mirror: Off 10:08:33 INFO - Online: Yes 10:08:33 INFO - Rotation: Supported 10:08:33 INFO - Return code: 0 10:08:33 INFO - Running post-action listener: _resource_record_post_action 10:08:33 INFO - [mozharness: 2017-05-02 17:08:33.874134Z] Finished run-tests step (success) 10:08:33 INFO - Running post-run listener: _resource_record_post_run 10:08:33 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 41479168; Write bytes: 514164224; Read time: 415; Write time: 1594 10:08:33 INFO - TinderboxPrint: CPU usage
54.2% 10:08:33 INFO - TinderboxPrint: I/O read bytes / time
41,479,168 / 415 10:08:33 INFO - TinderboxPrint: I/O write bytes / time
514,164,224 / 1,594 10:08:33 INFO - TinderboxPrint: CPU idle
2,194.0 (45.8%) 10:08:33 INFO - TinderboxPrint: CPU system
964.7 (20.1%) 10:08:33 INFO - TinderboxPrint: CPU user
1,630.8 (34.0%) 10:08:33 INFO - TinderboxPrint: Swap in / out
248,979,456 / 0 10:08:33 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208130560; Write bytes: 206005760; Read time: 16065; Write time: 433 10:08:33 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36391936; Write bytes: 300933120; Read time: 374; Write time: 1129 10:08:34 INFO - Running post-run listener: _upload_blobber_files 10:08:34 INFO - Blob upload gear active. 10:08:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:08:34 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 10:08:34 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'] 10:08:34 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 10:08:34 INFO - (blobuploader) - INFO - Open directory for files ... 10:08:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:08:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:08:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:35 INFO - (blobuploader) - INFO - Done attempting. 10:08:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:08:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:08:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:36 INFO - (blobuploader) - INFO - Done attempting. 10:08:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:08:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:08:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:38 INFO - (blobuploader) - INFO - Done attempting. 10:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:08:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:40 INFO - (blobuploader) - INFO - Done attempting. 10:08:40 INFO - (blobuploader) - INFO - Iteration through files over. 10:08:40 INFO - Return code: 0 10:08:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:08:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:08:40 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19ab0e4e8bb21af20909c78907cd99ccbe43b575ecc774761e3c5c6aeee0f2f5d1579b98b6062438dfb70895caa44ee7a4a6e9819de8df08e1e1956dca1f4a6d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5c01ed06b01a819aec46d3e00d94d244d38dc7e06bfea235cadc83b554ff2b3652733cf5d553ffa7dce035fb2033331912ed2288e24ea6ed85f50609f22ead4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cc8b823f95a3bf45edc858390afdfbed70fe484bae276509dd0931353e40aa43f74fdc06284c79a3d29fe15a5e21e3b66c26a87464e510778b9d6890913fe2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d6345de0605aa303cb2c21914f7e3a29d6842afae1e504999bcef4d865df211491a08201b2dfbcf9a2a7b32ab339d453dfae485d5d65080ae34dd275aedd2f7"} 10:08:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:08:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:08:40 INFO - Contents: 10:08:40 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19ab0e4e8bb21af20909c78907cd99ccbe43b575ecc774761e3c5c6aeee0f2f5d1579b98b6062438dfb70895caa44ee7a4a6e9819de8df08e1e1956dca1f4a6d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5c01ed06b01a819aec46d3e00d94d244d38dc7e06bfea235cadc83b554ff2b3652733cf5d553ffa7dce035fb2033331912ed2288e24ea6ed85f50609f22ead4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cc8b823f95a3bf45edc858390afdfbed70fe484bae276509dd0931353e40aa43f74fdc06284c79a3d29fe15a5e21e3b66c26a87464e510778b9d6890913fe2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d6345de0605aa303cb2c21914f7e3a29d6842afae1e504999bcef4d865df211491a08201b2dfbcf9a2a7b32ab339d453dfae485d5d65080ae34dd275aedd2f7"} 10:08:40 INFO - Running post-run listener: copy_logs_to_upload_dir 10:08:40 INFO - Copying logs to upload dir... 10:08:40 INFO - mkdir: /builds/slave/test/build/upload/logs 10:08:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.756391 ========= master_lag: -0.02 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-05-02 10:08:40.333263) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 10:08:40.336736) ========= 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.BllhYNqU7i/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.8q3jxm0YqO/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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/19ab0e4e8bb21af20909c78907cd99ccbe43b575ecc774761e3c5c6aeee0f2f5d1579b98b6062438dfb70895caa44ee7a4a6e9819de8df08e1e1956dca1f4a6d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5c01ed06b01a819aec46d3e00d94d244d38dc7e06bfea235cadc83b554ff2b3652733cf5d553ffa7dce035fb2033331912ed2288e24ea6ed85f50609f22ead4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cc8b823f95a3bf45edc858390afdfbed70fe484bae276509dd0931353e40aa43f74fdc06284c79a3d29fe15a5e21e3b66c26a87464e510778b9d6890913fe2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d6345de0605aa303cb2c21914f7e3a29d6842afae1e504999bcef4d865df211491a08201b2dfbcf9a2a7b32ab339d453dfae485d5d65080ae34dd275aedd2f7"} build_url:https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010964 build_url: 'https://queue.taskcluster.net/v1/task/EWxko7yyQKGJH51u213Nzw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/19ab0e4e8bb21af20909c78907cd99ccbe43b575ecc774761e3c5c6aeee0f2f5d1579b98b6062438dfb70895caa44ee7a4a6e9819de8df08e1e1956dca1f4a6d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5c01ed06b01a819aec46d3e00d94d244d38dc7e06bfea235cadc83b554ff2b3652733cf5d553ffa7dce035fb2033331912ed2288e24ea6ed85f50609f22ead4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7cc8b823f95a3bf45edc858390afdfbed70fe484bae276509dd0931353e40aa43f74fdc06284c79a3d29fe15a5e21e3b66c26a87464e510778b9d6890913fe2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0d6345de0605aa303cb2c21914f7e3a29d6842afae1e504999bcef4d865df211491a08201b2dfbcf9a2a7b32ab339d453dfae485d5d65080ae34dd275aedd2f7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-02 10:08:40.371012) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 10:08:40.371295) ========= 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.BllhYNqU7i/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.8q3jxm0YqO/Listeners TMPDIR=/var/folders/q8/1vnm3qf56qs7z6b9j3w0gwl800000w/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.005085 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-02 10:08:40.420196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 10:08:40.420501) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-02 10:08:40.420804) ========= ========= Total master_lag: 0.12 =========