builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0312 starttime: 1493328850.29 results: success (0) buildid: 20170427130024 builduid: 2b8e7122be1a4fdba7ea4e9cef99dda4 revision: 2cca333f546f38860f84940d4c72d7470a3410f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.287568) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.288141) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.288443) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.315489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.315808) ========= 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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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-04-27 14:34:10-- 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% 242M=0s 2017-04-27 14:34:10 (242 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129422 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.469521) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.469840) ========= 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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.026729 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:10.518471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-27 14:34:10.518813) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2cca333f546f38860f84940d4c72d7470a3410f4 --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 2cca333f546f38860f84940d4c72d7470a3410f4 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AyM9FfnzOh/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.e5aAbEvlo8/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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-04-27 14:34:10,627 truncating revision to first 12 chars 2017-04-27 14:34:10,627 Setting DEBUG logging. 2017-04-27 14:34:10,627 attempt 1/10 2017-04-27 14:34:10,627 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2cca333f546f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-27 14:34:11,006 unpacking tar archive at: mozilla-central-2cca333f546f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654341 ========= master_lag: 3.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2017-04-27 14:34:14.281883) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:14.282216) ========= script_repo_revision: 2cca333f546f38860f84940d4c72d7470a3410f4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:14.282636) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:14.282925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-27 14:34:14.311112) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-27 14:34:14.311496) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AyM9FfnzOh/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.e5aAbEvlo8/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:34:14 INFO - MultiFileLogger online at 20170427 14:34:14 in /builds/slave/test 14:34:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:34:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:34:14 INFO - {'append_to_log': False, 14:34:14 INFO - 'base_work_dir': '/builds/slave/test', 14:34:14 INFO - 'blob_upload_branch': 'Firefox', 14:34:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:34:14 INFO - 'branch': 'Firefox', 14:34:14 INFO - 'buildbot_json_path': 'buildprops.json', 14:34:14 INFO - 'config_files': ('talos/mac_config.py',), 14:34:14 INFO - 'default_actions': ('clobber', 14:34:14 INFO - 'read-buildbot-config', 14:34:14 INFO - 'download-and-extract', 14:34:14 INFO - 'populate-webroot', 14:34:14 INFO - 'create-virtualenv', 14:34:14 INFO - 'install', 14:34:14 INFO - 'run-tests'), 14:34:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:34:14 INFO - 'download_minidump_stackwalk': True, 14:34:14 INFO - 'download_symbols': 'ondemand', 14:34:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:34:14 INFO - 'tooltool.py': '/tools/tooltool.py', 14:34:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:34:14 INFO - '/tools/misc-python/virtualenv.py')}, 14:34:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:34:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:34:14 INFO - 'gecko_profile': False, 14:34:14 INFO - 'gecko_profile_interval': 0, 14:34:14 INFO - 'installer_path': 'installer.exe', 14:34:14 INFO - 'log_level': 'info', 14:34:14 INFO - 'log_name': 'talos', 14:34:14 INFO - 'log_to_console': True, 14:34:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:34:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:34:14 INFO - 'opt_config_files': (), 14:34:14 INFO - 'pip_index': False, 14:34:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:34:14 INFO - 'cmd': ('bash', 14:34:14 INFO - '-c', 14:34:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:34:14 INFO - 'enabled': True, 14:34:14 INFO - 'halt_on_failure': False, 14:34:14 INFO - 'name': 'check_screen_resolution'},), 14:34:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:34:14 INFO - 'cmd': ('bash', 14:34:14 INFO - '-c', 14:34:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:34:14 INFO - 'enabled': True, 14:34:14 INFO - 'halt_on_failure': False, 14:34:14 INFO - 'name': 'check_screen_resolution'},), 14:34:14 INFO - 'run_cmd_checks_enabled': True, 14:34:14 INFO - 'suite': 'dromaeojs-e10s', 14:34:14 INFO - 'system_bits': '32', 14:34:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:34:14 INFO - 'title': 't-yosemite-r7-0312', 14:34:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:34:14 INFO - 'use_talos_json': True, 14:34:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:34:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:34:14 INFO - 'work_dir': 'build'} 14:34:14 INFO - [mozharness: 2017-04-27 21:34:14.635979Z] Running clobber step. 14:34:14 INFO - Running pre-action listener: _resource_record_pre_action 14:34:14 INFO - Running main action method: clobber 14:34:14 INFO - rmtree: /builds/slave/test/build 14:34:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:34:17 INFO - Running post-action listener: _resource_record_post_action 14:34:17 INFO - [mozharness: 2017-04-27 21:34:17.432664Z] Finished clobber step (success) 14:34:17 INFO - [mozharness: 2017-04-27 21:34:17.432793Z] Running read-buildbot-config step. 14:34:17 INFO - Running pre-action listener: _resource_record_pre_action 14:34:17 INFO - Running main action method: read_buildbot_config 14:34:17 INFO - Using buildbot properties: 14:34:17 INFO - { 14:34:17 INFO - "project": "", 14:34:17 INFO - "product": "firefox", 14:34:17 INFO - "script_repo_revision": "production", 14:34:17 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 14:34:17 INFO - "repository": "", 14:34:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 14:34:17 INFO - "buildid": "20170427130024", 14:34:17 INFO - "pgo_build": "False", 14:34:17 INFO - "basedir": "/builds/slave/test", 14:34:17 INFO - "buildnumber": 47, 14:34:17 INFO - "slavename": "t-yosemite-r7-0312", 14:34:17 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 14:34:17 INFO - "platform": "yosemite_r7", 14:34:17 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:34:17 INFO - "branch": "mozilla-central", 14:34:17 INFO - "repo_path": "mozilla-central", 14:34:17 INFO - "revision": "2cca333f546f38860f84940d4c72d7470a3410f4", 14:34:17 INFO - "stage_platform": "macosx64", 14:34:17 INFO - "builduid": "2b8e7122be1a4fdba7ea4e9cef99dda4", 14:34:17 INFO - "slavebuilddir": "test" 14:34:17 INFO - } 14:34:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 14:34:17 INFO - Running post-action listener: _resource_record_post_action 14:34:17 INFO - [mozharness: 2017-04-27 21:34:17.436082Z] Finished read-buildbot-config step (success) 14:34:17 INFO - [mozharness: 2017-04-27 21:34:17.436234Z] Running download-and-extract step. 14:34:17 INFO - Running pre-action listener: _resource_record_pre_action 14:34:17 INFO - Running main action method: download_and_extract 14:34:17 INFO - mkdir: /builds/slave/test/build/tests 14:34:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:34:17 INFO - trying https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 14:34:17 INFO - Downloading https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:34:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 14:34:18 INFO - Downloaded 1325 bytes. 14:34:18 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:34:18 INFO - Using the following test package requirements: 14:34:18 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:34:18 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 14:34:18 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:34:18 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:34:18 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 14:34:18 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:34:18 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 14:34:18 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:34:18 INFO - u'jsshell-mac.zip'], 14:34:18 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:34:18 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 14:34:18 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:34:18 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:34:18 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 14:34:18 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:34:18 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 14:34:18 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:34:18 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 14:34:18 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:34:18 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 14:34:18 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:34:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:34:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:34:18 INFO - Fetch https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:34:20 INFO - Content-Length response header: 52695432 14:34:20 INFO - Bytes received: 52695432 14:34:36 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:34:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:34:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:34:36 INFO - Fetch https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:34:38 INFO - Content-Length response header: 52695432 14:34:38 INFO - Bytes received: 52695432 14:34:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 14:34:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:34:54 INFO - Fetch https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 14:34:55 INFO - Content-Length response header: 14408809 14:34:55 INFO - Bytes received: 14408809 14:34:55 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')]} 14:34:55 INFO - trying https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:34:55 INFO - Downloading https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 14:34:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 14:34:57 INFO - Downloaded 71238474 bytes. 14:34:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:34:57 INFO - mkdir: /builds/slave/test/properties 14:34:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:34:57 INFO - Writing to file /builds/slave/test/properties/build_url 14:34:57 INFO - Contents: 14:34:57 INFO - build_url:https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:34:58 INFO - Running post-action listener: _resource_record_post_action 14:34:58 INFO - Running post-action listener: set_extra_try_arguments 14:34:58 INFO - [mozharness: 2017-04-27 21:34:58.305609Z] Finished download-and-extract step (success) 14:34:58 INFO - [mozharness: 2017-04-27 21:34:58.305738Z] Running populate-webroot step. 14:34:58 INFO - Running pre-action listener: _resource_record_pre_action 14:34:58 INFO - Running main action method: populate_webroot 14:34:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:34:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:34:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:34:58 INFO - '--tppagecycles', 14:34:58 INFO - '7'], 14:34:58 INFO - 'tests': ['tsvgm']}}, 14:34:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:34:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:34:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:34:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:34:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:34:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:34:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:34:58 INFO - 'talos_options': ['--disable-e10s'], 14:34:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:34:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:34:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:34:58 INFO - 'talos_options': ['--disable-e10s'], 14:34:58 INFO - 'tests': ['damp', 'tps']}, 14:34:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:34:58 INFO - 'tests': ['damp', 'tps']}, 14:34:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:34:58 INFO - 'tests': ['dromaeo_dom']}, 14:34:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:34:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:34:58 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:34:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:34:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:34:58 INFO - 'tests': ['a11yr', 14:34:58 INFO - 'ts_paint', 14:34:58 INFO - 'tpaint', 14:34:58 INFO - 'sessionrestore', 14:34:58 INFO - 'sessionrestore_no_auto_restore', 14:34:58 INFO - 'tabpaint']}, 14:34:58 INFO - 'other-e10s': {'tests': ['a11yr', 14:34:58 INFO - 'ts_paint', 14:34:58 INFO - 'tpaint', 14:34:58 INFO - 'sessionrestore', 14:34:58 INFO - 'sessionrestore_no_auto_restore', 14:34:58 INFO - 'tabpaint']}, 14:34:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:34:58 INFO - 'ts_paint', 14:34:58 INFO - 'tpaint', 14:34:58 INFO - 'sessionrestore', 14:34:58 INFO - 'sessionrestore_no_auto_restore', 14:34:58 INFO - 'tabpaint']}, 14:34:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:34:58 INFO - 'ts_paint', 14:34:58 INFO - 'tpaint', 14:34:58 INFO - 'sessionrestore', 14:34:58 INFO - 'sessionrestore_no_auto_restore', 14:34:58 INFO - 'tabpaint']}, 14:34:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:34:58 INFO - 'tests': ['a11yr', 14:34:58 INFO - 'ts_paint', 14:34:58 INFO - 'tpaint', 14:34:58 INFO - 'sessionrestore', 14:34:58 INFO - 'sessionrestore_no_auto_restore', 14:34:58 INFO - 'tabpaint']}, 14:34:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:34:58 INFO - 'tests': ['a11yr', 14:34:58 INFO - 'ts_paint', 14:34:58 INFO - 'tpaint', 14:34:58 INFO - 'sessionrestore', 14:34:58 INFO - 'sessionrestore_no_auto_restore', 14:34:58 INFO - 'tabpaint']}, 14:34:58 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:34:58 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:34:58 INFO - 'bloom_basic_ref']}, 14:34:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:34:58 INFO - 'tests': ['tsvgx', 14:34:58 INFO - 'tsvgr_opacity', 14:34:58 INFO - 'tart', 14:34:58 INFO - 'tscrollx', 14:34:58 INFO - 'cart', 14:34:58 INFO - 'tsvg_static']}, 14:34:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:34:58 INFO - 'tsvgr_opacity', 14:34:58 INFO - 'tart', 14:34:58 INFO - 'tscrollx', 14:34:58 INFO - 'cart', 14:34:58 INFO - 'tsvg_static']}, 14:34:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:34:58 INFO - 'talos_options': ['--disable-e10s'], 14:34:58 INFO - 'tests': ['tp5o']}, 14:34:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:34:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:34:58 INFO - 'talos_options': ['--disable-e10s', 14:34:58 INFO - '--xperf_path', 14:34:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:58 INFO - 'tests': ['tp5n']}, 14:34:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:34:58 INFO - 'talos_options': ['--xperf_path', 14:34:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:34:58 INFO - 'tests': ['tp5n']}}, 14:34:58 INFO - 'talos.zip': {'path': '', 14:34:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:34:58 INFO - Running post-action listener: _resource_record_post_action 14:34:58 INFO - [mozharness: 2017-04-27 21:34:58.324922Z] Finished populate-webroot step (success) 14:34:58 INFO - [mozharness: 2017-04-27 21:34:58.325019Z] Running create-virtualenv step. 14:34:58 INFO - Running pre-action listener: _resource_record_pre_action 14:34:58 INFO - Running main action method: create_virtualenv 14:34:58 INFO - Creating virtualenv /builds/slave/test/build/venv 14:34:58 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 14:34:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:34:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:34:58 INFO - Using real prefix '/tools/python27' 14:34:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:34:59 INFO - Installing distribute.............................................................................................................................................................................................done. 14:35:02 INFO - Installing pip.................done. 14:35:02 INFO - Return code: 0 14:35:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:35:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:35:02 INFO - Reading from file tmpfile_stdout 14:35:02 INFO - Output received: 14:35:02 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) 14:35:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:02 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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:35:02 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 14:35:02 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 14:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render', 14:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:02 INFO - 'HOME': '/Users/cltbld', 14:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:02 INFO - 'LOGNAME': 'cltbld', 14:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:02 INFO - 'MOZ_NO_REMOTE': '1', 14:35:02 INFO - 'NO_EM_RESTART': '1', 14:35:02 INFO - 'PAGER': '/bin/cat', 14:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:02 INFO - 'PWD': '/builds/slave/test', 14:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:02 INFO - 'SHELL': '/bin/bash', 14:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners', 14:35:02 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:02 INFO - 'USER': 'cltbld', 14:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:02 INFO - 'XPC_FLAGS': '0x0', 14:35:02 INFO - 'XPC_SERVICE_NAME': '0', 14:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:02 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 14:35:02 INFO - Cleaning up... 14:35:02 INFO - Return code: 0 14:35:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:02 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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:35:02 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 14:35:02 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 14:35:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render', 14:35:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:02 INFO - 'HOME': '/Users/cltbld', 14:35:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:02 INFO - 'LOGNAME': 'cltbld', 14:35:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:02 INFO - 'MOZ_NO_REMOTE': '1', 14:35:02 INFO - 'NO_EM_RESTART': '1', 14:35:02 INFO - 'PAGER': '/bin/cat', 14:35:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:02 INFO - 'PWD': '/builds/slave/test', 14:35:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:02 INFO - 'SHELL': '/bin/bash', 14:35:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners', 14:35:02 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:35:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:02 INFO - 'USER': 'cltbld', 14:35:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:02 INFO - 'XPC_FLAGS': '0x0', 14:35:02 INFO - 'XPC_SERVICE_NAME': '0', 14:35:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:02 INFO - Downloading/unpacking psutil>=3.1.1 14:35:02 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 14:35:02 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 14:35:02 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 14:35:02 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 14:35:02 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 14:35:02 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 14:35:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:35:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:06 INFO - Installing collected packages: psutil 14:35:06 INFO - Running setup.py install for psutil 14:35:06 INFO - building 'psutil._psutil_osx' extension 14:35:06 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 14:35:07 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 14:35:07 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 14:35:07 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 14:35:07 INFO - building 'psutil._psutil_posix' extension 14:35:07 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 14:35:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:35:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:35:07 INFO - ^ 14:35:07 INFO - 1 warning generated. 14:35:07 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 14:35:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:35:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:35:07 INFO - Successfully installed psutil 14:35:07 INFO - Cleaning up... 14:35:07 INFO - Return code: 0 14:35:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:35:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:08 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')]} 14:35:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:08 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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:35:08 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 14:35:08 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 14:35:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render', 14:35:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:08 INFO - 'HOME': '/Users/cltbld', 14:35:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:08 INFO - 'LOGNAME': 'cltbld', 14:35:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:08 INFO - 'MOZ_NO_REMOTE': '1', 14:35:08 INFO - 'NO_EM_RESTART': '1', 14:35:08 INFO - 'PAGER': '/bin/cat', 14:35:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:08 INFO - 'PWD': '/builds/slave/test', 14:35:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:08 INFO - 'SHELL': '/bin/bash', 14:35:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners', 14:35:08 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:35:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:08 INFO - 'USER': 'cltbld', 14:35:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:08 INFO - 'XPC_FLAGS': '0x0', 14:35:08 INFO - 'XPC_SERVICE_NAME': '0', 14:35:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:35:08 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 14:35:08 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 14:35:08 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 14:35:08 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 14:35:08 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 14:35:08 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 14:35:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:35:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:35:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:35:11 INFO - Installing collected packages: mozsystemmonitor 14:35:11 INFO - Running setup.py install for mozsystemmonitor 14:35:11 INFO - Successfully installed mozsystemmonitor 14:35:11 INFO - Cleaning up... 14:35:11 INFO - Return code: 0 14:35:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:11 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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:35:11 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 14:35:11 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 14:35:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render', 14:35:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:11 INFO - 'HOME': '/Users/cltbld', 14:35:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:11 INFO - 'LOGNAME': 'cltbld', 14:35:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:11 INFO - 'MOZ_NO_REMOTE': '1', 14:35:11 INFO - 'NO_EM_RESTART': '1', 14:35:11 INFO - 'PAGER': '/bin/cat', 14:35:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:11 INFO - 'PWD': '/builds/slave/test', 14:35:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:11 INFO - 'SHELL': '/bin/bash', 14:35:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners', 14:35:11 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:35:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:11 INFO - 'USER': 'cltbld', 14:35:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:11 INFO - 'XPC_FLAGS': '0x0', 14:35:11 INFO - 'XPC_SERVICE_NAME': '0', 14:35:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:12 INFO - Downloading/unpacking jsonschema==2.5.1 14:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:35:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:35:14 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 14:35:14 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 14:35:14 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 14:35:14 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 14:35:14 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 14:35:14 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 14:35:15 INFO - Downloading functools32-3.2.3-2.tar.gz 14:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:35:15 INFO - warning: no files found matching '*.txt' 14:35:15 INFO - no previously-included directories found matching 'build' 14:35:15 INFO - no previously-included directories found matching 'dist' 14:35:15 INFO - no previously-included directories found matching '.git*' 14:35:15 INFO - Installing collected packages: jsonschema, functools32 14:35:15 INFO - Running setup.py install for functools32 14:35:15 INFO - warning: no files found matching '*.txt' 14:35:15 INFO - no previously-included directories found matching 'build' 14:35:15 INFO - no previously-included directories found matching 'dist' 14:35:15 INFO - no previously-included directories found matching '.git*' 14:35:15 INFO - Successfully installed jsonschema functools32 14:35:15 INFO - Cleaning up... 14:35:15 INFO - Return code: 0 14:35:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:15 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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:35:15 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 14:35:15 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 14:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render', 14:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:15 INFO - 'HOME': '/Users/cltbld', 14:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:15 INFO - 'LOGNAME': 'cltbld', 14:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:15 INFO - 'MOZ_NO_REMOTE': '1', 14:35:15 INFO - 'NO_EM_RESTART': '1', 14:35:15 INFO - 'PAGER': '/bin/cat', 14:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:15 INFO - 'PWD': '/builds/slave/test', 14:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:15 INFO - 'SHELL': '/bin/bash', 14:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners', 14:35:15 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:15 INFO - 'USER': 'cltbld', 14:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:15 INFO - 'XPC_FLAGS': '0x0', 14:35:15 INFO - 'XPC_SERVICE_NAME': '0', 14:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:35:15 INFO - Cleaning up... 14:35:15 INFO - Return code: 0 14:35:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:15 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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:35:15 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 14:35:15 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 14:35:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render', 14:35:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:15 INFO - 'HOME': '/Users/cltbld', 14:35:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:15 INFO - 'LOGNAME': 'cltbld', 14:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:15 INFO - 'MOZ_NO_REMOTE': '1', 14:35:15 INFO - 'NO_EM_RESTART': '1', 14:35:15 INFO - 'PAGER': '/bin/cat', 14:35:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:15 INFO - 'PWD': '/builds/slave/test', 14:35:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:15 INFO - 'SHELL': '/bin/bash', 14:35:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners', 14:35:15 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:35:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:15 INFO - 'USER': 'cltbld', 14:35:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:15 INFO - 'XPC_FLAGS': '0x0', 14:35:15 INFO - 'XPC_SERVICE_NAME': '0', 14:35:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:15 INFO - Downloading/unpacking blobuploader==1.2.4 14:35:15 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 14:35:15 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 14:35:15 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 14:35:15 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 14:35:15 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 14:35:15 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 14:35:18 INFO - Downloading blobuploader-1.2.4.tar.gz 14:35:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:35:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:35:18 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 14:35:18 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 14:35:18 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 14:35:18 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 14:35:18 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 14:35:18 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 14:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:35:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35: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 14:35:19 INFO - Downloading docopt-0.6.1.tar.gz 14:35:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:35:19 INFO - Installing collected packages: blobuploader, requests, docopt 14:35:19 INFO - Running setup.py install for blobuploader 14:35:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:35:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:35:20 INFO - Running setup.py install for requests 14:35:20 INFO - Running setup.py install for docopt 14:35:20 INFO - Successfully installed blobuploader requests docopt 14:35:20 INFO - Cleaning up... 14:35:20 INFO - Return code: 0 14:35:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:20 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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:35:20 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 14:35:20 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 14:35:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render', 14:35:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:20 INFO - 'HOME': '/Users/cltbld', 14:35:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:20 INFO - 'LOGNAME': 'cltbld', 14:35:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:20 INFO - 'MOZ_NO_REMOTE': '1', 14:35:20 INFO - 'NO_EM_RESTART': '1', 14:35:20 INFO - 'PAGER': '/bin/cat', 14:35:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:20 INFO - 'PWD': '/builds/slave/test', 14:35:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:20 INFO - 'SHELL': '/bin/bash', 14:35:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners', 14:35:20 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:35:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:20 INFO - 'USER': 'cltbld', 14:35:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:20 INFO - 'XPC_FLAGS': '0x0', 14:35:20 INFO - 'XPC_SERVICE_NAME': '0', 14:35:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-urpYqP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-VcKOVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-6TDc06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-nE87n9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-EDlk8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-cEN1Dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-gg4gYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-uAEF63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-TgtSJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:35:21 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Dd8vAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-x2OalY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Z4ouWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-reIkzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-IwaDnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-NvKrHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-avGaQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:35:22 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-GOcJQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:35:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:35:22 INFO - Running setup.py install for manifestparser 14:35:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:35:22 INFO - Running setup.py install for mozcrash 14:35:23 INFO - Running setup.py install for mozdebug 14:35:23 INFO - Running setup.py install for mozdevice 14:35:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:35:23 INFO - Running setup.py install for mozfile 14:35:23 INFO - Running setup.py install for mozhttpd 14:35:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:35:23 INFO - Running setup.py install for mozinfo 14:35:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:35:23 INFO - Running setup.py install for mozInstall 14:35:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:35:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:35:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:35:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:35:23 INFO - Running setup.py install for mozleak 14:35:24 INFO - Running setup.py install for mozlog 14:35:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:35:24 INFO - Running setup.py install for moznetwork 14:35:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:35:24 INFO - Running setup.py install for mozprocess 14:35:24 INFO - Running setup.py install for mozprofile 14:35:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:35:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:35:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:35:24 INFO - Running setup.py install for mozrunner 14:35:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:35:24 INFO - Running setup.py install for mozscreenshot 14:35:25 INFO - Running setup.py install for moztest 14:35:25 INFO - Running setup.py install for mozversion 14:35:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:35:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:35:25 INFO - Cleaning up... 14:35:25 INFO - Return code: 0 14:35:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35: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')]} 14:35:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35: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')]} 14:35:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:25 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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:35:25 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 14:35:25 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 14:35:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render', 14:35:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:25 INFO - 'HOME': '/Users/cltbld', 14:35:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:25 INFO - 'LOGNAME': 'cltbld', 14:35:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:25 INFO - 'MOZ_NO_REMOTE': '1', 14:35:25 INFO - 'NO_EM_RESTART': '1', 14:35:25 INFO - 'PAGER': '/bin/cat', 14:35:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:25 INFO - 'PWD': '/builds/slave/test', 14:35:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:25 INFO - 'SHELL': '/bin/bash', 14:35:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners', 14:35:25 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:35:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:25 INFO - 'USER': 'cltbld', 14:35:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:25 INFO - 'XPC_FLAGS': '0x0', 14:35:25 INFO - 'XPC_SERVICE_NAME': '0', 14:35:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:35:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-phwrtF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:35:25 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)) 14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:35:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-uK6TTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:35:25 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)) 14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:35:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-j5kAk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:35:25 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)) 14:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:35:25 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-DPWX0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:35:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-S7GBjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:35:26 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)) 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-0TtF8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:35:26 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)) 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-KbZiwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:35:26 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)) 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ZPPuiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:35:26 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)) 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-I17s_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:35:26 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)) 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-eYcf9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:35:26 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)) 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-at5tYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:35:26 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)) 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-iH4k_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:35:26 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)) 14:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:35:26 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Q2QILs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:35:27 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)) 14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:35:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Sp2KIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:35:27 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)) 14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-SVAb5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:35:27 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)) 14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:35:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-cFKCX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:35:27 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)) 14:35:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:35:27 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-CFpcd_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:35:27 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)) 14:35:27 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)) 14:35:27 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)) 14:35:27 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)) 14:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:35:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:35:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:35:29 INFO - Downloading blessings-1.6.tar.gz 14:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:35:30 INFO - Installing collected packages: blessings 14:35:30 INFO - Running setup.py install for blessings 14:35:30 INFO - Successfully installed blessings 14:35:30 INFO - Cleaning up... 14:35:30 INFO - Return code: 0 14:35:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:35:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:30 INFO - Reading from file tmpfile_stdout 14:35:30 INFO - Current package versions: 14:35:30 INFO - blessings == 1.6 14:35:30 INFO - blobuploader == 1.2.4 14:35:30 INFO - docopt == 0.6.1 14:35:30 INFO - functools32 == 3.2.3-2 14:35:30 INFO - jsonschema == 2.5.1 14:35:30 INFO - manifestparser == 1.1 14:35:30 INFO - mozInstall == 1.12 14:35:30 INFO - mozcrash == 1.0 14:35:30 INFO - mozdebug == 0.1 14:35:30 INFO - mozdevice == 0.50 14:35:30 INFO - mozfile == 1.2 14:35:30 INFO - mozhttpd == 0.7 14:35:30 INFO - mozinfo == 0.9 14:35:30 INFO - mozleak == 0.1 14:35:30 INFO - mozlog == 3.4 14:35:30 INFO - moznetwork == 0.27 14:35:30 INFO - mozprocess == 0.25 14:35:30 INFO - mozprofile == 0.28 14:35:30 INFO - mozrunner == 6.13 14:35:30 INFO - mozscreenshot == 0.1 14:35:30 INFO - mozsystemmonitor == 0.3 14:35:30 INFO - moztest == 0.8 14:35:30 INFO - mozversion == 1.4 14:35:30 INFO - psutil == 3.1.1 14:35:30 INFO - requests == 1.2.3 14:35:30 INFO - wsgiref == 0.1.2 14:35:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:30 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 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:35:30 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 14:35:30 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 14:35:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render', 14:35:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:30 INFO - 'HOME': '/Users/cltbld', 14:35:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:30 INFO - 'LOGNAME': 'cltbld', 14:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:30 INFO - 'MOZ_NO_REMOTE': '1', 14:35:30 INFO - 'NO_EM_RESTART': '1', 14:35:30 INFO - 'PAGER': '/bin/cat', 14:35:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:30 INFO - 'PWD': '/builds/slave/test', 14:35:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:30 INFO - 'SHELL': '/bin/bash', 14:35:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners', 14:35:30 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:35:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:30 INFO - 'USER': 'cltbld', 14:35:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:30 INFO - 'XPC_FLAGS': '0x0', 14:35:30 INFO - 'XPC_SERVICE_NAME': '0', 14:35:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:30 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)) 14:35:30 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)) 14:35:30 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)) 14:35:30 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)) 14:35:30 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)) 14:35:30 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)) 14:35:30 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)) 14:35:30 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)) 14:35:30 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)) 14:35:30 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)) 14:35:30 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)) 14:35:30 INFO - Cleaning up... 14:35:30 INFO - Return code: 0 14:35:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:35:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d439b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d43c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9a1856c150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, '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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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 14:35:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:35:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:35:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render', 14:35:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:30 INFO - 'HOME': '/Users/cltbld', 14:35:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:30 INFO - 'LOGNAME': 'cltbld', 14:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:30 INFO - 'MOZ_NO_REMOTE': '1', 14:35:30 INFO - 'NO_EM_RESTART': '1', 14:35:30 INFO - 'PAGER': '/bin/cat', 14:35:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:30 INFO - 'PWD': '/builds/slave/test', 14:35:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:30 INFO - 'SHELL': '/bin/bash', 14:35:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners', 14:35:30 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:35:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:30 INFO - 'USER': 'cltbld', 14:35:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:30 INFO - 'XPC_FLAGS': '0x0', 14:35:30 INFO - 'XPC_SERVICE_NAME': '0', 14:35:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:35:31 INFO - Cleaning up... 14:35:31 INFO - Return code: 0 14:35:31 INFO - Running post-action listener: _resource_record_post_action 14:35:31 INFO - Running post-action listener: _start_resource_monitoring 14:35:31 INFO - Starting resource monitoring. 14:35:31 INFO - [mozharness: 2017-04-27 21:35:31.201344Z] Finished create-virtualenv step (success) 14:35:31 INFO - [mozharness: 2017-04-27 21:35:31.202401Z] Running install step. 14:35:31 INFO - Running pre-action listener: _resource_record_pre_action 14:35:31 INFO - Running main action method: install 14:35:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:35:31 INFO - Reading from file tmpfile_stdout 14:35:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:35:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:35:31 INFO - Reading from file tmpfile_stdout 14:35:31 INFO - Output received: 14:35:31 INFO - Usage: mozinstall [options] installer 14:35:31 INFO - Options: 14:35:31 INFO - -h, --help show this help message and exit 14:35:31 INFO - -d DEST, --destination=DEST 14:35:31 INFO - Directory to install application into. [default: 14:35:31 INFO - "/builds/slave/test"] 14:35:31 INFO - --app=APP Application being installed. [default: firefox] 14:35:31 INFO - mkdir: /builds/slave/test/build/application 14:35:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:35:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:35:50 INFO - Reading from file tmpfile_stdout 14:35:50 INFO - Output received: 14:35:50 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:35:50 INFO - Running post-action listener: _resource_record_post_action 14:35:50 INFO - [mozharness: 2017-04-27 21:35:50.996460Z] Finished install step (success) 14:35:50 INFO - [mozharness: 2017-04-27 21:35:50.996591Z] Running run-tests step. 14:35:50 INFO - Running pre-action listener: _resource_record_pre_action 14:35:50 INFO - Running main action method: run_tests 14:35:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:35:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:35:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:35:51 INFO - 2017-04-27 14:35:51.012 screenresolution[1621:7366] starting screenresolution argv=screenresolution get 14:35:51 INFO - 2017-04-27 14:35:51.015 screenresolution[1621:7366] Display 0: 1600x1200x32@60 14:35:51 INFO - 2017-04-27 14:35:51.020 screenresolution[1622:7424] starting screenresolution argv=screenresolution list 14:35:51 INFO - Available Modes on Display 0 14:35:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:35:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:35:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:35:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:35:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:35:51 INFO - Intel Iris: 14:35:51 INFO - Chipset Model: Intel Iris 14:35:51 INFO - Type: GPU 14:35:51 INFO - Bus: Built-In 14:35:51 INFO - VRAM (Dynamic, Max): 1536 MB 14:35:51 INFO - Vendor: Intel (0x8086) 14:35:51 INFO - Device ID: 0x0a2e 14:35:51 INFO - Revision ID: 0x0009 14:35:51 INFO - Displays: 14:35:51 INFO - Display: 14:35:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:35:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:35:51 INFO - Display Serial Number: 1600x1200 60 14:35:51 INFO - Main Display: Yes 14:35:51 INFO - Mirror: Off 14:35:51 INFO - Online: Yes 14:35:51 INFO - Rotation: Supported 14:35:51 INFO - Return code: 0 14:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:35:51 INFO - Python 2.7.3 14:35:51 INFO - Return code: 0 14:35:51 INFO - grabbing minidump binary from tooltool 14:35:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:35:51 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 0x10d217d30>, '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 0x10d13ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d20cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:35:51 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 14:35:51 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 14:35:51 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 14:35:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:35:51 INFO - Return code: 0 14:35:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:35:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:35:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:35:51 INFO - ENV: RUST_BACKTRACE is now 1 14:35:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:35:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:35:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:35:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:35:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AyM9FfnzOh/Render', 14:35:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:35:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:35:51 INFO - 'HOME': '/Users/cltbld', 14:35:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:35:51 INFO - 'LOGNAME': 'cltbld', 14:35:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:35:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:35:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:35:51 INFO - 'MOZ_NO_REMOTE': '1', 14:35:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:35:51 INFO - 'NO_EM_RESTART': '1', 14:35:51 INFO - 'PAGER': '/bin/cat', 14:35:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:35:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:35:51 INFO - 'PWD': '/builds/slave/test', 14:35:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:35:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:35:51 INFO - 'RUST_BACKTRACE': '1', 14:35:51 INFO - 'SHELL': '/bin/bash', 14:35:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e5aAbEvlo8/Listeners', 14:35:51 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 14:35:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:35:51 INFO - 'USER': 'cltbld', 14:35:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:35:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:35:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:35:51 INFO - 'XPC_FLAGS': '0x0', 14:35:51 INFO - 'XPC_SERVICE_NAME': '0', 14:35:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:35:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:35:51 INFO - mozversion application_buildid: 20170427130024 14:35:51 INFO - mozversion application_changeset: 2cca333f546f38860f84940d4c72d7470a3410f4 14:35:51 INFO - mozversion application_display_name: Nightly 14:35:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:35:51 INFO - mozversion application_name: Firefox 14:35:51 INFO - mozversion application_remotingname: firefox 14:35:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:35:51 INFO - mozversion application_vendor: Mozilla 14:35:51 INFO - mozversion application_version: 55.0a1 14:35:51 INFO - mozversion platform_buildid: 20170427130024 14:35:51 INFO - mozversion platform_changeset: 2cca333f546f38860f84940d4c72d7470a3410f4 14:35:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:35:51 INFO - mozversion platform_version: 55.0a1 14:35:51 INFO - using testdate: 1493328951 14:35:51 INFO - actual date: 1493328951 14:35:51 INFO - starting webserver on 'localhost:49234' 14:35:51 INFO - SUITE-START | Running 2 tests 14:35:51 INFO - TEST-START | dromaeo_css 14:35:51 INFO - operating with platform_type : mac_ 14:35:51 INFO - Initialising browser for dromaeo_css test... 14:35:51 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpXEOdQ9/profile http://localhost:49234/getInfo.html) 14:35:54 INFO - PID 1632 | 2017-04-27 14:35:54.160 plugin-container[1634:7668] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x973f, name = 'com.apple.tsm.portname' 14:35:54 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:35:54 INFO - PID 1632 | 2017-04-27 14:35:54.163 plugin-container[1634:7668] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9d0b, name = 'com.apple.CFPasteboardClient' 14:35:54 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:35:54 INFO - PID 1632 | 2017-04-27 14:35:54.163 plugin-container[1634:7668] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:35:54 INFO - PID 1632 | __metrics Screen width/height:1600/1200 14:35:54 INFO - PID 1632 | colorDepth:24 14:35:54 INFO - PID 1632 | Browser inner width/height: 1024/689 14:35:54 INFO - PID 1632 | __metrics 14:35:54 ERROR - PID 1632 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 14:35:55 INFO - TEST-INFO | 1632: exit 0 14:35:55 INFO - Browser initialized. 14:35:55 INFO - Running cycle 1/1 for dromaeo_css test... 14:35:55 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpXEOdQ9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:35:57 INFO - PID 1635 | 2017-04-27 14:35:57.519 plugin-container[1636:7796] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x933b, name = 'com.apple.tsm.portname' 14:35:57 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:35:57 INFO - PID 1635 | 2017-04-27 14:35:57.520 plugin-container[1636:7796] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 14:35:57 INFO - PID 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:35:57 INFO - PID 1635 | 2017-04-27 14:35:57.520 plugin-container[1636:7796] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:36:07 INFO - PID 1635 | RSS: Main: 251232256 14:36:07 INFO - PID 1635 | 14:39:10 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49234/tests/dromaeo/cssquery-ext.html) 14:39:12 INFO - PID 1635 | RSS: Main: 255221760 14:39:12 INFO - PID 1635 | 14:40:56 INFO - PID 1635 | ************************* 14:40:56 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 14:40:56 INFO - PID 1635 | 14:40:56 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:40:56 INFO - PID 1635 | Full stack: 14:40:56 INFO - PID 1635 | ************************* 14:40:56 INFO - PID 1635 | ************************* 14:40:56 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 14:40:56 INFO - PID 1635 | 14:40:56 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:40:56 INFO - PID 1635 | Full stack: 14:40:56 INFO - PID 1635 | ************************* 14:40:56 INFO - PID 1635 | ************************* 14:40:56 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 14:40:56 INFO - PID 1635 | 14:40:56 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:40:56 INFO - PID 1635 | Full stack: 14:40:56 INFO - PID 1635 | ************************* 14:40:56 INFO - PID 1635 | ************************* 14:40:56 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 14:40:56 INFO - PID 1635 | 14:40:56 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:40:56 INFO - PID 1635 | Full stack: 14:40:56 INFO - PID 1635 | ************************* 14:42:14 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-ext.html (next: http://localhost:49234/tests/dromaeo/cssquery-jquery.html) 14:42:15 INFO - PID 1635 | RSS: Main: 258920448 14:42:15 INFO - PID 1635 | 14:45:16 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49234/tests/dromaeo/cssquery-mootools.html) 14:45:17 INFO - PID 1635 | RSS: Main: 269828096 14:45:17 INFO - PID 1635 | 14:48:19 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49234/tests/dromaeo/cssquery-prototype.html) 14:48:19 INFO - PID 1635 | RSS: Main: 262742016 14:48:19 INFO - PID 1635 | 14:51:22 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49234/tests/dromaeo/cssquery-yui.html) 14:51:23 INFO - PID 1635 | RSS: Main: 271310848 14:51:23 INFO - PID 1635 | 14:54:24 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49234/tests/dromaeo/cssquery-yui.html (next: http://localhost:49234/tests/dromaeo/cssquery-dojo.html) 14:54:25 INFO - PID 1635 | RSS: Main: 265986048 14:54:25 INFO - PID 1635 | 14:54:25 INFO - PID 1635 | __start_tp_report 14:54:25 INFO - PID 1635 | _x_x_mozilla_page_load 14:54:25 INFO - PID 1635 | _x_x_mozilla_page_load_details 14:54:25 INFO - PID 1635 | |i|pagename|runs| 14:54:25 INFO - PID 1635 | |0;dojo.html;3237.676232376762;3336.1159292787415;3404.8808291709797;3597.010822023943;3602.675759181674;5809.925163844681;5954;6098.969505152473;6160.845978850531;6184.196054512919;6001.129836173752;6010.398960103998;6057;6061.575689701723;6127.816165515031;4292.6780491463105;5298.655587386817;5311.920321195185;5332.413434522199;5373.785048598052;5363.9463605363835;5367.919481207766;5379.139337705968;5380.811671591495;5396.5952553558445;5222.294990176316;5268.736563171826;5388.084025715618;5420.268263784398;5427.6472029318165;4681.344611754357;4808.374911261513;5217.452167522431;5300.708461034642;5405.297311349519;5220.086484865172;5259.658122222043;5292.550133238641;5296.523312901857;5356.1430171172815;4915.48387419323;6025.276966764016;6046.879062418727;6092.5430592705725;6129.325774164839;5053.191489361721;6499.512536559777;6504.902426463606;6525.347465253484;6558.639274839882;6305.968470157666;6384.138141350904;6551.21385433751;6606.405423511859;6631.27056023837;6258.499320054385;6282.057691346335;6288.056791481269;6295.992641177481;6308.558400911892;6575.408213260829;6769.458443324522;6785.42323902464;6789.25318214996;6820.624865632438;5383.542398896059;6224.751009959551;6286.528510361742;6406.167198264196;6699.933000669931;5435.239066530688;6516.869662606721;6578.111954886125;6595.373439523238;6626.4367528760595;5625.987322281947;6189.133521307021;6432.871342573122;6451.774187903401;6486.189226346707;6253.7185826637915;6299.622022678563;6315.336889626615;6409.230892292861;6444.645544495098;4781.760911954389;4962.727050012284;5182.352205974254;5214.45248248936;5232.581393488512;4677.508861569554;4687.81248750053;4698.600618947427;4716.646251531149;4790.161721698689;5153.639245252872;5995.5803093783015;6237;6241.095041218998;6348.904766428507;6297.716602752887;6356.745730170834;6461.870762584722;6520.739170433129;6525.575837570543;6099.111808770591;6139.048447490646;6149.692515374213;6158.322584515699;6218.471429928416;5773.538116950634;5822.272215973004;5834.883302333929;5845.210896528914;5859.648421094748;6526.608403495806;6588.472922166119;6670.633115178712;6751.223609284897;6778.288279730557;6570.375814297634;6586.110875032001;6605.966970165118;6619.073329733745;6653.800385988428;6509.283978762238;6631.038499417654;6678.766243181465;6802.795916122524;6806.7957961261245;6355;6367.331430199948;6411.5832470889245;6419.325970773001;6432.678366081771;6006;6350.142730731292;6350.587211831216;6383;6455.903161452676;6235.688215589112;6245.96877015612;6321.462675672619;6324.051392291193;6356.523260755369;6361.650109244036;6372.267189273293;6372.394622510854;6374.713137908712;6392.712327945346;5568.470995255444;6252.218472690914;6257.374262573706;6264.718087685974;6289.811305660837;6181.752729890934;6218.440340369389;6242.687865606792;6262.874742505215;6365.299817020216;6214.8135555933395;6215.129881816459;6229.5327850410495;6232.376762323913;6256.499480041494 14:54:25 INFO - PID 1635 | |1;ext.html;747.6897087708597;768.9038870141233;840.4159109418954;1203.1397550751217;1252.1985929005432;31440;31737.73049078037;31781;34451.31097378054;37860.43209351855;37182.62817371826;37416.81291593545;37439;37439.438408423826;37562.624373756254;7955.7215497457455;8125.75622731319;8371.823325935271;8598;8631.093735157812;7429.294217049372;8546.05993340732;8600.8709869352;8647.69733059343;8664.176903194186;6538.8692226155445;7315.707371705125;8188.50868947865;8620.525871077089;8623.223909848113;7993.520388776692;8639.611217495196;8641.95679021604;8654.48073115615;8656.523891185981;7863.8034049148655;8417.663293468315;8434.915650843473;8437.987441506997;8449.408541402105;36974.63025369739;37105.257894841954;37120.628793712254;37178.88463346104;37280.25439491195;3635.2366003139373;3650.34293827111;3674.2467794102145;3675.6140605236333;3677.4483827425834;25691.871540642365;29368.41263174746;30382.54426183609;30562;30583.541246881094;2791.3021744563857;3129.874805007797;3147.8740850365957;3149.9842500787577;3160.873565057395;216555.9172204129;216830.99014059207;272094.999999998;287844;288800.5559972208;47598.76200618975;47708;47844.73707892129;47863.28205076927;47967.60161991887;49398.01203975901;49718.50281497139;49749.75625609316;49802.750986244835;49835.75082124566;13548.187108773505;13646.727065458635;13723.588292351245;13739.381727822272;13755.867840484541;10957.17821163416;10992.28550144238;11052.668419947415;11073.889261107446;11107.94446027781;13296.401661925236;13335.066545341733;13384.93307533456;13519.188848669111;13534.45862165522;5110.514501122388;5998.670073146019;6022.518198544106;6047.637141771508;6062.757489700362;1015.2030655935056;1018.4245901065874;1023.2325755683238;1052.1582733812918;1063.8616979792578;23506.64740028901;24590.754092459203;24597.754022459903;24675.62986555203;25395.49209015809;1109.6060898380958;1132.7904337697553;1140.1278022312938;1153.2503872482785;1169.7601991591703;11054.613088541862;12468.43892024861;12601.684957876127;12616.30610316423;12628.989680825513;309506.9049309523;311946;312260;312750;312835.4358228194;52514.737426312626;52549.68625784386;52636;52730.73634631802;52760.73619631877;1498.8201415829951;1505.1871989125968;1538.8153421589257;1542.2443002928485;1543.8301786803443;23774.88112559426;23941.760582393952;23993.760062399153;24054.39864003414;24646.876765616056;36798.44802328021;36842.44736328904;36869.631303687696;36914.63085369112;36941;259894;261292;261364;261431;262687;33399.49900751442;33468;33806.81676141323;34336.45485953188;34417.82791086029;42323;44665;44683;44722.3291650632;44743.10513789771;29062;29166.27084322909;29698.960536381124;31016.22459438532;31143.221419464695;28515.572266416435;29802.10593682193;30668.386632267677;30851.69148308488;31312.843435782674;35195.648043519235;36209.63790362063;37040.25919481649;37100.25799483941;37111.25777484489;29926.25184370408;30491;31043.84478077595;31150.68849311478;31621.73513059452;21741.782582173975;23196.536069278183;24479.143229986865;24550.508989819748;24579.508409832062 14:54:25 INFO - PID 1635 | |2;jquery.html;439.27300317973766;446.4597836617692;447.55244755244746;462.7501149379335;466.5544405093136;18529.814701852978;18928.716069258953;19911.30310439135;21171.153153873827;21425.928703564838;20387.898060509713;22062.558748825013;22086.00612972416;22296.331110066683;22376.104955801788;5952.7321270542825;6190.040543715709;6217.440430361266;6254.7185376657935;6262.937370626281;5784.56615753818;6014.3985601439945;6106.542009349294;6112.327643959183;6114.144019837227;5836.5914385993;6028.849278768022;6038.33578306386;6055.818325450244;6063.302720187169;5957.1659967604355;6047.909281360783;6090.5736598438125;6095.664738439384;6109.266887973427;5353.839384818422;5356.035913535601;5365;5414.864628384283;5417.702026388547;26017.869910650516;26047.348816279555;26072.73927260722;26275.292106013047;26596.069137580285;2157.0616781699855;2229.3312006398014;2230.8549944253573;2231.553689262154;2235.798778109962;14480.782788258184;15368;17400.825991740174;18036.008019558918;18240;2087.2277257414703;2129.233475948657;2165.274632997932;2166.620841352773;2195.560887822442;128743;143432;153763;154600;157244.42755572413;12187.39063046844;12657.11400201977;12687.68280792969;12767.744645107046;12785.488580456678;14796.298425680969;15304.770428443582;16311.67376652484;16340.591485212964;16374.263158157912;6375.681215939185;7265.709371625181;8413.789655258544;8491.787705307293;8523.531205783742;7754.418418618626;7757.7672669819995;7790.182030886788;7903.249191326815;7915;7894.21057894206;7982.760517184493;7999.200079991954;8062.072861620989;8075.273225409741;1971.7929617389968;2028.3509277031503;2036.1877928643519;2040.8163265305898;2041.285550057468;891.4784850862188;922.9630814767469;960.9855852162223;963.393062370702;993.8956409577034;20134.395968120978;20521.589568208554;20525.58948821045;20527.897360513103;20839.79160208409;906.9455832650062;939.9671011514564;977.8288799460066;1016.598443614768;1016.8017236638784;9073.637054517745;10685.305455145392;10748.570057197781;10788.51451684676;10843.349399036084;535787;544428;544573;558654;560190;129118;129571;131537;134819.32590337182;136019;1179.151011271883;1207.402335843763;1223.7552489502136;1226.6320103968774;1227.6869398303375;20583.691244631642;21790.782092178877;21830.45423864416;21914.890425547772;21950.121995120015;53013.73493132664;56576.717116414155;56921.43078569161;57939.42060579509;58131.709341453025;78390.6080469594;78714;80104;80182;80649;8601.494738420626;8702.782430439289;8807.119288071142;9231.030741772018;9240.399374040666;14070.648233794236;14197.929010355296;14226.573202803518;14539.781903271249;14568.41726330935;11967.880321197024;11974.46114924813;12099.971502422393;12119.333436661069;12178;11482.598109066143;11495.48270327854;11571.6528504145;11853.288802671867;11882.702932426759;12032.338221397908;12194.51221951112;12292.569760058355;12457.252564845776;12561.560345387868;7856.332211762065;8851;8956.149165829236;8975.32685048611;9120.179183873483;10168.440735759605;10262.897371026493;11936.820947685617;11971.401429928643;11995.820062698893 14:54:25 INFO - PID 1635 | |3;mootools.html;1404.782258749893;1409.4714482069223;1415.810718996043;1490.3070072416324;1497.8202615686116;11351.886481135196;11643.883561164386;11659.300441973488;11661.766764664711;11743.41282935854;9975.40147591145;11440.771184576304;11596.884031159685;11610.245334053281;11630.069594432447;2196.857634030311;2463.08865719684;2525.6716626838484;2560.7567281108263;2562.3209849389928;1995.6828493194494;2325.976740232593;2361.917332893349;2375.6080246759266;2376.738558758535;2466.3094333586537;2497.9875100624563;2516.8238223324374;2522.407234299938;2523.7854782343525;2471.1104002559064;2492.67595212623;2504.912328068518;2521.2562294123277;2522.6846644169477;2450.5834008218644;2495.7254701982765;2505.1732928133674;2509.874506274679;2562.744255314882;11672.299662020307;11835.11236657254;11877;11890;11894.286342819458;6584.5061620378665;6782.626955517445;6825.36191314086;6844.589324640538;6847.657617119125;3723;4059.269331520325;4403.22943484892;4443.37792709021;4483.529229430928;1077.8329358949375;1243.359669770069;1252.4301442843575;1291.8901893339078;1300.8959283257316;16029.198540073066;16166.949148305323;16302.592435189215;16484.34062637493;17098.23057962382;4914.754262286871;5369.677819330853;5682.119271512922;5832.3292821326095;5846.947549441142;9605.759856003655;11598.88401115995;11769.117316201318;11778.587749428729;11849.881501185051;5517.61376703635;5856.1508581255475;6352.14246076783;6606.372394622503;6616.933830661728;5750.453706897838;6032.758689652453;6265.749370025148;6271.216097987752;6287.434130928147;4303.655707543389;4415.249407600716;4424.402705634698;4443.311286750559;4444.488883778342;1259.962201133949;1287.575100216926;1291.489861504719;1300.9349532523336;1303.4981532110016;708.9255628159073;779.5985067690144;800.4996876951905;827.1728271728272;828.8176601147737;6598.538102332791;6830.965845170742;6933.11339222719;6974.895376569356;7015.543989640657;900.9234215091791;930.7161315798746;938.1134827587864;948.369334392635;950.626344931581;3948.545917219499;4335.479742430928;4556.316552517149;4569.748663823521;4678.111158879802;15092.1699306537;15138.243087845563;15414.152221627694;15432.92283538575;15433.074015558877;14646.63383415423;14660;15180;15541.378344866305;15542.84457155414;8145.592720363839;8641.56792160402;8702.173293537104;8783.868241976375;8878;6898.586084834926;7066.505344626033;7203.991441198341;7218.855622887618;7238.348548630648;13274.668133296746;13330.466781328638;13569.52506662262;13598.048136630341;13618.727625447635;11378;13382.866171338552;13460.93269533646;13805.964552658792;13967.301634918416;9363.812723745623;9424.670136545188;9474.336796424459;9519.476428796206;9537.47543885093;10673.733156671145;10688.839667405151;10755.247132700635;10811.027007569357;10923.289986150874;9205.585748641193;9243.306751993761;9255.167034966886;9293.86059209126;9335.48654823964;7625.923740762521;8825.470471771714;9024.142706442877;9159.633614655339;9218.492982886006;8130;8200.26197642215;8303.252707256375;8324.0427350853;8362.331013519026;5316.6544174628525;6166.167567378347;6182.352412076896;6191.133241346305;6200.844978875564;6055.273367195965;6128.4790792783115;6219.160413344322;6274.121622972879;6380.840478988062 14:54:25 INFO - PID 1635 | |4;prototype.html;388.947492088568;405.8696530163495;406.19370549459325;409.41862555171656;419.2160659566611;5370.7851685932565;5955;6241.157443745093;6253.71858266378;6265.874682506347;4666.486686464486;5528.336599608043;5898.7935422260225;6057.575969682124;6114.768109639983;4653.464851542082;4691.366665500165;4695.225287827521;4712.717236965776;4715.033418149271;4238.936415953764;4554.749488778116;4704.035672687108;4725.8109675613105;4742.952570474303;3598.85604575818;4054.2702313583545;4604.743675598966;4643.907121857561;4696.272077827942;4650.116477869194;4663.580277775;4669.7898594562985;4697.4832768395445;4709.105269998689;3446;3892.552356479013;4037.253108174997;4099.344104943225;4162.229987452331;5368.91946620801;5938.930992421362;5963.910541341883;5993.910091348634;6079.483243924272;4814.3019262207135;5390.21841832932;5535.114381698909;5543.533127758149;5559.916601250984;6493.70778314977;6566.770163044318;6610.272869984298;6610.6778644271335;6662.600243985328;4486.147631949919;4722.197226471508;4742.316477650419;4750;4757.809687612491;5946.108083787466;6007.927265093579;6966.4078553323025;6979.755708550177;7036.542624729376;4265.893352666146;4832.251001094836;4832.49258827818;4863.076015557032;4872.366592342973;4923.87690307738;4944.53026962438;4949.307097006422;4971.825986090542;4986.227134794112;5399.244105825188;5489.39616642169;5544.500994910478;5546.445355464502;5557.972210138923;5721.456461636138;6599;6604.867902642017;6610.768623098168;6632.204135503771;1493.7609982402764;1688.4174959638906;1701.174930158872;1701.5150682055555;1702.1319127245195;1150.5685367987005;1170.5200867644226;1172.4841069929205;1175.976900096921;1193.3854065156452;6205;6215.564910456224;6217;6221.720022598994;6234.625922444668;5308.761105750251;5473.370562385297;6613.768518101843;6759.290274521203;6795.762148324785;6204.348543402968;6207.317195108534;6208;6209.472194863397;6254.405831446005;2921.5471601901313;3416.940748368014;3435.4331535296897;3452.6374730653424;3549.982250088733;6008.858316919771;6984.825379365455;7046.964765176243;7080.2919708028785;7141.714331426685;6000.669963151981;6022.789202377896;6973;7067.469939754539;7068.858622827514;6977.930220697728;6993.335633114846;7033.507654464139;7058.71765129389;7129.465290103263;5438.320209973754;5769.94230057694;5983.760649573968;6126.5098792097415;6526.074807931766;5894.764209431574;6707.3292670732535;6721.260661327152;6735.64252511617;6744.359285867835;6319.936800632118;6754.5609535380045;7073.3987611053635;7112.288771122846;7136.892946605909;4429.601335879786;4493.460784705856;4774.7851346688785;4839.7096174229655;4859.198232291632;6826.917790074075;6851.9657401712675;6852.211995620568;6870.690818913061;6896.793096207121;5658.641925937827;6158.507319414526;6605.867882642417;6625.536212465274;6632.403083722488;6577.704003319958;6608.471322294301;6624.271330153776;6626.933730662825;6699.464042876656;5170.43125256214;5350.5184533392185;6381.904271436025;6498.772542961163;6530.575512591857;5718.914216286842;6238.220222472191;6591.5056370773345;6608.867822643424;6616.742818864401;5489.58828087887;5744.937186620488;5811.302643682785;5971.940280597139;6416.935830641633 14:54:25 INFO - PID 1635 | |5;yui.html;734.6326836581709;777.0869228656327;782.3662833105182;849.0702680564782;871.6600525794939;16446;16911.40810071648;16965.236564354618;18394.816051839476;19101.42695719127;17987;18299.268029278846;18416.81583184168;18425.07874606271;18576.16407261673;1002.4486532407166;1030.7680771826317;1036.1037702387418;1037.4345981440133;1038.0449986012886;847.516915358246;1019.5157300282343;1028.0644613401805;1032.7160030991463;1033.0650761061252;1080.1628737728283;1085.8642669666292;1089.5478376473754;1089.585957336211;1090.4438736244492;1053.9947300263489;1071.346478648024;1080.9945950270198;1081.5998080710149;1082.6048492300333;769.6498093367504;784.1687810920442;790.5414859381602;794.6702118620766;796.4982061301401;14553.636159096002;16806.075665838496;16935.830641693672;17077.7438338425;17117.743233851503;16921.7461738074;17039.403620873334;17356.218970146372;17443.5639109022;17486.562835929075;13746.725065498735;13950.372233249427;14291.356888940023;14299.356528956221;14315.42738290467;3228.580284563015;3498.8775392861126;3561.5013898054294;3569.839357228931;3581.943326718598;96784;129068.35465822705;129172;130348;131137;12911.35443227835;12998.480060797463;13626.93186534061;13676.179429234278;13697.972652051136;21296.893515532323;24450.144244951698;25142.371440713763;25369.238922832345;25975.350616234744;7546.1321947976685;7621.542707437571;7731.690732370755;7758.340541054074;7808.6095695216145;3334.8666053357592;3795.3927371620407;3868.497095377583;3868.8065596720053;3882.1847412043785;4136.31750761127;4246.66026717868;4322.524522302544;4354.390385346054;4402.933955990663;825.6160885188416;947.4646824544111;953.6471505542855;972.7422233108232;973.756560859785;648.3613640564041;652.7845810882397;678.7149397253165;679.6431873266475;681.4786688183543;10945;11846.703832404259;11995.340256285814;12029;12107.031437485157;648.3484098480997;653.8626888353499;657.8585604095142;667.1893649216129;682.9760958366434;5377.838664840061;5511.421300763443;5545.426091622278;5587.944120558824;5597.104463285936;106151.46924265329;106279.87440251152;106385.46807265915;106961.9303806952;110286;85925;86640.56679716561;87349;87755;88696.556517217;78407.60796195983;82164.58917705492;85027;86651.53393864175;87259.56370218108;11717.707057323634;12352.3823808811;12432.627021189379;12525.311107889154;12603.87396126027;39964.60035399609;41104.38343424791;41396;41746.58253417427;42103.7894810524;53721.73139134279;54464.18303725368;55003.44996550144;55852;56229.15656265241;15686.450974216305;15997.360105595646;16237.350505979628;17029.829701702824;17035.48893533196;18450.630987379907;18473.16870740793;18696;18710.625787484445;18891.811081889005;16598.25307861125;16729.247183877;17257;17284.135793210036;17485.82514174842;13204.933975330061;16719.916400418406;16887.7466838;16943.661126777642;17064.48806535806;16265.268062937434;16619.335226591284;16733.330666773192;16989.915050425163;17136.886102403303;10289.9485502572;11720.765584688088;11780.175387722777;12163.45264463119;12192.268463892195;12598.622041338775;12630.43163057683;12633.368331583568;12634.557790477289;12642.620721378373 14:54:25 INFO - PID 1635 | __end_tp_report 14:54:25 INFO - PID 1635 | __start_cc_report 14:54:25 INFO - PID 1635 | _x_x_mozilla_cycle_collect,422 14:54:25 INFO - PID 1635 | __end_cc_report 14:54:25 INFO - PID 1635 | __startTimestamp1493330065178__endTimestamp 14:54:25 INFO - PID 1635 | 14:54:25 INFO - PID 1635 | ------- Summary: start ------- 14:54:25 INFO - PID 1635 | Number of tests: 6 14:54:25 INFO - PID 1635 | 14:54:25 INFO - PID 1635 | [#0] dojo.html Cycles:165 Average:5958.04 Median:6237.00 stddev:723.70 (11.6%) stddev-sans-first:693.74 14:54:25 INFO - PID 1635 | Values: 3237.7 3336.1 3404.9 3597.0 3602.7 5809.9 5954.0 6099.0 6160.8 6184.2 6001.1 6010.4 6057.0 6061.6 6127.8 4292.7 5298.7 5311.9 5332.4 5373.8 5363.9 5367.9 5379.1 5380.8 5396.6 5222.3 5268.7 5388.1 5420.3 5427.6 4681.3 4808.4 5217.5 5300.7 5405.3 5220.1 5259.7 5292.6 5296.5 5356.1 4915.5 6025.3 6046.9 6092.5 6129.3 5053.2 6499.5 6504.9 6525.3 6558.6 6306.0 6384.1 6551.2 6606.4 6631.3 6258.5 6282.1 6288.1 6296.0 6308.6 6575.4 6769.5 6785.4 6789.3 6820.6 5383.5 6224.8 6286.5 6406.2 6699.9 5435.2 6516.9 6578.1 6595.4 6626.4 5626.0 6189.1 6432.9 6451.8 6486.2 6253.7 6299.6 6315.3 6409.2 6444.6 4781.8 4962.7 5182.4 5214.5 5232.6 4677.5 4687.8 4698.6 4716.6 4790.2 5153.6 5995.6 6237.0 6241.1 6348.9 6297.7 6356.7 6461.9 6520.7 6525.6 6099.1 6139.0 6149.7 6158.3 6218.5 5773.5 5822.3 5834.9 5845.2 5859.6 6526.6 6588.5 6670.6 6751.2 6778.3 6570.4 6586.1 6606.0 6619.1 6653.8 6509.3 6631.0 6678.8 6802.8 6806.8 6355.0 6367.3 6411.6 6419.3 6432.7 6006.0 6350.1 6350.6 6383.0 6455.9 6235.7 6246.0 6321.5 6324.1 6356.5 6361.7 6372.3 6372.4 6374.7 6392.7 5568.5 6252.2 6257.4 6264.7 6289.8 6181.8 6218.4 6242.7 6262.9 6365.3 6214.8 6215.1 6229.5 6232.4 6256.5 14:54:25 INFO - PID 1635 | 14:54:25 INFO - PID 1635 | [#1] ext.html Cycles:180 Average:42808.08 Median:3155.43 stddev:72866.07 (2309.2%) stddev-sans-first:73002.05 14:54:25 INFO - PID 1635 | Values: 747.7 768.9 840.4 1203.1 1252.2 31440.0 31737.7 31781.0 34451.3 37860.4 37182.6 37416.8 37439.0 37439.4 37562.6 7955.7 8125.8 8371.8 8598.0 8631.1 7429.3 8546.1 8600.9 8647.7 8664.2 6538.9 7315.7 8188.5 8620.5 8623.2 7993.5 8639.6 8642.0 8654.5 8656.5 7863.8 8417.7 8434.9 8438.0 8449.4 36974.6 37105.3 37120.6 37178.9 37280.3 3635.2 3650.3 3674.2 3675.6 3677.4 25691.9 29368.4 30382.5 30562.0 30583.5 2791.3 3129.9 3147.9 3150.0 3160.9 216555.9 216831.0 272095.0 287844.0 288800.6 47598.8 47708.0 47844.7 47863.3 47967.6 49398.0 49718.5 49749.8 49802.8 49835.8 13548.2 13646.7 13723.6 13739.4 13755.9 10957.2 10992.3 11052.7 11073.9 11107.9 13296.4 13335.1 13384.9 13519.2 13534.5 5110.5 5998.7 6022.5 6047.6 6062.8 1015.2 1018.4 1023.2 1052.2 1063.9 23506.6 24590.8 24597.8 24675.6 25395.5 1109.6 1132.8 1140.1 1153.3 1169.8 11054.6 12468.4 12601.7 12616.3 12629.0 309506.9 311946.0 312260.0 312750.0 312835.4 52514.7 52549.7 52636.0 52730.7 52760.7 1498.8 1505.2 1538.8 1542.2 1543.8 23774.9 23941.8 23993.8 24054.4 24646.9 36798.4 36842.4 36869.6 36914.6 36941.0 259894.0 261292.0 261364.0 261431.0 262687.0 33399.5 33468.0 33806.8 34336.5 34417.8 42323.0 44665.0 44683.0 44722.3 44743.1 29062.0 29166.3 29699.0 31016.2 31143.2 28515.6 29802.1 30668.4 30851.7 31312.8 35195.6 36209.6 37040.3 37100.3 37111.3 29926.3 30491.0 31043.8 31150.7 31621.7 21741.8 23196.5 24479.1 24550.5 24579.5 14:54:25 INFO - PID 1635 | 14:54:25 INFO - PID 1635 | [#2] jquery.html Cycles:180 Average:35358.55 Median:12262.83 stddev:93001.33 (758.4%) stddev-sans-first:93225.26 14:54:25 INFO - PID 1635 | Values: 439.3 446.5 447.6 462.8 466.6 18529.8 18928.7 19911.3 21171.2 21425.9 20387.9 22062.6 22086.0 22296.3 22376.1 5952.7 6190.0 6217.4 6254.7 6262.9 5784.6 6014.4 6106.5 6112.3 6114.1 5836.6 6028.8 6038.3 6055.8 6063.3 5957.2 6047.9 6090.6 6095.7 6109.3 5353.8 5356.0 5365.0 5414.9 5417.7 26017.9 26047.3 26072.7 26275.3 26596.1 2157.1 2229.3 2230.9 2231.6 2235.8 14480.8 15368.0 17400.8 18036.0 18240.0 2087.2 2129.2 2165.3 2166.6 2195.6 128743.0 143432.0 153763.0 154600.0 157244.4 12187.4 12657.1 12687.7 12767.7 12785.5 14796.3 15304.8 16311.7 16340.6 16374.3 6375.7 7265.7 8413.8 8491.8 8523.5 7754.4 7757.8 7790.2 7903.2 7915.0 7894.2 7982.8 7999.2 8062.1 8075.3 1971.8 2028.4 2036.2 2040.8 2041.3 891.5 923.0 961.0 963.4 993.9 20134.4 20521.6 20525.6 20527.9 20839.8 906.9 940.0 977.8 1016.6 1016.8 9073.6 10685.3 10748.6 10788.5 10843.3 535787.0 544428.0 544573.0 558654.0 560190.0 129118.0 129571.0 131537.0 134819.3 136019.0 1179.2 1207.4 1223.8 1226.6 1227.7 20583.7 21790.8 21830.5 21914.9 21950.1 53013.7 56576.7 56921.4 57939.4 58131.7 78390.6 78714.0 80104.0 80182.0 80649.0 8601.5 8702.8 8807.1 9231.0 9240.4 14070.6 14197.9 14226.6 14539.8 14568.4 11967.9 11974.5 12100.0 12119.3 12178.0 11482.6 11495.5 11571.7 11853.3 11882.7 12032.3 12194.5 12292.6 12457.3 12561.6 7856.3 8851.0 8956.1 8975.3 9120.2 10168.4 10262.9 11936.8 11971.4 11995.8 14:54:25 INFO - PID 1635 | 14:54:25 INFO - PID 1635 | [#3] mootools.html Cycles:180 Average:7125.71 Median:4181.46 stddev:4493.84 (107.5%) stddev-sans-first:4485.89 14:54:25 INFO - PID 1635 | Values: 1404.8 1409.5 1415.8 1490.3 1497.8 11351.9 11643.9 11659.3 11661.8 11743.4 9975.4 11440.8 11596.9 11610.2 11630.1 2196.9 2463.1 2525.7 2560.8 2562.3 1995.7 2326.0 2361.9 2375.6 2376.7 2466.3 2498.0 2516.8 2522.4 2523.8 2471.1 2492.7 2504.9 2521.3 2522.7 2450.6 2495.7 2505.2 2509.9 2562.7 11672.3 11835.1 11877.0 11890.0 11894.3 6584.5 6782.6 6825.4 6844.6 6847.7 3723.0 4059.3 4403.2 4443.4 4483.5 1077.8 1243.4 1252.4 1291.9 1300.9 16029.2 16166.9 16302.6 16484.3 17098.2 4914.8 5369.7 5682.1 5832.3 5846.9 9605.8 11598.9 11769.1 11778.6 11849.9 5517.6 5856.2 6352.1 6606.4 6616.9 5750.5 6032.8 6265.7 6271.2 6287.4 4303.7 4415.2 4424.4 4443.3 4444.5 1260.0 1287.6 1291.5 1300.9 1303.5 708.9 779.6 800.5 827.2 828.8 6598.5 6831.0 6933.1 6974.9 7015.5 900.9 930.7 938.1 948.4 950.6 3948.5 4335.5 4556.3 4569.7 4678.1 15092.2 15138.2 15414.2 15432.9 15433.1 14646.6 14660.0 15180.0 15541.4 15542.8 8145.6 8641.6 8702.2 8783.9 8878.0 6898.6 7066.5 7204.0 7218.9 7238.3 13274.7 13330.5 13569.5 13598.0 13618.7 11378.0 13382.9 13460.9 13806.0 13967.3 9363.8 9424.7 9474.3 9519.5 9537.5 10673.7 10688.8 10755.2 10811.0 10923.3 9205.6 9243.3 9255.2 9293.9 9335.5 7625.9 8825.5 9024.1 9159.6 9218.5 8130.0 8200.3 8303.3 8324.0 8362.3 5316.7 6166.2 6182.4 6191.1 6200.8 6055.3 6128.5 6219.2 6274.1 6380.8 14:54:25 INFO - PID 1635 | 14:54:25 INFO - PID 1635 | [#4] prototype.html Cycles:180 Average:5347.00 Median:5853.03 stddev:1616.68 (27.6%) stddev-sans-first:1577.80 14:54:25 INFO - PID 1635 | Values: 388.9 405.9 406.2 409.4 419.2 5370.8 5955.0 6241.2 6253.7 6265.9 4666.5 5528.3 5898.8 6057.6 6114.8 4653.5 4691.4 4695.2 4712.7 4715.0 4238.9 4554.7 4704.0 4725.8 4743.0 3598.9 4054.3 4604.7 4643.9 4696.3 4650.1 4663.6 4669.8 4697.5 4709.1 3446.0 3892.6 4037.3 4099.3 4162.2 5368.9 5938.9 5963.9 5993.9 6079.5 4814.3 5390.2 5535.1 5543.5 5559.9 6493.7 6566.8 6610.3 6610.7 6662.6 4486.1 4722.2 4742.3 4750.0 4757.8 5946.1 6007.9 6966.4 6979.8 7036.5 4265.9 4832.3 4832.5 4863.1 4872.4 4923.9 4944.5 4949.3 4971.8 4986.2 5399.2 5489.4 5544.5 5546.4 5558.0 5721.5 6599.0 6604.9 6610.8 6632.2 1493.8 1688.4 1701.2 1701.5 1702.1 1150.6 1170.5 1172.5 1176.0 1193.4 6205.0 6215.6 6217.0 6221.7 6234.6 5308.8 5473.4 6613.8 6759.3 6795.8 6204.3 6207.3 6208.0 6209.5 6254.4 2921.5 3416.9 3435.4 3452.6 3550.0 6008.9 6984.8 7047.0 7080.3 7141.7 6000.7 6022.8 6973.0 7067.5 7068.9 6977.9 6993.3 7033.5 7058.7 7129.5 5438.3 5769.9 5983.8 6126.5 6526.1 5894.8 6707.3 6721.3 6735.6 6744.4 6319.9 6754.6 7073.4 7112.3 7136.9 4429.6 4493.5 4774.8 4839.7 4859.2 6826.9 6852.0 6852.2 6870.7 6896.8 5658.6 6158.5 6605.9 6625.5 6632.4 6577.7 6608.5 6624.3 6626.9 6699.5 5170.4 5350.5 6381.9 6498.8 6530.6 5718.9 6238.2 6591.5 6608.9 6616.7 5489.6 5744.9 5811.3 5971.9 6416.9 14:54:25 INFO - PID 1635 | 14:54:25 INFO - PID 1635 | [#5] yui.html Cycles:180 Average:21827.46 Median:17736.78 stddev:30591.93 (172.5%) stddev-sans-first:30636.75 14:54:25 INFO - PID 1635 | Values: 734.6 777.1 782.4 849.1 871.7 16446.0 16911.4 16965.2 18394.8 19101.4 17987.0 18299.3 18416.8 18425.1 18576.2 1002.4 1030.8 1036.1 1037.4 1038.0 847.5 1019.5 1028.1 1032.7 1033.1 1080.2 1085.9 1089.5 1089.6 1090.4 1054.0 1071.3 1081.0 1081.6 1082.6 769.6 784.2 790.5 794.7 796.5 14553.6 16806.1 16935.8 17077.7 17117.7 16921.7 17039.4 17356.2 17443.6 17486.6 13746.7 13950.4 14291.4 14299.4 14315.4 3228.6 3498.9 3561.5 3569.8 3581.9 96784.0 129068.4 129172.0 130348.0 131137.0 12911.4 12998.5 13626.9 13676.2 13698.0 21296.9 24450.1 25142.4 25369.2 25975.4 7546.1 7621.5 7731.7 7758.3 7808.6 3334.9 3795.4 3868.5 3868.8 3882.2 4136.3 4246.7 4322.5 4354.4 4402.9 825.6 947.5 953.6 972.7 973.8 648.4 652.8 678.7 679.6 681.5 10945.0 11846.7 11995.3 12029.0 12107.0 648.3 653.9 657.9 667.2 683.0 5377.8 5511.4 5545.4 5587.9 5597.1 106151.5 106279.9 106385.5 106961.9 110286.0 85925.0 86640.6 87349.0 87755.0 88696.6 78407.6 82164.6 85027.0 86651.5 87259.6 11717.7 12352.4 12432.6 12525.3 12603.9 39964.6 41104.4 41396.0 41746.6 42103.8 53721.7 54464.2 55003.4 55852.0 56229.2 15686.5 15997.4 16237.4 17029.8 17035.5 18450.6 18473.2 18696.0 18710.6 18891.8 16598.3 16729.2 17257.0 17284.1 17485.8 13204.9 16719.9 16887.7 16943.7 17064.5 16265.3 16619.3 16733.3 16989.9 17136.9 10289.9 11720.8 11780.2 12163.5 12192.3 12598.6 12630.4 12633.4 12634.6 12642.6 14:54:25 INFO - PID 1635 | -------- Summary: end -------- 14:54:25 INFO - PID 1635 | 14:54:25 INFO - TEST-INFO | 1635: exit 0 14:54:25 INFO - TEST-OK | dromaeo_css | took 1114314ms 14:54:25 INFO - TEST-START | kraken 14:54:25 INFO - operating with platform_type : mac_ 14:54:25 INFO - Initialising browser for kraken test... 14:54:25 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp9uQFvI/profile http://localhost:49234/getInfo.html) 14:54:28 INFO - PID 1647 | 2017-04-27 14:54:28.444 plugin-container[1648:10460] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 14:54:28 INFO - PID 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:54:28 INFO - PID 1647 | 2017-04-27 14:54:28.447 plugin-container[1648:10460] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x962b, name = 'com.apple.CFPasteboardClient' 14:54:28 INFO - PID 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:54:28 INFO - PID 1647 | 2017-04-27 14:54:28.447 plugin-container[1648:10460] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:54:28 INFO - PID 1647 | __metrics Screen width/height:1600/1200 14:54:28 INFO - PID 1647 | colorDepth:24 14:54:28 INFO - PID 1647 | Browser inner width/height: 1024/689 14:54:28 INFO - PID 1647 | __metrics 14:54:28 ERROR - PID 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 14:54:29 INFO - TEST-INFO | 1647: exit 0 14:54:29 INFO - Browser initialized. 14:54:29 INFO - Running cycle 1/1 for kraken test... 14:54:29 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmp9uQFvI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:54:31 INFO - PID 1649 | 2017-04-27 14:54:31.857 plugin-container[1650:10584] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 14:54:31 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:54:31 INFO - PID 1649 | 2017-04-27 14:54:31.858 plugin-container[1650:10584] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 14:54:31 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:54:31 INFO - PID 1649 | 2017-04-27 14:54:31.858 plugin-container[1650:10584] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:54:42 INFO - PID 1649 | RSS: Main: 251764736 14:54:42 INFO - PID 1649 | 14:54:44 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection) 14:54:45 INFO - PID 1649 | RSS: Main: 259518464 14:54:45 INFO - PID 1649 | 14:54:48 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-dft) 14:54:48 INFO - PID 1649 | RSS: Main: 266547200 14:54:48 INFO - PID 1649 | 14:54:52 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-fft) 14:54:52 INFO - PID 1649 | RSS: Main: 262893568 14:54:52 INFO - PID 1649 | 14:54:54 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator) 14:54:55 INFO - PID 1649 | RSS: Main: 263847936 14:54:55 INFO - PID 1649 | 14:54:57 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:54:57 INFO - PID 1649 | RSS: Main: 264200192 14:54:57 INFO - PID 1649 | 14:55:00 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom) 14:55:01 INFO - PID 1649 | RSS: Main: 269512704 14:55:01 INFO - PID 1649 | 14:55:04 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate) 14:55:05 INFO - PID 1649 | RSS: Main: 271364096 14:55:05 INFO - PID 1649 | 14:55:08 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial) 14:55:08 INFO - PID 1649 | RSS: Main: 270352384 14:55:08 INFO - PID 1649 | 14:55:10 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:55:11 INFO - PID 1649 | RSS: Main: 270204928 14:55:11 INFO - PID 1649 | 14:55:12 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:55:13 INFO - PID 1649 | RSS: Main: 271745024 14:55:13 INFO - PID 1649 | 14:55:15 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:55:16 INFO - PID 1649 | RSS: Main: 271200256 14:55:16 INFO - PID 1649 | 14:55:19 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:55:20 INFO - PID 1649 | RSS: Main: 271667200 14:55:20 INFO - PID 1649 | 14:55:23 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:55:23 INFO - PID 1649 | RSS: Main: 271536128 14:55:23 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | Cycle 1(1): loaded http://localhost:49234/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49234/tests/kraken/driver.html?testName=ai-astar) 14:55:25 INFO - PID 1649 | RSS: Main: 273092608 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | __start_tp_report 14:55:25 INFO - PID 1649 | _x_x_mozilla_page_load 14:55:25 INFO - PID 1649 | _x_x_mozilla_page_load_details 14:55:25 INFO - PID 1649 | |i|pagename|runs| 14:55:25 INFO - PID 1649 | |0;ai-astar;101;116;146;168;144;115;115;118;114;115 14:55:25 INFO - PID 1649 | |1;audio-beat-detection;149;113;108;148;111;110;105;111;138;114 14:55:25 INFO - PID 1649 | |2;audio-dft;206;194;193;213;212;212;201;194;203;194 14:55:25 INFO - PID 1649 | |3;audio-fft;83;58;73;109;58;60;58;60;79;59 14:55:25 INFO - PID 1649 | |4;audio-oscillator;91;71;70;73;88;65;95;102;57;89 14:55:25 INFO - PID 1649 | |5;imaging-gaussian-blur;88;88;88;88;87;89;98;136;110;121 14:55:25 INFO - PID 1649 | |6;imaging-darkroom;100;106;91;123;90;139;153;110;146;107 14:55:25 INFO - PID 1649 | |7;imaging-desaturate;91;94;89;88;96;90;89;92;92;92 14:55:25 INFO - PID 1649 | |8;json-parse-financial;49;50;49;51;51;51;51;67;74;72 14:55:25 INFO - PID 1649 | |9;json-stringify-tinderbox;57;62;57;55;63;58;55;57;57;55 14:55:25 INFO - PID 1649 | |10;stanford-crypto-aes;83;88;107;106;102;83;83;82;85;95 14:55:25 INFO - PID 1649 | |11;stanford-crypto-ccm;126;153;152;155;139;173;151;154;266;155 14:55:25 INFO - PID 1649 | |12;stanford-crypto-pbkdf2;188;185;187;184;183;230;231;163;228;226 14:55:25 INFO - PID 1649 | |13;stanford-crypto-sha256-iterative;69;68;69;83;91;99;83;69;67;72 14:55:25 INFO - PID 1649 | __end_tp_report 14:55:25 INFO - PID 1649 | __start_cc_report 14:55:25 INFO - PID 1649 | _x_x_mozilla_cycle_collect,997 14:55:25 INFO - PID 1649 | __end_cc_report 14:55:25 INFO - PID 1649 | __startTimestamp1493330125900__endTimestamp 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | ------- Summary: start ------- 14:55:25 INFO - PID 1649 | Number of tests: 14 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#0] ai-astar Cycles:10 Average:125.20 Median:117.00 stddev:20.49 (17.5%) stddev-sans-first:19.77 14:55:25 INFO - PID 1649 | Values: 101.0 116.0 146.0 168.0 144.0 115.0 115.0 118.0 114.0 115.0 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#1] audio-beat-detection Cycles:10 Average:120.70 Median:113.50 stddev:17.19 (15.1%) stddev-sans-first:14.88 14:55:25 INFO - PID 1649 | Values: 149.0 113.0 108.0 148.0 111.0 110.0 105.0 111.0 138.0 114.0 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#2] audio-dft Cycles:10 Average:202.20 Median:204.50 stddev:8.24 (4.0%) stddev-sans-first:8.63 14:55:25 INFO - PID 1649 | Values: 206.0 194.0 193.0 213.0 212.0 212.0 201.0 194.0 203.0 194.0 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#3] audio-fft Cycles:10 Average:69.70 Median:60.00 stddev:16.77 (28.0%) stddev-sans-first:17.09 14:55:25 INFO - PID 1649 | Values: 83.0 58.0 73.0 109.0 58.0 60.0 58.0 60.0 79.0 59.0 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#4] audio-oscillator Cycles:10 Average:80.10 Median:80.50 stddev:14.75 (18.3%) stddev-sans-first:15.11 14:55:25 INFO - PID 1649 | Values: 91.0 71.0 70.0 73.0 88.0 65.0 95.0 102.0 57.0 89.0 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:99.30 Median:88.00 stddev:17.33 (19.7%) stddev-sans-first:17.89 14:55:25 INFO - PID 1649 | Values: 88.0 88.0 88.0 88.0 87.0 89.0 98.0 136.0 110.0 121.0 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#6] imaging-darkroom Cycles:10 Average:116.50 Median:142.50 stddev:22.65 (15.9%) stddev-sans-first:23.23 14:55:25 INFO - PID 1649 | Values: 100.0 106.0 91.0 123.0 90.0 139.0 153.0 110.0 146.0 107.0 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#7] imaging-desaturate Cycles:10 Average:91.30 Median:92.00 stddev:2.45 (2.7%) stddev-sans-first:2.60 14:55:25 INFO - PID 1649 | Values: 91.0 94.0 89.0 88.0 96.0 90.0 89.0 92.0 92.0 92.0 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#8] json-parse-financial Cycles:10 Average:56.50 Median:51.00 stddev:10.18 (20.0%) stddev-sans-first:10.43 14:55:25 INFO - PID 1649 | Values: 49.0 50.0 49.0 51.0 51.0 51.0 51.0 67.0 74.0 72.0 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:57.60 Median:57.00 stddev:2.80 (4.9%) stddev-sans-first:2.96 14:55:25 INFO - PID 1649 | Values: 57.0 62.0 57.0 55.0 63.0 58.0 55.0 57.0 57.0 55.0 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#10] stanford-crypto-aes Cycles:10 Average:91.40 Median:83.00 stddev:10.19 (12.3%) stddev-sans-first:10.34 14:55:25 INFO - PID 1649 | Values: 83.0 88.0 107.0 106.0 102.0 83.0 83.0 82.0 85.0 95.0 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:162.40 Median:154.50 stddev:38.33 (24.8%) stddev-sans-first:38.33 14:55:25 INFO - PID 1649 | Values: 126.0 153.0 152.0 155.0 139.0 173.0 151.0 154.0 266.0 155.0 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.50 Median:207.00 stddev:25.32 (12.2%) stddev-sans-first:26.45 14:55:25 INFO - PID 1649 | Values: 188.0 185.0 187.0 184.0 183.0 230.0 231.0 163.0 228.0 226.0 14:55:25 INFO - PID 1649 | 14:55:25 INFO - PID 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.00 Median:77.50 stddev:11.30 (14.6%) stddev-sans-first:11.61 14:55:25 INFO - PID 1649 | Values: 69.0 68.0 69.0 83.0 91.0 99.0 83.0 69.0 67.0 72.0 14:55:25 INFO - PID 1649 | -------- Summary: end -------- 14:55:25 INFO - PID 1649 | 14:55:26 INFO - TEST-INFO | 1649: exit 0 14:55:26 INFO - TEST-OK | kraken | took 61030ms 14:55:26 INFO - SUITE-END | took 1175s 14:55:27 INFO - Completed test suite (00:19:35) 14:55:27 INFO - javascript benchmark 14:55:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7839.650153321025, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3237.676232376762, 3336.1159292787415, 3404.8808291709797, 3597.010822023943, 3602.675759181674, 5809.925163844681, 5954.0, 6098.969505152473, 6160.845978850531, 6184.196054512919, 6001.129836173752, 6010.398960103998, 6057.0, 6061.575689701723, 6127.816165515031, 4292.6780491463105, 5298.655587386817, 5311.920321195185, 5332.413434522199, 5373.785048598052, 5363.9463605363835, 5367.919481207766, 5379.139337705968, 5380.811671591495, 5396.5952553558445, 5222.294990176316, 5268.736563171826, 5388.084025715618, 5420.268263784398, 5427.6472029318165, 4681.344611754357, 4808.374911261513, 5217.452167522431, 5300.708461034642, 5405.297311349519, 5220.086484865172, 5259.658122222043, 5292.550133238641, 5296.523312901857, 5356.1430171172815, 4915.48387419323, 6025.276966764016, 6046.879062418727, 6092.5430592705725, 6129.325774164839, 5053.191489361721, 6499.512536559777, 6504.902426463606, 6525.347465253484, 6558.639274839882, 6305.968470157666, 6384.138141350904, 6551.21385433751, 6606.405423511859, 6631.27056023837, 6258.499320054385, 6282.057691346335, 6288.056791481269, 6295.992641177481, 6308.558400911892, 6575.408213260829, 6769.458443324522, 6785.42323902464, 6789.25318214996, 6820.624865632438, 5383.542398896059, 6224.751009959551, 6286.528510361742, 6406.167198264196, 6699.933000669931, 5435.239066530688, 6516.869662606721, 6578.111954886125, 6595.373439523238, 6626.4367528760595, 5625.987322281947, 6189.133521307021, 6432.871342573122, 6451.774187903401, 6486.189226346707, 6253.7185826637915, 6299.622022678563, 6315.336889626615, 6409.230892292861, 6444.645544495098, 4781.760911954389, 4962.727050012284, 5182.352205974254, 5214.45248248936, 5232.581393488512, 4677.508861569554, 4687.81248750053, 4698.600618947427, 4716.646251531149, 4790.161721698689, 5153.639245252872, 5995.5803093783015, 6237.0, 6241.095041218998, 6348.904766428507, 6297.716602752887, 6356.745730170834, 6461.870762584722, 6520.739170433129, 6525.575837570543, 6099.111808770591, 6139.048447490646, 6149.692515374213, 6158.322584515699, 6218.471429928416, 5773.538116950634, 5822.272215973004, 5834.883302333929, 5845.210896528914, 5859.648421094748, 6526.608403495806, 6588.472922166119, 6670.633115178712, 6751.223609284897, 6778.288279730557, 6570.375814297634, 6586.110875032001, 6605.966970165118, 6619.073329733745, 6653.800385988428, 6509.283978762238, 6631.038499417654, 6678.766243181465, 6802.795916122524, 6806.7957961261245, 6355.0, 6367.331430199948, 6411.5832470889245, 6419.325970773001, 6432.678366081771, 6006.0, 6350.142730731292, 6350.587211831216, 6383.0, 6455.903161452676, 6235.688215589112, 6245.96877015612, 6321.462675672619, 6324.051392291193, 6356.523260755369, 6361.650109244036, 6372.267189273293, 6372.394622510854, 6374.713137908712, 6392.712327945346, 5568.470995255444, 6252.218472690914, 6257.374262573706, 6264.718087685974, 6289.811305660837, 6181.752729890934, 6218.440340369389, 6242.687865606792, 6262.874742505215, 6365.299817020216, 6214.8135555933395, 6215.129881816459, 6229.5327850410495, 6232.376762323913, 6256.499480041494], "value": 5911.367796239522, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.6897087708597, 768.9038870141233, 840.4159109418954, 1203.1397550751217, 1252.1985929005432, 31440.0, 31737.73049078037, 31781.0, 34451.31097378054, 37860.43209351855, 37182.62817371826, 37416.81291593545, 37439.0, 37439.438408423826, 37562.624373756254, 7955.7215497457455, 8125.75622731319, 8371.823325935271, 8598.0, 8631.093735157812, 7429.294217049372, 8546.05993340732, 8600.8709869352, 8647.69733059343, 8664.176903194186, 6538.8692226155445, 7315.707371705125, 8188.50868947865, 8620.525871077089, 8623.223909848113, 7993.520388776692, 8639.611217495196, 8641.95679021604, 8654.48073115615, 8656.523891185981, 7863.8034049148655, 8417.663293468315, 8434.915650843473, 8437.987441506997, 8449.408541402105, 36974.63025369739, 37105.257894841954, 37120.628793712254, 37178.88463346104, 37280.25439491195, 3635.2366003139373, 3650.34293827111, 3674.2467794102145, 3675.6140605236333, 3677.4483827425834, 25691.871540642365, 29368.41263174746, 30382.54426183609, 30562.0, 30583.541246881094, 2791.3021744563857, 3129.874805007797, 3147.8740850365957, 3149.9842500787577, 3160.873565057395, 216555.9172204129, 216830.99014059207, 272094.999999998, 287844.0, 288800.5559972208, 47598.76200618975, 47708.0, 47844.73707892129, 47863.28205076927, 47967.60161991887, 49398.01203975901, 49718.50281497139, 49749.75625609316, 49802.750986244835, 49835.75082124566, 13548.187108773505, 13646.727065458635, 13723.588292351245, 13739.381727822272, 13755.867840484541, 10957.17821163416, 10992.28550144238, 11052.668419947415, 11073.889261107446, 11107.94446027781, 13296.401661925236, 13335.066545341733, 13384.93307533456, 13519.188848669111, 13534.45862165522, 5110.514501122388, 5998.670073146019, 6022.518198544106, 6047.637141771508, 6062.757489700362, 1015.2030655935056, 1018.4245901065874, 1023.2325755683238, 1052.1582733812918, 1063.8616979792578, 23506.64740028901, 24590.754092459203, 24597.754022459903, 24675.62986555203, 25395.49209015809, 1109.6060898380958, 1132.7904337697553, 1140.1278022312938, 1153.2503872482785, 1169.7601991591703, 11054.613088541862, 12468.43892024861, 12601.684957876127, 12616.30610316423, 12628.989680825513, 309506.9049309523, 311946.0, 312260.0, 312750.0, 312835.4358228194, 52514.737426312626, 52549.68625784386, 52636.0, 52730.73634631802, 52760.73619631877, 1498.8201415829951, 1505.1871989125968, 1538.8153421589257, 1542.2443002928485, 1543.8301786803443, 23774.88112559426, 23941.760582393952, 23993.760062399153, 24054.39864003414, 24646.876765616056, 36798.44802328021, 36842.44736328904, 36869.631303687696, 36914.63085369112, 36941.0, 259894.0, 261292.0, 261364.0, 261431.0, 262687.0, 33399.49900751442, 33468.0, 33806.81676141323, 34336.45485953188, 34417.82791086029, 42323.0, 44665.0, 44683.0, 44722.3291650632, 44743.10513789771, 29062.0, 29166.27084322909, 29698.960536381124, 31016.22459438532, 31143.221419464695, 28515.572266416435, 29802.10593682193, 30668.386632267677, 30851.69148308488, 31312.843435782674, 35195.648043519235, 36209.63790362063, 37040.25919481649, 37100.25799483941, 37111.25777484489, 29926.25184370408, 30491.0, 31043.84478077595, 31150.68849311478, 31621.73513059452, 21741.782582173975, 23196.536069278183, 24479.143229986865, 24550.508989819748, 24579.508409832062], "value": 17217.664451055058, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.27300317973766, 446.4597836617692, 447.55244755244746, 462.7501149379335, 466.5544405093136, 18529.814701852978, 18928.716069258953, 19911.30310439135, 21171.153153873827, 21425.928703564838, 20387.898060509713, 22062.558748825013, 22086.00612972416, 22296.331110066683, 22376.104955801788, 5952.7321270542825, 6190.040543715709, 6217.440430361266, 6254.7185376657935, 6262.937370626281, 5784.56615753818, 6014.3985601439945, 6106.542009349294, 6112.327643959183, 6114.144019837227, 5836.5914385993, 6028.849278768022, 6038.33578306386, 6055.818325450244, 6063.302720187169, 5957.1659967604355, 6047.909281360783, 6090.5736598438125, 6095.664738439384, 6109.266887973427, 5353.839384818422, 5356.035913535601, 5365.0, 5414.864628384283, 5417.702026388547, 26017.869910650516, 26047.348816279555, 26072.73927260722, 26275.292106013047, 26596.069137580285, 2157.0616781699855, 2229.3312006398014, 2230.8549944253573, 2231.553689262154, 2235.798778109962, 14480.782788258184, 15368.0, 17400.825991740174, 18036.008019558918, 18240.0, 2087.2277257414703, 2129.233475948657, 2165.274632997932, 2166.620841352773, 2195.560887822442, 128743.0, 143432.0, 153763.0, 154600.0, 157244.42755572413, 12187.39063046844, 12657.11400201977, 12687.68280792969, 12767.744645107046, 12785.488580456678, 14796.298425680969, 15304.770428443582, 16311.67376652484, 16340.591485212964, 16374.263158157912, 6375.681215939185, 7265.709371625181, 8413.789655258544, 8491.787705307293, 8523.531205783742, 7754.418418618626, 7757.7672669819995, 7790.182030886788, 7903.249191326815, 7915.0, 7894.21057894206, 7982.760517184493, 7999.200079991954, 8062.072861620989, 8075.273225409741, 1971.7929617389968, 2028.3509277031503, 2036.1877928643519, 2040.8163265305898, 2041.285550057468, 891.4784850862188, 922.9630814767469, 960.9855852162223, 963.393062370702, 993.8956409577034, 20134.395968120978, 20521.589568208554, 20525.58948821045, 20527.897360513103, 20839.79160208409, 906.9455832650062, 939.9671011514564, 977.8288799460066, 1016.598443614768, 1016.8017236638784, 9073.637054517745, 10685.305455145392, 10748.570057197781, 10788.51451684676, 10843.349399036084, 535787.0, 544428.0, 544573.0, 558654.0, 560190.0, 129118.0, 129571.0, 131537.0, 134819.32590337182, 136019.0, 1179.151011271883, 1207.402335843763, 1223.7552489502136, 1226.6320103968774, 1227.6869398303375, 20583.691244631642, 21790.782092178877, 21830.45423864416, 21914.890425547772, 21950.121995120015, 53013.73493132664, 56576.717116414155, 56921.43078569161, 57939.42060579509, 58131.709341453025, 78390.6080469594, 78714.0, 80104.0, 80182.0, 80649.0, 8601.494738420626, 8702.782430439289, 8807.119288071142, 9231.030741772018, 9240.399374040666, 14070.648233794236, 14197.929010355296, 14226.573202803518, 14539.781903271249, 14568.41726330935, 11967.880321197024, 11974.46114924813, 12099.971502422393, 12119.333436661069, 12178.0, 11482.598109066143, 11495.48270327854, 11571.6528504145, 11853.288802671867, 11882.702932426759, 12032.338221397908, 12194.51221951112, 12292.569760058355, 12457.252564845776, 12561.560345387868, 7856.332211762065, 8851.0, 8956.149165829236, 8975.32685048611, 9120.179183873483, 10168.440735759605, 10262.897371026493, 11936.820947685617, 11971.401429928643, 11995.820062698893], "value": 10331.23667610028, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1404.782258749893, 1409.4714482069223, 1415.810718996043, 1490.3070072416324, 1497.8202615686116, 11351.886481135196, 11643.883561164386, 11659.300441973488, 11661.766764664711, 11743.41282935854, 9975.40147591145, 11440.771184576304, 11596.884031159685, 11610.245334053281, 11630.069594432447, 2196.857634030311, 2463.08865719684, 2525.6716626838484, 2560.7567281108263, 2562.3209849389928, 1995.6828493194494, 2325.976740232593, 2361.917332893349, 2375.6080246759266, 2376.738558758535, 2466.3094333586537, 2497.9875100624563, 2516.8238223324374, 2522.407234299938, 2523.7854782343525, 2471.1104002559064, 2492.67595212623, 2504.912328068518, 2521.2562294123277, 2522.6846644169477, 2450.5834008218644, 2495.7254701982765, 2505.1732928133674, 2509.874506274679, 2562.744255314882, 11672.299662020307, 11835.11236657254, 11877.0, 11890.0, 11894.286342819458, 6584.5061620378665, 6782.626955517445, 6825.36191314086, 6844.589324640538, 6847.657617119125, 3723.0, 4059.269331520325, 4403.22943484892, 4443.37792709021, 4483.529229430928, 1077.8329358949375, 1243.359669770069, 1252.4301442843575, 1291.8901893339078, 1300.8959283257316, 16029.198540073066, 16166.949148305323, 16302.592435189215, 16484.34062637493, 17098.23057962382, 4914.754262286871, 5369.677819330853, 5682.119271512922, 5832.3292821326095, 5846.947549441142, 9605.759856003655, 11598.88401115995, 11769.117316201318, 11778.587749428729, 11849.881501185051, 5517.61376703635, 5856.1508581255475, 6352.14246076783, 6606.372394622503, 6616.933830661728, 5750.453706897838, 6032.758689652453, 6265.749370025148, 6271.216097987752, 6287.434130928147, 4303.655707543389, 4415.249407600716, 4424.402705634698, 4443.311286750559, 4444.488883778342, 1259.962201133949, 1287.575100216926, 1291.489861504719, 1300.9349532523336, 1303.4981532110016, 708.9255628159073, 779.5985067690144, 800.4996876951905, 827.1728271728272, 828.8176601147737, 6598.538102332791, 6830.965845170742, 6933.11339222719, 6974.895376569356, 7015.543989640657, 900.9234215091791, 930.7161315798746, 938.1134827587864, 948.369334392635, 950.626344931581, 3948.545917219499, 4335.479742430928, 4556.316552517149, 4569.748663823521, 4678.111158879802, 15092.1699306537, 15138.243087845563, 15414.152221627694, 15432.92283538575, 15433.074015558877, 14646.63383415423, 14660.0, 15180.0, 15541.378344866305, 15542.84457155414, 8145.592720363839, 8641.56792160402, 8702.173293537104, 8783.868241976375, 8878.0, 6898.586084834926, 7066.505344626033, 7203.991441198341, 7218.855622887618, 7238.348548630648, 13274.668133296746, 13330.466781328638, 13569.52506662262, 13598.048136630341, 13618.727625447635, 11378.0, 13382.866171338552, 13460.93269533646, 13805.964552658792, 13967.301634918416, 9363.812723745623, 9424.670136545188, 9474.336796424459, 9519.476428796206, 9537.47543885093, 10673.733156671145, 10688.839667405151, 10755.247132700635, 10811.027007569357, 10923.289986150874, 9205.585748641193, 9243.306751993761, 9255.167034966886, 9293.86059209126, 9335.48654823964, 7625.923740762521, 8825.470471771714, 9024.142706442877, 9159.633614655339, 9218.492982886006, 8130.0, 8200.26197642215, 8303.252707256375, 8324.0427350853, 8362.331013519026, 5316.6544174628525, 6166.167567378347, 6182.352412076896, 6191.133241346305, 6200.844978875564, 6055.273367195965, 6128.4790792783115, 6219.160413344322, 6274.121622972879, 6380.840478988062], "value": 5394.12731522713, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.947492088568, 405.8696530163495, 406.19370549459325, 409.41862555171656, 419.2160659566611, 5370.7851685932565, 5955.0, 6241.157443745093, 6253.71858266378, 6265.874682506347, 4666.486686464486, 5528.336599608043, 5898.7935422260225, 6057.575969682124, 6114.768109639983, 4653.464851542082, 4691.366665500165, 4695.225287827521, 4712.717236965776, 4715.033418149271, 4238.936415953764, 4554.749488778116, 4704.035672687108, 4725.8109675613105, 4742.952570474303, 3598.85604575818, 4054.2702313583545, 4604.743675598966, 4643.907121857561, 4696.272077827942, 4650.116477869194, 4663.580277775, 4669.7898594562985, 4697.4832768395445, 4709.105269998689, 3446.0, 3892.552356479013, 4037.253108174997, 4099.344104943225, 4162.229987452331, 5368.91946620801, 5938.930992421362, 5963.910541341883, 5993.910091348634, 6079.483243924272, 4814.3019262207135, 5390.21841832932, 5535.114381698909, 5543.533127758149, 5559.916601250984, 6493.70778314977, 6566.770163044318, 6610.272869984298, 6610.6778644271335, 6662.600243985328, 4486.147631949919, 4722.197226471508, 4742.316477650419, 4750.0, 4757.809687612491, 5946.108083787466, 6007.927265093579, 6966.4078553323025, 6979.755708550177, 7036.542624729376, 4265.893352666146, 4832.251001094836, 4832.49258827818, 4863.076015557032, 4872.366592342973, 4923.87690307738, 4944.53026962438, 4949.307097006422, 4971.825986090542, 4986.227134794112, 5399.244105825188, 5489.39616642169, 5544.500994910478, 5546.445355464502, 5557.972210138923, 5721.456461636138, 6599.0, 6604.867902642017, 6610.768623098168, 6632.204135503771, 1493.7609982402764, 1688.4174959638906, 1701.174930158872, 1701.5150682055555, 1702.1319127245195, 1150.5685367987005, 1170.5200867644226, 1172.4841069929205, 1175.976900096921, 1193.3854065156452, 6205.0, 6215.564910456224, 6217.0, 6221.720022598994, 6234.625922444668, 5308.761105750251, 5473.370562385297, 6613.768518101843, 6759.290274521203, 6795.762148324785, 6204.348543402968, 6207.317195108534, 6208.0, 6209.472194863397, 6254.405831446005, 2921.5471601901313, 3416.940748368014, 3435.4331535296897, 3452.6374730653424, 3549.982250088733, 6008.858316919771, 6984.825379365455, 7046.964765176243, 7080.2919708028785, 7141.714331426685, 6000.669963151981, 6022.789202377896, 6973.0, 7067.469939754539, 7068.858622827514, 6977.930220697728, 6993.335633114846, 7033.507654464139, 7058.71765129389, 7129.465290103263, 5438.320209973754, 5769.94230057694, 5983.760649573968, 6126.5098792097415, 6526.074807931766, 5894.764209431574, 6707.3292670732535, 6721.260661327152, 6735.64252511617, 6744.359285867835, 6319.936800632118, 6754.5609535380045, 7073.3987611053635, 7112.288771122846, 7136.892946605909, 4429.601335879786, 4493.460784705856, 4774.7851346688785, 4839.7096174229655, 4859.198232291632, 6826.917790074075, 6851.9657401712675, 6852.211995620568, 6870.690818913061, 6896.793096207121, 5658.641925937827, 6158.507319414526, 6605.867882642417, 6625.536212465274, 6632.403083722488, 6577.704003319958, 6608.471322294301, 6624.271330153776, 6626.933730662825, 6699.464042876656, 5170.43125256214, 5350.5184533392185, 6381.904271436025, 6498.772542961163, 6530.575512591857, 5718.914216286842, 6238.220222472191, 6591.5056370773345, 6608.867822643424, 6616.742818864401, 5489.58828087887, 5744.937186620488, 5811.302643682785, 5971.940280597139, 6416.935830641633], "value": 4857.070728957302, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [734.6326836581709, 777.0869228656327, 782.3662833105182, 849.0702680564782, 871.6600525794939, 16446.0, 16911.40810071648, 16965.236564354618, 18394.816051839476, 19101.42695719127, 17987.0, 18299.268029278846, 18416.81583184168, 18425.07874606271, 18576.16407261673, 1002.4486532407166, 1030.7680771826317, 1036.1037702387418, 1037.4345981440133, 1038.0449986012886, 847.516915358246, 1019.5157300282343, 1028.0644613401805, 1032.7160030991463, 1033.0650761061252, 1080.1628737728283, 1085.8642669666292, 1089.5478376473754, 1089.585957336211, 1090.4438736244492, 1053.9947300263489, 1071.346478648024, 1080.9945950270198, 1081.5998080710149, 1082.6048492300333, 769.6498093367504, 784.1687810920442, 790.5414859381602, 794.6702118620766, 796.4982061301401, 14553.636159096002, 16806.075665838496, 16935.830641693672, 17077.7438338425, 17117.743233851503, 16921.7461738074, 17039.403620873334, 17356.218970146372, 17443.5639109022, 17486.562835929075, 13746.725065498735, 13950.372233249427, 14291.356888940023, 14299.356528956221, 14315.42738290467, 3228.580284563015, 3498.8775392861126, 3561.5013898054294, 3569.839357228931, 3581.943326718598, 96784.0, 129068.35465822705, 129172.0, 130348.0, 131137.0, 12911.35443227835, 12998.480060797463, 13626.93186534061, 13676.179429234278, 13697.972652051136, 21296.893515532323, 24450.144244951698, 25142.371440713763, 25369.238922832345, 25975.350616234744, 7546.1321947976685, 7621.542707437571, 7731.690732370755, 7758.340541054074, 7808.6095695216145, 3334.8666053357592, 3795.3927371620407, 3868.497095377583, 3868.8065596720053, 3882.1847412043785, 4136.31750761127, 4246.66026717868, 4322.524522302544, 4354.390385346054, 4402.933955990663, 825.6160885188416, 947.4646824544111, 953.6471505542855, 972.7422233108232, 973.756560859785, 648.3613640564041, 652.7845810882397, 678.7149397253165, 679.6431873266475, 681.4786688183543, 10945.0, 11846.703832404259, 11995.340256285814, 12029.0, 12107.031437485157, 648.3484098480997, 653.8626888353499, 657.8585604095142, 667.1893649216129, 682.9760958366434, 5377.838664840061, 5511.421300763443, 5545.426091622278, 5587.944120558824, 5597.104463285936, 106151.46924265329, 106279.87440251152, 106385.46807265915, 106961.9303806952, 110286.0, 85925.0, 86640.56679716561, 87349.0, 87755.0, 88696.556517217, 78407.60796195983, 82164.58917705492, 85027.0, 86651.53393864175, 87259.56370218108, 11717.707057323634, 12352.3823808811, 12432.627021189379, 12525.311107889154, 12603.87396126027, 39964.60035399609, 41104.38343424791, 41396.0, 41746.58253417427, 42103.7894810524, 53721.73139134279, 54464.18303725368, 55003.44996550144, 55852.0, 56229.15656265241, 15686.450974216305, 15997.360105595646, 16237.350505979628, 17029.829701702824, 17035.48893533196, 18450.630987379907, 18473.16870740793, 18696.0, 18710.625787484445, 18891.811081889005, 16598.25307861125, 16729.247183877, 17257.0, 17284.135793210036, 17485.82514174842, 13204.933975330061, 16719.916400418406, 16887.7466838, 16943.661126777642, 17064.48806535806, 16265.268062937434, 16619.335226591284, 16733.330666773192, 16989.915050425163, 17136.886102403303, 10289.9485502572, 11720.765584688088, 11780.175387722777, 12163.45264463119, 12192.268463892195, 12598.622041338775, 12630.43163057683, 12633.368331583568, 12634.557790477289, 12642.620721378373], "value": 8426.362491619735, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1550.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 116.0, 146.0, 168.0, 144.0, 115.0, 115.0, 118.0, 114.0, 115.0], "value": 125.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 113.0, 108.0, 148.0, 111.0, 110.0, 105.0, 111.0, 138.0, 114.0], "value": 120.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [206.0, 194.0, 193.0, 213.0, 212.0, 212.0, 201.0, 194.0, 203.0, 194.0], "value": 202.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 58.0, 73.0, 109.0, 58.0, 60.0, 58.0, 60.0, 79.0, 59.0], "value": 69.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 70.0, 73.0, 88.0, 65.0, 95.0, 102.0, 57.0, 89.0], "value": 80.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 88.0, 87.0, 89.0, 98.0, 136.0, 110.0, 121.0], "value": 99.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 106.0, 91.0, 123.0, 90.0, 139.0, 153.0, 110.0, 146.0, 107.0], "value": 116.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 89.0, 88.0, 96.0, 90.0, 89.0, 92.0, 92.0, 92.0], "value": 91.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 49.0, 51.0, 51.0, 51.0, 51.0, 67.0, 74.0, 72.0], "value": 56.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 62.0, 57.0, 55.0, 63.0, 58.0, 55.0, 57.0, 57.0, 55.0], "value": 57.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 107.0, 106.0, 102.0, 83.0, 83.0, 82.0, 85.0, 95.0], "value": 91.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 153.0, 152.0, 155.0, 139.0, 173.0, 151.0, 154.0, 266.0, 155.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 185.0, 187.0, 184.0, 183.0, 230.0, 231.0, 163.0, 228.0, 226.0], "value": 200.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 69.0, 83.0, 91.0, 99.0, 83.0, 69.0, 67.0, 72.0], "value": 77.0, "unit": "score"}]}]} 14:55:27 INFO - Return code: 0 14:55:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:55:27 ERROR - # TBPL SUCCESS # 14:55:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:55:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:55:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:55:27 INFO - 2017-04-27 14:55:27.239 screenresolution[1654:10981] starting screenresolution argv=screenresolution get 14:55:27 INFO - 2017-04-27 14:55:27.241 screenresolution[1654:10981] Display 0: 1600x1200x32@60 14:55:27 INFO - 2017-04-27 14:55:27.247 screenresolution[1655:10984] starting screenresolution argv=screenresolution list 14:55:27 INFO - Available Modes on Display 0 14:55:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:55:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:55:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:55:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:55:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:55:27 INFO - Intel Iris: 14:55:27 INFO - Chipset Model: Intel Iris 14:55:27 INFO - Type: GPU 14:55:27 INFO - Bus: Built-In 14:55:27 INFO - VRAM (Dynamic, Max): 1536 MB 14:55:27 INFO - Vendor: Intel (0x8086) 14:55:27 INFO - Device ID: 0x0a2e 14:55:27 INFO - Revision ID: 0x0009 14:55:27 INFO - Displays: 14:55:27 INFO - Display: 14:55:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:55:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:55:27 INFO - Display Serial Number: 1600x1200 60 14:55:27 INFO - Main Display: Yes 14:55:27 INFO - Mirror: Off 14:55:27 INFO - Online: Yes 14:55:27 INFO - Rotation: Supported 14:55:27 INFO - Return code: 0 14:55:27 INFO - Running post-action listener: _resource_record_post_action 14:55:27 INFO - [mozharness: 2017-04-27 21:55:27.493458Z] Finished run-tests step (success) 14:55:27 INFO - Running post-run listener: _resource_record_post_run 14:55:27 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 40334848; Write bytes: 511667200; Read time: 263; Write time: 1612 14:55:27 INFO - TinderboxPrint: CPU usage
54.3% 14:55:27 INFO - TinderboxPrint: I/O read bytes / time
40,334,848 / 263 14:55:27 INFO - TinderboxPrint: I/O write bytes / time
511,667,200 / 1,612 14:55:27 INFO - TinderboxPrint: CPU idle
2,186.4 (45.7%) 14:55:27 INFO - TinderboxPrint: CPU system
960.4 (20.1%) 14:55:27 INFO - TinderboxPrint: CPU user
1,634.8 (34.2%) 14:55:27 INFO - TinderboxPrint: Swap in / out
247,988,224 / 0 14:55:27 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 197499392; Write bytes: 195762176; Read time: 15023; Write time: 405 14:55:27 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 39319040; Write bytes: 299000832; Read time: 247; Write time: 1157 14:55:27 INFO - Running post-run listener: _upload_blobber_files 14:55:27 INFO - Blob upload gear active. 14:55:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:55:27 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 14:55:27 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'] 14:55:27 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 14:55:28 INFO - (blobuploader) - INFO - Open directory for files ... 14:55:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:55:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:55:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:29 INFO - (blobuploader) - INFO - Done attempting. 14:55:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:55:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:55:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:30 INFO - (blobuploader) - INFO - Done attempting. 14:55:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:55:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:31 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:55:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:31 INFO - (blobuploader) - INFO - Done attempting. 14:55:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:55:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:55:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:55:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:55:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:55:33 INFO - (blobuploader) - INFO - Done attempting. 14:55:33 INFO - (blobuploader) - INFO - Iteration through files over. 14:55:33 INFO - Return code: 0 14:55:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:55:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:55:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe411f53dbfbcab0bd0a47e17c3ab52a3b4be091273c9eed82162d74e74c0fe31478138087f3ea4314649328c23a309e44ec7c21e03563a59e0269de6b7e26c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26d0cdcaf9ce1d16f5d1d3d57b9b0a8aceb606c99cbbf1003e411e0a47c2abc4d58289d4ac92fa067563e96f32ef63cce78135e5b16ec51fb2dbf332b89c6d07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab2fbacac9486aca37f8d7b84f5438d8b62bad4948218fca9d13e26a4c26f013ff0b63c96a36d8635922ddf4a98b85a8ef212aa03320ecaba5fb0aa918ac7601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7581a84026d9478c6efc9d57c79cdf474add962798e61de2caca5e74e8db7d67ecf57fcccadf9b32badc83a220b76cf0f56b9cdc38b59992a6df114d25626274"} 14:55:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:55:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:55:33 INFO - Contents: 14:55:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe411f53dbfbcab0bd0a47e17c3ab52a3b4be091273c9eed82162d74e74c0fe31478138087f3ea4314649328c23a309e44ec7c21e03563a59e0269de6b7e26c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26d0cdcaf9ce1d16f5d1d3d57b9b0a8aceb606c99cbbf1003e411e0a47c2abc4d58289d4ac92fa067563e96f32ef63cce78135e5b16ec51fb2dbf332b89c6d07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab2fbacac9486aca37f8d7b84f5438d8b62bad4948218fca9d13e26a4c26f013ff0b63c96a36d8635922ddf4a98b85a8ef212aa03320ecaba5fb0aa918ac7601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7581a84026d9478c6efc9d57c79cdf474add962798e61de2caca5e74e8db7d67ecf57fcccadf9b32badc83a220b76cf0f56b9cdc38b59992a6df114d25626274"} 14:55:33 INFO - Running post-run listener: copy_logs_to_upload_dir 14:55:33 INFO - Copying logs to upload dir... 14:55:33 INFO - mkdir: /builds/slave/test/build/upload/logs 14:55:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.316110 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-27 14:55:33.778400) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 14:55:33.781707) ========= 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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe411f53dbfbcab0bd0a47e17c3ab52a3b4be091273c9eed82162d74e74c0fe31478138087f3ea4314649328c23a309e44ec7c21e03563a59e0269de6b7e26c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26d0cdcaf9ce1d16f5d1d3d57b9b0a8aceb606c99cbbf1003e411e0a47c2abc4d58289d4ac92fa067563e96f32ef63cce78135e5b16ec51fb2dbf332b89c6d07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab2fbacac9486aca37f8d7b84f5438d8b62bad4948218fca9d13e26a4c26f013ff0b63c96a36d8635922ddf4a98b85a8ef212aa03320ecaba5fb0aa918ac7601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7581a84026d9478c6efc9d57c79cdf474add962798e61de2caca5e74e8db7d67ecf57fcccadf9b32badc83a220b76cf0f56b9cdc38b59992a6df114d25626274"} build_url:https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/UotzmtMtQkuyvXMpORjfsQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ffe411f53dbfbcab0bd0a47e17c3ab52a3b4be091273c9eed82162d74e74c0fe31478138087f3ea4314649328c23a309e44ec7c21e03563a59e0269de6b7e26c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26d0cdcaf9ce1d16f5d1d3d57b9b0a8aceb606c99cbbf1003e411e0a47c2abc4d58289d4ac92fa067563e96f32ef63cce78135e5b16ec51fb2dbf332b89c6d07", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ab2fbacac9486aca37f8d7b84f5438d8b62bad4948218fca9d13e26a4c26f013ff0b63c96a36d8635922ddf4a98b85a8ef212aa03320ecaba5fb0aa918ac7601", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7581a84026d9478c6efc9d57c79cdf474add962798e61de2caca5e74e8db7d67ecf57fcccadf9b32badc83a220b76cf0f56b9cdc38b59992a6df114d25626274"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-27 14:55:33.817758) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:55:33.818100) ========= 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.AyM9FfnzOh/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.e5aAbEvlo8/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/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.005177 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-27 14:55:33.867214) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 14:55:33.867554) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-27 14:55:33.867875) ========= ========= Total master_lag: 3.37 =========