builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0173 starttime: 1488464908.06 results: success (0) buildid: 20170302050322 builduid: 0987379bc2814ae0af968f2a3b71164c revision: 66535e831760421b270662aa8d0773b0fde7c9f3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 06:28:28.063327) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 06:28:28.063756) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 06:28:28.064082) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 06:28:28.091256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 06:28:28.091612) ========= 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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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-03-02 06:28:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 70.0M=0s 2017-03-02 06:28:28 (70.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130884 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 06:28:28.247223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 06:28:28.247535) ========= 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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.039659 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 06:28:28.310993) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-02 06:28:28.311344) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 66535e831760421b270662aa8d0773b0fde7c9f3 --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 66535e831760421b270662aa8d0773b0fde7c9f3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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-03-02 06:28:28,413 truncating revision to first 12 chars 2017-03-02 06:28:28,413 Setting DEBUG logging. 2017-03-02 06:28:28,413 attempt 1/10 2017-03-02 06:28:28,413 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/66535e831760?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-02 06:28:30,456 unpacking tar archive at: mozilla-central-66535e831760/testing/mozharness/ program finished with exit code 0 elapsedTime=2.306459 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-02 06:28:30.641880) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 06:28:30.642196) ========= script_repo_revision: 66535e831760421b270662aa8d0773b0fde7c9f3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 06:28:30.642586) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 06:28:30.642860) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 06:28:30.662748) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-02 06:28:30.663108) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 06:28:30 INFO - MultiFileLogger online at 20170302 06:28:30 in /builds/slave/test 06:28:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 06:28:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:28:30 INFO - {'append_to_log': False, 06:28:30 INFO - 'base_work_dir': '/builds/slave/test', 06:28:30 INFO - 'blob_upload_branch': 'Firefox', 06:28:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:28:30 INFO - 'branch': 'Firefox', 06:28:30 INFO - 'buildbot_json_path': 'buildprops.json', 06:28:30 INFO - 'config_files': ('talos/mac_config.py',), 06:28:30 INFO - 'default_actions': ('clobber', 06:28:30 INFO - 'read-buildbot-config', 06:28:30 INFO - 'download-and-extract', 06:28:30 INFO - 'populate-webroot', 06:28:30 INFO - 'create-virtualenv', 06:28:30 INFO - 'install', 06:28:30 INFO - 'run-tests'), 06:28:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:28:30 INFO - 'download_minidump_stackwalk': True, 06:28:30 INFO - 'download_symbols': 'ondemand', 06:28:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:28:30 INFO - 'tooltool.py': '/tools/tooltool.py', 06:28:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:28:30 INFO - '/tools/misc-python/virtualenv.py')}, 06:28:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:28:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:28:30 INFO - 'gecko_profile': False, 06:28:30 INFO - 'gecko_profile_interval': 0, 06:28:30 INFO - 'installer_path': 'installer.exe', 06:28:30 INFO - 'log_level': 'info', 06:28:30 INFO - 'log_name': 'talos', 06:28:30 INFO - 'log_to_console': True, 06:28:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:28:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:28:30 INFO - 'opt_config_files': (), 06:28:30 INFO - 'pip_index': False, 06:28:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:28:30 INFO - 'cmd': ('bash', 06:28:30 INFO - '-c', 06:28:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:28:30 INFO - 'enabled': True, 06:28:30 INFO - 'halt_on_failure': False, 06:28:30 INFO - 'name': 'check_screen_resolution'},), 06:28:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:28:30 INFO - 'cmd': ('bash', 06:28:30 INFO - '-c', 06:28:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:28:30 INFO - 'enabled': True, 06:28:30 INFO - 'halt_on_failure': False, 06:28:30 INFO - 'name': 'check_screen_resolution'},), 06:28:30 INFO - 'run_cmd_checks_enabled': True, 06:28:30 INFO - 'suite': 'dromaeojs', 06:28:30 INFO - 'system_bits': '32', 06:28:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:28:30 INFO - 'title': 't-yosemite-r7-0173', 06:28:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:28:30 INFO - 'use_talos_json': True, 06:28:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:28:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:28:30 INFO - 'work_dir': 'build'} 06:28:30 INFO - [mozharness: 2017-03-02 14:28:30.875212Z] Running clobber step. 06:28:30 INFO - Running pre-action listener: _resource_record_pre_action 06:28:30 INFO - Running main action method: clobber 06:28:30 INFO - rmtree: /builds/slave/test/build 06:28:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:28:33 INFO - Running post-action listener: _resource_record_post_action 06:28:33 INFO - [mozharness: 2017-03-02 14:28:33.971529Z] Finished clobber step (success) 06:28:33 INFO - [mozharness: 2017-03-02 14:28:33.971683Z] Running read-buildbot-config step. 06:28:33 INFO - Running pre-action listener: _resource_record_pre_action 06:28:33 INFO - Running main action method: read_buildbot_config 06:28:33 INFO - Using buildbot properties: 06:28:33 INFO - { 06:28:33 INFO - "project": "", 06:28:33 INFO - "product": "firefox", 06:28:33 INFO - "script_repo_revision": "production", 06:28:33 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 06:28:33 INFO - "repository": "", 06:28:33 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 06:28:33 INFO - "buildid": "20170302050322", 06:28:33 INFO - "pgo_build": "False", 06:28:33 INFO - "basedir": "/builds/slave/test", 06:28:33 INFO - "buildnumber": 0, 06:28:33 INFO - "slavename": "t-yosemite-r7-0173", 06:28:33 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:28:33 INFO - "platform": "yosemite_r7", 06:28:33 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 06:28:33 INFO - "branch": "mozilla-central", 06:28:33 INFO - "repo_path": "mozilla-central", 06:28:33 INFO - "revision": "66535e831760421b270662aa8d0773b0fde7c9f3", 06:28:33 INFO - "stage_platform": "macosx64", 06:28:33 INFO - "builduid": "0987379bc2814ae0af968f2a3b71164c", 06:28:33 INFO - "slavebuilddir": "test" 06:28:33 INFO - } 06:28:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 06:28:33 INFO - Running post-action listener: _resource_record_post_action 06:28:33 INFO - [mozharness: 2017-03-02 14:28:33.975048Z] Finished read-buildbot-config step (success) 06:28:33 INFO - [mozharness: 2017-03-02 14:28:33.975163Z] Running download-and-extract step. 06:28:33 INFO - Running pre-action listener: _resource_record_pre_action 06:28:33 INFO - Running main action method: download_and_extract 06:28:33 INFO - mkdir: /builds/slave/test/build/tests 06:28:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:28:33 INFO - trying https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 06:28:33 INFO - Downloading https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 06:28:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 06:28:35 INFO - Downloaded 1199 bytes. 06:28:35 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 06:28:35 INFO - Using the following test package requirements: 06:28:35 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 06:28:35 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 06:28:35 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 06:28:35 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 06:28:35 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 06:28:35 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 06:28:35 INFO - u'jsshell-mac.zip'], 06:28:35 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 06:28:35 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 06:28:35 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 06:28:35 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 06:28:35 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 06:28:35 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 06:28:35 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 06:28:35 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 06:28:35 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 06:28:35 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 06:28:35 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 06:28:35 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:28:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 06:28:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:28:35 INFO - Fetch https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 06:28:36 INFO - Expected file size: 51768375 06:28:36 INFO - Obtained file size: 51768375 06:28:53 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 06:28:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 06:28:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:28:53 INFO - Fetch https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 06:28:54 INFO - Expected file size: 51768375 06:28:54 INFO - Obtained file size: 51768375 06:29:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 06:29:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:29:10 INFO - Fetch https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 06:29:11 INFO - Expected file size: 14404424 06:29:11 INFO - Obtained file size: 14404424 06:29: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')]} 06:29:12 INFO - trying https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 06:29:12 INFO - Downloading https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 06:29:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 06:29:14 INFO - Downloaded 75025757 bytes. 06:29:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 06:29:14 INFO - mkdir: /builds/slave/test/properties 06:29:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:29:14 INFO - Writing to file /builds/slave/test/properties/build_url 06:29:14 INFO - Contents: 06:29:14 INFO - build_url:https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 06:29:15 INFO - Running post-action listener: _resource_record_post_action 06:29:15 INFO - Running post-action listener: set_extra_try_arguments 06:29:15 INFO - [mozharness: 2017-03-02 14:29:15.079235Z] Finished download-and-extract step (success) 06:29:15 INFO - [mozharness: 2017-03-02 14:29:15.079382Z] Running populate-webroot step. 06:29:15 INFO - Running pre-action listener: _resource_record_pre_action 06:29:15 INFO - Running main action method: populate_webroot 06:29:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:29:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:29:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:29:15 INFO - '--tppagecycles', 06:29:15 INFO - '7'], 06:29:15 INFO - 'tests': ['tsvgm']}}, 06:29:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:29:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:29:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:29:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:29:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:29:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:29:15 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:29:15 INFO - 'talos_options': ['--disable-e10s'], 06:29:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:29:15 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:29:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:29:15 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:29:15 INFO - 'talos_options': ['--disable-e10s'], 06:29:15 INFO - 'tests': ['damp', 'tps']}, 06:29:15 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:29:15 INFO - 'tests': ['damp', 'tps']}, 06:29:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:29:15 INFO - 'tests': ['dromaeo_dom']}, 06:29:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:29:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:29:15 INFO - 'tests': ['basic_compositor_video']}, 06:29:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:29:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:29:15 INFO - 'tests': ['a11yr', 06:29:15 INFO - 'ts_paint', 06:29:15 INFO - 'tpaint', 06:29:15 INFO - 'sessionrestore', 06:29:15 INFO - 'sessionrestore_no_auto_restore', 06:29:15 INFO - 'tabpaint']}, 06:29:15 INFO - 'other-e10s': {'tests': ['a11yr', 06:29:15 INFO - 'ts_paint', 06:29:15 INFO - 'tpaint', 06:29:15 INFO - 'sessionrestore', 06:29:15 INFO - 'sessionrestore_no_auto_restore', 06:29:15 INFO - 'tabpaint']}, 06:29:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:29:15 INFO - 'ts_paint', 06:29:15 INFO - 'tpaint', 06:29:15 INFO - 'sessionrestore', 06:29:15 INFO - 'sessionrestore_no_auto_restore', 06:29:15 INFO - 'tabpaint']}, 06:29:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:29:15 INFO - 'ts_paint', 06:29:15 INFO - 'tpaint', 06:29:15 INFO - 'sessionrestore', 06:29:15 INFO - 'sessionrestore_no_auto_restore', 06:29:15 INFO - 'tabpaint']}, 06:29:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:29:15 INFO - 'tests': ['a11yr', 06:29:15 INFO - 'ts_paint', 06:29:15 INFO - 'tpaint', 06:29:15 INFO - 'sessionrestore', 06:29:15 INFO - 'sessionrestore_no_auto_restore', 06:29:15 INFO - 'tabpaint']}, 06:29:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:29:15 INFO - 'tests': ['a11yr', 06:29:15 INFO - 'ts_paint', 06:29:15 INFO - 'tpaint', 06:29:15 INFO - 'sessionrestore', 06:29:15 INFO - 'sessionrestore_no_auto_restore', 06:29:15 INFO - 'tabpaint']}, 06:29:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:29:15 INFO - 'tests': ['tsvgx', 06:29:15 INFO - 'tsvgr_opacity', 06:29:15 INFO - 'tart', 06:29:15 INFO - 'tscrollx', 06:29:15 INFO - 'cart', 06:29:15 INFO - 'tsvg_static']}, 06:29:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:29:15 INFO - 'tsvgr_opacity', 06:29:15 INFO - 'tart', 06:29:15 INFO - 'tscrollx', 06:29:15 INFO - 'cart', 06:29:15 INFO - 'tsvg_static']}, 06:29:15 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:29:15 INFO - 'talos_options': ['--disable-e10s'], 06:29:15 INFO - 'tests': ['tp5o']}, 06:29:15 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:29:15 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:29:15 INFO - 'talos_options': ['--disable-e10s', 06:29:15 INFO - '--xperf_path', 06:29:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:29:15 INFO - 'tests': ['tp5n']}, 06:29:15 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:29:15 INFO - 'talos_options': ['--xperf_path', 06:29:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:29:15 INFO - 'tests': ['tp5n']}}, 06:29:15 INFO - 'talos.zip': {'path': '', 06:29:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:29:15 INFO - Running post-action listener: _resource_record_post_action 06:29:15 INFO - [mozharness: 2017-03-02 14:29:15.097911Z] Finished populate-webroot step (success) 06:29:15 INFO - [mozharness: 2017-03-02 14:29:15.098041Z] Running create-virtualenv step. 06:29:15 INFO - Running pre-action listener: _resource_record_pre_action 06:29:15 INFO - Running main action method: create_virtualenv 06:29:15 INFO - Creating virtualenv /builds/slave/test/build/venv 06:29:15 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 06:29:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:29:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:29:15 INFO - Using real prefix '/tools/python27' 06:29:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:29:15 INFO - Installing distribute.............................................................................................................................................................................................done. 06:29:19 INFO - Installing pip.................done. 06:29:19 INFO - Return code: 0 06:29:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:29:19 INFO - Reading from file tmpfile_stdout 06:29:19 INFO - Output received: 06:29:19 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) 06:29:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5885c03f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6cd30>, '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 0x10cc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd61be8>, '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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 06:29:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:29:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dOZhv8KfAH/Render', 06:29:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:29:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:29:19 INFO - 'HOME': '/Users/cltbld', 06:29:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:29:19 INFO - 'LOGNAME': 'cltbld', 06:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:19 INFO - 'MOZ_NO_REMOTE': '1', 06:29:19 INFO - 'NO_EM_RESTART': '1', 06:29:19 INFO - 'PAGER': '/bin/cat', 06:29:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:19 INFO - 'PWD': '/builds/slave/test', 06:29:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:29:19 INFO - 'SHELL': '/bin/bash', 06:29:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJIZ5Ya5X9/Listeners', 06:29:19 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 06:29:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:29:19 INFO - 'USER': 'cltbld', 06:29:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:29:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:19 INFO - 'XPC_FLAGS': '0x0', 06:29:19 INFO - 'XPC_SERVICE_NAME': '0', 06:29:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:19 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 06:29:19 INFO - Cleaning up... 06:29:19 INFO - Return code: 0 06:29:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cf8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5885c03f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6cd30>, '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 0x10cc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd61be8>, '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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 06:29:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:29:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:29:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dOZhv8KfAH/Render', 06:29:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:29:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:29:19 INFO - 'HOME': '/Users/cltbld', 06:29:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:29:19 INFO - 'LOGNAME': 'cltbld', 06:29:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:19 INFO - 'MOZ_NO_REMOTE': '1', 06:29:19 INFO - 'NO_EM_RESTART': '1', 06:29:19 INFO - 'PAGER': '/bin/cat', 06:29:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:29:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:19 INFO - 'PWD': '/builds/slave/test', 06:29:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:29:19 INFO - 'SHELL': '/bin/bash', 06:29:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJIZ5Ya5X9/Listeners', 06:29:19 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 06:29:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:29:19 INFO - 'USER': 'cltbld', 06:29:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:29:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:29:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:19 INFO - 'XPC_FLAGS': '0x0', 06:29:19 INFO - 'XPC_SERVICE_NAME': '0', 06:29:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:29:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:19 INFO - Downloading/unpacking psutil>=3.1.1 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:29:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:29:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:29:23 INFO - Installing collected packages: psutil 06:29:23 INFO - Running setup.py install for psutil 06:29:23 INFO - building 'psutil._psutil_osx' extension 06:29:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:29:24 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 06:29:24 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 06:29:24 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 06:29:24 INFO - building 'psutil._psutil_posix' extension 06:29:24 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 06:29:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:29:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:29:24 INFO - ^ 06:29:24 INFO - 1 warning generated. 06:29:24 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 06:29:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:29:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:29:24 INFO - Successfully installed psutil 06:29:24 INFO - Cleaning up... 06:29:24 INFO - Return code: 0 06:29:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:29:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29: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')]} 06:29:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5885c03f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6cd30>, '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 0x10cc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd61be8>, '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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 06:29:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:29:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:29:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dOZhv8KfAH/Render', 06:29:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:29:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:29:25 INFO - 'HOME': '/Users/cltbld', 06:29:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:29:25 INFO - 'LOGNAME': 'cltbld', 06:29:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:25 INFO - 'MOZ_NO_REMOTE': '1', 06:29:25 INFO - 'NO_EM_RESTART': '1', 06:29:25 INFO - 'PAGER': '/bin/cat', 06:29:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:29:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:25 INFO - 'PWD': '/builds/slave/test', 06:29:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:29:25 INFO - 'SHELL': '/bin/bash', 06:29:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJIZ5Ya5X9/Listeners', 06:29:25 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 06:29:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:29:25 INFO - 'USER': 'cltbld', 06:29:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:29:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:29:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:25 INFO - 'XPC_FLAGS': '0x0', 06:29:25 INFO - 'XPC_SERVICE_NAME': '0', 06:29:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:29:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:29:28 INFO - Installing collected packages: mozsystemmonitor 06:29:28 INFO - Running setup.py install for mozsystemmonitor 06:29:29 INFO - Successfully installed mozsystemmonitor 06:29:29 INFO - Cleaning up... 06:29:29 INFO - Return code: 0 06:29:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cf8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5885c03f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6cd30>, '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 0x10cc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd61be8>, '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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 06:29:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:29:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:29:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dOZhv8KfAH/Render', 06:29:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:29:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:29:29 INFO - 'HOME': '/Users/cltbld', 06:29:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:29:29 INFO - 'LOGNAME': 'cltbld', 06:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:29 INFO - 'MOZ_NO_REMOTE': '1', 06:29:29 INFO - 'NO_EM_RESTART': '1', 06:29:29 INFO - 'PAGER': '/bin/cat', 06:29:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:29 INFO - 'PWD': '/builds/slave/test', 06:29:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:29:29 INFO - 'SHELL': '/bin/bash', 06:29:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJIZ5Ya5X9/Listeners', 06:29:29 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 06:29:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:29:29 INFO - 'USER': 'cltbld', 06:29:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:29:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:29 INFO - 'XPC_FLAGS': '0x0', 06:29:29 INFO - 'XPC_SERVICE_NAME': '0', 06:29:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:29:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:29 INFO - Downloading/unpacking jsonschema==2.5.1 06:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:29:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:29:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:29:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29: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 06:29:32 INFO - Downloading functools32-3.2.3-2.tar.gz 06:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:29:32 INFO - warning: no files found matching '*.txt' 06:29:32 INFO - no previously-included directories found matching 'build' 06:29:32 INFO - no previously-included directories found matching 'dist' 06:29:32 INFO - no previously-included directories found matching '.git*' 06:29:32 INFO - Installing collected packages: jsonschema, functools32 06:29:32 INFO - Running setup.py install for functools32 06:29:32 INFO - warning: no files found matching '*.txt' 06:29:32 INFO - no previously-included directories found matching 'build' 06:29:32 INFO - no previously-included directories found matching 'dist' 06:29:32 INFO - no previously-included directories found matching '.git*' 06:29:32 INFO - Successfully installed jsonschema functools32 06:29:32 INFO - Cleaning up... 06:29:32 INFO - Return code: 0 06:29:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:32 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 0x10cf8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5885c03f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6cd30>, '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 0x10cc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd61be8>, '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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 06:29:32 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 06:29:32 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 06:29:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dOZhv8KfAH/Render', 06:29:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:29:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:29:32 INFO - 'HOME': '/Users/cltbld', 06:29:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:29:32 INFO - 'LOGNAME': 'cltbld', 06:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:32 INFO - 'MOZ_NO_REMOTE': '1', 06:29:32 INFO - 'NO_EM_RESTART': '1', 06:29:32 INFO - 'PAGER': '/bin/cat', 06:29:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:32 INFO - 'PWD': '/builds/slave/test', 06:29:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:29:32 INFO - 'SHELL': '/bin/bash', 06:29:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJIZ5Ya5X9/Listeners', 06:29:32 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 06:29:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:29:32 INFO - 'USER': 'cltbld', 06:29:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:29:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:32 INFO - 'XPC_FLAGS': '0x0', 06:29:32 INFO - 'XPC_SERVICE_NAME': '0', 06:29:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:29:33 INFO - Cleaning up... 06:29:33 INFO - Return code: 0 06:29:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:33 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 0x10cf8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5885c03f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6cd30>, '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 0x10cc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd61be8>, '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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 06:29:33 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 06:29:33 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 06:29:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dOZhv8KfAH/Render', 06:29:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:29:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:29:33 INFO - 'HOME': '/Users/cltbld', 06:29:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:29:33 INFO - 'LOGNAME': 'cltbld', 06:29:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:33 INFO - 'MOZ_NO_REMOTE': '1', 06:29:33 INFO - 'NO_EM_RESTART': '1', 06:29:33 INFO - 'PAGER': '/bin/cat', 06:29:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:29:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:33 INFO - 'PWD': '/builds/slave/test', 06:29:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:29:33 INFO - 'SHELL': '/bin/bash', 06:29:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJIZ5Ya5X9/Listeners', 06:29:33 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 06:29:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:29:33 INFO - 'USER': 'cltbld', 06:29:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:29:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:29:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:33 INFO - 'XPC_FLAGS': '0x0', 06:29:33 INFO - 'XPC_SERVICE_NAME': '0', 06:29:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:29:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:33 INFO - Downloading/unpacking blobuploader==1.2.4 06:29:33 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 06:29:33 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 06:29:33 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 06:29:33 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 06:29:33 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 06:29:33 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 06:29:35 INFO - Downloading blobuploader-1.2.4.tar.gz 06:29:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:29:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:29:36 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 06:29:36 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 06:29:36 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 06:29:36 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 06:29:36 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 06:29:36 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 06:29:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:29:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:29:36 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 06:29:36 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 06:29:36 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 06:29:36 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 06:29:36 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 06:29:36 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 06:29:37 INFO - Downloading docopt-0.6.1.tar.gz 06:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:29:37 INFO - Installing collected packages: blobuploader, requests, docopt 06:29:37 INFO - Running setup.py install for blobuploader 06:29:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:29:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:29:37 INFO - Running setup.py install for requests 06:29:37 INFO - Running setup.py install for docopt 06:29:38 INFO - Successfully installed blobuploader requests docopt 06:29:38 INFO - Cleaning up... 06:29:38 INFO - Return code: 0 06:29:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:38 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 0x10cf8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5885c03f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6cd30>, '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 0x10cc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd61be8>, '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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 06:29:38 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 06:29:38 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 06:29:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dOZhv8KfAH/Render', 06:29:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:29:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:29:38 INFO - 'HOME': '/Users/cltbld', 06:29:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:29:38 INFO - 'LOGNAME': 'cltbld', 06:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:38 INFO - 'MOZ_NO_REMOTE': '1', 06:29:38 INFO - 'NO_EM_RESTART': '1', 06:29:38 INFO - 'PAGER': '/bin/cat', 06:29:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:38 INFO - 'PWD': '/builds/slave/test', 06:29:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:29:38 INFO - 'SHELL': '/bin/bash', 06:29:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJIZ5Ya5X9/Listeners', 06:29:38 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 06:29:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:29:38 INFO - 'USER': 'cltbld', 06:29:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:29:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:38 INFO - 'XPC_FLAGS': '0x0', 06:29:38 INFO - 'XPC_SERVICE_NAME': '0', 06:29:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:29:38 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-qXVs_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:29:38 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-ROZ2zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:29:38 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-XEI0Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:29:38 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-6L0BIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:29:38 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-FE9FP8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:29:38 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-lHrxr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:29:39 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-cGXphH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:29:39 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-pNpAdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:29:39 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-30VO6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:29:39 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-u2rej4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:29:39 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-3n9Z0e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:29:39 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-O68c3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:29:39 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-e1cyI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:29:39 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-3Biiki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:39 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-366aGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:29:40 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-n7IK2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:29:40 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-seW1Nq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:29:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:29:40 INFO - Running setup.py install for manifestparser 06:29:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:29:40 INFO - Running setup.py install for mozcrash 06:29:40 INFO - Running setup.py install for mozdebug 06:29:40 INFO - Running setup.py install for mozdevice 06:29:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:29:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:29:40 INFO - Running setup.py install for mozfile 06:29:41 INFO - Running setup.py install for mozhttpd 06:29:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:29:41 INFO - Running setup.py install for mozinfo 06:29:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:29:41 INFO - Running setup.py install for mozInstall 06:29:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:29:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:29:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:29:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:29:41 INFO - Running setup.py install for mozleak 06:29:41 INFO - Running setup.py install for mozlog 06:29:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:29:41 INFO - Running setup.py install for moznetwork 06:29:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:29:41 INFO - Running setup.py install for mozprocess 06:29:42 INFO - Running setup.py install for mozprofile 06:29:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Running setup.py install for mozrunner 06:29:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Running setup.py install for mozscreenshot 06:29:42 INFO - Running setup.py install for moztest 06:29:42 INFO - Running setup.py install for mozversion 06:29:42 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:29:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:29:42 INFO - Cleaning up... 06:29:42 INFO - Return code: 0 06:29:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:42 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 0x10cf8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5885c03f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6cd30>, '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 0x10cc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd61be8>, '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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 06:29:42 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 06:29:42 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 06:29:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dOZhv8KfAH/Render', 06:29:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:29:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:29:42 INFO - 'HOME': '/Users/cltbld', 06:29:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:29:42 INFO - 'LOGNAME': 'cltbld', 06:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:42 INFO - 'MOZ_NO_REMOTE': '1', 06:29:42 INFO - 'NO_EM_RESTART': '1', 06:29:42 INFO - 'PAGER': '/bin/cat', 06:29:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:42 INFO - 'PWD': '/builds/slave/test', 06:29:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:29:42 INFO - 'SHELL': '/bin/bash', 06:29:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJIZ5Ya5X9/Listeners', 06:29:42 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 06:29:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:29:42 INFO - 'USER': 'cltbld', 06:29:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:29:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:42 INFO - 'XPC_FLAGS': '0x0', 06:29:42 INFO - 'XPC_SERVICE_NAME': '0', 06:29:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:29:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-oKfgOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:29:43 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)) 06:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:29:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-iRuu94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:29:43 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)) 06:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:29:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-RTF3zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:29:43 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)) 06:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:29:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-ZqYxuF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 06:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:29:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-tkfhlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:29:43 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)) 06:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:29:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-xfMxzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:29:43 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)) 06:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:29:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-eHoEcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:29:43 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)) 06:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:29:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-zO5As_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:29:43 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)) 06:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:29:43 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-Xdj76T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:29:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-xtsSYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:29:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-7Xum1j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:29:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-fmeo2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:29:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-OQv7ft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:29:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-0AaMHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-WoH8Ut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:29:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-lcCs0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:29:44 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)) 06:29:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:29:44 INFO - Running setup.py (path:/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/pip-VmbYNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:29:44 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)) 06:29:44 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)) 06:29:44 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)) 06:29:44 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)) 06:29:44 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:44 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:29:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:29:44 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 06:29:44 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 06:29:44 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 06:29:44 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 06:29:44 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 06:29:44 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 06:29:47 INFO - Downloading blessings-1.6.tar.gz 06:29:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:29:47 INFO - Installing collected packages: blessings 06:29:47 INFO - Running setup.py install for blessings 06:29:47 INFO - Successfully installed blessings 06:29:47 INFO - Cleaning up... 06:29:48 INFO - Return code: 0 06:29:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:29:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:29:48 INFO - Reading from file tmpfile_stdout 06:29:48 INFO - Current package versions: 06:29:48 INFO - blessings == 1.6 06:29:48 INFO - blobuploader == 1.2.4 06:29:48 INFO - docopt == 0.6.1 06:29:48 INFO - functools32 == 3.2.3-2 06:29:48 INFO - jsonschema == 2.5.1 06:29:48 INFO - manifestparser == 1.1 06:29:48 INFO - mozInstall == 1.12 06:29:48 INFO - mozcrash == 1.0 06:29:48 INFO - mozdebug == 0.1 06:29:48 INFO - mozdevice == 0.49 06:29:48 INFO - mozfile == 1.2 06:29:48 INFO - mozhttpd == 0.7 06:29:48 INFO - mozinfo == 0.9 06:29:48 INFO - mozleak == 0.1 06:29:48 INFO - mozlog == 3.4 06:29:48 INFO - moznetwork == 0.27 06:29:48 INFO - mozprocess == 0.25 06:29:48 INFO - mozprofile == 0.28 06:29:48 INFO - mozrunner == 6.13 06:29:48 INFO - mozscreenshot == 0.1 06:29:48 INFO - mozsystemmonitor == 0.3 06:29:48 INFO - moztest == 0.8 06:29:48 INFO - mozversion == 1.4 06:29:48 INFO - psutil == 3.1.1 06:29:48 INFO - requests == 1.2.3 06:29:48 INFO - wsgiref == 0.1.2 06:29:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:48 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 0x10cf8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5885c03f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6cd30>, '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 0x10cc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd61be8>, '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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 06:29:48 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 06:29:48 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 06:29:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dOZhv8KfAH/Render', 06:29:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:29:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:29:48 INFO - 'HOME': '/Users/cltbld', 06:29:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:29:48 INFO - 'LOGNAME': 'cltbld', 06:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:48 INFO - 'MOZ_NO_REMOTE': '1', 06:29:48 INFO - 'NO_EM_RESTART': '1', 06:29:48 INFO - 'PAGER': '/bin/cat', 06:29:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:48 INFO - 'PWD': '/builds/slave/test', 06:29:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:29:48 INFO - 'SHELL': '/bin/bash', 06:29:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJIZ5Ya5X9/Listeners', 06:29:48 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 06:29:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:29:48 INFO - 'USER': 'cltbld', 06:29:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:29:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:48 INFO - 'XPC_FLAGS': '0x0', 06:29:48 INFO - 'XPC_SERVICE_NAME': '0', 06:29:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:48 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)) 06:29:48 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)) 06:29:48 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)) 06:29:48 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)) 06:29:48 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)) 06:29:48 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)) 06:29:48 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)) 06:29:48 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)) 06:29:48 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)) 06:29:48 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)) 06:29:48 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)) 06:29:48 INFO - Cleaning up... 06:29:48 INFO - Return code: 0 06:29:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:29:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:29:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:29:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:29:48 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 0x10cf8eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf91768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc5885c03f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd6cd30>, '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 0x10cc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd61be8>, '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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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 06:29:48 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 06:29:48 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 06:29:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dOZhv8KfAH/Render', 06:29:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:29:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:29:48 INFO - 'HOME': '/Users/cltbld', 06:29:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:29:48 INFO - 'LOGNAME': 'cltbld', 06:29:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:48 INFO - 'MOZ_NO_REMOTE': '1', 06:29:48 INFO - 'NO_EM_RESTART': '1', 06:29:48 INFO - 'PAGER': '/bin/cat', 06:29:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:29:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:48 INFO - 'PWD': '/builds/slave/test', 06:29:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:29:48 INFO - 'SHELL': '/bin/bash', 06:29:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJIZ5Ya5X9/Listeners', 06:29:48 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 06:29:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:29:48 INFO - 'USER': 'cltbld', 06:29:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:29:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:29:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:48 INFO - 'XPC_FLAGS': '0x0', 06:29:48 INFO - 'XPC_SERVICE_NAME': '0', 06:29:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:29:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:29:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:29:48 INFO - Cleaning up... 06:29:48 INFO - Return code: 0 06:29:48 INFO - Running post-action listener: _resource_record_post_action 06:29:48 INFO - Running post-action listener: _start_resource_monitoring 06:29:48 INFO - Starting resource monitoring. 06:29:48 INFO - [mozharness: 2017-03-02 14:29:48.875755Z] Finished create-virtualenv step (success) 06:29:48 INFO - [mozharness: 2017-03-02 14:29:48.876747Z] Running install step. 06:29:48 INFO - Running pre-action listener: _resource_record_pre_action 06:29:48 INFO - Running main action method: install 06:29:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:29:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:29:49 INFO - Reading from file tmpfile_stdout 06:29:49 INFO - Detecting whether we're running mozinstall >=1.0... 06:29:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:29:49 INFO - Reading from file tmpfile_stdout 06:29:49 INFO - Output received: 06:29:49 INFO - Usage: mozinstall [options] installer 06:29:49 INFO - Options: 06:29:49 INFO - -h, --help show this help message and exit 06:29:49 INFO - -d DEST, --destination=DEST 06:29:49 INFO - Directory to install application into. [default: 06:29:49 INFO - "/builds/slave/test"] 06:29:49 INFO - --app=APP Application being installed. [default: firefox] 06:29:49 INFO - mkdir: /builds/slave/test/build/application 06:29:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 06:30:09 INFO - Reading from file tmpfile_stdout 06:30:09 INFO - Output received: 06:30:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:30:09 INFO - Running post-action listener: _resource_record_post_action 06:30:09 INFO - [mozharness: 2017-03-02 14:30:09.331459Z] Finished install step (success) 06:30:09 INFO - [mozharness: 2017-03-02 14:30:09.331610Z] Running run-tests step. 06:30:09 INFO - Running pre-action listener: _resource_record_pre_action 06:30:09 INFO - Running main action method: run_tests 06:30:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:30:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:30:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:30:09 INFO - 2017-03-02 06:30:09.346 screenresolution[1624:7518] starting screenresolution argv=screenresolution get 06:30:09 INFO - 2017-03-02 06:30:09.348 screenresolution[1624:7518] Display 0: 1600x1200x32@60 06:30:09 INFO - 2017-03-02 06:30:09.354 screenresolution[1625:7521] starting screenresolution argv=screenresolution list 06:30:09 INFO - Available Modes on Display 0 06:30:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:30:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:30:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:30:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:30:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:30:09 INFO - Intel Iris: 06:30:09 INFO - Chipset Model: Intel Iris 06:30:09 INFO - Type: GPU 06:30:09 INFO - Bus: Built-In 06:30:09 INFO - VRAM (Dynamic, Max): 1536 MB 06:30:09 INFO - Vendor: Intel (0x8086) 06:30:09 INFO - Device ID: 0x0a2e 06:30:09 INFO - Revision ID: 0x0009 06:30:09 INFO - Displays: 06:30:09 INFO - Display: 06:30:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:30:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:30:09 INFO - Display Serial Number: 1600x1200 60 06:30:09 INFO - Main Display: Yes 06:30:09 INFO - Mirror: Off 06:30:09 INFO - Online: Yes 06:30:09 INFO - Rotation: Supported 06:30:09 INFO - Return code: 0 06:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:30:09 INFO - Python 2.7.3 06:30:09 INFO - Return code: 0 06:30:09 INFO - grabbing minidump binary from tooltool 06:30:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:30:09 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 0x10cd6cd30>, '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 0x10cc93db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd61be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:30:09 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 06:30:09 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 06:30:09 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 06:30:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:30:09 INFO - Return code: 0 06:30:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:30:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:30:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:30:09 INFO - ENV: RUST_BACKTRACE is now 1 06:30:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:30:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:30:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:30:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0173 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:30:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dOZhv8KfAH/Render', 06:30:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:30:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:30:09 INFO - 'HOME': '/Users/cltbld', 06:30:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:30:09 INFO - 'LOGNAME': 'cltbld', 06:30:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:30:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:09 INFO - 'MOZ_NO_REMOTE': '1', 06:30:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:30:09 INFO - 'NO_EM_RESTART': '1', 06:30:09 INFO - 'PAGER': '/bin/cat', 06:30:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:09 INFO - 'PWD': '/builds/slave/test', 06:30:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:30:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:30:09 INFO - 'RUST_BACKTRACE': '1', 06:30:09 INFO - 'SHELL': '/bin/bash', 06:30:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KJIZ5Ya5X9/Listeners', 06:30:09 INFO - 'TMPDIR': '/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/', 06:30:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:30:09 INFO - 'USER': 'cltbld', 06:30:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:30:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:09 INFO - 'XPC_FLAGS': '0x0', 06:30:09 INFO - 'XPC_SERVICE_NAME': '0', 06:30:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:30:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0173', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:30:09 INFO - mozversion application_buildid: 20170302050322 06:30:09 INFO - mozversion application_changeset: 66535e831760421b270662aa8d0773b0fde7c9f3 06:30:09 INFO - mozversion application_display_name: Nightly 06:30:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:30:09 INFO - mozversion application_name: Firefox 06:30:09 INFO - mozversion application_remotingname: firefox 06:30:09 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:30:09 INFO - mozversion application_vendor: Mozilla 06:30:09 INFO - mozversion application_version: 54.0a1 06:30:09 INFO - mozversion platform_buildid: 20170302050322 06:30:09 INFO - mozversion platform_changeset: 66535e831760421b270662aa8d0773b0fde7c9f3 06:30:09 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:30:09 INFO - mozversion platform_version: 54.0a1 06:30:09 INFO - using testdate: 1488465009 06:30:09 INFO - actual date: 1488465009 06:30:09 INFO - starting webserver on 'localhost:49250' 06:30:09 INFO - SUITE-START | Running 2 tests 06:30:09 INFO - TEST-START | dromaeo_css 06:30:09 INFO - operating with platform_type : mac_ 06:30:09 INFO - Initialising browser for dromaeo_css test... 06:30:09 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpGA3LgK/profile http://localhost:49250/getInfo.html) 06:30:12 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 06:30:12 INFO - PROCESS | 1635 | colorDepth:24 06:30:12 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 06:30:12 INFO - PROCESS | 1635 | __metrics 06:30:12 INFO - PROCESS | 1635 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:30:12 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:30:13 INFO - TEST-INFO | 1635: exit 0 06:30:13 INFO - Browser initialized. 06:30:13 INFO - Running cycle 1/1 for dromaeo_css test... 06:30:13 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpGA3LgK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:30:25 INFO - PROCESS | 1638 | RSS: Main: 232099840 06:30:25 INFO - PROCESS | 1638 | 06:33:30 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 06:33:32 INFO - PROCESS | 1638 | RSS: Main: 384794624 06:33:32 INFO - PROCESS | 1638 | 06:35:15 INFO - PROCESS | 1638 | ************************* 06:35:15 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 06:35:15 INFO - PROCESS | 1638 | 06:35:15 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:35:15 INFO - PROCESS | 1638 | Full stack: 06:35:15 INFO - PROCESS | 1638 | ************************* 06:36:35 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 06:36:35 INFO - PROCESS | 1638 | RSS: Main: 363397120 06:36:35 INFO - PROCESS | 1638 | 06:39:38 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 06:39:38 INFO - PROCESS | 1638 | RSS: Main: 350154752 06:39:38 INFO - PROCESS | 1638 | 06:42:41 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 06:42:42 INFO - PROCESS | 1638 | RSS: Main: 326987776 06:42:42 INFO - PROCESS | 1638 | 06:45:45 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 06:45:46 INFO - PROCESS | 1638 | RSS: Main: 336412672 06:45:46 INFO - PROCESS | 1638 | 06:48:49 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 06:48:50 INFO - PROCESS | 1638 | RSS: Main: 536141824 06:48:50 INFO - PROCESS | 1638 | 06:48:50 INFO - PROCESS | 1638 | __start_tp_report 06:48:50 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 06:48:50 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 06:48:50 INFO - PROCESS | 1638 | |i|pagename|runs| 06:48:50 INFO - PROCESS | 1638 | |0;dojo.html;3363.192833719907;3363.478660807574;3382.983085084574;3404.931901361973;3418.982905085474;5619.662820230789;5650.858728531789;5724.284464441945;5841.269841269841;5870.6184098033655;5658.179563963223;5713.285839270091;5717.399673034334;5724.542036637069;5742.2247996520455;5194.065068287716;5230.424653288135;5231.032259032091;5260.92108618371;5276.445973172819;5312.60155488338;5322.04203243416;5322.65402748822;5330.093884039703;5333.4399888011785;5310.256564081032;5313.521783039526;5317.574594032468;5318.494742999409;5322.680639161644;5293.258943747878;5302.045631786277;5308.097623403992;5309.867253318659;5311.814086506973;5146.202338637517;5233.398159211702;5245.291885595434;5249.86875328116;5279.260903473517;5790.247267855152;5960.612560183574;5969.61197522164;5970.492508136814;5976.701164941779;6360.395762402564;6361.713722882481;6373.553851230416;6385.840353991188;6401.455876250478;6193.411625895533;6212.161358216628;6243.594166379216;6254.155688981975;6319.936800631981;5277.208418737182;5792.623479473821;5815.680137592431;5915.940840591625;5998.430149135826;6360.6501642409185;6362.6500542469685;6364.936350636527;6368.5860419072615;6369.808905732835;6242.469390101802;6267.71795269214;6269.65516896566;6274.247090349188;6275.121482992385;6150.907736383958;6195.31851496335;6207.534434917399;6263.060540918807;6374.043893415932;6346.079818426302;6347.238331400169;6355.841103972345;6361.363863613694;6365.713542890581;6295.338989406138;6353.5870168438905;6359.8092057238355;6363.872722545523;6367.013112967497;4934.358533390637;4935.950640493549;4985.90028199434;5059.822906198339;5114.15616423286;4465.665075119379;4470.642348612103;4489.528599497005;4517.909641807146;4571.817127314936;5821.18503409523;5822.650640961556;5822.679752613562;5827.79602713903;5834.708264586754;6110.680268050674;6320.968395158086;6327.114204011442;6334.809955701337;6344.746210151542;5674.659520428788;5698.287714035746;5729.742161602655;5732.369439361667;5744.080947048452;5442.129259318569;5444.156155795858;5450.29146210998;5451.509364157245;5451.836444906659;6281.623102613858;6290.716917738621;6306.936930630727;6312.400321969406;6320.1467801848;6235.625862448268;6322.557420980487;6323.462505687068;6324.272708638566;6339.841503962438;6388.936110638834;6401.87196256063;6404.039394090923;6409.294977552372;6410.711517981796;6102.640737559575;6131.774283661862;6210.223722034746;6211.09939058843;6296.559240853279;6292.433680968735;6329.841753956188;6342.175517182736;6344.492440604833;6349.809505714836;6205.47253483459;6242.157308763259;6254.562180647311;6259.718312675849;6261.405166509175;5727.341355743976;5974.2233509643465;6006.429389208019;6020.939790602038;6237.345078766845;5927.2590926134235;5978.073398623221;5997.370276120944;6029.397060293935;6112.297085835008;5061.645684802029;6202.317745048132;6202.4417802398;6209.410106039919;6210.658413787104;5970.9701451492465;5992.280926288873;6039.063945088518;6051.485623721856;6065.5754097212775 06:48:50 INFO - PROCESS | 1638 | |1;ext.html;725.2529894208964;729.7921939190638;735.7204262380295;847.9491230526165;857.5669287010058;27788.027419040336;29134.708652913465;29159.416811663756;39486;40089.7995510022;40585.98535036618;40592;40595.59404405955;40660.59339406605;40699.59300406995;8996.965348984868;9168.633254669805;9182.540872956359;9184;9191.21874640653;7258.129024517066;7451.143118541383;7464.10430748311;9128.40665356753;9239.260859131287;7440.404767618605;7477.476576639638;7504.8123796904965;10816.351018938849;11046.116310695124;11022.50398732055;11071.833922491169;11079.889201107966;11081.058110060654;11082.00261976418;10757.946210268978;10798.082163016154;10826.945865270623;10838.40388778617;10839.349639021684;27308.590371144448;27817.887284508597;38646.420303695464;39212.215755685014;39463.60536394628;3772.3775577029755;3782.678472329855;3791.4881490998637;3901.4147877818273;3915.23652887687;23887.163949261692;28226.435471290664;28244.71755282462;28696.71303286961;28799.856000720072;3038.635363756341;3056;3061.7244447999788;3141.8429078545983;3154.44797160496;331229.3438532792;332611;332621;333106;339453;50893.74553127211;51240.23139652908;51246.487535124914;51288.48711512837;51311.7434412833;53996.46003539993;54086.72956635192;54116.72941635267;54169.3749187525;54242;12728.10903236783;12732.04509661779;12811.615651530468;12827.807582886264;12872.806907896389;10597.682069537927;10662.520186591622;10710.518026688818;10722.410267435365;10743.24797264184;10988.835167472334;12264.938675306745;12499.187552809039;12530.561430349893;12557.434915428828;4525.954740452619;4625.699329543569;4715.834945776881;4744.074905393415;5278.736063196825;962.6486332488731;998.7053819123377;1081.8214994525972;1116.1182665694012;1176.9529218831321;23252.65121023152;26289.76388909593;26597.73402265991;26797.866010669823;26821.597676034486;1211.4730092409654;1216.592441532079;1250.3123282194756;1272.6691060324383;1277.2719549856492;13261.535846245528;13581.524646637321;13876.306184690726;13912.51306204278;13952.441902323793;413715;413938;414665;415587;415642;56463.43536564582;56468;56512.43487565072;56591.151132733045;56594;1352.5266156845223;1416.4546649539795;1420.34664054534;1423.110555902561;1425.9287035648383;24800.50398991974;25989.220323390327;26000;26101.216963491126;26618.467630647665;45570;45709.314360283955;45732.542674572825;45747;45788.54211457843;350139;350694;351095;351573;352404;21666.566668666852;22165.445863853533;22376.77623223747;22966.770332296463;34040.65959340375;38062.80968595139;39116.63091791773;39370.81887543378;39371.60628393794;39373.80313098531;30892.785437022514;32660.183495412806;33470.661173552784;33744.32511349808;33748;32533.511997320533;32792.180195495304;32893.17767055843;33011.33977320392;33295.33409331848;32510;32614.184645384055;33049.33901322008;33067;33314;25456.74543254544;26426.07508737185;27597.172084837486;27621.03326383567;28897.42205155927;21088.71712216995;22418;22584.322470325915;22810;22911.656325154803 06:48:50 INFO - PROCESS | 1638 | |2;jquery.html;338.37063062703373;371.8345336325333;389.5228345277036;426.2115087088886;436.96722745794074;13127.343632818369;13375.464981400744;14820.184889831055;19901.800981990174;20753.688694669592;21181.36455906325;21799.147072498818;22157.335279941588;22363.888180559075;22556.548869022652;6246.593971391845;6300.968495157518;6456.386643268882;6505.902411463831;6566.409023187912;6485.416312531871;6500.4799616030605;6527.314631963647;6553.967230163867;6569.244536878273;4115.238680844039;4287.699861009731;4325.74045557266;4396.758178300192;7429.517081389719;7121.999999999948;7510.347723500849;7511.924880751178;7517.774466766005;7522.69909203634;7006.929930700679;7049.154101507801;7087.751928682523;7089.92910070903;7097.432205423554;23510;26628.46743065147;26638.73361266382;26838.86580567085;26865.059722909606;2755.9586606200924;2813.5779633055;2836.446892855894;2860.985695071532;2957.260684828793;16015.919920400323;16086;16527.091009994445;17000;17055.147242637944;1845.8523318134517;1928.797476264986;1937.6124775045048;1951.6194342103295;2007.8393728501685;104504.95495045028;127306.36346818299;129062.35468822595;131984.34007829995;133039.99999999904;12408.379581020912;12610.801973812473;14107.647308817363;14551.272436378138;15393.384264629512;22514.21200258016;22567.887160564092;22597.322080337617;22620.54758904813;22625;8633.697820576375;8741.650333986696;8764.517951512727;8926.776830579158;8998.955005224932;6205.47253483459;7656.464047516621;7679.500832445985;7824.29581337671;7861.724839630586;6740.9662951685905;6824.454043676494;6834.2140653825445;6851.383375496229;6852.177738671391;3698.9075273118387;3767.434884767307;3773.6226277409096;3782.7730336179366;3786.469894214812;1033.2095946600857;1035.5081336365317;1046.2005350796617;1057.2968975631272;1084.7776205877776;20533;21313.786862131492;21609.135634574755;21731.37014723902;21756.238531651317;870.4516154822421;1005.653049697853;1028.4497793680346;1085.934843909368;1094.688013916046;11016.394098324508;11268.943655281671;11338.072527670316;11453.541858325574;11470.254433461965;556678;635664.568108863;693542;694373;708831;142388;144678;146920;147506;148286;1024.533837104116;1028.6605420211313;1051.1800795379463;1051.8790339110947;1051.8895515970712;15443.536693899201;17928.551786204927;18408.26366945307;18536.907315463337;18678.906605466887;57786;60199.69900150471;60847.69576152091;61596;62050.828221012045;78453.7623549519;79347;79880.60059699665;80018.5999070001;81364.133993873;11261.71845703864;11319.207655464368;11470.942645286721;11628.732397182468;11690.661867626679;11912.40437978115;12372.938135309267;12469.563565275172;12669.176503527242;12699.55551555728;8898.866517002121;10659.733506662396;10904.50929708181;11018;11035.613753518588;10334.224933130195;10416.270861039655;10429.68710938673;10595.152387808803;10647.893521065;11419.543218271176;11458.656240312805;11488.483018264365;11523.596674116367;11621.360825154698;11276.718082048015;11280.943595281971;11438.313701177956;11531.654050378502;11561.826572601585;8245;9588.808223835624;10647.361158330525;10936.890631093587;10962.397068161328 06:48:50 INFO - PROCESS | 1638 | |3;mootools.html;1428.8428272889983;1562.9374825007;1565.819930707969;1591.1646385647541;1597.0497553955397;10526.947365263173;11095.944520277388;11103.389313587759;11133.1093512519;11134.10927125831;10380.532876020578;10814.674844908342;10816.405097719622;10940.671779846598;10946.616868409606;2297.7357603875516;2326.8952897119584;2336.8714720690355;2338.53229354129;2339.9766002340016;2303.124812571229;2331.9883400583058;2336.754640762721;2340.742518322983;2342.8945697443655;2284.132029828663;2287.1994801819314;2310.4916918278036;2316.050419328076;2318.524702436005;2299.9885000574973;2310.2145270608075;2330.9883450582806;2332.1720789119872;2338.356951838241;2192.6053310404122;2253.2339004738305;2326.685897403846;2329.9301020969397;2332.6267797152373;10706.982836630508;10788.838167427495;10792.892071079266;10809.83785243222;10818.08046316064;5473.917891231635;5626.774929002835;5641.097424412115;5645.068563686987;5647.237622920894;3221.178599457147;3380.6431079239965;3447.24160684649;3531.0289670340603;3532.0816587687127;1099.1811100730008;1139.7663478986872;1157.7742340243656;1186.9465874035602;1192.0463629096687;13647.454101835914;14026.579202623938;14050.43798248069;15055.698886022219;15068.698626027528;4116.423700681907;4225.471816022997;4241.27898257297;4524.298733696282;4725.385699858996;11561.826572601418;11569.30584164936;11590.71023224426;11598.072154227642;11619.186656933933;5674.120511320752;5676.971615141981;5688.77244910199;5689.9146512802345;5691.743871525791;4882.36529251195;5171.7672704728375;5234.712090834964;5236.031334203185;5250.0549901018185;3605.2428989912414;3722.571904230994;3745.176061266517;3798.772073675588;3803.391457366808;1012.2661070723814;1014.5840205515703;1019.7501612105082;1028.5240679624762;1033.8655974723238;626.9373412066594;775.8525880082766;797.8763291689797;798.8681867491799;814.7229941819692;6048.909266361008;6245.375462453719;6473.255575608771;6474.838129046811;6609.678064387142;947.0016577492337;987.4568987057233;997.2769741937037;1004.492731170754;1053.378506681062;3691.9077023074638;4062.9639441942118;4084.8366065357645;4108.712390132722;4155.23128221274;10136.2904596679;13211.471541138439;13215.008874334271;13480.865191348157;13486.662833429244;13354.265515396552;13361.799573006412;13380.665483362995;13384.330783460982;13405.396757145953;9585.089416505421;9754.512274386252;9797.951010245046;10039.598416063276;10053;6498.870022599616;6512.641804700787;6656.76701315471;6673.532852700265;6746.395594918946;11819.113566482376;11835.585754498896;11964.880351196376;12046.216995895238;12097.637070887888;10005.699829005142;11001.504932277907;11863.288202707865;12134.817977730518;12250.509979600716;8603.440776349516;8899.110088991309;8957.641694332153;9010.5945232466;9014.774630634025;9579.712608621752;9789.951050244703;9897.65358212459;9899.406035637885;9990.200783937413;8582.613782379933;8957.59690813902;8969.596368163318;8977.28181745472;8985.820283594423;7279.672414741455;8656.653733850575;8761.721952292577;8783.165599268059;8962.372633915564;7639.88540171909;7649.579273139808;7664;7720.266574675396;7771.145174030965;5464.672119672832;5672.829815105553;5689.687067211177;5817.912731308949;5839.5036421904615;5757.971210143923;5837.124431335334;5930.34766175729;6089.786857459968;6120.969395152996 06:48:50 INFO - PROCESS | 1638 | |4;prototype.html;371.95164628598286;373.5722597625719;374.8013552817008;382.9578746337901;384.31399951087303;4382.561743825616;5218.425973142951;5317.521423071923;5322.361316642004;5351.919721204185;4444.9554354726615;4956.479569645189;5181.740912954356;5195.506426889449;5199.896002079966;3597.8592737321383;3645.3073915955883;3683.6554657549937;4142.937855932163;4168.916621667565;3634.309481198564;3831.601465465099;4161.146964872194;4174.891679701746;4212.8314867405425;3277.88527401541;3363.3441478911623;3705.7961812100325;4165.895852603694;4183.874483765477;3239.1740106272987;3817.675497582709;4043.6765058795227;4075.4090656854887;4088.34586466164;2971.777116716233;3654.903528941307;3682.650148235913;3690.0959264979983;3691.9261614767825;5061.569766569846;5069.340985671876;5144.871378215537;5168.793248270064;5181.300524429192;3857.324968130566;4205.789710514493;4777.976110119427;4818.301751019405;4825.9758701206265;5125;5263.631545791796;5465.5182750144895;5488.4785945335125;5566.4990150886615;3635.1093981974323;3791;4034.8587799426878;4095.1604920991126;4125.18491863582;5075.297928400536;5110.8466745997675;5654.6324488908085;5765.8286198390515;5837.795677151279;4278.507971583308;4317.892052698708;4396.868093957187;4902.504736055466;5014.197728363444;5017.54842064216;5252.2971305230485;5254.474552544715;5259.263703081571;5279.52484276417;3997.5003124609425;4511.751853648016;4880.170371036932;5370.946290537123;5449.64577302482;4759.928601070987;5045.747712614428;5680.14797780328;5719.4271575317125;5733.197352370671;1513.583764464759;1628.6172749403881;1662.8087769906615;1711.7346811244277;1719.7936247650111;1276.6106337566946;1347.5014244729514;1357.803118547805;1363.7886127650231;1386.660268234289;4148.69316165407;4179.582041795857;4629.814807407666;4761.476327575212;5079.974600126976;5295.470452954673;5336.039512887717;5416.075319327598;5545.639533430395;5663.518600918886;4390.3414487827085;4795.017021510582;5203.60972927032;5254.003478678078;5270.8155214567305;2651.0191229244915;2770.252031951362;2831.089014914924;2857.4996877731983;2931.6775154732964;5135.199952035467;5460.324441023869;5859.710863609999;5882.735276912464;5883.117532370093;4934.55588996992;5096.413912400121;5713.542916566665;5735.541156707453;5857.619254748428;4951.084049450791;5248.950209957948;5595.63628364155;5871.825634873043;5873.383294754075;4973.825916092919;5264.9206912583595;5602.607817452902;5642.407547207484;5655.293088363955;5317.308749862493;5483.75323110453;5573.888522229614;5644.8306550803545;5646.2942132233475;4979.958217131104;5817.360090389969;5890.882182356415;5968.283805943314;6030.939690603213;3759.642833930772;4035.858744943913;4140.068484590943;4583.312503124558;4665.533446655308;5692.886142277214;5837.766489340549;5869.35437101927;5870.471657550841;5878.706064696663;4740.431148262231;4927.457979622311;5046.77289521965;5516.345096470963;5734.2258795062135;5276.657017293864;5434.500129940272;5659.858503537444;5660.88678226425;5672.610210498454;4361.476622805284;5280.894382112413;5553.4724201200825;5606.635568688022;5621.353544342453;5630.971845140748;5665.801696940587;5667.838093190969;5686.9715651421475;5752.453516915886;4974.253861920741;5235.0576896159055;5290.947090529045;5306.89087557786;5519.806806761744 06:48:50 INFO - PROCESS | 1638 | |5;yui.html;714.8141483214363;718.8706032914073;757.4394947738672;809.651849704627;817.1269815329302;14448.349824257908;14805.111693298382;14976.475823346185;15088.849111508882;15129.09225446474;14011.789823152661;14055.78916316256;14180.149191048544;14184.858151418483;14268.429262829475;922.4188761080543;940.666063547441;943.2124176312769;958.238200630497;960.0255740423476;771.7221800151941;952.4285428742768;955.2071780422233;956.9808603827919;958.9904100958971;1010.6058637131524;1010.7473131717071;1013.8327176015948;1015;1016.6340117557673;1007.3552926127211;1008.1581879130935;1009.7273736091252;1009.9646512372068;1011.8886922438526;621.2420846567181;659.6899457255082;742.8997085393456;745.0798264143779;745.4222977192665;15120.319585618563;15386.846131538654;15432.614184645361;15502.22488875563;15595.844041559552;13643.249621270925;13842.930785346109;13903.582892513241;14010.22943738094;14063.226522541256;11408.20142590019;11625.59310424131;11743.47154378055;12051;12084.456199471046;3528.2438201131636;3614.6746792788776;3648.3615367310613;3648.781073135594;3761.3981762918074;95767.52116239374;97150.02849971481;98891;100145.4992725039;100544.49727751387;9107.681231156877;10369.792604147875;10608.522616482276;10763.246572739834;10813.891861081289;20073.799262007484;21126.78873211279;21148.682769758467;21742.239021634166;21892.78107218939;7299.379552738077;7496.512726672749;7563.394928405714;7572.81067973294;7659.042619672541;4150.501939767248;4186.895327616773;4203.516595591485;4246.808893599796;4258.084511829971;3324.700776930088;3393.609734880471;3425.1265927188406;3428.0401487583517;3444.3111377724053;614.5156960036603;624.7938180400457;625.0904933322097;626.5457543281085;631.958922670025;634.9492040636738;661.315538417745;679.932006799326;682.8873235916018;699.8495323505471;9499.620015199453;9585.568649410794;10111.949440252753;10218.335808172445;10409.739756505996;611.016263815257;650.2652003236407;661.2773724447841;682.160942041292;723.992760072403;3800.6959443244473;3949.1114499238015;4761.999700941991;5244.125671476516;5322.2282768998275;101123.49438252761;101556.96886062238;101579.49210253902;102284.97715022754;103580;47258.76370618125;56108.719456403276;67953;73280.26719732842;74178;51404;70685.29314706993;70948.64525677338;71230.64384678044;72250;8547.801452398211;10014.3490673106;10418.218633602359;11033.393163376091;11088;40939;43319.35020974751;44758.77620612006;46584;47350.763246183546;59086.40913590981;59608.509787255665;60150.49623759266;60469;60988.78022439437;12039.819402708792;12188.146829721834;12230.510779568718;12273;12857.871421285667;14026.649333766738;14093.647658808612;14111.71860217296;14296;14972.401103955719;10537.998890105428;11071.72320691989;11410.771784564427;11631.302121872715;11778.705532361417;12934.547290844775;13322.533711320057;13549.729005420033;13729.725405492034;13750.724985500434;12924.806127907901;12991.870081299066;12998.610041698765;13393;13573.59279221625;9443.716688499357;10360.171186305228;10470.319429237075;10544.84182737275;10609.734756631146;7869.803254918673;7876.72431464896;8703.651853925772;9249.856747801337;10154.035366640157 06:48:50 INFO - PROCESS | 1638 | __end_tp_report 06:48:50 INFO - PROCESS | 1638 | __start_cc_report 06:48:50 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1620 06:48:50 INFO - PROCESS | 1638 | __end_cc_report 06:48:50 INFO - PROCESS | 1638 | __startTimestamp1488466130119__endTimestamp 06:48:50 INFO - PROCESS | 1638 | 06:48:50 INFO - PROCESS | 1638 | ------- Summary: start ------- 06:48:50 INFO - PROCESS | 1638 | Number of tests: 6 06:48:50 INFO - PROCESS | 1638 | 06:48:50 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5809.47 Median:5998.43 stddev:647.96 (10.8%) stddev-sans-first:620.88 06:48:50 INFO - PROCESS | 1638 | Values: 3363.2 3363.5 3383.0 3404.9 3419.0 5619.7 5650.9 5724.3 5841.3 5870.6 5658.2 5713.3 5717.4 5724.5 5742.2 5194.1 5230.4 5231.0 5260.9 5276.4 5312.6 5322.0 5322.7 5330.1 5333.4 5310.3 5313.5 5317.6 5318.5 5322.7 5293.3 5302.0 5308.1 5309.9 5311.8 5146.2 5233.4 5245.3 5249.9 5279.3 5790.2 5960.6 5969.6 5970.5 5976.7 6360.4 6361.7 6373.6 6385.8 6401.5 6193.4 6212.2 6243.6 6254.2 6319.9 5277.2 5792.6 5815.7 5915.9 5998.4 6360.7 6362.7 6364.9 6368.6 6369.8 6242.5 6267.7 6269.7 6274.2 6275.1 6150.9 6195.3 6207.5 6263.1 6374.0 6346.1 6347.2 6355.8 6361.4 6365.7 6295.3 6353.6 6359.8 6363.9 6367.0 4934.4 4936.0 4985.9 5059.8 5114.2 4465.7 4470.6 4489.5 4517.9 4571.8 5821.2 5822.7 5822.7 5827.8 5834.7 6110.7 6321.0 6327.1 6334.8 6344.7 5674.7 5698.3 5729.7 5732.4 5744.1 5442.1 5444.2 5450.3 5451.5 5451.8 6281.6 6290.7 6306.9 6312.4 6320.1 6235.6 6322.6 6323.5 6324.3 6339.8 6388.9 6401.9 6404.0 6409.3 6410.7 6102.6 6131.8 6210.2 6211.1 6296.6 6292.4 6329.8 6342.2 6344.5 6349.8 6205.5 6242.2 6254.6 6259.7 6261.4 5727.3 5974.2 6006.4 6020.9 6237.3 5927.3 5978.1 5997.4 6029.4 6112.3 5061.6 6202.3 6202.4 6209.4 6210.7 5971.0 5992.3 6039.1 6051.5 6065.6 06:48:50 INFO - PROCESS | 1638 | 06:48:50 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:50568.40 Median:32952.26 stddev:97370.23 (295.5%) stddev-sans-first:97571.47 06:48:50 INFO - PROCESS | 1638 | Values: 725.3 729.8 735.7 847.9 857.6 27788.0 29134.7 29159.4 39486.0 40089.8 40586.0 40592.0 40595.6 40660.6 40699.6 8997.0 9168.6 9182.5 9184.0 9191.2 7258.1 7451.1 7464.1 9128.4 9239.3 7440.4 7477.5 7504.8 10816.4 11046.1 11022.5 11071.8 11079.9 11081.1 11082.0 10757.9 10798.1 10826.9 10838.4 10839.3 27308.6 27817.9 38646.4 39212.2 39463.6 3772.4 3782.7 3791.5 3901.4 3915.2 23887.2 28226.4 28244.7 28696.7 28799.9 3038.6 3056.0 3061.7 3141.8 3154.4 331229.3 332611.0 332621.0 333106.0 339453.0 50893.7 51240.2 51246.5 51288.5 51311.7 53996.5 54086.7 54116.7 54169.4 54242.0 12728.1 12732.0 12811.6 12827.8 12872.8 10597.7 10662.5 10710.5 10722.4 10743.2 10988.8 12264.9 12499.2 12530.6 12557.4 4526.0 4625.7 4715.8 4744.1 5278.7 962.6 998.7 1081.8 1116.1 1177.0 23252.7 26289.8 26597.7 26797.9 26821.6 1211.5 1216.6 1250.3 1272.7 1277.3 13261.5 13581.5 13876.3 13912.5 13952.4 413715.0 413938.0 414665.0 415587.0 415642.0 56463.4 56468.0 56512.4 56591.2 56594.0 1352.5 1416.5 1420.3 1423.1 1425.9 24800.5 25989.2 26000.0 26101.2 26618.5 45570.0 45709.3 45732.5 45747.0 45788.5 350139.0 350694.0 351095.0 351573.0 352404.0 21666.6 22165.4 22376.8 22966.8 34040.7 38062.8 39116.6 39370.8 39371.6 39373.8 30892.8 32660.2 33470.7 33744.3 33748.0 32533.5 32792.2 32893.2 33011.3 33295.3 32510.0 32614.2 33049.3 33067.0 33314.0 25456.7 26426.1 27597.2 27621.0 28897.4 21088.7 22418.0 22584.3 22810.0 22911.7 06:48:50 INFO - PROCESS | 1638 | 06:48:50 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:38404.49 Median:21743.80 stddev:110175.01 (506.7%) stddev-sans-first:110447.00 06:48:50 INFO - PROCESS | 1638 | Values: 338.4 371.8 389.5 426.2 437.0 13127.3 13375.5 14820.2 19901.8 20753.7 21181.4 21799.1 22157.3 22363.9 22556.5 6246.6 6301.0 6456.4 6505.9 6566.4 6485.4 6500.5 6527.3 6554.0 6569.2 4115.2 4287.7 4325.7 4396.8 7429.5 7122.0 7510.3 7511.9 7517.8 7522.7 7006.9 7049.2 7087.8 7089.9 7097.4 23510.0 26628.5 26638.7 26838.9 26865.1 2756.0 2813.6 2836.4 2861.0 2957.3 16015.9 16086.0 16527.1 17000.0 17055.1 1845.9 1928.8 1937.6 1951.6 2007.8 104505.0 127306.4 129062.4 131984.3 133040.0 12408.4 12610.8 14107.6 14551.3 15393.4 22514.2 22567.9 22597.3 22620.5 22625.0 8633.7 8741.7 8764.5 8926.8 8999.0 6205.5 7656.5 7679.5 7824.3 7861.7 6741.0 6824.5 6834.2 6851.4 6852.2 3698.9 3767.4 3773.6 3782.8 3786.5 1033.2 1035.5 1046.2 1057.3 1084.8 20533.0 21313.8 21609.1 21731.4 21756.2 870.5 1005.7 1028.4 1085.9 1094.7 11016.4 11268.9 11338.1 11453.5 11470.3 556678.0 635664.6 693542.0 694373.0 708831.0 142388.0 144678.0 146920.0 147506.0 148286.0 1024.5 1028.7 1051.2 1051.9 1051.9 15443.5 17928.6 18408.3 18536.9 18678.9 57786.0 60199.7 60847.7 61596.0 62050.8 78453.8 79347.0 79880.6 80018.6 81364.1 11261.7 11319.2 11470.9 11628.7 11690.7 11912.4 12372.9 12469.6 12669.2 12699.6 8898.9 10659.7 10904.5 11018.0 11035.6 10334.2 10416.3 10429.7 10595.2 10647.9 11419.5 11458.7 11488.5 11523.6 11621.4 11276.7 11280.9 11438.3 11531.7 11561.8 8245.0 9588.8 10647.4 10936.9 10962.4 06:48:50 INFO - PROCESS | 1638 | 06:48:50 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:6537.09 Median:3413.94 stddev:4071.12 (119.2%) stddev-sans-first:4064.44 06:48:50 INFO - PROCESS | 1638 | Values: 1428.8 1562.9 1565.8 1591.2 1597.0 10526.9 11095.9 11103.4 11133.1 11134.1 10380.5 10814.7 10816.4 10940.7 10946.6 2297.7 2326.9 2336.9 2338.5 2340.0 2303.1 2332.0 2336.8 2340.7 2342.9 2284.1 2287.2 2310.5 2316.1 2318.5 2300.0 2310.2 2331.0 2332.2 2338.4 2192.6 2253.2 2326.7 2329.9 2332.6 10707.0 10788.8 10792.9 10809.8 10818.1 5473.9 5626.8 5641.1 5645.1 5647.2 3221.2 3380.6 3447.2 3531.0 3532.1 1099.2 1139.8 1157.8 1186.9 1192.0 13647.5 14026.6 14050.4 15055.7 15068.7 4116.4 4225.5 4241.3 4524.3 4725.4 11561.8 11569.3 11590.7 11598.1 11619.2 5674.1 5677.0 5688.8 5689.9 5691.7 4882.4 5171.8 5234.7 5236.0 5250.1 3605.2 3722.6 3745.2 3798.8 3803.4 1012.3 1014.6 1019.8 1028.5 1033.9 626.9 775.9 797.9 798.9 814.7 6048.9 6245.4 6473.3 6474.8 6609.7 947.0 987.5 997.3 1004.5 1053.4 3691.9 4063.0 4084.8 4108.7 4155.2 10136.3 13211.5 13215.0 13480.9 13486.7 13354.3 13361.8 13380.7 13384.3 13405.4 9585.1 9754.5 9798.0 10039.6 10053.0 6498.9 6512.6 6656.8 6673.5 6746.4 11819.1 11835.6 11964.9 12046.2 12097.6 10005.7 11001.5 11863.3 12134.8 12250.5 8603.4 8899.1 8957.6 9010.6 9014.8 9579.7 9790.0 9897.7 9899.4 9990.2 8582.6 8957.6 8969.6 8977.3 8985.8 7279.7 8656.7 8761.7 8783.2 8962.4 7639.9 7649.6 7664.0 7720.3 7771.1 5464.7 5672.8 5689.7 5817.9 5839.5 5758.0 5837.1 5930.3 6089.8 6121.0 06:48:50 INFO - PROCESS | 1638 | 06:48:50 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4585.35 Median:5072.32 stddev:1312.10 (25.9%) stddev-sans-first:1277.10 06:48:50 INFO - PROCESS | 1638 | Values: 372.0 373.6 374.8 383.0 384.3 4382.6 5218.4 5317.5 5322.4 5351.9 4445.0 4956.5 5181.7 5195.5 5199.9 3597.9 3645.3 3683.7 4142.9 4168.9 3634.3 3831.6 4161.1 4174.9 4212.8 3277.9 3363.3 3705.8 4165.9 4183.9 3239.2 3817.7 4043.7 4075.4 4088.3 2971.8 3654.9 3682.7 3690.1 3691.9 5061.6 5069.3 5144.9 5168.8 5181.3 3857.3 4205.8 4778.0 4818.3 4826.0 5125.0 5263.6 5465.5 5488.5 5566.5 3635.1 3791.0 4034.9 4095.2 4125.2 5075.3 5110.8 5654.6 5765.8 5837.8 4278.5 4317.9 4396.9 4902.5 5014.2 5017.5 5252.3 5254.5 5259.3 5279.5 3997.5 4511.8 4880.2 5370.9 5449.6 4759.9 5045.7 5680.1 5719.4 5733.2 1513.6 1628.6 1662.8 1711.7 1719.8 1276.6 1347.5 1357.8 1363.8 1386.7 4148.7 4179.6 4629.8 4761.5 5080.0 5295.5 5336.0 5416.1 5545.6 5663.5 4390.3 4795.0 5203.6 5254.0 5270.8 2651.0 2770.3 2831.1 2857.5 2931.7 5135.2 5460.3 5859.7 5882.7 5883.1 4934.6 5096.4 5713.5 5735.5 5857.6 4951.1 5249.0 5595.6 5871.8 5873.4 4973.8 5264.9 5602.6 5642.4 5655.3 5317.3 5483.8 5573.9 5644.8 5646.3 4980.0 5817.4 5890.9 5968.3 6030.9 3759.6 4035.9 4140.1 4583.3 4665.5 5692.9 5837.8 5869.4 5870.5 5878.7 4740.4 4927.5 5046.8 5516.3 5734.2 5276.7 5434.5 5659.9 5660.9 5672.6 4361.5 5280.9 5553.5 5606.6 5621.4 5631.0 5665.8 5667.8 5687.0 5752.5 4974.3 5235.1 5290.9 5306.9 5519.8 06:48:50 INFO - PROCESS | 1638 | 06:48:50 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:18676.63 Median:3426.58 stddev:26335.29 (768.6%) stddev-sans-first:26374.63 06:48:50 INFO - PROCESS | 1638 | Values: 714.8 718.9 757.4 809.7 817.1 14448.3 14805.1 14976.5 15088.8 15129.1 14011.8 14055.8 14180.1 14184.9 14268.4 922.4 940.7 943.2 958.2 960.0 771.7 952.4 955.2 957.0 959.0 1010.6 1010.7 1013.8 1015.0 1016.6 1007.4 1008.2 1009.7 1010.0 1011.9 621.2 659.7 742.9 745.1 745.4 15120.3 15386.8 15432.6 15502.2 15595.8 13643.2 13842.9 13903.6 14010.2 14063.2 11408.2 11625.6 11743.5 12051.0 12084.5 3528.2 3614.7 3648.4 3648.8 3761.4 95767.5 97150.0 98891.0 100145.5 100544.5 9107.7 10369.8 10608.5 10763.2 10813.9 20073.8 21126.8 21148.7 21742.2 21892.8 7299.4 7496.5 7563.4 7572.8 7659.0 4150.5 4186.9 4203.5 4246.8 4258.1 3324.7 3393.6 3425.1 3428.0 3444.3 614.5 624.8 625.1 626.5 632.0 634.9 661.3 679.9 682.9 699.8 9499.6 9585.6 10111.9 10218.3 10409.7 611.0 650.3 661.3 682.2 724.0 3800.7 3949.1 4762.0 5244.1 5322.2 101123.5 101557.0 101579.5 102285.0 103580.0 47258.8 56108.7 67953.0 73280.3 74178.0 51404.0 70685.3 70948.6 71230.6 72250.0 8547.8 10014.3 10418.2 11033.4 11088.0 40939.0 43319.4 44758.8 46584.0 47350.8 59086.4 59608.5 60150.5 60469.0 60988.8 12039.8 12188.1 12230.5 12273.0 12857.9 14026.6 14093.6 14111.7 14296.0 14972.4 10538.0 11071.7 11410.8 11631.3 11778.7 12934.5 13322.5 13549.7 13729.7 13750.7 12924.8 12991.9 12998.6 13393.0 13573.6 9443.7 10360.2 10470.3 10544.8 10609.7 7869.8 7876.7 8703.7 9249.9 10154.0 06:48:50 INFO - PROCESS | 1638 | -------- Summary: end -------- 06:48:50 INFO - PROCESS | 1638 | 06:48:50 INFO - TEST-INFO | 1638: exit 0 06:48:50 INFO - TEST-OK | dromaeo_css | took 1120898ms 06:48:50 INFO - TEST-START | kraken 06:48:50 INFO - operating with platform_type : mac_ 06:48:50 INFO - Initialising browser for kraken test... 06:48:50 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpoU_wcW/profile http://localhost:49250/getInfo.html) 06:48:53 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 06:48:53 INFO - PROCESS | 1648 | colorDepth:24 06:48:53 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 06:48:53 INFO - PROCESS | 1648 | __metrics 06:48:53 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:48:53 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:48:54 INFO - TEST-INFO | 1648: exit 0 06:48:54 INFO - Browser initialized. 06:48:54 INFO - Running cycle 1/1 for kraken test... 06:48:54 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/tmpoU_wcW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:49:06 INFO - PROCESS | 1649 | RSS: Main: 232366080 06:49:06 INFO - PROCESS | 1649 | 06:49:09 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 06:49:10 INFO - PROCESS | 1649 | RSS: Main: 283983872 06:49:10 INFO - PROCESS | 1649 | 06:49:12 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 06:49:13 INFO - PROCESS | 1649 | RSS: Main: 285745152 06:49:13 INFO - PROCESS | 1649 | 06:49:16 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 06:49:17 INFO - PROCESS | 1649 | RSS: Main: 377942016 06:49:17 INFO - PROCESS | 1649 | 06:49:19 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 06:49:19 INFO - PROCESS | 1649 | RSS: Main: 279031808 06:49:19 INFO - PROCESS | 1649 | 06:49:22 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:49:22 INFO - PROCESS | 1649 | RSS: Main: 282042368 06:49:22 INFO - PROCESS | 1649 | 06:49:25 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 06:49:26 INFO - PROCESS | 1649 | RSS: Main: 325328896 06:49:26 INFO - PROCESS | 1649 | 06:49:29 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 06:49:30 INFO - PROCESS | 1649 | RSS: Main: 328269824 06:49:30 INFO - PROCESS | 1649 | 06:49:33 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 06:49:33 INFO - PROCESS | 1649 | RSS: Main: 323862528 06:49:33 INFO - PROCESS | 1649 | 06:49:35 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:49:35 INFO - PROCESS | 1649 | RSS: Main: 301182976 06:49:35 INFO - PROCESS | 1649 | 06:49:37 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:49:38 INFO - PROCESS | 1649 | RSS: Main: 305229824 06:49:38 INFO - PROCESS | 1649 | 06:49:40 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:49:41 INFO - PROCESS | 1649 | RSS: Main: 312082432 06:49:41 INFO - PROCESS | 1649 | 06:49:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:49:45 INFO - PROCESS | 1649 | RSS: Main: 315207680 06:49:45 INFO - PROCESS | 1649 | 06:49:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:49:48 INFO - PROCESS | 1649 | RSS: Main: 316162048 06:49:48 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 06:49:50 INFO - PROCESS | 1649 | RSS: Main: 361496576 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | __start_tp_report 06:49:50 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 06:49:50 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 06:49:50 INFO - PROCESS | 1649 | |i|pagename|runs| 06:49:50 INFO - PROCESS | 1649 | |0;ai-astar;118;114;117;115;116;114;114;115;115;114 06:49:50 INFO - PROCESS | 1649 | |1;audio-beat-detection;133;110;113;178;141;109;108;110;129;109 06:49:50 INFO - PROCESS | 1649 | |2;audio-dft;185;185;184;184;181;182;184;186;183;187 06:49:50 INFO - PROCESS | 1649 | |3;audio-fft;83;60;59;90;62;59;62;60;76;60 06:49:50 INFO - PROCESS | 1649 | |4;audio-oscillator;88;70;89;74;71;70;86;72;69;85 06:49:50 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;87;87;87;87;88;86;87;87;88;87 06:49:50 INFO - PROCESS | 1649 | |6;imaging-darkroom;94;100;95;94;95;95;93;95;94;94 06:49:50 INFO - PROCESS | 1649 | |7;imaging-desaturate;83;84;86;83;84;85;84;82;84;86 06:49:50 INFO - PROCESS | 1649 | |8;json-parse-financial;64;60;61;61;63;62;65;65;63;64 06:49:50 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;54;66;66;65;62;55;58;59;58;59 06:49:50 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;90;91;87;88;89;88;89;91;87;128 06:49:50 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;133;149;158;146;133;151;152;147;141;145 06:49:50 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;175;174;174;232;220;170;172;171;176;172 06:49:50 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;66;68;69;66;66;67;67;67;68;67 06:49:50 INFO - PROCESS | 1649 | __end_tp_report 06:49:50 INFO - PROCESS | 1649 | __start_cc_report 06:49:50 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2108 06:49:50 INFO - PROCESS | 1649 | __end_cc_report 06:49:50 INFO - PROCESS | 1649 | __startTimestamp1488466190771__endTimestamp 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | ------- Summary: start ------- 06:49:50 INFO - PROCESS | 1649 | Number of tests: 14 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:115.20 Median:115.00 stddev:1.40 (1.2%) stddev-sans-first:1.05 06:49:50 INFO - PROCESS | 1649 | Values: 118.0 114.0 117.0 115.0 116.0 114.0 114.0 115.0 115.0 114.0 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:124.00 Median:121.00 stddev:22.44 (18.5%) stddev-sans-first:23.56 06:49:50 INFO - PROCESS | 1649 | Values: 133.0 110.0 113.0 178.0 141.0 109.0 108.0 110.0 129.0 109.0 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.50 stddev:1.79 (1.0%) stddev-sans-first:1.87 06:49:50 INFO - PROCESS | 1649 | Values: 185.0 185.0 184.0 184.0 181.0 182.0 184.0 186.0 183.0 187.0 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:67.10 Median:62.00 stddev:11.50 (18.6%) stddev-sans-first:10.67 06:49:50 INFO - PROCESS | 1649 | Values: 83.0 60.0 59.0 90.0 62.0 59.0 62.0 60.0 76.0 60.0 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:79.50 stddev:8.44 (10.6%) stddev-sans-first:8.03 06:49:50 INFO - PROCESS | 1649 | Values: 88.0 70.0 89.0 74.0 71.0 70.0 86.0 72.0 69.0 85.0 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:87.10 Median:87.00 stddev:0.57 (0.7%) stddev-sans-first:0.60 06:49:50 INFO - PROCESS | 1649 | Values: 87.0 87.0 87.0 87.0 88.0 86.0 87.0 87.0 88.0 87.0 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:94.90 Median:94.50 stddev:1.91 (2.0%) stddev-sans-first:2.00 06:49:50 INFO - PROCESS | 1649 | Values: 94.0 100.0 95.0 94.0 95.0 95.0 93.0 95.0 94.0 94.0 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:1.29 (1.5%) stddev-sans-first:1.30 06:49:50 INFO - PROCESS | 1649 | Values: 83.0 84.0 86.0 83.0 84.0 85.0 84.0 82.0 84.0 86.0 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.50 stddev:1.75 (2.8%) stddev-sans-first:1.80 06:49:50 INFO - PROCESS | 1649 | Values: 64.0 60.0 61.0 61.0 63.0 62.0 65.0 65.0 63.0 64.0 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.50 stddev:4.37 (7.2%) stddev-sans-first:4.01 06:49:50 INFO - PROCESS | 1649 | Values: 54.0 66.0 66.0 65.0 62.0 55.0 58.0 59.0 58.0 59.0 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:92.80 Median:89.00 stddev:12.45 (14.0%) stddev-sans-first:13.17 06:49:50 INFO - PROCESS | 1649 | Values: 90.0 91.0 87.0 88.0 89.0 88.0 89.0 91.0 87.0 128.0 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:148.00 stddev:8.00 (5.4%) stddev-sans-first:7.10 06:49:50 INFO - PROCESS | 1649 | Values: 133.0 149.0 158.0 146.0 133.0 151.0 152.0 147.0 141.0 145.0 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.60 Median:174.50 stddev:22.60 (13.0%) stddev-sans-first:23.75 06:49:50 INFO - PROCESS | 1649 | Values: 175.0 174.0 174.0 232.0 220.0 170.0 172.0 171.0 176.0 172.0 06:49:50 INFO - PROCESS | 1649 | 06:49:50 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 06:49:50 INFO - PROCESS | 1649 | Values: 66.0 68.0 69.0 66.0 66.0 67.0 67.0 67.0 68.0 67.0 06:49:50 INFO - PROCESS | 1649 | -------- Summary: end -------- 06:49:50 INFO - PROCESS | 1649 | 06:49:51 INFO - TEST-INFO | 1649: exit 0 06:49:51 INFO - TEST-OK | kraken | took 60845ms 06:49:51 INFO - SUITE-END | took 1181s 06:49:51 INFO - Completed test suite (00:19:41) 06:49:51 INFO - javascript benchmark 06:49:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7421.446295220812, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3363.192833719907, 3363.478660807574, 3382.983085084574, 3404.931901361973, 3418.982905085474, 5619.662820230789, 5650.858728531789, 5724.284464441945, 5841.269841269841, 5870.6184098033655, 5658.179563963223, 5713.285839270091, 5717.399673034334, 5724.542036637069, 5742.2247996520455, 5194.065068287716, 5230.424653288135, 5231.032259032091, 5260.92108618371, 5276.445973172819, 5312.60155488338, 5322.04203243416, 5322.65402748822, 5330.093884039703, 5333.4399888011785, 5310.256564081032, 5313.521783039526, 5317.574594032468, 5318.494742999409, 5322.680639161644, 5293.258943747878, 5302.045631786277, 5308.097623403992, 5309.867253318659, 5311.814086506973, 5146.202338637517, 5233.398159211702, 5245.291885595434, 5249.86875328116, 5279.260903473517, 5790.247267855152, 5960.612560183574, 5969.61197522164, 5970.492508136814, 5976.701164941779, 6360.395762402564, 6361.713722882481, 6373.553851230416, 6385.840353991188, 6401.455876250478, 6193.411625895533, 6212.161358216628, 6243.594166379216, 6254.155688981975, 6319.936800631981, 5277.208418737182, 5792.623479473821, 5815.680137592431, 5915.940840591625, 5998.430149135826, 6360.6501642409185, 6362.6500542469685, 6364.936350636527, 6368.5860419072615, 6369.808905732835, 6242.469390101802, 6267.71795269214, 6269.65516896566, 6274.247090349188, 6275.121482992385, 6150.907736383958, 6195.31851496335, 6207.534434917399, 6263.060540918807, 6374.043893415932, 6346.079818426302, 6347.238331400169, 6355.841103972345, 6361.363863613694, 6365.713542890581, 6295.338989406138, 6353.5870168438905, 6359.8092057238355, 6363.872722545523, 6367.013112967497, 4934.358533390637, 4935.950640493549, 4985.90028199434, 5059.822906198339, 5114.15616423286, 4465.665075119379, 4470.642348612103, 4489.528599497005, 4517.909641807146, 4571.817127314936, 5821.18503409523, 5822.650640961556, 5822.679752613562, 5827.79602713903, 5834.708264586754, 6110.680268050674, 6320.968395158086, 6327.114204011442, 6334.809955701337, 6344.746210151542, 5674.659520428788, 5698.287714035746, 5729.742161602655, 5732.369439361667, 5744.080947048452, 5442.129259318569, 5444.156155795858, 5450.29146210998, 5451.509364157245, 5451.836444906659, 6281.623102613858, 6290.716917738621, 6306.936930630727, 6312.400321969406, 6320.1467801848, 6235.625862448268, 6322.557420980487, 6323.462505687068, 6324.272708638566, 6339.841503962438, 6388.936110638834, 6401.87196256063, 6404.039394090923, 6409.294977552372, 6410.711517981796, 6102.640737559575, 6131.774283661862, 6210.223722034746, 6211.09939058843, 6296.559240853279, 6292.433680968735, 6329.841753956188, 6342.175517182736, 6344.492440604833, 6349.809505714836, 6205.47253483459, 6242.157308763259, 6254.562180647311, 6259.718312675849, 6261.405166509175, 5727.341355743976, 5974.2233509643465, 6006.429389208019, 6020.939790602038, 6237.345078766845, 5927.2590926134235, 5978.073398623221, 5997.370276120944, 6029.397060293935, 6112.297085835008, 5061.645684802029, 6202.317745048132, 6202.4417802398, 6209.410106039919, 6210.658413787104, 5970.9701451492465, 5992.280926288873, 6039.063945088518, 6051.485623721856, 6065.5754097212775], "value": 5767.644756452103, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.2529894208964, 729.7921939190638, 735.7204262380295, 847.9491230526165, 857.5669287010058, 27788.027419040336, 29134.708652913465, 29159.416811663756, 39486.0, 40089.7995510022, 40585.98535036618, 40592.0, 40595.59404405955, 40660.59339406605, 40699.59300406995, 8996.965348984868, 9168.633254669805, 9182.540872956359, 9184.0, 9191.21874640653, 7258.129024517066, 7451.143118541383, 7464.10430748311, 9128.40665356753, 9239.260859131287, 7440.404767618605, 7477.476576639638, 7504.8123796904965, 10816.351018938849, 11046.116310695124, 11022.50398732055, 11071.833922491169, 11079.889201107966, 11081.058110060654, 11082.00261976418, 10757.946210268978, 10798.082163016154, 10826.945865270623, 10838.40388778617, 10839.349639021684, 27308.590371144448, 27817.887284508597, 38646.420303695464, 39212.215755685014, 39463.60536394628, 3772.3775577029755, 3782.678472329855, 3791.4881490998637, 3901.4147877818273, 3915.23652887687, 23887.163949261692, 28226.435471290664, 28244.71755282462, 28696.71303286961, 28799.856000720072, 3038.635363756341, 3056.0, 3061.7244447999788, 3141.8429078545983, 3154.44797160496, 331229.3438532792, 332611.0, 332621.0, 333106.0, 339453.0, 50893.74553127211, 51240.23139652908, 51246.487535124914, 51288.48711512837, 51311.7434412833, 53996.46003539993, 54086.72956635192, 54116.72941635267, 54169.3749187525, 54242.0, 12728.10903236783, 12732.04509661779, 12811.615651530468, 12827.807582886264, 12872.806907896389, 10597.682069537927, 10662.520186591622, 10710.518026688818, 10722.410267435365, 10743.24797264184, 10988.835167472334, 12264.938675306745, 12499.187552809039, 12530.561430349893, 12557.434915428828, 4525.954740452619, 4625.699329543569, 4715.834945776881, 4744.074905393415, 5278.736063196825, 962.6486332488731, 998.7053819123377, 1081.8214994525972, 1116.1182665694012, 1176.9529218831321, 23252.65121023152, 26289.76388909593, 26597.73402265991, 26797.866010669823, 26821.597676034486, 1211.4730092409654, 1216.592441532079, 1250.3123282194756, 1272.6691060324383, 1277.2719549856492, 13261.535846245528, 13581.524646637321, 13876.306184690726, 13912.51306204278, 13952.441902323793, 413715.0, 413938.0, 414665.0, 415587.0, 415642.0, 56463.43536564582, 56468.0, 56512.43487565072, 56591.151132733045, 56594.0, 1352.5266156845223, 1416.4546649539795, 1420.34664054534, 1423.110555902561, 1425.9287035648383, 24800.50398991974, 25989.220323390327, 26000.0, 26101.216963491126, 26618.467630647665, 45570.0, 45709.314360283955, 45732.542674572825, 45747.0, 45788.54211457843, 350139.0, 350694.0, 351095.0, 351573.0, 352404.0, 21666.566668666852, 22165.445863853533, 22376.77623223747, 22966.770332296463, 34040.65959340375, 38062.80968595139, 39116.63091791773, 39370.81887543378, 39371.60628393794, 39373.80313098531, 30892.785437022514, 32660.183495412806, 33470.661173552784, 33744.32511349808, 33748.0, 32533.511997320533, 32792.180195495304, 32893.17767055843, 33011.33977320392, 33295.33409331848, 32510.0, 32614.184645384055, 33049.33901322008, 33067.0, 33314.0, 25456.74543254544, 26426.07508737185, 27597.172084837486, 27621.03326383567, 28897.42205155927, 21088.71712216995, 22418.0, 22584.322470325915, 22810.0, 22911.656325154803], "value": 17746.096336689672, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.37063062703373, 371.8345336325333, 389.5228345277036, 426.2115087088886, 436.96722745794074, 13127.343632818369, 13375.464981400744, 14820.184889831055, 19901.800981990174, 20753.688694669592, 21181.36455906325, 21799.147072498818, 22157.335279941588, 22363.888180559075, 22556.548869022652, 6246.593971391845, 6300.968495157518, 6456.386643268882, 6505.902411463831, 6566.409023187912, 6485.416312531871, 6500.4799616030605, 6527.314631963647, 6553.967230163867, 6569.244536878273, 4115.238680844039, 4287.699861009731, 4325.74045557266, 4396.758178300192, 7429.517081389719, 7121.999999999948, 7510.347723500849, 7511.924880751178, 7517.774466766005, 7522.69909203634, 7006.929930700679, 7049.154101507801, 7087.751928682523, 7089.92910070903, 7097.432205423554, 23510.0, 26628.46743065147, 26638.73361266382, 26838.86580567085, 26865.059722909606, 2755.9586606200924, 2813.5779633055, 2836.446892855894, 2860.985695071532, 2957.260684828793, 16015.919920400323, 16086.0, 16527.091009994445, 17000.0, 17055.147242637944, 1845.8523318134517, 1928.797476264986, 1937.6124775045048, 1951.6194342103295, 2007.8393728501685, 104504.95495045028, 127306.36346818299, 129062.35468822595, 131984.34007829995, 133039.99999999904, 12408.379581020912, 12610.801973812473, 14107.647308817363, 14551.272436378138, 15393.384264629512, 22514.21200258016, 22567.887160564092, 22597.322080337617, 22620.54758904813, 22625.0, 8633.697820576375, 8741.650333986696, 8764.517951512727, 8926.776830579158, 8998.955005224932, 6205.47253483459, 7656.464047516621, 7679.500832445985, 7824.29581337671, 7861.724839630586, 6740.9662951685905, 6824.454043676494, 6834.2140653825445, 6851.383375496229, 6852.177738671391, 3698.9075273118387, 3767.434884767307, 3773.6226277409096, 3782.7730336179366, 3786.469894214812, 1033.2095946600857, 1035.5081336365317, 1046.2005350796617, 1057.2968975631272, 1084.7776205877776, 20533.0, 21313.786862131492, 21609.135634574755, 21731.37014723902, 21756.238531651317, 870.4516154822421, 1005.653049697853, 1028.4497793680346, 1085.934843909368, 1094.688013916046, 11016.394098324508, 11268.943655281671, 11338.072527670316, 11453.541858325574, 11470.254433461965, 556678.0, 635664.568108863, 693542.0, 694373.0, 708831.0, 142388.0, 144678.0, 146920.0, 147506.0, 148286.0, 1024.533837104116, 1028.6605420211313, 1051.1800795379463, 1051.8790339110947, 1051.8895515970712, 15443.536693899201, 17928.551786204927, 18408.26366945307, 18536.907315463337, 18678.906605466887, 57786.0, 60199.69900150471, 60847.69576152091, 61596.0, 62050.828221012045, 78453.7623549519, 79347.0, 79880.60059699665, 80018.5999070001, 81364.133993873, 11261.71845703864, 11319.207655464368, 11470.942645286721, 11628.732397182468, 11690.661867626679, 11912.40437978115, 12372.938135309267, 12469.563565275172, 12669.176503527242, 12699.55551555728, 8898.866517002121, 10659.733506662396, 10904.50929708181, 11018.0, 11035.613753518588, 10334.224933130195, 10416.270861039655, 10429.68710938673, 10595.152387808803, 10647.893521065, 11419.543218271176, 11458.656240312805, 11488.483018264365, 11523.596674116367, 11621.360825154698, 11276.718082048015, 11280.943595281971, 11438.313701177956, 11531.654050378502, 11561.826572601585, 8245.0, 9588.808223835624, 10647.361158330525, 10936.890631093587, 10962.397068161328], "value": 10691.58295832617, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1428.8428272889983, 1562.9374825007, 1565.819930707969, 1591.1646385647541, 1597.0497553955397, 10526.947365263173, 11095.944520277388, 11103.389313587759, 11133.1093512519, 11134.10927125831, 10380.532876020578, 10814.674844908342, 10816.405097719622, 10940.671779846598, 10946.616868409606, 2297.7357603875516, 2326.8952897119584, 2336.8714720690355, 2338.53229354129, 2339.9766002340016, 2303.124812571229, 2331.9883400583058, 2336.754640762721, 2340.742518322983, 2342.8945697443655, 2284.132029828663, 2287.1994801819314, 2310.4916918278036, 2316.050419328076, 2318.524702436005, 2299.9885000574973, 2310.2145270608075, 2330.9883450582806, 2332.1720789119872, 2338.356951838241, 2192.6053310404122, 2253.2339004738305, 2326.685897403846, 2329.9301020969397, 2332.6267797152373, 10706.982836630508, 10788.838167427495, 10792.892071079266, 10809.83785243222, 10818.08046316064, 5473.917891231635, 5626.774929002835, 5641.097424412115, 5645.068563686987, 5647.237622920894, 3221.178599457147, 3380.6431079239965, 3447.24160684649, 3531.0289670340603, 3532.0816587687127, 1099.1811100730008, 1139.7663478986872, 1157.7742340243656, 1186.9465874035602, 1192.0463629096687, 13647.454101835914, 14026.579202623938, 14050.43798248069, 15055.698886022219, 15068.698626027528, 4116.423700681907, 4225.471816022997, 4241.27898257297, 4524.298733696282, 4725.385699858996, 11561.826572601418, 11569.30584164936, 11590.71023224426, 11598.072154227642, 11619.186656933933, 5674.120511320752, 5676.971615141981, 5688.77244910199, 5689.9146512802345, 5691.743871525791, 4882.36529251195, 5171.7672704728375, 5234.712090834964, 5236.031334203185, 5250.0549901018185, 3605.2428989912414, 3722.571904230994, 3745.176061266517, 3798.772073675588, 3803.391457366808, 1012.2661070723814, 1014.5840205515703, 1019.7501612105082, 1028.5240679624762, 1033.8655974723238, 626.9373412066594, 775.8525880082766, 797.8763291689797, 798.8681867491799, 814.7229941819692, 6048.909266361008, 6245.375462453719, 6473.255575608771, 6474.838129046811, 6609.678064387142, 947.0016577492337, 987.4568987057233, 997.2769741937037, 1004.492731170754, 1053.378506681062, 3691.9077023074638, 4062.9639441942118, 4084.8366065357645, 4108.712390132722, 4155.23128221274, 10136.2904596679, 13211.471541138439, 13215.008874334271, 13480.865191348157, 13486.662833429244, 13354.265515396552, 13361.799573006412, 13380.665483362995, 13384.330783460982, 13405.396757145953, 9585.089416505421, 9754.512274386252, 9797.951010245046, 10039.598416063276, 10053.0, 6498.870022599616, 6512.641804700787, 6656.76701315471, 6673.532852700265, 6746.395594918946, 11819.113566482376, 11835.585754498896, 11964.880351196376, 12046.216995895238, 12097.637070887888, 10005.699829005142, 11001.504932277907, 11863.288202707865, 12134.817977730518, 12250.509979600716, 8603.440776349516, 8899.110088991309, 8957.641694332153, 9010.5945232466, 9014.774630634025, 9579.712608621752, 9789.951050244703, 9897.65358212459, 9899.406035637885, 9990.200783937413, 8582.613782379933, 8957.59690813902, 8969.596368163318, 8977.28181745472, 8985.820283594423, 7279.672414741455, 8656.653733850575, 8761.721952292577, 8783.165599268059, 8962.372633915564, 7639.88540171909, 7649.579273139808, 7664.0, 7720.266574675396, 7771.145174030965, 5464.672119672832, 5672.829815105553, 5689.687067211177, 5817.912731308949, 5839.5036421904615, 5757.971210143923, 5837.124431335334, 5930.34766175729, 6089.786857459968, 6120.969395152996], "value": 4974.35659098461, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [371.95164628598286, 373.5722597625719, 374.8013552817008, 382.9578746337901, 384.31399951087303, 4382.561743825616, 5218.425973142951, 5317.521423071923, 5322.361316642004, 5351.919721204185, 4444.9554354726615, 4956.479569645189, 5181.740912954356, 5195.506426889449, 5199.896002079966, 3597.8592737321383, 3645.3073915955883, 3683.6554657549937, 4142.937855932163, 4168.916621667565, 3634.309481198564, 3831.601465465099, 4161.146964872194, 4174.891679701746, 4212.8314867405425, 3277.88527401541, 3363.3441478911623, 3705.7961812100325, 4165.895852603694, 4183.874483765477, 3239.1740106272987, 3817.675497582709, 4043.6765058795227, 4075.4090656854887, 4088.34586466164, 2971.777116716233, 3654.903528941307, 3682.650148235913, 3690.0959264979983, 3691.9261614767825, 5061.569766569846, 5069.340985671876, 5144.871378215537, 5168.793248270064, 5181.300524429192, 3857.324968130566, 4205.789710514493, 4777.976110119427, 4818.301751019405, 4825.9758701206265, 5125.0, 5263.631545791796, 5465.5182750144895, 5488.4785945335125, 5566.4990150886615, 3635.1093981974323, 3791.0, 4034.8587799426878, 4095.1604920991126, 4125.18491863582, 5075.297928400536, 5110.8466745997675, 5654.6324488908085, 5765.8286198390515, 5837.795677151279, 4278.507971583308, 4317.892052698708, 4396.868093957187, 4902.504736055466, 5014.197728363444, 5017.54842064216, 5252.2971305230485, 5254.474552544715, 5259.263703081571, 5279.52484276417, 3997.5003124609425, 4511.751853648016, 4880.170371036932, 5370.946290537123, 5449.64577302482, 4759.928601070987, 5045.747712614428, 5680.14797780328, 5719.4271575317125, 5733.197352370671, 1513.583764464759, 1628.6172749403881, 1662.8087769906615, 1711.7346811244277, 1719.7936247650111, 1276.6106337566946, 1347.5014244729514, 1357.803118547805, 1363.7886127650231, 1386.660268234289, 4148.69316165407, 4179.582041795857, 4629.814807407666, 4761.476327575212, 5079.974600126976, 5295.470452954673, 5336.039512887717, 5416.075319327598, 5545.639533430395, 5663.518600918886, 4390.3414487827085, 4795.017021510582, 5203.60972927032, 5254.003478678078, 5270.8155214567305, 2651.0191229244915, 2770.252031951362, 2831.089014914924, 2857.4996877731983, 2931.6775154732964, 5135.199952035467, 5460.324441023869, 5859.710863609999, 5882.735276912464, 5883.117532370093, 4934.55588996992, 5096.413912400121, 5713.542916566665, 5735.541156707453, 5857.619254748428, 4951.084049450791, 5248.950209957948, 5595.63628364155, 5871.825634873043, 5873.383294754075, 4973.825916092919, 5264.9206912583595, 5602.607817452902, 5642.407547207484, 5655.293088363955, 5317.308749862493, 5483.75323110453, 5573.888522229614, 5644.8306550803545, 5646.2942132233475, 4979.958217131104, 5817.360090389969, 5890.882182356415, 5968.283805943314, 6030.939690603213, 3759.642833930772, 4035.858744943913, 4140.068484590943, 4583.312503124558, 4665.533446655308, 5692.886142277214, 5837.766489340549, 5869.35437101927, 5870.471657550841, 5878.706064696663, 4740.431148262231, 4927.457979622311, 5046.77289521965, 5516.345096470963, 5734.2258795062135, 5276.657017293864, 5434.500129940272, 5659.858503537444, 5660.88678226425, 5672.610210498454, 4361.476622805284, 5280.894382112413, 5553.4724201200825, 5606.635568688022, 5621.353544342453, 5630.971845140748, 5665.801696940587, 5667.838093190969, 5686.9715651421475, 5752.453516915886, 4974.253861920741, 5235.0576896159055, 5290.947090529045, 5306.89087557786, 5519.806806761744], "value": 4219.123943581885, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.8141483214363, 718.8706032914073, 757.4394947738672, 809.651849704627, 817.1269815329302, 14448.349824257908, 14805.111693298382, 14976.475823346185, 15088.849111508882, 15129.09225446474, 14011.789823152661, 14055.78916316256, 14180.149191048544, 14184.858151418483, 14268.429262829475, 922.4188761080543, 940.666063547441, 943.2124176312769, 958.238200630497, 960.0255740423476, 771.7221800151941, 952.4285428742768, 955.2071780422233, 956.9808603827919, 958.9904100958971, 1010.6058637131524, 1010.7473131717071, 1013.8327176015948, 1015.0, 1016.6340117557673, 1007.3552926127211, 1008.1581879130935, 1009.7273736091252, 1009.9646512372068, 1011.8886922438526, 621.2420846567181, 659.6899457255082, 742.8997085393456, 745.0798264143779, 745.4222977192665, 15120.319585618563, 15386.846131538654, 15432.614184645361, 15502.22488875563, 15595.844041559552, 13643.249621270925, 13842.930785346109, 13903.582892513241, 14010.22943738094, 14063.226522541256, 11408.20142590019, 11625.59310424131, 11743.47154378055, 12051.0, 12084.456199471046, 3528.2438201131636, 3614.6746792788776, 3648.3615367310613, 3648.781073135594, 3761.3981762918074, 95767.52116239374, 97150.02849971481, 98891.0, 100145.4992725039, 100544.49727751387, 9107.681231156877, 10369.792604147875, 10608.522616482276, 10763.246572739834, 10813.891861081289, 20073.799262007484, 21126.78873211279, 21148.682769758467, 21742.239021634166, 21892.78107218939, 7299.379552738077, 7496.512726672749, 7563.394928405714, 7572.81067973294, 7659.042619672541, 4150.501939767248, 4186.895327616773, 4203.516595591485, 4246.808893599796, 4258.084511829971, 3324.700776930088, 3393.609734880471, 3425.1265927188406, 3428.0401487583517, 3444.3111377724053, 614.5156960036603, 624.7938180400457, 625.0904933322097, 626.5457543281085, 631.958922670025, 634.9492040636738, 661.315538417745, 679.932006799326, 682.8873235916018, 699.8495323505471, 9499.620015199453, 9585.568649410794, 10111.949440252753, 10218.335808172445, 10409.739756505996, 611.016263815257, 650.2652003236407, 661.2773724447841, 682.160942041292, 723.992760072403, 3800.6959443244473, 3949.1114499238015, 4761.999700941991, 5244.125671476516, 5322.2282768998275, 101123.49438252761, 101556.96886062238, 101579.49210253902, 102284.97715022754, 103580.0, 47258.76370618125, 56108.719456403276, 67953.0, 73280.26719732842, 74178.0, 51404.0, 70685.29314706993, 70948.64525677338, 71230.64384678044, 72250.0, 8547.801452398211, 10014.3490673106, 10418.218633602359, 11033.393163376091, 11088.0, 40939.0, 43319.35020974751, 44758.77620612006, 46584.0, 47350.763246183546, 59086.40913590981, 59608.509787255665, 60150.49623759266, 60469.0, 60988.78022439437, 12039.819402708792, 12188.146829721834, 12230.510779568718, 12273.0, 12857.871421285667, 14026.649333766738, 14093.647658808612, 14111.71860217296, 14296.0, 14972.401103955719, 10537.998890105428, 11071.72320691989, 11410.771784564427, 11631.302121872715, 11778.705532361417, 12934.547290844775, 13322.533711320057, 13549.729005420033, 13729.725405492034, 13750.724985500434, 12924.806127907901, 12991.870081299066, 12998.610041698765, 13393.0, 13573.59279221625, 9443.716688499357, 10360.171186305228, 10470.319429237075, 10544.84182737275, 10609.734756631146, 7869.803254918673, 7876.72431464896, 8703.651853925772, 9249.856747801337, 10154.035366640157], "value": 7274.271993058103, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1445.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 114.0, 117.0, 115.0, 116.0, 114.0, 114.0, 115.0, 115.0, 114.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 110.0, 113.0, 178.0, 141.0, 109.0, 108.0, 110.0, 129.0, 109.0], "value": 124.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 184.0, 184.0, 181.0, 182.0, 184.0, 186.0, 183.0, 187.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 59.0, 90.0, 62.0, 59.0, 62.0, 60.0, 76.0, 60.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 89.0, 74.0, 71.0, 70.0, 86.0, 72.0, 69.0, 85.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 87.0, 87.0, 88.0, 86.0, 87.0, 87.0, 88.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 100.0, 95.0, 94.0, 95.0, 95.0, 93.0, 95.0, 94.0, 94.0], "value": 94.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 86.0, 83.0, 84.0, 85.0, 84.0, 82.0, 84.0, 86.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 60.0, 61.0, 61.0, 63.0, 62.0, 65.0, 65.0, 63.0, 64.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 66.0, 66.0, 65.0, 62.0, 55.0, 58.0, 59.0, 58.0, 59.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 91.0, 87.0, 88.0, 89.0, 88.0, 89.0, 91.0, 87.0, 128.0], "value": 92.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 149.0, 158.0, 146.0, 133.0, 151.0, 152.0, 147.0, 141.0, 145.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 174.0, 174.0, 232.0, 220.0, 170.0, 172.0, 171.0, 176.0, 172.0], "value": 183.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 69.0, 66.0, 66.0, 67.0, 67.0, 67.0, 68.0, 67.0], "value": 67.1, "unit": "score"}]}]} 06:49:52 INFO - Return code: 0 06:49:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:49:52 ERROR - # TBPL SUCCESS # 06:49:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:49:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:49:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:49:52 INFO - 2017-03-02 06:49:52.109 screenresolution[1653:10288] starting screenresolution argv=screenresolution get 06:49:52 INFO - 2017-03-02 06:49:52.112 screenresolution[1653:10288] Display 0: 1600x1200x32@60 06:49:52 INFO - 2017-03-02 06:49:52.118 screenresolution[1654:10291] starting screenresolution argv=screenresolution list 06:49:52 INFO - Available Modes on Display 0 06:49:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:49:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:49:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:49:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:49:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:49:52 INFO - Intel Iris: 06:49:52 INFO - Chipset Model: Intel Iris 06:49:52 INFO - Type: GPU 06:49:52 INFO - Bus: Built-In 06:49:52 INFO - VRAM (Dynamic, Max): 1536 MB 06:49:52 INFO - Vendor: Intel (0x8086) 06:49:52 INFO - Device ID: 0x0a2e 06:49:52 INFO - Revision ID: 0x0009 06:49:52 INFO - Displays: 06:49:52 INFO - Display: 06:49:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:49:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:49:52 INFO - Display Serial Number: 1600x1200 60 06:49:52 INFO - Main Display: Yes 06:49:52 INFO - Mirror: Off 06:49:52 INFO - Online: Yes 06:49:52 INFO - Rotation: Supported 06:49:52 INFO - Return code: 0 06:49:52 INFO - Running post-action listener: _resource_record_post_action 06:49:52 INFO - [mozharness: 2017-03-02 14:49:52.356235Z] Finished run-tests step (success) 06:49:52 INFO - Running post-run listener: _resource_record_post_run 06:49:52 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 39404544; Write bytes: 514319360; Read time: 437; Write time: 1720 06:49:52 INFO - TinderboxPrint: CPU usage
53.9% 06:49:52 INFO - TinderboxPrint: I/O read bytes / time
39,404,544 / 437 06:49:52 INFO - TinderboxPrint: I/O write bytes / time
514,319,360 / 1,720 06:49:52 INFO - TinderboxPrint: CPU idle
2,221.3 (46.1%) 06:49:52 INFO - TinderboxPrint: CPU system
959.9 (19.9%) 06:49:52 INFO - TinderboxPrint: CPU user
1,632.5 (33.9%) 06:49:52 INFO - TinderboxPrint: Swap in / out
263,790,592 / 0 06:49:52 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206379520; Write bytes: 204306432; Read time: 15586; Write time: 491 06:49:52 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 37331968; Write bytes: 297159680; Read time: 414; Write time: 1192 06:49:52 INFO - Running post-run listener: _upload_blobber_files 06:49:52 INFO - Blob upload gear active. 06:49:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:49:52 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 06:49:52 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'] 06:49:52 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 06:49:53 INFO - (blobuploader) - INFO - Open directory for files ... 06:49:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:49:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:49:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:54 INFO - (blobuploader) - INFO - Done attempting. 06:49:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:49:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:49:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:55 INFO - (blobuploader) - INFO - Done attempting. 06:49:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:49:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:49:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:56 INFO - (blobuploader) - INFO - Done attempting. 06:49:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:49:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:49:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:49:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:49:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:49:58 INFO - (blobuploader) - INFO - Done attempting. 06:49:58 INFO - (blobuploader) - INFO - Iteration through files over. 06:49:58 INFO - Return code: 0 06:49:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:49:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:49:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa208ab916d36aa3ae8d7cd223b8999a9627c9e1f0143dc163a1316544cb39282f38faff3cbb291e5846fee0099ecb4d6a280723af87046d42e229de3c07913b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b2318120e0189a3df44f79374ca6fdc289afd6ab5687fd07f633d8df01c137eadc96f446d62bc4bcc4fd5c4e9456f146204f88aebed0f71503ffd427a7521fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78aba0f15c98e7459b1478bb215b1f4f87769b55b87dc0c47a171c8c2b3df984c75f69a41dd99f4752d561e144b4e7b08dfef5314fb10c91da115bb585440f67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a886e6dbf45beaff64649ff8ccdc96a7880649dc6885614c872737bab85f683a8358672e05e0183815e59307f0cf4eb38fbde5ec6e8d2106ebebec974c0bcc1"} 06:49:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:49:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:49:58 INFO - Contents: 06:49:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa208ab916d36aa3ae8d7cd223b8999a9627c9e1f0143dc163a1316544cb39282f38faff3cbb291e5846fee0099ecb4d6a280723af87046d42e229de3c07913b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b2318120e0189a3df44f79374ca6fdc289afd6ab5687fd07f633d8df01c137eadc96f446d62bc4bcc4fd5c4e9456f146204f88aebed0f71503ffd427a7521fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78aba0f15c98e7459b1478bb215b1f4f87769b55b87dc0c47a171c8c2b3df984c75f69a41dd99f4752d561e144b4e7b08dfef5314fb10c91da115bb585440f67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a886e6dbf45beaff64649ff8ccdc96a7880649dc6885614c872737bab85f683a8358672e05e0183815e59307f0cf4eb38fbde5ec6e8d2106ebebec974c0bcc1"} 06:49:58 INFO - Running post-run listener: copy_logs_to_upload_dir 06:49:58 INFO - Copying logs to upload dir... 06:49:58 INFO - mkdir: /builds/slave/test/build/upload/logs 06:49:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.760340 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-02 06:49:58.466316) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 06:49:58.470299) ========= 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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa208ab916d36aa3ae8d7cd223b8999a9627c9e1f0143dc163a1316544cb39282f38faff3cbb291e5846fee0099ecb4d6a280723af87046d42e229de3c07913b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b2318120e0189a3df44f79374ca6fdc289afd6ab5687fd07f633d8df01c137eadc96f446d62bc4bcc4fd5c4e9456f146204f88aebed0f71503ffd427a7521fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78aba0f15c98e7459b1478bb215b1f4f87769b55b87dc0c47a171c8c2b3df984c75f69a41dd99f4752d561e144b4e7b08dfef5314fb10c91da115bb585440f67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a886e6dbf45beaff64649ff8ccdc96a7880649dc6885614c872737bab85f683a8358672e05e0183815e59307f0cf4eb38fbde5ec6e8d2106ebebec974c0bcc1"} build_url:https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/JH0oU-v-Qfyv9KBHFfixnw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa208ab916d36aa3ae8d7cd223b8999a9627c9e1f0143dc163a1316544cb39282f38faff3cbb291e5846fee0099ecb4d6a280723af87046d42e229de3c07913b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5b2318120e0189a3df44f79374ca6fdc289afd6ab5687fd07f633d8df01c137eadc96f446d62bc4bcc4fd5c4e9456f146204f88aebed0f71503ffd427a7521fd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78aba0f15c98e7459b1478bb215b1f4f87769b55b87dc0c47a171c8c2b3df984c75f69a41dd99f4752d561e144b4e7b08dfef5314fb10c91da115bb585440f67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8a886e6dbf45beaff64649ff8ccdc96a7880649dc6885614c872737bab85f683a8358672e05e0183815e59307f0cf4eb38fbde5ec6e8d2106ebebec974c0bcc1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 06:49:58.506490) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 06:49:58.506889) ========= 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.dOZhv8KfAH/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.KJIZ5Ya5X9/Listeners TMPDIR=/var/folders/f9/cg1m6_fx7ts4ntdpv3xn3tmm00000w/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.005169 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 06:49:58.556297) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 06:49:58.556662) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 06:49:58.557051) ========= ========= Total master_lag: 0.18 =========