builder: pine_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0057 starttime: 1490991927.65 results: success (0) buildid: 20170331100223 builduid: 43d59f14c7bb4e34b3dab76c8d93ab45 revision: 8ebe0de69632ccc5eba46dc7a46a3a75c614e638 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:27.646311) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:27.646818) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:27.647100) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:27.671614) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:27.671987) ========= 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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-31 13:25:27-- 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% 66.8M=0s 2017-03-31 13:25:27 (66.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094495 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:27.791282) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:27.791612) ========= 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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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.020892 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:27.840445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:27.840864) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 8ebe0de69632ccc5eba46dc7a46a3a75c614e638 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev 8ebe0de69632ccc5eba46dc7a46a3a75c614e638 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-31 13:25:27,931 truncating revision to first 12 chars 2017-03-31 13:25:27,931 Setting DEBUG logging. 2017-03-31 13:25:27,931 attempt 1/10 2017-03-31 13:25:27,932 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/8ebe0de69632?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-31 13:25:28,381 unpacking tar archive at: pine-8ebe0de69632/testing/mozharness/ program finished with exit code 0 elapsedTime=0.733654 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:28.598539) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:28.599109) ========= script_repo_revision: 8ebe0de69632ccc5eba46dc7a46a3a75c614e638 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:28.599698) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:28.599999) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-31 13:25:28.620179) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-31 13:25:28.620504) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 13:25:28 INFO - MultiFileLogger online at 20170331 13:25:28 in /builds/slave/test 13:25:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 13:25:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:25:28 INFO - {'append_to_log': False, 13:25:28 INFO - 'base_work_dir': '/builds/slave/test', 13:25:28 INFO - 'blob_upload_branch': 'Pine', 13:25:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:25:28 INFO - 'branch': 'Pine', 13:25:28 INFO - 'buildbot_json_path': 'buildprops.json', 13:25:28 INFO - 'config_files': ('talos/mac_config.py',), 13:25:28 INFO - 'default_actions': ('clobber', 13:25:28 INFO - 'read-buildbot-config', 13:25:28 INFO - 'download-and-extract', 13:25:28 INFO - 'populate-webroot', 13:25:28 INFO - 'create-virtualenv', 13:25:28 INFO - 'install', 13:25:28 INFO - 'run-tests'), 13:25:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:25:28 INFO - 'download_minidump_stackwalk': True, 13:25:28 INFO - 'download_symbols': 'ondemand', 13:25:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:25:28 INFO - 'tooltool.py': '/tools/tooltool.py', 13:25:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:25:28 INFO - '/tools/misc-python/virtualenv.py')}, 13:25:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:25:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:25:28 INFO - 'gecko_profile': False, 13:25:28 INFO - 'gecko_profile_interval': 0, 13:25:28 INFO - 'installer_path': 'installer.exe', 13:25:28 INFO - 'log_level': 'info', 13:25:28 INFO - 'log_name': 'talos', 13:25:28 INFO - 'log_to_console': True, 13:25:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:25:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:25:28 INFO - 'opt_config_files': (), 13:25:28 INFO - 'pip_index': False, 13:25:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:25:28 INFO - 'cmd': ('bash', 13:25:28 INFO - '-c', 13:25:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:25:28 INFO - 'enabled': True, 13:25:28 INFO - 'halt_on_failure': False, 13:25:28 INFO - 'name': 'check_screen_resolution'},), 13:25:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:25:28 INFO - 'cmd': ('bash', 13:25:28 INFO - '-c', 13:25:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:25:28 INFO - 'enabled': True, 13:25:28 INFO - 'halt_on_failure': False, 13:25:28 INFO - 'name': 'check_screen_resolution'},), 13:25:28 INFO - 'run_cmd_checks_enabled': True, 13:25:28 INFO - 'suite': 'dromaeojs-e10s', 13:25:28 INFO - 'system_bits': '32', 13:25:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:25:28 INFO - 'title': 't-yosemite-r7-0057', 13:25:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:25:28 INFO - 'use_talos_json': True, 13:25:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:25:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:25:28 INFO - 'work_dir': 'build'} 13:25:28 INFO - [mozharness: 2017-03-31 20:25:28.830312Z] Running clobber step. 13:25:28 INFO - Running pre-action listener: _resource_record_pre_action 13:25:28 INFO - Running main action method: clobber 13:25:28 INFO - rmtree: /builds/slave/test/build 13:25:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:25:30 INFO - Running post-action listener: _resource_record_post_action 13:25:30 INFO - [mozharness: 2017-03-31 20:25:30.890205Z] Finished clobber step (success) 13:25:30 INFO - [mozharness: 2017-03-31 20:25:30.890368Z] Running read-buildbot-config step. 13:25:30 INFO - Running pre-action listener: _resource_record_pre_action 13:25:30 INFO - Running main action method: read_buildbot_config 13:25:30 INFO - Using buildbot properties: 13:25:30 INFO - { 13:25:30 INFO - "project": "", 13:25:30 INFO - "product": "firefox", 13:25:30 INFO - "script_repo_revision": "default", 13:25:30 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs-e10s", 13:25:30 INFO - "repository": "", 13:25:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs-e10s", 13:25:30 INFO - "buildid": "20170331100223", 13:25:30 INFO - "pgo_build": "False", 13:25:30 INFO - "basedir": "/builds/slave/test", 13:25:30 INFO - "buildnumber": 0, 13:25:30 INFO - "slavename": "t-yosemite-r7-0057", 13:25:30 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:25:30 INFO - "platform": "yosemite_r7", 13:25:30 INFO - "scheduler": "tests-pine-macosx64-talos", 13:25:30 INFO - "branch": "pine", 13:25:30 INFO - "repo_path": "projects/pine", 13:25:30 INFO - "revision": "8ebe0de69632ccc5eba46dc7a46a3a75c614e638", 13:25:30 INFO - "stage_platform": "macosx64", 13:25:30 INFO - "builduid": "43d59f14c7bb4e34b3dab76c8d93ab45", 13:25:30 INFO - "slavebuilddir": "test" 13:25:30 INFO - } 13:25:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 13:25:30 INFO - Running post-action listener: _resource_record_post_action 13:25:30 INFO - [mozharness: 2017-03-31 20:25:30.893732Z] Finished read-buildbot-config step (success) 13:25:30 INFO - [mozharness: 2017-03-31 20:25:30.893856Z] Running download-and-extract step. 13:25:30 INFO - Running pre-action listener: _resource_record_pre_action 13:25:30 INFO - Running main action method: download_and_extract 13:25:30 INFO - mkdir: /builds/slave/test/build/tests 13:25: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')]} 13:25:30 INFO - trying https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 13:25:30 INFO - Downloading https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/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 13:25:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/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 13:25:31 INFO - Downloaded 1325 bytes. 13:25:31 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 13:25:31 INFO - Using the following test package requirements: 13:25:31 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:31 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 13:25:31 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:25:31 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:31 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 13:25:31 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:31 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 13:25:31 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:31 INFO - u'jsshell-mac.zip'], 13:25:31 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:31 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 13:25:31 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 13:25:31 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:31 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 13:25:31 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:31 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 13:25:31 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:31 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 13:25:31 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 13:25:31 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 13:25:31 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 13:25:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:25:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:25:31 INFO - Fetch https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:25:33 INFO - Expected file size: 52507879 13:25:33 INFO - Obtained file size: 52507879 13:25:49 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 13:25:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 13:25:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 13:25:49 INFO - Fetch https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 13:25:51 INFO - Expected file size: 52507879 13:25:51 INFO - Obtained file size: 52507879 13:26:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 13:26:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 13:26:06 INFO - Fetch https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 13:26:07 INFO - Expected file size: 14404152 13:26:07 INFO - Obtained file size: 14404152 13:26: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')]} 13:26:07 INFO - trying https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:26:07 INFO - Downloading https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 13:26:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/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 13:26:10 INFO - Downloaded 75675645 bytes. 13:26:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:26:10 INFO - mkdir: /builds/slave/test/properties 13:26:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:26:10 INFO - Writing to file /builds/slave/test/properties/build_url 13:26:10 INFO - Contents: 13:26:10 INFO - build_url:https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 13:26:10 INFO - Running post-action listener: _resource_record_post_action 13:26:10 INFO - Running post-action listener: set_extra_try_arguments 13:26:10 INFO - [mozharness: 2017-03-31 20:26:10.939595Z] Finished download-and-extract step (success) 13:26:10 INFO - [mozharness: 2017-03-31 20:26:10.939751Z] Running populate-webroot step. 13:26:10 INFO - Running pre-action listener: _resource_record_pre_action 13:26:10 INFO - Running main action method: populate_webroot 13:26:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:26:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:26:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:26:10 INFO - '--tppagecycles', 13:26:10 INFO - '7'], 13:26:10 INFO - 'tests': ['tsvgm']}}, 13:26:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:26:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:26:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:26:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:26:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:26:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:26:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:26:10 INFO - 'talos_options': ['--disable-e10s'], 13:26:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:26:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:26:10 INFO - 'talos_options': ['--disable-e10s'], 13:26:10 INFO - 'tests': ['damp', 'tps']}, 13:26:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:26:10 INFO - 'tests': ['damp', 'tps']}, 13:26:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:26:10 INFO - 'tests': ['dromaeo_dom']}, 13:26:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:26:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:26:10 INFO - 'tests': ['basic_compositor_video']}, 13:26:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:26:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:26:10 INFO - 'tests': ['a11yr', 13:26:10 INFO - 'ts_paint', 13:26:10 INFO - 'tpaint', 13:26:10 INFO - 'sessionrestore', 13:26:10 INFO - 'sessionrestore_no_auto_restore', 13:26:10 INFO - 'tabpaint']}, 13:26:10 INFO - 'other-e10s': {'tests': ['a11yr', 13:26:10 INFO - 'ts_paint', 13:26:10 INFO - 'tpaint', 13:26:10 INFO - 'sessionrestore', 13:26:10 INFO - 'sessionrestore_no_auto_restore', 13:26:10 INFO - 'tabpaint']}, 13:26:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:26:10 INFO - 'ts_paint', 13:26:10 INFO - 'tpaint', 13:26:10 INFO - 'sessionrestore', 13:26:10 INFO - 'sessionrestore_no_auto_restore', 13:26:10 INFO - 'tabpaint']}, 13:26:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:26:10 INFO - 'ts_paint', 13:26:10 INFO - 'tpaint', 13:26:10 INFO - 'sessionrestore', 13:26:10 INFO - 'sessionrestore_no_auto_restore', 13:26:10 INFO - 'tabpaint']}, 13:26:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:26:10 INFO - 'tests': ['a11yr', 13:26:10 INFO - 'ts_paint', 13:26:10 INFO - 'tpaint', 13:26:10 INFO - 'sessionrestore', 13:26:10 INFO - 'sessionrestore_no_auto_restore', 13:26:10 INFO - 'tabpaint']}, 13:26:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:26:10 INFO - 'tests': ['a11yr', 13:26:10 INFO - 'ts_paint', 13:26:10 INFO - 'tpaint', 13:26:10 INFO - 'sessionrestore', 13:26:10 INFO - 'sessionrestore_no_auto_restore', 13:26:10 INFO - 'tabpaint']}, 13:26:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:26:10 INFO - 'tests': ['tsvgx', 13:26:10 INFO - 'tsvgr_opacity', 13:26:10 INFO - 'tart', 13:26:10 INFO - 'tscrollx', 13:26:10 INFO - 'cart', 13:26:10 INFO - 'tsvg_static']}, 13:26:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:26:10 INFO - 'tsvgr_opacity', 13:26:10 INFO - 'tart', 13:26:10 INFO - 'tscrollx', 13:26:10 INFO - 'cart', 13:26:10 INFO - 'tsvg_static']}, 13:26:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:26:10 INFO - 'talos_options': ['--disable-e10s'], 13:26:10 INFO - 'tests': ['tp5o']}, 13:26:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:26:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:26:10 INFO - 'talos_options': ['--disable-e10s', 13:26:10 INFO - '--xperf_path', 13:26:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:10 INFO - 'tests': ['tp5n']}, 13:26:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:26:10 INFO - 'talos_options': ['--xperf_path', 13:26:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:10 INFO - 'tests': ['tp5n']}}, 13:26:10 INFO - 'talos.zip': {'path': '', 13:26:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:26:10 INFO - Running post-action listener: _resource_record_post_action 13:26:10 INFO - [mozharness: 2017-03-31 20:26:10.958283Z] Finished populate-webroot step (success) 13:26:10 INFO - [mozharness: 2017-03-31 20:26:10.958394Z] Running create-virtualenv step. 13:26:10 INFO - Running pre-action listener: _resource_record_pre_action 13:26:10 INFO - Running main action method: create_virtualenv 13:26:10 INFO - Creating virtualenv /builds/slave/test/build/venv 13:26:10 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 13:26:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:26:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:26:11 INFO - Using real prefix '/tools/python27' 13:26:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:26:11 INFO - Installing distribute.............................................................................................................................................................................................done. 13:26:14 INFO - Installing pip.................done. 13:26:14 INFO - Return code: 0 13:26:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:26:14 INFO - Reading from file tmpfile_stdout 13:26:14 INFO - Output received: 13:26:14 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) 13:26:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:26:14 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')]} 13:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:14 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')]} 13:26:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:14 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 0x10d71fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d722768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fced149db40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4fdd30>, '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 0x10d424db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f2be8>, '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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 13:26:14 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 13:26:14 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 13:26:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0jN4Nsw4G/Render', 13:26:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:14 INFO - 'HOME': '/Users/cltbld', 13:26:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:14 INFO - 'LOGNAME': 'cltbld', 13:26:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:14 INFO - 'MOZ_NO_REMOTE': '1', 13:26:14 INFO - 'NO_EM_RESTART': '1', 13:26:14 INFO - 'PAGER': '/bin/cat', 13:26:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:14 INFO - 'PWD': '/builds/slave/test', 13:26:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:14 INFO - 'SHELL': '/bin/bash', 13:26:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDSptHK4Pm/Listeners', 13:26:14 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 13:26:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:14 INFO - 'USER': 'cltbld', 13:26:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:14 INFO - 'XPC_FLAGS': '0x0', 13:26:14 INFO - 'XPC_SERVICE_NAME': '0', 13:26:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:15 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 13:26:15 INFO - Cleaning up... 13:26:15 INFO - Return code: 0 13:26:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:26: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')]} 13:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26: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')]} 13:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26: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', '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 0x10d71fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d722768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fced149db40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4fdd30>, '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 0x10d424db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f2be8>, '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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 13:26: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', 'psutil>=3.1.1'] in /builds/slave/test/build 13:26: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 psutil>=3.1.1 13:26:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0jN4Nsw4G/Render', 13:26:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:15 INFO - 'HOME': '/Users/cltbld', 13:26:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:15 INFO - 'LOGNAME': 'cltbld', 13:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:15 INFO - 'MOZ_NO_REMOTE': '1', 13:26:15 INFO - 'NO_EM_RESTART': '1', 13:26:15 INFO - 'PAGER': '/bin/cat', 13:26:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:15 INFO - 'PWD': '/builds/slave/test', 13:26:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:15 INFO - 'SHELL': '/bin/bash', 13:26:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDSptHK4Pm/Listeners', 13:26:15 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 13:26:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:15 INFO - 'USER': 'cltbld', 13:26:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:15 INFO - 'XPC_FLAGS': '0x0', 13:26:15 INFO - 'XPC_SERVICE_NAME': '0', 13:26:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:15 INFO - Downloading/unpacking psutil>=3.1.1 13:26: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 13:26: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 13:26: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 13:26: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 13:26: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 13:26: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 13:26:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:26:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:19 INFO - Installing collected packages: psutil 13:26:19 INFO - Running setup.py install for psutil 13:26:19 INFO - building 'psutil._psutil_osx' extension 13:26:19 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 13:26:19 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 13:26:19 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 13:26:19 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 13:26:19 INFO - building 'psutil._psutil_posix' extension 13:26:19 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 13:26:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:26:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:26:19 INFO - ^ 13:26:19 INFO - 1 warning generated. 13:26:19 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 13:26:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:19 INFO - Successfully installed psutil 13:26:19 INFO - Cleaning up... 13:26:20 INFO - Return code: 0 13:26:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:26: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')]} 13:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26: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')]} 13:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d71fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d722768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fced149db40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4fdd30>, '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 0x10d424db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f2be8>, '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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 13:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:26:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0jN4Nsw4G/Render', 13:26:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:20 INFO - 'HOME': '/Users/cltbld', 13:26:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:20 INFO - 'LOGNAME': 'cltbld', 13:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:20 INFO - 'MOZ_NO_REMOTE': '1', 13:26:20 INFO - 'NO_EM_RESTART': '1', 13:26:20 INFO - 'PAGER': '/bin/cat', 13:26:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:20 INFO - 'PWD': '/builds/slave/test', 13:26:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:20 INFO - 'SHELL': '/bin/bash', 13:26:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDSptHK4Pm/Listeners', 13:26:20 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 13:26:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:20 INFO - 'USER': 'cltbld', 13:26:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:20 INFO - 'XPC_FLAGS': '0x0', 13:26:20 INFO - 'XPC_SERVICE_NAME': '0', 13:26:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:26:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:26:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:26:23 INFO - Installing collected packages: mozsystemmonitor 13:26:23 INFO - Running setup.py install for mozsystemmonitor 13:26:23 INFO - Successfully installed mozsystemmonitor 13:26:23 INFO - Cleaning up... 13:26:23 INFO - Return code: 0 13:26:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:23 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 0x10d71fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d722768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fced149db40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4fdd30>, '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 0x10d424db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f2be8>, '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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 13:26:23 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 13:26:23 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 13:26:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0jN4Nsw4G/Render', 13:26:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:23 INFO - 'HOME': '/Users/cltbld', 13:26:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:23 INFO - 'LOGNAME': 'cltbld', 13:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:23 INFO - 'MOZ_NO_REMOTE': '1', 13:26:23 INFO - 'NO_EM_RESTART': '1', 13:26:23 INFO - 'PAGER': '/bin/cat', 13:26:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:23 INFO - 'PWD': '/builds/slave/test', 13:26:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:23 INFO - 'SHELL': '/bin/bash', 13:26:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDSptHK4Pm/Listeners', 13:26:23 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 13:26:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:23 INFO - 'USER': 'cltbld', 13:26:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:23 INFO - 'XPC_FLAGS': '0x0', 13:26:23 INFO - 'XPC_SERVICE_NAME': '0', 13:26:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:23 INFO - Downloading/unpacking jsonschema==2.5.1 13:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:26:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:26:26 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 13:26:26 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 13:26:26 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 13:26:26 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 13:26:26 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 13:26:26 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 13:26:26 INFO - Downloading functools32-3.2.3-2.tar.gz 13:26:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:26:26 INFO - warning: no files found matching '*.txt' 13:26:26 INFO - no previously-included directories found matching 'build' 13:26:26 INFO - no previously-included directories found matching 'dist' 13:26:26 INFO - no previously-included directories found matching '.git*' 13:26:26 INFO - Installing collected packages: jsonschema, functools32 13:26:26 INFO - Running setup.py install for functools32 13:26:26 INFO - warning: no files found matching '*.txt' 13:26:26 INFO - no previously-included directories found matching 'build' 13:26:26 INFO - no previously-included directories found matching 'dist' 13:26:26 INFO - no previously-included directories found matching '.git*' 13:26:26 INFO - Successfully installed jsonschema functools32 13:26:26 INFO - Cleaning up... 13:26:27 INFO - Return code: 0 13:26:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d71fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d722768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fced149db40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4fdd30>, '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 0x10d424db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f2be8>, '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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 13:26:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:26:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:26:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0jN4Nsw4G/Render', 13:26:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:27 INFO - 'HOME': '/Users/cltbld', 13:26:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:27 INFO - 'LOGNAME': 'cltbld', 13:26:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:27 INFO - 'MOZ_NO_REMOTE': '1', 13:26:27 INFO - 'NO_EM_RESTART': '1', 13:26:27 INFO - 'PAGER': '/bin/cat', 13:26:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:27 INFO - 'PWD': '/builds/slave/test', 13:26:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:27 INFO - 'SHELL': '/bin/bash', 13:26:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDSptHK4Pm/Listeners', 13:26:27 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 13:26:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:27 INFO - 'USER': 'cltbld', 13:26:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:27 INFO - 'XPC_FLAGS': '0x0', 13:26:27 INFO - 'XPC_SERVICE_NAME': '0', 13:26:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:26:28 INFO - Cleaning up... 13:26:28 INFO - Return code: 0 13:26:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:26:28 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')]} 13:26:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:28 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')]} 13:26:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:28 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 0x10d71fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d722768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fced149db40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4fdd30>, '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 0x10d424db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f2be8>, '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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 13:26:28 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 13:26:28 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 13:26:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0jN4Nsw4G/Render', 13:26:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:28 INFO - 'HOME': '/Users/cltbld', 13:26:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:28 INFO - 'LOGNAME': 'cltbld', 13:26:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:28 INFO - 'MOZ_NO_REMOTE': '1', 13:26:28 INFO - 'NO_EM_RESTART': '1', 13:26:28 INFO - 'PAGER': '/bin/cat', 13:26:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:28 INFO - 'PWD': '/builds/slave/test', 13:26:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:28 INFO - 'SHELL': '/bin/bash', 13:26:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDSptHK4Pm/Listeners', 13:26:28 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 13:26:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:28 INFO - 'USER': 'cltbld', 13:26:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:28 INFO - 'XPC_FLAGS': '0x0', 13:26:28 INFO - 'XPC_SERVICE_NAME': '0', 13:26:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:28 INFO - Downloading/unpacking blobuploader==1.2.4 13:26:28 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 13:26:28 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 13:26:28 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 13:26:28 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 13:26:28 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 13:26:28 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 13:26:31 INFO - Downloading blobuploader-1.2.4.tar.gz 13:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:26:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:26:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:32 INFO - Downloading docopt-0.6.1.tar.gz 13:26:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:26:32 INFO - Installing collected packages: blobuploader, requests, docopt 13:26:32 INFO - Running setup.py install for blobuploader 13:26:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:26:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:26:32 INFO - Running setup.py install for requests 13:26:33 INFO - Running setup.py install for docopt 13:26:33 INFO - Successfully installed blobuploader requests docopt 13:26:33 INFO - Cleaning up... 13:26:33 INFO - Return code: 0 13:26:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:33 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 0x10d71fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d722768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fced149db40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4fdd30>, '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 0x10d424db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f2be8>, '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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 13:26:33 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 13:26:33 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 13:26:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0jN4Nsw4G/Render', 13:26:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:33 INFO - 'HOME': '/Users/cltbld', 13:26:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:33 INFO - 'LOGNAME': 'cltbld', 13:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:33 INFO - 'MOZ_NO_REMOTE': '1', 13:26:33 INFO - 'NO_EM_RESTART': '1', 13:26:33 INFO - 'PAGER': '/bin/cat', 13:26:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:33 INFO - 'PWD': '/builds/slave/test', 13:26:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:33 INFO - 'SHELL': '/bin/bash', 13:26:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDSptHK4Pm/Listeners', 13:26:33 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 13:26:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:33 INFO - 'USER': 'cltbld', 13:26:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:33 INFO - 'XPC_FLAGS': '0x0', 13:26:33 INFO - 'XPC_SERVICE_NAME': '0', 13:26:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:33 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-WM97MA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:33 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-0GVdUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:33 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-hQcegP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-Fa9CZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-h9H4HD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-sClaAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-8bgANc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-RtLtN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-EN10ag-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-QCixcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-xig5Ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:34 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-Q0T_vc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:35 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-UxNmlf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:35 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-xfUfYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:35 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-1HMeaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:35 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-Qke_uq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:35 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-bewtoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:26:35 INFO - Running setup.py install for manifestparser 13:26:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:26:35 INFO - Running setup.py install for mozcrash 13:26:35 INFO - Running setup.py install for mozdebug 13:26:35 INFO - Running setup.py install for mozdevice 13:26:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:26:36 INFO - Running setup.py install for mozfile 13:26:36 INFO - Running setup.py install for mozhttpd 13:26:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:26:36 INFO - Running setup.py install for mozinfo 13:26:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:26:36 INFO - Running setup.py install for mozInstall 13:26:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:26:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:26:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:26:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:26:36 INFO - Running setup.py install for mozleak 13:26:36 INFO - Running setup.py install for mozlog 13:26:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:26:37 INFO - Running setup.py install for moznetwork 13:26:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:26:37 INFO - Running setup.py install for mozprocess 13:26:37 INFO - Running setup.py install for mozprofile 13:26:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:26:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:26:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:26:37 INFO - Running setup.py install for mozrunner 13:26:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:26:37 INFO - Running setup.py install for mozscreenshot 13:26:37 INFO - Running setup.py install for moztest 13:26:37 INFO - Running setup.py install for mozversion 13:26:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:26:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:26:38 INFO - Cleaning up... 13:26:38 INFO - Return code: 0 13:26:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:38 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 0x10d71fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d722768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fced149db40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4fdd30>, '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 0x10d424db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f2be8>, '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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 13:26:38 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 13:26:38 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 13:26:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0jN4Nsw4G/Render', 13:26:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:38 INFO - 'HOME': '/Users/cltbld', 13:26:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:38 INFO - 'LOGNAME': 'cltbld', 13:26:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:38 INFO - 'MOZ_NO_REMOTE': '1', 13:26:38 INFO - 'NO_EM_RESTART': '1', 13:26:38 INFO - 'PAGER': '/bin/cat', 13:26:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:38 INFO - 'PWD': '/builds/slave/test', 13:26:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:38 INFO - 'SHELL': '/bin/bash', 13:26:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDSptHK4Pm/Listeners', 13:26:38 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 13:26:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:38 INFO - 'USER': 'cltbld', 13:26:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:38 INFO - 'XPC_FLAGS': '0x0', 13:26:38 INFO - 'XPC_SERVICE_NAME': '0', 13:26:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:38 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-AGkIXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:38 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)) 13:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:38 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-XmEXMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:38 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)) 13:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:38 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-u6_E_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:38 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)) 13:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:38 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-baNc47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:38 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-9e8J6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:38 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)) 13:26:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:38 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-Mcjd4d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:39 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-bOIUw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:39 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-lWYYxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:39 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-NHa2dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:39 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-hcU4S1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:39 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-VKj1Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:39 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-ON873V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:39 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-FpsTxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:39 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-G3HyMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:39 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-kEiSnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:39 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)) 13:26:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:39 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-UaLuxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:40 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)) 13:26:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:40 INFO - Running setup.py (path:/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/pip-Zzy7To-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:40 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)) 13:26:40 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)) 13:26:40 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)) 13:26:40 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)) 13:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:26:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:42 INFO - Downloading blessings-1.6.tar.gz 13:26:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:26:42 INFO - Installing collected packages: blessings 13:26:42 INFO - Running setup.py install for blessings 13:26:43 INFO - Successfully installed blessings 13:26:43 INFO - Cleaning up... 13:26:43 INFO - Return code: 0 13:26:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:26:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:43 INFO - Reading from file tmpfile_stdout 13:26:43 INFO - Current package versions: 13:26:43 INFO - blessings == 1.6 13:26:43 INFO - blobuploader == 1.2.4 13:26:43 INFO - docopt == 0.6.1 13:26:43 INFO - functools32 == 3.2.3-2 13:26:43 INFO - jsonschema == 2.5.1 13:26:43 INFO - manifestparser == 1.1 13:26:43 INFO - mozInstall == 1.12 13:26:43 INFO - mozcrash == 1.0 13:26:43 INFO - mozdebug == 0.1 13:26:43 INFO - mozdevice == 0.49 13:26:43 INFO - mozfile == 1.2 13:26:43 INFO - mozhttpd == 0.7 13:26:43 INFO - mozinfo == 0.9 13:26:43 INFO - mozleak == 0.1 13:26:43 INFO - mozlog == 3.4 13:26:43 INFO - moznetwork == 0.27 13:26:43 INFO - mozprocess == 0.25 13:26:43 INFO - mozprofile == 0.28 13:26:43 INFO - mozrunner == 6.13 13:26:43 INFO - mozscreenshot == 0.1 13:26:43 INFO - mozsystemmonitor == 0.3 13:26:43 INFO - moztest == 0.8 13:26:43 INFO - mozversion == 1.4 13:26:43 INFO - psutil == 3.1.1 13:26:43 INFO - requests == 1.2.3 13:26:43 INFO - wsgiref == 0.1.2 13:26:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:43 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')]} 13:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:43 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')]} 13:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:43 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 0x10d71fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d722768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fced149db40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4fdd30>, '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 0x10d424db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f2be8>, '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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 13:26:43 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 13:26:43 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 13:26:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0jN4Nsw4G/Render', 13:26:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:43 INFO - 'HOME': '/Users/cltbld', 13:26:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:43 INFO - 'LOGNAME': 'cltbld', 13:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:43 INFO - 'MOZ_NO_REMOTE': '1', 13:26:43 INFO - 'NO_EM_RESTART': '1', 13:26:43 INFO - 'PAGER': '/bin/cat', 13:26:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:43 INFO - 'PWD': '/builds/slave/test', 13:26:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:43 INFO - 'SHELL': '/bin/bash', 13:26:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDSptHK4Pm/Listeners', 13:26:43 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 13:26:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:43 INFO - 'USER': 'cltbld', 13:26:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:43 INFO - 'XPC_FLAGS': '0x0', 13:26:43 INFO - 'XPC_SERVICE_NAME': '0', 13:26:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 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)) 13:26:43 INFO - Cleaning up... 13:26:43 INFO - Return code: 0 13:26:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:26:43 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')]} 13:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:43 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')]} 13:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:43 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 0x10d71fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d722768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fced149db40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d4fdd30>, '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 0x10d424db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f2be8>, '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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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 13:26:43 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 13:26:43 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 13:26:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0jN4Nsw4G/Render', 13:26:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:43 INFO - 'HOME': '/Users/cltbld', 13:26:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:43 INFO - 'LOGNAME': 'cltbld', 13:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:43 INFO - 'MOZ_NO_REMOTE': '1', 13:26:43 INFO - 'NO_EM_RESTART': '1', 13:26:43 INFO - 'PAGER': '/bin/cat', 13:26:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:43 INFO - 'PWD': '/builds/slave/test', 13:26:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:43 INFO - 'SHELL': '/bin/bash', 13:26:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDSptHK4Pm/Listeners', 13:26:43 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 13:26:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:43 INFO - 'USER': 'cltbld', 13:26:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:43 INFO - 'XPC_FLAGS': '0x0', 13:26:43 INFO - 'XPC_SERVICE_NAME': '0', 13:26:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:26:43 INFO - Cleaning up... 13:26:43 INFO - Return code: 0 13:26:43 INFO - Running post-action listener: _resource_record_post_action 13:26:43 INFO - Running post-action listener: _start_resource_monitoring 13:26:43 INFO - Starting resource monitoring. 13:26:43 INFO - [mozharness: 2017-03-31 20:26:43.969231Z] Finished create-virtualenv step (success) 13:26:43 INFO - [mozharness: 2017-03-31 20:26:43.970244Z] Running install step. 13:26:43 INFO - Running pre-action listener: _resource_record_pre_action 13:26:43 INFO - Running main action method: install 13:26:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:44 INFO - Reading from file tmpfile_stdout 13:26:44 INFO - Detecting whether we're running mozinstall >=1.0... 13:26:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:26:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:26:44 INFO - Reading from file tmpfile_stdout 13:26:44 INFO - Output received: 13:26:44 INFO - Usage: mozinstall [options] installer 13:26:44 INFO - Options: 13:26:44 INFO - -h, --help show this help message and exit 13:26:44 INFO - -d DEST, --destination=DEST 13:26:44 INFO - Directory to install application into. [default: 13:26:44 INFO - "/builds/slave/test"] 13:26:44 INFO - --app=APP Application being installed. [default: firefox] 13:26:44 INFO - mkdir: /builds/slave/test/build/application 13:26:44 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'] 13:26:44 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 13:27:04 INFO - Reading from file tmpfile_stdout 13:27:04 INFO - Output received: 13:27:04 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 13:27:04 INFO - Running post-action listener: _resource_record_post_action 13:27:04 INFO - [mozharness: 2017-03-31 20:27:04.364992Z] Finished install step (success) 13:27:04 INFO - [mozharness: 2017-03-31 20:27:04.365110Z] Running run-tests step. 13:27:04 INFO - Running pre-action listener: _resource_record_pre_action 13:27:04 INFO - Running main action method: run_tests 13:27:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:27:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:27:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:27:04 INFO - 2017-03-31 13:27:04.380 screenresolution[1893:10487] starting screenresolution argv=screenresolution get 13:27:04 INFO - 2017-03-31 13:27:04.382 screenresolution[1893:10487] Display 0: 1600x1200x32@60 13:27:04 INFO - 2017-03-31 13:27:04.388 screenresolution[1894:10490] starting screenresolution argv=screenresolution list 13:27:04 INFO - Available Modes on Display 0 13:27:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:27:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:27:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:27:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:27:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:27:04 INFO - Intel Iris: 13:27:04 INFO - Chipset Model: Intel Iris 13:27:04 INFO - Type: GPU 13:27:04 INFO - Bus: Built-In 13:27:04 INFO - VRAM (Dynamic, Max): 1536 MB 13:27:04 INFO - Vendor: Intel (0x8086) 13:27:04 INFO - Device ID: 0x0a2e 13:27:04 INFO - Revision ID: 0x0009 13:27:04 INFO - Displays: 13:27:04 INFO - Display: 13:27:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:27:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:27:04 INFO - Display Serial Number: 1600x1200 60 13:27:04 INFO - Main Display: Yes 13:27:04 INFO - Mirror: Off 13:27:04 INFO - Online: Yes 13:27:04 INFO - Rotation: Supported 13:27:04 INFO - Return code: 0 13:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:27:04 INFO - Python 2.7.3 13:27:04 INFO - Return code: 0 13:27:04 INFO - grabbing minidump binary from tooltool 13:27:04 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')]} 13:27:04 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 0x10d4fdd30>, '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 0x10d424db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4f2be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:27:04 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 13:27:04 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 13:27:04 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 13:27:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:27:04 INFO - Return code: 0 13:27:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:27:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:27:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:27:04 INFO - ENV: RUST_BACKTRACE is now 1 13:27:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:27:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:27:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--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 13:27:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0057 --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 13:27:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.P0jN4Nsw4G/Render', 13:27:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:04 INFO - 'HOME': '/Users/cltbld', 13:27:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:04 INFO - 'LOGNAME': 'cltbld', 13:27:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:27:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:04 INFO - 'MOZ_NO_REMOTE': '1', 13:27:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:27:04 INFO - 'NO_EM_RESTART': '1', 13:27:04 INFO - 'PAGER': '/bin/cat', 13:27:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:04 INFO - 'PWD': '/builds/slave/test', 13:27:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:27:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:04 INFO - 'RUST_BACKTRACE': '1', 13:27:04 INFO - 'SHELL': '/bin/bash', 13:27:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UDSptHK4Pm/Listeners', 13:27:04 INFO - 'TMPDIR': '/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/', 13:27:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:04 INFO - 'USER': 'cltbld', 13:27:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:04 INFO - 'XPC_FLAGS': '0x0', 13:27:04 INFO - 'XPC_SERVICE_NAME': '0', 13:27:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--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 13:27:04 INFO - mozversion application_buildid: 20170331100223 13:27:04 INFO - mozversion application_changeset: 8ebe0de69632ccc5eba46dc7a46a3a75c614e638 13:27:04 INFO - mozversion application_display_name: Nightly 13:27:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:27:04 INFO - mozversion application_name: Firefox 13:27:04 INFO - mozversion application_remotingname: firefox 13:27:04 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 13:27:04 INFO - mozversion application_vendor: Mozilla 13:27:04 INFO - mozversion application_version: 55.0a1 13:27:04 INFO - mozversion platform_buildid: 20170331100223 13:27:04 INFO - mozversion platform_changeset: 8ebe0de69632ccc5eba46dc7a46a3a75c614e638 13:27:04 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 13:27:04 INFO - mozversion platform_version: 55.0a1 13:27:04 INFO - using testdate: 1490992024 13:27:04 INFO - actual date: 1490992024 13:27:04 INFO - starting webserver on 'localhost:49705' 13:27:04 INFO - SUITE-START | Running 2 tests 13:27:04 INFO - TEST-START | dromaeo_css 13:27:04 INFO - operating with platform_type : mac_ 13:27:04 INFO - Initialising browser for dromaeo_css test... 13:27:04 INFO - TEST-INFO | started process 1904 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/tmpa8oHkd/profile http://localhost:49705/getInfo.html) 13:27:07 INFO - PID 1904 | 2017-03-31 13:27:07.608 plugin-container[1906:10669] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 13:27:07 INFO - PID 1904 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:27:07 INFO - PID 1904 | 2017-03-31 13:27:07.611 plugin-container[1906:10669] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c1b, name = 'com.apple.CFPasteboardClient' 13:27:07 INFO - PID 1904 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:27:07 INFO - PID 1904 | 2017-03-31 13:27:07.611 plugin-container[1906:10669] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:27:07 INFO - PID 1904 | __metrics Screen width/height:1600/1200 13:27:07 INFO - PID 1904 | colorDepth:24 13:27:07 INFO - PID 1904 | Browser inner width/height: 1024/689 13:27:07 INFO - PID 1904 | __metrics 13:27:07 ERROR - PID 1904 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 13:27:08 INFO - TEST-INFO | 1904: exit 0 13:27:08 INFO - Browser initialized. 13:27:08 INFO - Running cycle 1/1 for dromaeo_css test... 13:27:08 INFO - TEST-INFO | started process 1907 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/tmpa8oHkd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:11 INFO - PID 1907 | 2017-03-31 13:27:11.030 plugin-container[1908:10798] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 13:27:11 INFO - PID 1907 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:27:11 INFO - PID 1907 | 2017-03-31 13:27:11.030 plugin-container[1908:10798] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 13:27:11 INFO - PID 1907 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:27:11 INFO - PID 1907 | 2017-03-31 13:27:11.030 plugin-container[1908:10798] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:27:20 INFO - PID 1907 | RSS: Main: 230305792 13:27:20 INFO - PID 1907 | 13:30:24 INFO - PID 1907 | Cycle 1(1): loaded http://localhost:49705/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49705/tests/dromaeo/cssquery-ext.html) 13:30:26 INFO - PID 1907 | RSS: Main: 257622016 13:30:26 INFO - PID 1907 | 13:32:08 INFO - PID 1907 | ************************* 13:32:08 INFO - PID 1907 | A coding exception was thrown and uncaught in a Task. 13:32:08 INFO - PID 1907 | 13:32:08 ERROR - PID 1907 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:32:08 INFO - PID 1907 | Full stack: 13:32:08 INFO - PID 1907 | ************************* 13:32:08 INFO - PID 1907 | ************************* 13:32:08 INFO - PID 1907 | A coding exception was thrown and uncaught in a Task. 13:32:08 INFO - PID 1907 | 13:32:08 ERROR - PID 1907 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:32:08 INFO - PID 1907 | Full stack: 13:32:08 INFO - PID 1907 | ************************* 13:32:08 INFO - PID 1907 | ************************* 13:32:08 INFO - PID 1907 | A coding exception was thrown and uncaught in a Task. 13:32:08 INFO - PID 1907 | 13:32:08 ERROR - PID 1907 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:32:08 INFO - PID 1907 | Full stack: 13:32:08 INFO - PID 1907 | ************************* 13:32:08 INFO - PID 1907 | ************************* 13:32:08 INFO - PID 1907 | A coding exception was thrown and uncaught in a Task. 13:32:08 INFO - PID 1907 | 13:32:08 ERROR - PID 1907 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:32:08 INFO - PID 1907 | Full stack: 13:32:08 INFO - PID 1907 | ************************* 13:33:28 INFO - PID 1907 | Cycle 1(1): loaded http://localhost:49705/tests/dromaeo/cssquery-ext.html (next: http://localhost:49705/tests/dromaeo/cssquery-jquery.html) 13:33:29 INFO - PID 1907 | RSS: Main: 264802304 13:33:29 INFO - PID 1907 | 13:36:31 INFO - PID 1907 | Cycle 1(1): loaded http://localhost:49705/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49705/tests/dromaeo/cssquery-mootools.html) 13:36:31 INFO - PID 1907 | RSS: Main: 275861504 13:36:31 INFO - PID 1907 | 13:39:33 INFO - PID 1907 | Cycle 1(1): loaded http://localhost:49705/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49705/tests/dromaeo/cssquery-prototype.html) 13:39:34 INFO - PID 1907 | RSS: Main: 269389824 13:39:34 INFO - PID 1907 | 13:42:37 INFO - PID 1907 | Cycle 1(1): loaded http://localhost:49705/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49705/tests/dromaeo/cssquery-yui.html) 13:42:37 INFO - PID 1907 | RSS: Main: 279711744 13:42:37 INFO - PID 1907 | 13:45:40 INFO - PID 1907 | Cycle 1(1): loaded http://localhost:49705/tests/dromaeo/cssquery-yui.html (next: http://localhost:49705/tests/dromaeo/cssquery-dojo.html) 13:45:41 INFO - PID 1907 | RSS: Main: 273334272 13:45:41 INFO - PID 1907 | 13:45:41 INFO - PID 1907 | __start_tp_report 13:45:41 INFO - PID 1907 | _x_x_mozilla_page_load 13:45:41 INFO - PID 1907 | _x_x_mozilla_page_load_details 13:45:41 INFO - PID 1907 | |i|pagename|runs| 13:45:41 INFO - PID 1907 | |0;dojo.html;2878.7265209805073;3522.823858807059;3561.7506774525796;3563.590187128481;3593.5148754918087;6140.35526269742;6218.4714299284615;6247.437730604244;6262.467690246329;6280.528960327971;6184.69076546172;6201.503879689614;6236.220472440945;6244.56288059836;6299;5378.542823859977;5465.398806131322;5493.285872836525;5572.080606699889;5607.243022191993;5432.891342173174;5506.394296627388;5594.944050559503;5626.381098079208;5633.464820842013;5558.176608181325;5559.58303127265;5575.414581468928;5602.355729091146;5627.943720562804;5384.757685904144;5462.317210348707;5522.5581953443625;5533.893221355705;5567.944320556823;5443.673379597197;5446.346438427375;5449.618526703132;5462.481064298885;5482.424345443751;5198.844034678966;5924.377940316248;6103.004334463713;6234.376562343729;6247.500199983991;6499.902501462482;6631.171103612049;6677.732890684367;6688.565243259172;6725.865482690368;5655.915161272585;6825.1809782825885;6830.829229269259;6832.043513908056;6834;6188.659623720649;6358.046293056079;6362.491000719885;6362.586431881913;6365.077063825812;6813.284605116491;6904.758333458405;6943.756968506078;6968.338007889242;6971.930280697229;6389.233292004989;6526.771562995273;6545.803625891231;6561;6623.503237257225;6653.168353955755;6755.93244067553;6875.5874647521305;6875.7937261882225;6879.484038697117;6439.967800160969;6698.4641228701585;6728.259891411941;6742.224644165984;6750.054992301082;5508.366537848118;6432.71052802625;6483.610983341015;6542.051402546699;6598;5376.166694162411;5380.3274590676165;5382.757775900094;5384.946150538444;5435.945640543544;4756.120117778222;4762.714237145713;4774.474807771142;4791.568758811654;4792.137415265286;6200.844978875474;6278.121063051177;6351;6357.586756860789;6384.48924086072;6719.193696756421;6802.829929251809;6813.080234168324;6820.215675197316;6843.863122737517;4730.692504987165;5277.868053298698;6191.9690401547705;6340.492760579143;6380.84047898797;5766.740496677659;5959.463648271676;5962.821115366546;5965.791197308074;5984.281886173687;6842.281560436082;6843.247242803288;6903.551269167488;6969.54697944632;7023.086998690138;6793.762218322335;6796.422304104207;6817.625030623363;6822.624755638289;6833.897491537531;6942.375186233263;6984.371406573433;7039.54242974205;7043;7045.1898031727005;6439.935600643934;6531.052997315268;6578.934210657832;6619.569727967667;6699.39705426514;6674.632895190617;6732.091167692494;6795.38841504267;6802.591844489347;6803.727850885909;6260.092286618506;6331.96834015827;6500.414962653384;6531.510136739668;6569.080328754074;6567.9671601641685;6569.113169722026;6585.670716464062;6586.50601204902;6595.835104122435;6248.156498872594;6262.906056409066;6294.779682711083;6364.840878978062;6438.195225596801;5360.785568577213;6542.803715888531;6579.276279609144;6589.209294884645;6623.271440141677;6422.165118534561;6438.227412710505;6440.29156792743;6447.548671593131;6453.09656648079 13:45:41 INFO - PID 1907 | |1;ext.html;719.5538765965101;1116.3692513729743;1119.9160062995277;1275.9744805103892;1285.5307812648387;30353.69646303539;39134.8043259784;39201.60798392022;39259;39273.99999999996;37994.24011519768;38274.04314892129;38375;38436.42345364822;38538.229235415274;8051.6376763045655;8581.442206256605;8768.34237432192;8798.252148567379;8808.163224493695;8722.30221582272;8746.781330466758;8832.911670883273;8834.86747698785;8836.160564746371;8808.295336373107;8811.95594022029;8812.471251724884;8859.29125669945;8900.37697361185;8752.56237188138;8823.823523529525;8845.469271843709;8850.822983540293;8870.246029087535;8652.22130008296;8697.739067827912;8711.607977640959;8716.997545282311;8739.60671769772;39016;39034.169020421316;39054.80472597647;39242.80378598089;39358.606413935784;3087.8919237826567;3094.3347180356104;3117.329774098557;3134.8902788402524;3206.486962086055;28277.57583636247;28286.72516840924;28314.575281370795;28727.42545149106;29051.854740726372;2775.722427757228;2824.5339518979345;2831.447867665806;2893.788844463791;2902.201894479014;286124;309648;313194;319357.8064219375;322858;40660.59339406627;41659.37510937338;49211;50230.49769502331;50294;51960;51965;51965;51969.48030519646;51977.74011129996;14418;14556.272186390637;14564.980451368303;14571.708565828623;14572.854271457361;8865.955670221607;9894.307398482037;11729.589464368706;11790.056795456343;11944.343061131722;13540.796888046687;13594.32028398576;13664.248466334448;13744.175349479063;13804.03371763987;5051.621128415383;6006.429389208019;6022.945984452791;6035.155078289043;6036.305824830113;983.2625530851861;991.633095754561;993.4337427666305;1000.9099181073739;1038.2265212416646;20588.176472940915;22109.33671989843;24759.62860557093;24763.62854557183;24959.251222463354;1089.9019088282093;1090.8219123346767;1111.8048098294366;1113.1428799824253;1135.7501349703052;11121.999020088231;11915.761684766256;12223.69440763988;12709.93645031769;12954.417051232716;467030;470969;471209.79555920063;471753;471867;56670;56990.43009569934;57306;57452;57521;1458.7301349250422;1486.9776953345493;1521.1481570320657;1524.8932574719663;1535.5930678370241;23998.28605024267;24261.029558818154;24406.02375904944;24408;24503.264902052968;33572.66427335695;39119.60880391159;39427.60572394354;39443.40834887536;39504;450725;452222;452490;452976;453021;26733.598996014687;27313.453730925667;32771.672283276865;33324.166895827795;33492.311076449805;41462;42726.57273427226;42851.71444856659;43468;43513.34729979116;25114;26127.738722612532;29071.12786616405;29745.958891438695;30148.547771783004;27917.860410697816;28943.276418088873;29674.703252967192;29736.85131574415;29783.404331913673;35598.28803423969;35689.82155089312;35724.749633762694;35833.46249806203;37428.62571374251;30051.24871878133;30726;31450;31590;31629;20343;21203.939803010097;24375.390615234763;24722.876385617958;24933.875330623232 13:45:41 INFO - PID 1907 | |2;jquery.html;401.7228112602304;421.88609075549624;424.38676113016686;427.16062936330104;451.7869520337891;21673.241436549724;21933.01301441435;22576.661350079743;22940;23260.41848953777;22385.664215036788;22557;23118.306450806504;23335.833208339558;23436;6158;6241.968790156055;6405.743770249184;6406.807795766111;6415.6471394073305;6099.7865074722395;6248.625082495065;6315.115883776275;6330.27201871786;6338.683065846712;6195.6902154892305;6207.782727604535;6247.375262473762;6260.624362538239;6295.338989406115;6087.178230938811;6284.371562843725;6288.182536270256;6303.180586523746;6309.495240380758;5331.440198779111;5476.6713997159895;5517.144842549411;5533.418991005967;5587.7485513152005;26874;27028.324291892663;27213.047543336088;27294.863525682442;27670.446591068267;1768.45177994822;2021.2622392826659;2039.4391542325832;2049.559344740888;2081.002237851664;15832.525024249291;16574.08842513661;16616.750748738777;16733.497995060166;17215.741763873553;1882.7081802320663;1891.5743957609427;1893.1007771308655;1893.2521653946615;1919.4913347962802;152213;160154.19922900427;161520;163651;164921;10330.173586113093;12317.199382040139;12460.501579936883;12551.874481255254;12646.620601381974;16271.186440677919;16272.593185170228;16308.429204977769;16323.510294691177;16363;8595.226429621363;8850.955745221232;8854.24738897201;8990.28077753778;9151.405158664666;7250.9637451812405;8323.95838020806;8326.6669333226;8432.831343373098;8585.871211931826;7586;7708.614569271514;7734.7679569613;7737.613119344011;7767.718326476068;2135.540858715384;2147.49533859546;2151.494398816308;2170.6852506386485;2346.7354003386813;826.3636999510344;922.5341202692597;924.5423515359805;967.2310513142069;972.5915115651302;17910.01494917766;18590;20988.055537500848;21040.684389734168;21059.26292579783;950.3822515365068;950.4392408479031;971.8542218667116;975.327024353194;988.4020167798523;10619.991100845407;10824.188185885932;12673.429695663533;13463.259520726455;13808.516701915385;731967;732749;735841;739888;749418;152328;153078.46921530642;153828.230858845;155473;159801;1196.4496331687346;1213.769383817072;1240.70223146446;1243.347242697591;1246.812978053281;20341.898290508452;21359.932003400078;21512.462188445414;21698.02358893822;21789.34631961044;62567.06149407671;63514.364856352695;63653.363466364746;63772.04341934968;64331.35668643441;62569;82022.58988705018;83285.16714833016;84707.5764621173;89108.40602894597;7863.803404914923;8605.311575073854;8820.426672266281;8934.73195804127;9001;11940.985016273367;12222.938885305517;13612;13648.863511365156;14046.719065618427;11705.765884682089;11737.530498780296;11754.647360579196;12096.637100886988;12103.334316612318;10617.256792024793;10716.035556799925;10766.515506802056;10837.620683276047;11080.445977701243;11713.531458741896;11880.168388212742;11911.106667000184;12114.0308775296;12190.146689731633;8551.828963420821;8707.216350528483;8764.824703506021;8818.603162857558;8832.116788321116;10313.504541841541;11666.824997624874;11822.467988940347;12005.459754310903;12072.215306005082 13:45:41 INFO - PID 1907 | |3;mootools.html;1357.2670757790793;1406.2125209882468;1422.9715405691893;1425.7433661940854;1452.1577485058663;10640.62757803477;10723.892761072388;10952.014318711324;11024.283421577591;11194.656641203057;10839.18706097042;10945.781084378308;10977.890221097787;10992.450377481135;11024.393658348788;2070.637638413272;2408.253441433157;2462.630605409194;2462.827602067847;2464.839785413951;2356.823238257129;2446.2538925627678;2458.176510868861;2461.126300163443;2464.7904928081134;2356.2106694257445;2440.8169387295934;2445;2452.754724527551;2468.5309791139625;2027.9353339496809;2362.7519110493495;2439.7316295207424;2441.231012231159;2444.0590372706456;2329.801966832821;2428.672129262545;2445.963310550343;2447.4126209709543;2449;10709.357438553712;10777.030067293981;10786.406747628876;10787.137029037658;10821.350718956888;5450;6176.258848938111;6339.619622822645;6392;6394.424501794861;3940.566537680853;3972.4041393791163;3976.4631774710333;4005.2790497710403;4070.1859628074208;1185.5317149725897;1546.8221154567257;1582.1535478518938;1595.210370866417;1651.2486818497675;13992.93003534986;14564.344604492824;15275.923620381938;15290.464833730766;15409.998350107318;5148.279240906276;5223.817166399233;5418.701971391532;5452.482014208644;5459.12653975362;11366.829497557543;11401.543938242377;11440.370779607201;11460.426978651034;11485.540578376771;6252.343503932113;6297.307296197415;6320.209973753281;6324.051392291193;6325.557210995186;5649.350324712628;5834.970825145932;5887.970560147171;5964.194833697482;6022.668753218528;4170.22850772608;4241.172971270573;4282.464691913511;4310.159518893848;4333.068390296102;1125.386664267976;1235.8877010690271;1252.4426630149678;1268.543324403214;1277.6997405609675;671.2750229751856;751.1286907187637;754.9547027178387;785.3363907498155;811.853866304071;4940.456549779521;5831.62094463867;5966.164736936832;6080.179175811209;6104.908426373608;457.66361724132736;561.147056474157;579.5045236322967;584.0625795598089;599.9880002400015;3882.165334453106;4006.238814625212;4080.449429216879;4154.4183814266025;4180.937285940713;13495.460181592627;14023.509177178954;14029.368678409495;14036.789448158286;14052.156870587798;13222.867771322164;13798.034137610472;13798.448062077605;13981.650458738613;13985.79021314681;10045.19638428924;10252.6411575596;10298.485075746183;10299;10332.53503592325;5477.643953143033;5713.06077480273;6330.746770129143;6487.643179624977;6751.72993080291;9737.756556086155;12544.372781361079;12559.874401256237;12590.307533085768;12608.306543140216;12153.635390938285;12536.247825130522;12548.121631485708;12575.811362829749;12730.554430594884;9044.909550904407;9080.137386948229;9142.177204051668;9163.908360916572;9228.446293222429;9948.45283509414;9957.502124893581;10183.643572475225;10188.541515631667;10191.337563058378;7046.541974771623;8403.49579025236;8447.66209351619;8583.828323433372;8674.956625216833;8178.977627796526;8234.176582341717;8293.170682931659;8308.916910831056;8354.997400312002;7636.770896873103;7669.923300767144;7700.961495192488;7709.267619576131;7711.730089446843;5436.483534064258;5793.507551857971;5960.940390596039;5966.582339236212;5986.281646202484;4983.878627308826;5173.706573356661;5767.452092051249;5922.111683247547;6099.75600975956 13:45:41 INFO - PID 1907 | |4;prototype.html;348.199141973461;404.45600667102735;407.26082160878;413.3324680640764;417.01792279182524;5039.798408063678;5945.554083443737;6527;6554;6572.737090516385;5185.922211166826;5378.8924221515545;6359.777407790728;6373.649449280288;6375.521835862306;4790.568848803616;4793.065352256312;4807.879803004917;4839.709617422948;4857.73282469464;4848.733319667417;4855.854324370257;4868.586170175539;4880.902381952359;4884.487128851472;4378.16814805186;4565.954340456603;4572.382728331682;4589.678722489427;4613.953860461403;4036.717429779931;4336.436263285768;4584;4586.3808385867815;4619.976900115512;3303.0256074458093;3947.5460322063045;3950.6839452843706;3964.801759911993;3970.344893092636;5308.8141915033175;5766.567507436959;6126.540509461808;6130.478909292671;6221.191245138149;5458.699771512565;5458.781648734046;5479.479449452296;5480.424555421663;5496.31296087989;4905.901881962376;6071.210742603434;6162.907556386658;6614.437772789319;6659;4415.013244040195;4442.955570444286;4447.444069491314;4452.1986042512335;4480.574345437179;5892.469677729025;6430.1385883281955;6931.514793964425;7117.964410177916;7153.856922861566;4432.82268709248;4485.318005747845;4571.177188106173;4577.267637178035;4578.6794924355645;4228.640565551901;4241.388272456446;4267.954351183917;4596.7931443085145;4608.677392582487;4749.978754567785;4894.510548945148;5240.5750878328945;5306.912083022971;5466.453354664502;5888.941110588839;6710.362515561014;6784.525083244224;6800.217974932847;6843.794686159423;1318.815365848782;1413.1591702936737;1439.9208043557705;1537.9926148372833;1590.840915908423;981.239539357004;991.3011327014437;1022.447878145793;1043.9321444106108;1050.2280823594651;6001.709632429049;6411.403381630447;6430.614163150226;6440.710168042449;6451.3548645135115;5583.804566840141;6035.1249068885645;6468.31047490575;6649.73401063952;7006.789796306119;6206.441420272197;6436.16329877113;6547.639879806561;6566.474682025427;6590.472762179014;3260.8043517389033;3654.4518322251874;3673.1918977824835;3679.6504332088407;3685.244524872395;6724.831879203059;6773.8983915241315;6871.5189936703955;7318.414526837841;7366.410687145016;5870.444332251956;5963.642181469039;6702.83242918931;7327.487075904742;7367.5579465231185;6452.419282264525;6997.895031574531;7016.789496315118;7265.782026539212;7321.595458112003;5737.282839645044;6194.783182588588;6881.41507971828;7074.9292507076325;7076.929230707627;6567;6903.723851045902;6925.706062241443;6961.89557156633;6961.965190174017;7070.787876363717;7174.282571742784;7322.157951835394;7338.926610733824;7376.926230737624;4164.042270277913;4533.501314855429;4544.159330523864;4561.224591819332;4565.6119229865835;6921.82695432598;7014.351627367462;7085.433165346657;7090.220075791555;7130.967674212824;6787.423069039187;6801.5247725581385;6815.556988795713;6839.863202735818;6840.726370945106;5766.106253530709;6599.571027883172;6785.6946437411425;6881.89677154833;6909;5265.815696450606;6626.204855417381;6653.600783952978;6692.431143352675;6693.732250710112;5546.760655933596;5724.79963201286;6711.362420570038;6862.245153033063;6868.866637005038;5792.333881603669;6045.314880967286;6517.804465866032;6638.734450622114;6661.833454163685 13:45:41 INFO - PID 1907 | |5;yui.html;719.33820884786;735.6064505489561;737.7565403416871;740.6629983357573;745.3329270303079;15601.531954041382;15918.52244432666;15922;15937.521874343774;15956;15010.174440405774;15105.395784168648;15133.016353936986;15149.394024239045;15169.620759481018;841.3689732700475;946.5693109635134;966.5698764050001;988.5255077562738;1019.0166489337788;751.9848204923337;915.8305713443001;1015.6242190389529;1034.974125646861;1039.991208527727;997.7555498902778;1084.1110289562562;1088.2382332367335;1089.199438412766;1092.9781404371909;1045.0855501436242;1072.1904961753864;1076.4832880217539;1076.6285631457135;1077.5959015369237;775.170567492783;785.3717026378931;801.8917446144754;804.4489524675616;807.6930766308824;16552.586185345343;16802.579935501588;16869;17011.914940425344;17156.828431715647;12387.19483233587;14814.925925370304;14865.777013344808;15072.321745521369;15658.25980453416;9803.31376803624;11387.316760994367;11563.479643415982;11894.643160705193;12055.397230138458;3012.653544842349;3055.2972816252163;3078.4304903592906;3140.0579826052094;3216.0512648768668;108606.3709044365;112720.43639781831;113606.43196783963;114869.70260594825;115846.99999999916;11181.440927953732;11431.428428578703;11484.483198256099;11499.252548584314;11848.466818993165;24284.514309713708;24554.754452455247;24912.750872491404;25010.749892501208;25011.62482562763;7800.375969922393;7832.82507623861;7958.880616790752;8005.519668819889;8011.325534609963;4085.55058943516;4096.897071660972;4100.282450571198;4179.226843034048;4184.14225083857;4086.4483294755423;4164.8334066637;4181.6236538711055;4228.090960443458;4230.598093181143;764.4495962906698;768.2125821033485;771.1979541277009;771.2942657468466;773.2615352338503;551.41274542612;554.8446434998126;564.94350564944;577.0507515137575;589.0839744197814;9697.806043879224;10082.24383171265;10090.394576325443;10166.4916754162;10242.692719218287;548.410458756838;576;580.1269090019578;602.1900543768625;606.2179788073424;4435.379046933432;4616.792244349012;4630.282306242538;4714.693544919569;4746.406699162605;102963;102982.48508757408;104189;105647.94352056534;109299.45350273357;56705.432945670014;69822;74256.88614670784;88668;91698;80191;81126.59436702897;81613;82231.5888420566;82734;9160.6793762218;10016.248781341574;10877.67366978992;10927.125829933746;10978.286411383235;35665.82167089252;36694;37379.81310093432;38784.2243155141;40162.79918600388;60491;61890;64377.678111609144;65863.67068164628;66902;13696;13741;13747.587572372844;14227.217503037018;14305.141691498127;14551.563453096423;14580.781288280896;14673.266336683337;14827;14945;13638.249896255802;13784.241866697428;13804.378802954092;14007.509737159558;14087.577372678836;13657.863421365659;13857.653558661113;13955.441782328593;14151.219342908229;14318.427262909367;13377.495353995751;13385.598432047054;13772.24252666073;14009.719805603627;14188.645283867985;8520.659173633234;8787.989381221241;9359.578818953027;9734.75663108428;10397.948010259901;8047.315978141924;9125.04187060349;10520.107560202774;11284.943575282072;11312.547498099984 13:45:41 INFO - PID 1907 | __end_tp_report 13:45:41 INFO - PID 1907 | __start_cc_report 13:45:41 INFO - PID 1907 | _x_x_mozilla_cycle_collect,443 13:45:41 INFO - PID 1907 | __end_cc_report 13:45:41 INFO - PID 1907 | __startTimestamp1490993141074__endTimestamp 13:45:41 INFO - PID 1907 | 13:45:41 INFO - PID 1907 | ------- Summary: start ------- 13:45:41 INFO - PID 1907 | Number of tests: 6 13:45:41 INFO - PID 1907 | 13:45:41 INFO - PID 1907 | [#0] dojo.html Cycles:165 Average:6164.45 Median:6380.84 stddev:754.34 (11.8%) stddev-sans-first:711.26 13:45:41 INFO - PID 1907 | Values: 2878.7 3522.8 3561.8 3563.6 3593.5 6140.4 6218.5 6247.4 6262.5 6280.5 6184.7 6201.5 6236.2 6244.6 6299.0 5378.5 5465.4 5493.3 5572.1 5607.2 5432.9 5506.4 5594.9 5626.4 5633.5 5558.2 5559.6 5575.4 5602.4 5627.9 5384.8 5462.3 5522.6 5533.9 5567.9 5443.7 5446.3 5449.6 5462.5 5482.4 5198.8 5924.4 6103.0 6234.4 6247.5 6499.9 6631.2 6677.7 6688.6 6725.9 5655.9 6825.2 6830.8 6832.0 6834.0 6188.7 6358.0 6362.5 6362.6 6365.1 6813.3 6904.8 6943.8 6968.3 6971.9 6389.2 6526.8 6545.8 6561.0 6623.5 6653.2 6755.9 6875.6 6875.8 6879.5 6440.0 6698.5 6728.3 6742.2 6750.1 5508.4 6432.7 6483.6 6542.1 6598.0 5376.2 5380.3 5382.8 5384.9 5435.9 4756.1 4762.7 4774.5 4791.6 4792.1 6200.8 6278.1 6351.0 6357.6 6384.5 6719.2 6802.8 6813.1 6820.2 6843.9 4730.7 5277.9 6192.0 6340.5 6380.8 5766.7 5959.5 5962.8 5965.8 5984.3 6842.3 6843.2 6903.6 6969.5 7023.1 6793.8 6796.4 6817.6 6822.6 6833.9 6942.4 6984.4 7039.5 7043.0 7045.2 6439.9 6531.1 6578.9 6619.6 6699.4 6674.6 6732.1 6795.4 6802.6 6803.7 6260.1 6332.0 6500.4 6531.5 6569.1 6568.0 6569.1 6585.7 6586.5 6595.8 6248.2 6262.9 6294.8 6364.8 6438.2 5360.8 6542.8 6579.3 6589.2 6623.3 6422.2 6438.2 6440.3 6447.5 6453.1 13:45:41 INFO - PID 1907 | 13:45:41 INFO - PID 1907 | [#1] ext.html Cycles:180 Average:54184.21 Median:34585.48 stddev:110994.12 (320.9%) stddev-sans-first:111232.90 13:45:41 INFO - PID 1907 | Values: 719.6 1116.4 1119.9 1276.0 1285.5 30353.7 39134.8 39201.6 39259.0 39274.0 37994.2 38274.0 38375.0 38436.4 38538.2 8051.6 8581.4 8768.3 8798.3 8808.2 8722.3 8746.8 8832.9 8834.9 8836.2 8808.3 8812.0 8812.5 8859.3 8900.4 8752.6 8823.8 8845.5 8850.8 8870.2 8652.2 8697.7 8711.6 8717.0 8739.6 39016.0 39034.2 39054.8 39242.8 39358.6 3087.9 3094.3 3117.3 3134.9 3206.5 28277.6 28286.7 28314.6 28727.4 29051.9 2775.7 2824.5 2831.4 2893.8 2902.2 286124.0 309648.0 313194.0 319357.8 322858.0 40660.6 41659.4 49211.0 50230.5 50294.0 51960.0 51965.0 51965.0 51969.5 51977.7 14418.0 14556.3 14565.0 14571.7 14572.9 8866.0 9894.3 11729.6 11790.1 11944.3 13540.8 13594.3 13664.2 13744.2 13804.0 5051.6 6006.4 6022.9 6035.2 6036.3 983.3 991.6 993.4 1000.9 1038.2 20588.2 22109.3 24759.6 24763.6 24959.3 1089.9 1090.8 1111.8 1113.1 1135.8 11122.0 11915.8 12223.7 12709.9 12954.4 467030.0 470969.0 471209.8 471753.0 471867.0 56670.0 56990.4 57306.0 57452.0 57521.0 1458.7 1487.0 1521.1 1524.9 1535.6 23998.3 24261.0 24406.0 24408.0 24503.3 33572.7 39119.6 39427.6 39443.4 39504.0 450725.0 452222.0 452490.0 452976.0 453021.0 26733.6 27313.5 32771.7 33324.2 33492.3 41462.0 42726.6 42851.7 43468.0 43513.3 25114.0 26127.7 29071.1 29746.0 30148.5 27917.9 28943.3 29674.7 29736.9 29783.4 35598.3 35689.8 35724.7 35833.5 37428.6 30051.2 30726.0 31450.0 31590.0 31629.0 20343.0 21203.9 24375.4 24722.9 24933.9 13:45:41 INFO - PID 1907 | 13:45:41 INFO - PID 1907 | [#2] jquery.html Cycles:180 Average:41947.36 Median:23189.36 stddev:123541.18 (532.7%) stddev-sans-first:123848.36 13:45:41 INFO - PID 1907 | Values: 401.7 421.9 424.4 427.2 451.8 21673.2 21933.0 22576.7 22940.0 23260.4 22385.7 22557.0 23118.3 23335.8 23436.0 6158.0 6242.0 6405.7 6406.8 6415.6 6099.8 6248.6 6315.1 6330.3 6338.7 6195.7 6207.8 6247.4 6260.6 6295.3 6087.2 6284.4 6288.2 6303.2 6309.5 5331.4 5476.7 5517.1 5533.4 5587.7 26874.0 27028.3 27213.0 27294.9 27670.4 1768.5 2021.3 2039.4 2049.6 2081.0 15832.5 16574.1 16616.8 16733.5 17215.7 1882.7 1891.6 1893.1 1893.3 1919.5 152213.0 160154.2 161520.0 163651.0 164921.0 10330.2 12317.2 12460.5 12551.9 12646.6 16271.2 16272.6 16308.4 16323.5 16363.0 8595.2 8851.0 8854.2 8990.3 9151.4 7251.0 8324.0 8326.7 8432.8 8585.9 7586.0 7708.6 7734.8 7737.6 7767.7 2135.5 2147.5 2151.5 2170.7 2346.7 826.4 922.5 924.5 967.2 972.6 17910.0 18590.0 20988.1 21040.7 21059.3 950.4 950.4 971.9 975.3 988.4 10620.0 10824.2 12673.4 13463.3 13808.5 731967.0 732749.0 735841.0 739888.0 749418.0 152328.0 153078.5 153828.2 155473.0 159801.0 1196.4 1213.8 1240.7 1243.3 1246.8 20341.9 21359.9 21512.5 21698.0 21789.3 62567.1 63514.4 63653.4 63772.0 64331.4 62569.0 82022.6 83285.2 84707.6 89108.4 7863.8 8605.3 8820.4 8934.7 9001.0 11941.0 12222.9 13612.0 13648.9 14046.7 11705.8 11737.5 11754.6 12096.6 12103.3 10617.3 10716.0 10766.5 10837.6 11080.4 11713.5 11880.2 11911.1 12114.0 12190.1 8551.8 8707.2 8764.8 8818.6 8832.1 10313.5 11666.8 11822.5 12005.5 12072.2 13:45:41 INFO - PID 1907 | 13:45:41 INFO - PID 1907 | [#3] mootools.html Cycles:180 Average:6712.77 Median:2466.69 stddev:4166.93 (168.9%) stddev-sans-first:4159.18 13:45:41 INFO - PID 1907 | Values: 1357.3 1406.2 1423.0 1425.7 1452.2 10640.6 10723.9 10952.0 11024.3 11194.7 10839.2 10945.8 10977.9 10992.5 11024.4 2070.6 2408.3 2462.6 2462.8 2464.8 2356.8 2446.3 2458.2 2461.1 2464.8 2356.2 2440.8 2445.0 2452.8 2468.5 2027.9 2362.8 2439.7 2441.2 2444.1 2329.8 2428.7 2446.0 2447.4 2449.0 10709.4 10777.0 10786.4 10787.1 10821.4 5450.0 6176.3 6339.6 6392.0 6394.4 3940.6 3972.4 3976.5 4005.3 4070.2 1185.5 1546.8 1582.2 1595.2 1651.2 13992.9 14564.3 15275.9 15290.5 15410.0 5148.3 5223.8 5418.7 5452.5 5459.1 11366.8 11401.5 11440.4 11460.4 11485.5 6252.3 6297.3 6320.2 6324.1 6325.6 5649.4 5835.0 5888.0 5964.2 6022.7 4170.2 4241.2 4282.5 4310.2 4333.1 1125.4 1235.9 1252.4 1268.5 1277.7 671.3 751.1 755.0 785.3 811.9 4940.5 5831.6 5966.2 6080.2 6104.9 457.7 561.1 579.5 584.1 600.0 3882.2 4006.2 4080.4 4154.4 4180.9 13495.5 14023.5 14029.4 14036.8 14052.2 13222.9 13798.0 13798.4 13981.7 13985.8 10045.2 10252.6 10298.5 10299.0 10332.5 5477.6 5713.1 6330.7 6487.6 6751.7 9737.8 12544.4 12559.9 12590.3 12608.3 12153.6 12536.2 12548.1 12575.8 12730.6 9044.9 9080.1 9142.2 9163.9 9228.4 9948.5 9957.5 10183.6 10188.5 10191.3 7046.5 8403.5 8447.7 8583.8 8675.0 8179.0 8234.2 8293.2 8308.9 8355.0 7636.8 7669.9 7701.0 7709.3 7711.7 5436.5 5793.5 5960.9 5966.6 5986.3 4983.9 5173.7 5767.5 5922.1 6099.8 13:45:41 INFO - PID 1907 | 13:45:41 INFO - PID 1907 | [#4] prototype.html Cycles:180 Average:5411.95 Median:5982.68 stddev:1717.81 (28.7%) stddev-sans-first:1680.06 13:45:41 INFO - PID 1907 | Values: 348.2 404.5 407.3 413.3 417.0 5039.8 5945.6 6527.0 6554.0 6572.7 5185.9 5378.9 6359.8 6373.6 6375.5 4790.6 4793.1 4807.9 4839.7 4857.7 4848.7 4855.9 4868.6 4880.9 4884.5 4378.2 4566.0 4572.4 4589.7 4614.0 4036.7 4336.4 4584.0 4586.4 4620.0 3303.0 3947.5 3950.7 3964.8 3970.3 5308.8 5766.6 6126.5 6130.5 6221.2 5458.7 5458.8 5479.5 5480.4 5496.3 4905.9 6071.2 6162.9 6614.4 6659.0 4415.0 4443.0 4447.4 4452.2 4480.6 5892.5 6430.1 6931.5 7118.0 7153.9 4432.8 4485.3 4571.2 4577.3 4578.7 4228.6 4241.4 4268.0 4596.8 4608.7 4750.0 4894.5 5240.6 5306.9 5466.5 5888.9 6710.4 6784.5 6800.2 6843.8 1318.8 1413.2 1439.9 1538.0 1590.8 981.2 991.3 1022.4 1043.9 1050.2 6001.7 6411.4 6430.6 6440.7 6451.4 5583.8 6035.1 6468.3 6649.7 7006.8 6206.4 6436.2 6547.6 6566.5 6590.5 3260.8 3654.5 3673.2 3679.7 3685.2 6724.8 6773.9 6871.5 7318.4 7366.4 5870.4 5963.6 6702.8 7327.5 7367.6 6452.4 6997.9 7016.8 7265.8 7321.6 5737.3 6194.8 6881.4 7074.9 7076.9 6567.0 6903.7 6925.7 6961.9 6962.0 7070.8 7174.3 7322.2 7338.9 7376.9 4164.0 4533.5 4544.2 4561.2 4565.6 6921.8 7014.4 7085.4 7090.2 7131.0 6787.4 6801.5 6815.6 6839.9 6840.7 5766.1 6599.6 6785.7 6881.9 6909.0 5265.8 6626.2 6653.6 6692.4 6693.7 5546.8 5724.8 6711.4 6862.2 6868.9 5792.3 6045.3 6517.8 6638.7 6661.8 13:45:41 INFO - PID 1907 | 13:45:41 INFO - PID 1907 | [#5] yui.html Cycles:180 Average:20254.97 Median:24733.75 stddev:29232.46 (118.2%) stddev-sans-first:29277.66 13:45:41 INFO - PID 1907 | Values: 719.3 735.6 737.8 740.7 745.3 15601.5 15918.5 15922.0 15937.5 15956.0 15010.2 15105.4 15133.0 15149.4 15169.6 841.4 946.6 966.6 988.5 1019.0 752.0 915.8 1015.6 1035.0 1040.0 997.8 1084.1 1088.2 1089.2 1093.0 1045.1 1072.2 1076.5 1076.6 1077.6 775.2 785.4 801.9 804.4 807.7 16552.6 16802.6 16869.0 17011.9 17156.8 12387.2 14814.9 14865.8 15072.3 15658.3 9803.3 11387.3 11563.5 11894.6 12055.4 3012.7 3055.3 3078.4 3140.1 3216.1 108606.4 112720.4 113606.4 114869.7 115847.0 11181.4 11431.4 11484.5 11499.3 11848.5 24284.5 24554.8 24912.8 25010.7 25011.6 7800.4 7832.8 7958.9 8005.5 8011.3 4085.6 4096.9 4100.3 4179.2 4184.1 4086.4 4164.8 4181.6 4228.1 4230.6 764.4 768.2 771.2 771.3 773.3 551.4 554.8 564.9 577.1 589.1 9697.8 10082.2 10090.4 10166.5 10242.7 548.4 576.0 580.1 602.2 606.2 4435.4 4616.8 4630.3 4714.7 4746.4 102963.0 102982.5 104189.0 105647.9 109299.5 56705.4 69822.0 74256.9 88668.0 91698.0 80191.0 81126.6 81613.0 82231.6 82734.0 9160.7 10016.2 10877.7 10927.1 10978.3 35665.8 36694.0 37379.8 38784.2 40162.8 60491.0 61890.0 64377.7 65863.7 66902.0 13696.0 13741.0 13747.6 14227.2 14305.1 14551.6 14580.8 14673.3 14827.0 14945.0 13638.2 13784.2 13804.4 14007.5 14087.6 13657.9 13857.7 13955.4 14151.2 14318.4 13377.5 13385.6 13772.2 14009.7 14188.6 8520.7 8788.0 9359.6 9734.8 10397.9 8047.3 9125.0 10520.1 11284.9 11312.5 13:45:41 INFO - PID 1907 | -------- Summary: end -------- 13:45:41 INFO - PID 1907 | 13:45:41 INFO - TEST-INFO | 1907: exit 0 13:45:41 INFO - TEST-OK | dromaeo_css | took 1116752ms 13:45:41 INFO - TEST-START | kraken 13:45:41 INFO - operating with platform_type : mac_ 13:45:41 INFO - Initialising browser for kraken test... 13:45:41 INFO - TEST-INFO | started process 1913 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/tmpw3iUUI/profile http://localhost:49705/getInfo.html) 13:45:44 INFO - PID 1913 | 2017-03-31 13:45:44.637 plugin-container[1914:12959] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b43, name = 'com.apple.tsm.portname' 13:45:44 INFO - PID 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:45:44 INFO - PID 1913 | 2017-03-31 13:45:44.643 plugin-container[1914:12959] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0b, name = 'com.apple.CFPasteboardClient' 13:45:44 INFO - PID 1913 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:45:44 INFO - PID 1913 | 2017-03-31 13:45:44.643 plugin-container[1914:12959] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:45:44 INFO - PID 1913 | __metrics Screen width/height:1600/1200 13:45:44 INFO - PID 1913 | colorDepth:24 13:45:44 INFO - PID 1913 | Browser inner width/height: 1024/689 13:45:44 INFO - PID 1913 | __metrics 13:45:44 ERROR - PID 1913 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3396: TypeError: this.tabs is undefined 13:45:45 INFO - TEST-INFO | 1913: exit 0 13:45:45 INFO - Browser initialized. 13:45:45 INFO - Running cycle 1/1 for kraken test... 13:45:45 INFO - TEST-INFO | started process 1915 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/T/tmpw3iUUI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:48 INFO - PID 1915 | 2017-03-31 13:45:48.060 plugin-container[1916:13082] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 13:45:48 INFO - PID 1915 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:45:48 INFO - PID 1915 | 2017-03-31 13:45:48.060 plugin-container[1916:13082] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x434b, name = 'com.apple.CFPasteboardClient' 13:45:48 INFO - PID 1915 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:45:48 INFO - PID 1915 | 2017-03-31 13:45:48.060 plugin-container[1916:13082] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:45:57 INFO - PID 1915 | RSS: Main: 230219776 13:45:57 INFO - PID 1915 | 13:46:00 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49705/tests/kraken/driver.html?testName=audio-beat-detection) 13:46:01 INFO - PID 1915 | RSS: Main: 245231616 13:46:01 INFO - PID 1915 | 13:46:04 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49705/tests/kraken/driver.html?testName=audio-dft) 13:46:05 INFO - PID 1915 | RSS: Main: 253739008 13:46:05 INFO - PID 1915 | 13:46:08 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49705/tests/kraken/driver.html?testName=audio-fft) 13:46:09 INFO - PID 1915 | RSS: Main: 255987712 13:46:09 INFO - PID 1915 | 13:46:11 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49705/tests/kraken/driver.html?testName=audio-oscillator) 13:46:11 INFO - PID 1915 | RSS: Main: 258039808 13:46:11 INFO - PID 1915 | 13:46:13 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49705/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:46:14 INFO - PID 1915 | RSS: Main: 258523136 13:46:14 INFO - PID 1915 | 13:46:17 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49705/tests/kraken/driver.html?testName=imaging-darkroom) 13:46:18 INFO - PID 1915 | RSS: Main: 264540160 13:46:18 INFO - PID 1915 | 13:46:21 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49705/tests/kraken/driver.html?testName=imaging-desaturate) 13:46:21 INFO - PID 1915 | RSS: Main: 265134080 13:46:21 INFO - PID 1915 | 13:46:25 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49705/tests/kraken/driver.html?testName=json-parse-financial) 13:46:25 INFO - PID 1915 | RSS: Main: 264970240 13:46:25 INFO - PID 1915 | 13:46:27 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49705/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:46:28 INFO - PID 1915 | RSS: Main: 264249344 13:46:28 INFO - PID 1915 | 13:46:30 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:46:30 INFO - PID 1915 | RSS: Main: 264278016 13:46:30 INFO - PID 1915 | 13:46:32 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:46:33 INFO - PID 1915 | RSS: Main: 264515584 13:46:33 INFO - PID 1915 | 13:46:36 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:46:37 INFO - PID 1915 | RSS: Main: 264716288 13:46:37 INFO - PID 1915 | 13:46:40 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:46:41 INFO - PID 1915 | RSS: Main: 270073856 13:46:41 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | Cycle 1(1): loaded http://localhost:49705/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49705/tests/kraken/driver.html?testName=ai-astar) 13:46:43 INFO - PID 1915 | RSS: Main: 272678912 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | __start_tp_report 13:46:43 INFO - PID 1915 | _x_x_mozilla_page_load 13:46:43 INFO - PID 1915 | _x_x_mozilla_page_load_details 13:46:43 INFO - PID 1915 | |i|pagename|runs| 13:46:43 INFO - PID 1915 | |0;ai-astar;148;182;137;123;127;176;187;123;122;123 13:46:43 INFO - PID 1915 | |1;audio-beat-detection;153;106;115;156;122;118;118;118;138;115 13:46:43 INFO - PID 1915 | |2;audio-dft;231;218;229;222;238;209;209;215;211;211 13:46:43 INFO - PID 1915 | |3;audio-fft;86;61;62;92;91;66;87;79;73;57 13:46:43 INFO - PID 1915 | |4;audio-oscillator;88;71;89;75;72;75;85;72;71;86 13:46:43 INFO - PID 1915 | |5;imaging-gaussian-blur;92;91;92;101;91;91;99;90;90;98 13:46:43 INFO - PID 1915 | |6;imaging-darkroom;99;99;99;99;100;100;99;103;98;101 13:46:43 INFO - PID 1915 | |7;imaging-desaturate;100;107;115;164;156;104;106;102;108;103 13:46:43 INFO - PID 1915 | |8;json-parse-financial;50;51;51;52;52;52;62;67;82;84 13:46:43 INFO - PID 1915 | |9;json-stringify-tinderbox;51;49;57;75;97;95;87;88;58;60 13:46:43 INFO - PID 1915 | |10;stanford-crypto-aes;103;89;86;81;87;87;89;89;90;88 13:46:43 INFO - PID 1915 | |11;stanford-crypto-ccm;149;166;149;145;166;166;169;154;204;171 13:46:43 INFO - PID 1915 | |12;stanford-crypto-pbkdf2;199;249;255;203;195;200;187;198;253;247 13:46:43 INFO - PID 1915 | |13;stanford-crypto-sha256-iterative;103;98;76;72;71;77;100;70;79;65 13:46:43 INFO - PID 1915 | __end_tp_report 13:46:43 INFO - PID 1915 | __start_cc_report 13:46:43 INFO - PID 1915 | _x_x_mozilla_cycle_collect,1045 13:46:43 INFO - PID 1915 | __end_cc_report 13:46:43 INFO - PID 1915 | __startTimestamp1490993203655__endTimestamp 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | ------- Summary: start ------- 13:46:43 INFO - PID 1915 | Number of tests: 14 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#0] ai-astar Cycles:10 Average:144.80 Median:142.50 stddev:26.82 (18.8%) stddev-sans-first:28.42 13:46:43 INFO - PID 1915 | Values: 148.0 182.0 137.0 123.0 127.0 176.0 187.0 123.0 122.0 123.0 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#1] audio-beat-detection Cycles:10 Average:125.90 Median:120.00 stddev:17.07 (14.2%) stddev-sans-first:15.03 13:46:43 INFO - PID 1915 | Values: 153.0 106.0 115.0 156.0 122.0 118.0 118.0 118.0 138.0 115.0 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#2] audio-dft Cycles:10 Average:219.30 Median:220.00 stddev:10.32 (4.7%) stddev-sans-first:10.04 13:46:43 INFO - PID 1915 | Values: 231.0 218.0 229.0 222.0 238.0 209.0 209.0 215.0 211.0 211.0 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#3] audio-fft Cycles:10 Average:75.40 Median:82.50 stddev:13.33 (16.2%) stddev-sans-first:13.57 13:46:43 INFO - PID 1915 | Values: 86.0 61.0 62.0 92.0 91.0 66.0 87.0 79.0 73.0 57.0 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#4] audio-oscillator Cycles:10 Average:78.40 Median:80.00 stddev:7.60 (9.5%) stddev-sans-first:7.23 13:46:43 INFO - PID 1915 | Values: 88.0 71.0 89.0 75.0 72.0 75.0 85.0 72.0 71.0 86.0 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#5] imaging-gaussian-blur Cycles:10 Average:93.50 Median:91.50 stddev:4.14 (4.5%) stddev-sans-first:4.36 13:46:43 INFO - PID 1915 | Values: 92.0 91.0 92.0 101.0 91.0 91.0 99.0 90.0 90.0 98.0 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#6] imaging-darkroom Cycles:10 Average:99.70 Median:99.00 stddev:1.42 (1.4%) stddev-sans-first:1.48 13:46:43 INFO - PID 1915 | Values: 99.0 99.0 99.0 99.0 100.0 100.0 99.0 103.0 98.0 101.0 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#7] imaging-desaturate Cycles:10 Average:116.50 Median:107.50 stddev:23.36 (21.7%) stddev-sans-first:24.01 13:46:43 INFO - PID 1915 | Values: 100.0 107.0 115.0 164.0 156.0 104.0 106.0 102.0 108.0 103.0 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:57.00 stddev:13.19 (23.1%) stddev-sans-first:13.45 13:46:43 INFO - PID 1915 | Values: 50.0 51.0 51.0 52.0 52.0 52.0 62.0 67.0 82.0 84.0 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#9] json-stringify-tinderbox Cycles:10 Average:71.70 Median:81.00 stddev:18.79 (23.2%) stddev-sans-first:18.38 13:46:43 INFO - PID 1915 | Values: 51.0 49.0 57.0 75.0 97.0 95.0 87.0 88.0 58.0 60.0 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:88.50 stddev:5.57 (6.3%) stddev-sans-first:2.69 13:46:43 INFO - PID 1915 | Values: 103.0 89.0 86.0 81.0 87.0 87.0 89.0 89.0 90.0 88.0 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#11] stanford-crypto-ccm Cycles:10 Average:163.90 Median:166.00 stddev:16.99 (10.2%) stddev-sans-first:17.14 13:46:43 INFO - PID 1915 | Values: 149.0 166.0 149.0 145.0 166.0 166.0 169.0 154.0 204.0 171.0 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:218.60 Median:225.00 stddev:28.27 (12.6%) stddev-sans-first:29.08 13:46:43 INFO - PID 1915 | Values: 199.0 249.0 255.0 203.0 195.0 200.0 187.0 198.0 253.0 247.0 13:46:43 INFO - PID 1915 | 13:46:43 INFO - PID 1915 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.10 Median:74.00 stddev:13.89 (18.8%) stddev-sans-first:12.27 13:46:43 INFO - PID 1915 | Values: 103.0 98.0 76.0 72.0 71.0 77.0 100.0 70.0 79.0 65.0 13:46:43 INFO - PID 1915 | -------- Summary: end -------- 13:46:43 INFO - PID 1915 | 13:46:44 INFO - TEST-INFO | 1915: exit 0 13:46:44 INFO - TEST-OK | kraken | took 62837ms 13:46:44 INFO - SUITE-END | took 1179s 13:46:44 INFO - Completed test suite (00:19:39) 13:46:44 INFO - javascript benchmark 13:46:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7755.599246254076, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2878.7265209805073, 3522.823858807059, 3561.7506774525796, 3563.590187128481, 3593.5148754918087, 6140.35526269742, 6218.4714299284615, 6247.437730604244, 6262.467690246329, 6280.528960327971, 6184.69076546172, 6201.503879689614, 6236.220472440945, 6244.56288059836, 6299.0, 5378.542823859977, 5465.398806131322, 5493.285872836525, 5572.080606699889, 5607.243022191993, 5432.891342173174, 5506.394296627388, 5594.944050559503, 5626.381098079208, 5633.464820842013, 5558.176608181325, 5559.58303127265, 5575.414581468928, 5602.355729091146, 5627.943720562804, 5384.757685904144, 5462.317210348707, 5522.5581953443625, 5533.893221355705, 5567.944320556823, 5443.673379597197, 5446.346438427375, 5449.618526703132, 5462.481064298885, 5482.424345443751, 5198.844034678966, 5924.377940316248, 6103.004334463713, 6234.376562343729, 6247.500199983991, 6499.902501462482, 6631.171103612049, 6677.732890684367, 6688.565243259172, 6725.865482690368, 5655.915161272585, 6825.1809782825885, 6830.829229269259, 6832.043513908056, 6834.0, 6188.659623720649, 6358.046293056079, 6362.491000719885, 6362.586431881913, 6365.077063825812, 6813.284605116491, 6904.758333458405, 6943.756968506078, 6968.338007889242, 6971.930280697229, 6389.233292004989, 6526.771562995273, 6545.803625891231, 6561.0, 6623.503237257225, 6653.168353955755, 6755.93244067553, 6875.5874647521305, 6875.7937261882225, 6879.484038697117, 6439.967800160969, 6698.4641228701585, 6728.259891411941, 6742.224644165984, 6750.054992301082, 5508.366537848118, 6432.71052802625, 6483.610983341015, 6542.051402546699, 6598.0, 5376.166694162411, 5380.3274590676165, 5382.757775900094, 5384.946150538444, 5435.945640543544, 4756.120117778222, 4762.714237145713, 4774.474807771142, 4791.568758811654, 4792.137415265286, 6200.844978875474, 6278.121063051177, 6351.0, 6357.586756860789, 6384.48924086072, 6719.193696756421, 6802.829929251809, 6813.080234168324, 6820.215675197316, 6843.863122737517, 4730.692504987165, 5277.868053298698, 6191.9690401547705, 6340.492760579143, 6380.84047898797, 5766.740496677659, 5959.463648271676, 5962.821115366546, 5965.791197308074, 5984.281886173687, 6842.281560436082, 6843.247242803288, 6903.551269167488, 6969.54697944632, 7023.086998690138, 6793.762218322335, 6796.422304104207, 6817.625030623363, 6822.624755638289, 6833.897491537531, 6942.375186233263, 6984.371406573433, 7039.54242974205, 7043.0, 7045.1898031727005, 6439.935600643934, 6531.052997315268, 6578.934210657832, 6619.569727967667, 6699.39705426514, 6674.632895190617, 6732.091167692494, 6795.38841504267, 6802.591844489347, 6803.727850885909, 6260.092286618506, 6331.96834015827, 6500.414962653384, 6531.510136739668, 6569.080328754074, 6567.9671601641685, 6569.113169722026, 6585.670716464062, 6586.50601204902, 6595.835104122435, 6248.156498872594, 6262.906056409066, 6294.779682711083, 6364.840878978062, 6438.195225596801, 5360.785568577213, 6542.803715888531, 6579.276279609144, 6589.209294884645, 6623.271440141677, 6422.165118534561, 6438.227412710505, 6440.29156792743, 6447.548671593131, 6453.09656648079], "value": 6113.264000027549, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.5538765965101, 1116.3692513729743, 1119.9160062995277, 1275.9744805103892, 1285.5307812648387, 30353.69646303539, 39134.8043259784, 39201.60798392022, 39259.0, 39273.99999999996, 37994.24011519768, 38274.04314892129, 38375.0, 38436.42345364822, 38538.229235415274, 8051.6376763045655, 8581.442206256605, 8768.34237432192, 8798.252148567379, 8808.163224493695, 8722.30221582272, 8746.781330466758, 8832.911670883273, 8834.86747698785, 8836.160564746371, 8808.295336373107, 8811.95594022029, 8812.471251724884, 8859.29125669945, 8900.37697361185, 8752.56237188138, 8823.823523529525, 8845.469271843709, 8850.822983540293, 8870.246029087535, 8652.22130008296, 8697.739067827912, 8711.607977640959, 8716.997545282311, 8739.60671769772, 39016.0, 39034.169020421316, 39054.80472597647, 39242.80378598089, 39358.606413935784, 3087.8919237826567, 3094.3347180356104, 3117.329774098557, 3134.8902788402524, 3206.486962086055, 28277.57583636247, 28286.72516840924, 28314.575281370795, 28727.42545149106, 29051.854740726372, 2775.722427757228, 2824.5339518979345, 2831.447867665806, 2893.788844463791, 2902.201894479014, 286124.0, 309648.0, 313194.0, 319357.8064219375, 322858.0, 40660.59339406627, 41659.37510937338, 49211.0, 50230.49769502331, 50294.0, 51960.0, 51965.0, 51965.0, 51969.48030519646, 51977.74011129996, 14418.0, 14556.272186390637, 14564.980451368303, 14571.708565828623, 14572.854271457361, 8865.955670221607, 9894.307398482037, 11729.589464368706, 11790.056795456343, 11944.343061131722, 13540.796888046687, 13594.32028398576, 13664.248466334448, 13744.175349479063, 13804.03371763987, 5051.621128415383, 6006.429389208019, 6022.945984452791, 6035.155078289043, 6036.305824830113, 983.2625530851861, 991.633095754561, 993.4337427666305, 1000.9099181073739, 1038.2265212416646, 20588.176472940915, 22109.33671989843, 24759.62860557093, 24763.62854557183, 24959.251222463354, 1089.9019088282093, 1090.8219123346767, 1111.8048098294366, 1113.1428799824253, 1135.7501349703052, 11121.999020088231, 11915.761684766256, 12223.69440763988, 12709.93645031769, 12954.417051232716, 467030.0, 470969.0, 471209.79555920063, 471753.0, 471867.0, 56670.0, 56990.43009569934, 57306.0, 57452.0, 57521.0, 1458.7301349250422, 1486.9776953345493, 1521.1481570320657, 1524.8932574719663, 1535.5930678370241, 23998.28605024267, 24261.029558818154, 24406.02375904944, 24408.0, 24503.264902052968, 33572.66427335695, 39119.60880391159, 39427.60572394354, 39443.40834887536, 39504.0, 450725.0, 452222.0, 452490.0, 452976.0, 453021.0, 26733.598996014687, 27313.453730925667, 32771.672283276865, 33324.166895827795, 33492.311076449805, 41462.0, 42726.57273427226, 42851.71444856659, 43468.0, 43513.34729979116, 25114.0, 26127.738722612532, 29071.12786616405, 29745.958891438695, 30148.547771783004, 27917.860410697816, 28943.276418088873, 29674.703252967192, 29736.85131574415, 29783.404331913673, 35598.28803423969, 35689.82155089312, 35724.749633762694, 35833.46249806203, 37428.62571374251, 30051.24871878133, 30726.0, 31450.0, 31590.0, 31629.0, 20343.0, 21203.939803010097, 24375.390615234763, 24722.876385617958, 24933.875330623232], "value": 17851.81389102607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.7228112602304, 421.88609075549624, 424.38676113016686, 427.16062936330104, 451.7869520337891, 21673.241436549724, 21933.01301441435, 22576.661350079743, 22940.0, 23260.41848953777, 22385.664215036788, 22557.0, 23118.306450806504, 23335.833208339558, 23436.0, 6158.0, 6241.968790156055, 6405.743770249184, 6406.807795766111, 6415.6471394073305, 6099.7865074722395, 6248.625082495065, 6315.115883776275, 6330.27201871786, 6338.683065846712, 6195.6902154892305, 6207.782727604535, 6247.375262473762, 6260.624362538239, 6295.338989406115, 6087.178230938811, 6284.371562843725, 6288.182536270256, 6303.180586523746, 6309.495240380758, 5331.440198779111, 5476.6713997159895, 5517.144842549411, 5533.418991005967, 5587.7485513152005, 26874.0, 27028.324291892663, 27213.047543336088, 27294.863525682442, 27670.446591068267, 1768.45177994822, 2021.2622392826659, 2039.4391542325832, 2049.559344740888, 2081.002237851664, 15832.525024249291, 16574.08842513661, 16616.750748738777, 16733.497995060166, 17215.741763873553, 1882.7081802320663, 1891.5743957609427, 1893.1007771308655, 1893.2521653946615, 1919.4913347962802, 152213.0, 160154.19922900427, 161520.0, 163651.0, 164921.0, 10330.173586113093, 12317.199382040139, 12460.501579936883, 12551.874481255254, 12646.620601381974, 16271.186440677919, 16272.593185170228, 16308.429204977769, 16323.510294691177, 16363.0, 8595.226429621363, 8850.955745221232, 8854.24738897201, 8990.28077753778, 9151.405158664666, 7250.9637451812405, 8323.95838020806, 8326.6669333226, 8432.831343373098, 8585.871211931826, 7586.0, 7708.614569271514, 7734.7679569613, 7737.613119344011, 7767.718326476068, 2135.540858715384, 2147.49533859546, 2151.494398816308, 2170.6852506386485, 2346.7354003386813, 826.3636999510344, 922.5341202692597, 924.5423515359805, 967.2310513142069, 972.5915115651302, 17910.01494917766, 18590.0, 20988.055537500848, 21040.684389734168, 21059.26292579783, 950.3822515365068, 950.4392408479031, 971.8542218667116, 975.327024353194, 988.4020167798523, 10619.991100845407, 10824.188185885932, 12673.429695663533, 13463.259520726455, 13808.516701915385, 731967.0, 732749.0, 735841.0, 739888.0, 749418.0, 152328.0, 153078.46921530642, 153828.230858845, 155473.0, 159801.0, 1196.4496331687346, 1213.769383817072, 1240.70223146446, 1243.347242697591, 1246.812978053281, 20341.898290508452, 21359.932003400078, 21512.462188445414, 21698.02358893822, 21789.34631961044, 62567.06149407671, 63514.364856352695, 63653.363466364746, 63772.04341934968, 64331.35668643441, 62569.0, 82022.58988705018, 83285.16714833016, 84707.5764621173, 89108.40602894597, 7863.803404914923, 8605.311575073854, 8820.426672266281, 8934.73195804127, 9001.0, 11940.985016273367, 12222.938885305517, 13612.0, 13648.863511365156, 14046.719065618427, 11705.765884682089, 11737.530498780296, 11754.647360579196, 12096.637100886988, 12103.334316612318, 10617.256792024793, 10716.035556799925, 10766.515506802056, 10837.620683276047, 11080.445977701243, 11713.531458741896, 11880.168388212742, 11911.106667000184, 12114.0308775296, 12190.146689731633, 8551.828963420821, 8707.216350528483, 8764.824703506021, 8818.603162857558, 8832.116788321116, 10313.504541841541, 11666.824997624874, 11822.467988940347, 12005.459754310903, 12072.215306005082], "value": 10566.886291284492, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.2670757790793, 1406.2125209882468, 1422.9715405691893, 1425.7433661940854, 1452.1577485058663, 10640.62757803477, 10723.892761072388, 10952.014318711324, 11024.283421577591, 11194.656641203057, 10839.18706097042, 10945.781084378308, 10977.890221097787, 10992.450377481135, 11024.393658348788, 2070.637638413272, 2408.253441433157, 2462.630605409194, 2462.827602067847, 2464.839785413951, 2356.823238257129, 2446.2538925627678, 2458.176510868861, 2461.126300163443, 2464.7904928081134, 2356.2106694257445, 2440.8169387295934, 2445.0, 2452.754724527551, 2468.5309791139625, 2027.9353339496809, 2362.7519110493495, 2439.7316295207424, 2441.231012231159, 2444.0590372706456, 2329.801966832821, 2428.672129262545, 2445.963310550343, 2447.4126209709543, 2449.0, 10709.357438553712, 10777.030067293981, 10786.406747628876, 10787.137029037658, 10821.350718956888, 5450.0, 6176.258848938111, 6339.619622822645, 6392.0, 6394.424501794861, 3940.566537680853, 3972.4041393791163, 3976.4631774710333, 4005.2790497710403, 4070.1859628074208, 1185.5317149725897, 1546.8221154567257, 1582.1535478518938, 1595.210370866417, 1651.2486818497675, 13992.93003534986, 14564.344604492824, 15275.923620381938, 15290.464833730766, 15409.998350107318, 5148.279240906276, 5223.817166399233, 5418.701971391532, 5452.482014208644, 5459.12653975362, 11366.829497557543, 11401.543938242377, 11440.370779607201, 11460.426978651034, 11485.540578376771, 6252.343503932113, 6297.307296197415, 6320.209973753281, 6324.051392291193, 6325.557210995186, 5649.350324712628, 5834.970825145932, 5887.970560147171, 5964.194833697482, 6022.668753218528, 4170.22850772608, 4241.172971270573, 4282.464691913511, 4310.159518893848, 4333.068390296102, 1125.386664267976, 1235.8877010690271, 1252.4426630149678, 1268.543324403214, 1277.6997405609675, 671.2750229751856, 751.1286907187637, 754.9547027178387, 785.3363907498155, 811.853866304071, 4940.456549779521, 5831.62094463867, 5966.164736936832, 6080.179175811209, 6104.908426373608, 457.66361724132736, 561.147056474157, 579.5045236322967, 584.0625795598089, 599.9880002400015, 3882.165334453106, 4006.238814625212, 4080.449429216879, 4154.4183814266025, 4180.937285940713, 13495.460181592627, 14023.509177178954, 14029.368678409495, 14036.789448158286, 14052.156870587798, 13222.867771322164, 13798.034137610472, 13798.448062077605, 13981.650458738613, 13985.79021314681, 10045.19638428924, 10252.6411575596, 10298.485075746183, 10299.0, 10332.53503592325, 5477.643953143033, 5713.06077480273, 6330.746770129143, 6487.643179624977, 6751.72993080291, 9737.756556086155, 12544.372781361079, 12559.874401256237, 12590.307533085768, 12608.306543140216, 12153.635390938285, 12536.247825130522, 12548.121631485708, 12575.811362829749, 12730.554430594884, 9044.909550904407, 9080.137386948229, 9142.177204051668, 9163.908360916572, 9228.446293222429, 9948.45283509414, 9957.502124893581, 10183.643572475225, 10188.541515631667, 10191.337563058378, 7046.541974771623, 8403.49579025236, 8447.66209351619, 8583.828323433372, 8674.956625216833, 8178.977627796526, 8234.176582341717, 8293.170682931659, 8308.916910831056, 8354.997400312002, 7636.770896873103, 7669.923300767144, 7700.961495192488, 7709.267619576131, 7711.730089446843, 5436.483534064258, 5793.507551857971, 5960.940390596039, 5966.582339236212, 5986.281646202484, 4983.878627308826, 5173.706573356661, 5767.452092051249, 5922.111683247547, 6099.75600975956], "value": 5086.484884958308, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.199141973461, 404.45600667102735, 407.26082160878, 413.3324680640764, 417.01792279182524, 5039.798408063678, 5945.554083443737, 6527.0, 6554.0, 6572.737090516385, 5185.922211166826, 5378.8924221515545, 6359.777407790728, 6373.649449280288, 6375.521835862306, 4790.568848803616, 4793.065352256312, 4807.879803004917, 4839.709617422948, 4857.73282469464, 4848.733319667417, 4855.854324370257, 4868.586170175539, 4880.902381952359, 4884.487128851472, 4378.16814805186, 4565.954340456603, 4572.382728331682, 4589.678722489427, 4613.953860461403, 4036.717429779931, 4336.436263285768, 4584.0, 4586.3808385867815, 4619.976900115512, 3303.0256074458093, 3947.5460322063045, 3950.6839452843706, 3964.801759911993, 3970.344893092636, 5308.8141915033175, 5766.567507436959, 6126.540509461808, 6130.478909292671, 6221.191245138149, 5458.699771512565, 5458.781648734046, 5479.479449452296, 5480.424555421663, 5496.31296087989, 4905.901881962376, 6071.210742603434, 6162.907556386658, 6614.437772789319, 6659.0, 4415.013244040195, 4442.955570444286, 4447.444069491314, 4452.1986042512335, 4480.574345437179, 5892.469677729025, 6430.1385883281955, 6931.514793964425, 7117.964410177916, 7153.856922861566, 4432.82268709248, 4485.318005747845, 4571.177188106173, 4577.267637178035, 4578.6794924355645, 4228.640565551901, 4241.388272456446, 4267.954351183917, 4596.7931443085145, 4608.677392582487, 4749.978754567785, 4894.510548945148, 5240.5750878328945, 5306.912083022971, 5466.453354664502, 5888.941110588839, 6710.362515561014, 6784.525083244224, 6800.217974932847, 6843.794686159423, 1318.815365848782, 1413.1591702936737, 1439.9208043557705, 1537.9926148372833, 1590.840915908423, 981.239539357004, 991.3011327014437, 1022.447878145793, 1043.9321444106108, 1050.2280823594651, 6001.709632429049, 6411.403381630447, 6430.614163150226, 6440.710168042449, 6451.3548645135115, 5583.804566840141, 6035.1249068885645, 6468.31047490575, 6649.73401063952, 7006.789796306119, 6206.441420272197, 6436.16329877113, 6547.639879806561, 6566.474682025427, 6590.472762179014, 3260.8043517389033, 3654.4518322251874, 3673.1918977824835, 3679.6504332088407, 3685.244524872395, 6724.831879203059, 6773.8983915241315, 6871.5189936703955, 7318.414526837841, 7366.410687145016, 5870.444332251956, 5963.642181469039, 6702.83242918931, 7327.487075904742, 7367.5579465231185, 6452.419282264525, 6997.895031574531, 7016.789496315118, 7265.782026539212, 7321.595458112003, 5737.282839645044, 6194.783182588588, 6881.41507971828, 7074.9292507076325, 7076.929230707627, 6567.0, 6903.723851045902, 6925.706062241443, 6961.89557156633, 6961.965190174017, 7070.787876363717, 7174.282571742784, 7322.157951835394, 7338.926610733824, 7376.926230737624, 4164.042270277913, 4533.501314855429, 4544.159330523864, 4561.224591819332, 4565.6119229865835, 6921.82695432598, 7014.351627367462, 7085.433165346657, 7090.220075791555, 7130.967674212824, 6787.423069039187, 6801.5247725581385, 6815.556988795713, 6839.863202735818, 6840.726370945106, 5766.106253530709, 6599.571027883172, 6785.6946437411425, 6881.89677154833, 6909.0, 5265.815696450606, 6626.204855417381, 6653.600783952978, 6692.431143352675, 6693.732250710112, 5546.760655933596, 5724.79963201286, 6711.362420570038, 6862.245153033063, 6868.866637005038, 5792.333881603669, 6045.314880967286, 6517.804465866032, 6638.734450622114, 6661.833454163685], "value": 4869.746235641356, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.33820884786, 735.6064505489561, 737.7565403416871, 740.6629983357573, 745.3329270303079, 15601.531954041382, 15918.52244432666, 15922.0, 15937.521874343774, 15956.0, 15010.174440405774, 15105.395784168648, 15133.016353936986, 15149.394024239045, 15169.620759481018, 841.3689732700475, 946.5693109635134, 966.5698764050001, 988.5255077562738, 1019.0166489337788, 751.9848204923337, 915.8305713443001, 1015.6242190389529, 1034.974125646861, 1039.991208527727, 997.7555498902778, 1084.1110289562562, 1088.2382332367335, 1089.199438412766, 1092.9781404371909, 1045.0855501436242, 1072.1904961753864, 1076.4832880217539, 1076.6285631457135, 1077.5959015369237, 775.170567492783, 785.3717026378931, 801.8917446144754, 804.4489524675616, 807.6930766308824, 16552.586185345343, 16802.579935501588, 16869.0, 17011.914940425344, 17156.828431715647, 12387.19483233587, 14814.925925370304, 14865.777013344808, 15072.321745521369, 15658.25980453416, 9803.31376803624, 11387.316760994367, 11563.479643415982, 11894.643160705193, 12055.397230138458, 3012.653544842349, 3055.2972816252163, 3078.4304903592906, 3140.0579826052094, 3216.0512648768668, 108606.3709044365, 112720.43639781831, 113606.43196783963, 114869.70260594825, 115846.99999999916, 11181.440927953732, 11431.428428578703, 11484.483198256099, 11499.252548584314, 11848.466818993165, 24284.514309713708, 24554.754452455247, 24912.750872491404, 25010.749892501208, 25011.62482562763, 7800.375969922393, 7832.82507623861, 7958.880616790752, 8005.519668819889, 8011.325534609963, 4085.55058943516, 4096.897071660972, 4100.282450571198, 4179.226843034048, 4184.14225083857, 4086.4483294755423, 4164.8334066637, 4181.6236538711055, 4228.090960443458, 4230.598093181143, 764.4495962906698, 768.2125821033485, 771.1979541277009, 771.2942657468466, 773.2615352338503, 551.41274542612, 554.8446434998126, 564.94350564944, 577.0507515137575, 589.0839744197814, 9697.806043879224, 10082.24383171265, 10090.394576325443, 10166.4916754162, 10242.692719218287, 548.410458756838, 576.0, 580.1269090019578, 602.1900543768625, 606.2179788073424, 4435.379046933432, 4616.792244349012, 4630.282306242538, 4714.693544919569, 4746.406699162605, 102963.0, 102982.48508757408, 104189.0, 105647.94352056534, 109299.45350273357, 56705.432945670014, 69822.0, 74256.88614670784, 88668.0, 91698.0, 80191.0, 81126.59436702897, 81613.0, 82231.5888420566, 82734.0, 9160.6793762218, 10016.248781341574, 10877.67366978992, 10927.125829933746, 10978.286411383235, 35665.82167089252, 36694.0, 37379.81310093432, 38784.2243155141, 40162.79918600388, 60491.0, 61890.0, 64377.678111609144, 65863.67068164628, 66902.0, 13696.0, 13741.0, 13747.587572372844, 14227.217503037018, 14305.141691498127, 14551.563453096423, 14580.781288280896, 14673.266336683337, 14827.0, 14945.0, 13638.249896255802, 13784.241866697428, 13804.378802954092, 14007.509737159558, 14087.577372678836, 13657.863421365659, 13857.653558661113, 13955.441782328593, 14151.219342908229, 14318.427262909367, 13377.495353995751, 13385.598432047054, 13772.24252666073, 14009.719805603627, 14188.645283867985, 8520.659173633234, 8787.989381221241, 9359.578818953027, 9734.75663108428, 10397.948010259901, 8047.315978141924, 9125.04187060349, 10520.107560202774, 11284.943575282072, 11312.547498099984], "value": 7617.868725782753, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1638.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 182.0, 137.0, 123.0, 127.0, 176.0, 187.0, 123.0, 122.0, 123.0], "value": 144.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 106.0, 115.0, 156.0, 122.0, 118.0, 118.0, 118.0, 138.0, 115.0], "value": 125.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [231.0, 218.0, 229.0, 222.0, 238.0, 209.0, 209.0, 215.0, 211.0, 211.0], "value": 219.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 61.0, 62.0, 92.0, 91.0, 66.0, 87.0, 79.0, 73.0, 57.0], "value": 75.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 89.0, 75.0, 72.0, 75.0, 85.0, 72.0, 71.0, 86.0], "value": 78.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 92.0, 101.0, 91.0, 91.0, 99.0, 90.0, 90.0, 98.0], "value": 93.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 99.0, 99.0, 100.0, 100.0, 99.0, 103.0, 98.0, 101.0], "value": 99.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 107.0, 115.0, 164.0, 156.0, 104.0, 106.0, 102.0, 108.0, 103.0], "value": 116.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 52.0, 52.0, 52.0, 62.0, 67.0, 82.0, 84.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 49.0, 57.0, 75.0, 97.0, 95.0, 87.0, 88.0, 58.0, 60.0], "value": 71.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 89.0, 86.0, 81.0, 87.0, 87.0, 89.0, 89.0, 90.0, 88.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 166.0, 149.0, 145.0, 166.0, 166.0, 169.0, 154.0, 204.0, 171.0], "value": 163.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 249.0, 255.0, 203.0, 195.0, 200.0, 187.0, 198.0, 253.0, 247.0], "value": 218.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 98.0, 76.0, 72.0, 71.0, 77.0, 100.0, 70.0, 79.0, 65.0], "value": 81.1, "unit": "score"}]}]} 13:46:44 INFO - Return code: 0 13:46:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:46:44 ERROR - # TBPL SUCCESS # 13:46:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:46:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:46:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:46:45 INFO - 2017-03-31 13:46:45.002 screenresolution[1920:13483] starting screenresolution argv=screenresolution get 13:46:45 INFO - 2017-03-31 13:46:45.005 screenresolution[1920:13483] Display 0: 1600x1200x32@60 13:46:45 INFO - 2017-03-31 13:46:45.012 screenresolution[1921:13486] starting screenresolution argv=screenresolution list 13:46:45 INFO - Available Modes on Display 0 13:46:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:46:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:46:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:46:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:46:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:46:45 INFO - Intel Iris: 13:46:45 INFO - Chipset Model: Intel Iris 13:46:45 INFO - Type: GPU 13:46:45 INFO - Bus: Built-In 13:46:45 INFO - VRAM (Dynamic, Max): 1536 MB 13:46:45 INFO - Vendor: Intel (0x8086) 13:46:45 INFO - Device ID: 0x0a2e 13:46:45 INFO - Revision ID: 0x0009 13:46:45 INFO - Displays: 13:46:45 INFO - Display: 13:46:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:46:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:46:45 INFO - Display Serial Number: 1600x1200 60 13:46:45 INFO - Main Display: Yes 13:46:45 INFO - Mirror: Off 13:46:45 INFO - Online: Yes 13:46:45 INFO - Rotation: Supported 13:46:45 INFO - Return code: 0 13:46:45 INFO - Running post-action listener: _resource_record_post_action 13:46:45 INFO - [mozharness: 2017-03-31 20:46:45.247868Z] Finished run-tests step (success) 13:46:45 INFO - Running post-run listener: _resource_record_post_run 13:46:45 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 1349120; Write bytes: 514975744; Read time: 18; Write time: 1668 13:46:45 INFO - TinderboxPrint: CPU usage
54.1% 13:46:45 INFO - TinderboxPrint: I/O read bytes / time
1,349,120 / 18 13:46:45 INFO - TinderboxPrint: I/O write bytes / time
514,975,744 / 1,668 13:46:45 INFO - TinderboxPrint: CPU idle
2,202.4 (45.9%) 13:46:45 INFO - TinderboxPrint: CPU system
963.9 (20.1%) 13:46:45 INFO - TinderboxPrint: CPU user
1,635.3 (34.1%) 13:46:45 INFO - TinderboxPrint: Swap in / out
213,409,792 / 0 13:46:45 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209175040; Write bytes: 205158400; Read time: 15789; Write time: 418 13:46:45 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 1349120; Write bytes: 298770432; Read time: 18; Write time: 1215 13:46:45 INFO - Running post-run listener: _upload_blobber_files 13:46:45 INFO - Blob upload gear active. 13:46:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:46:45 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 13:46:45 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:46:45 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:46:46 INFO - (blobuploader) - INFO - Open directory for files ... 13:46:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:46:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:46:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:46 INFO - (blobuploader) - INFO - Done attempting. 13:46:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:46:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:46:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:47 INFO - (blobuploader) - INFO - Done attempting. 13:46:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:46:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:46:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:48 INFO - (blobuploader) - INFO - Done attempting. 13:46:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:46:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:46:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:51 INFO - (blobuploader) - INFO - Done attempting. 13:46:51 INFO - (blobuploader) - INFO - Iteration through files over. 13:46:51 INFO - Return code: 0 13:46:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:46:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:46:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9682146a1e28368782d02e4c1dc93f96a2f00e0f61372b0d872f598db465b8ffa9ef3418733fed22601457087fa694839a78e9ec5b5dbcbe4b0a8a62794431d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/013723b1b7b73297954249e8183955abefd5cadfb087d297bc591a89e98264d06024f341b39ad6eb213f9942cd3aab99b64fb92cdce89a1005620f3ce7bb0261", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5a5d025b61ecd05d15353fc2b314ad607009e49c2ed13bc2301b18aaf03619f98a131b09f8071c826e8f7e8f00f7a34600c1f9cb8ea341e8b4518310a146aef4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/17313e395fc9771c6e7fb6ded578fa7a64071bfb101cb955a3472ae859161380c3b8f07a7adad93f94e64ff4adb455bde5e75fa7b4e78a855730f94f2bb4074e"} 13:46:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:46:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:46:51 INFO - Contents: 13:46:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9682146a1e28368782d02e4c1dc93f96a2f00e0f61372b0d872f598db465b8ffa9ef3418733fed22601457087fa694839a78e9ec5b5dbcbe4b0a8a62794431d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/013723b1b7b73297954249e8183955abefd5cadfb087d297bc591a89e98264d06024f341b39ad6eb213f9942cd3aab99b64fb92cdce89a1005620f3ce7bb0261", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5a5d025b61ecd05d15353fc2b314ad607009e49c2ed13bc2301b18aaf03619f98a131b09f8071c826e8f7e8f00f7a34600c1f9cb8ea341e8b4518310a146aef4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/17313e395fc9771c6e7fb6ded578fa7a64071bfb101cb955a3472ae859161380c3b8f07a7adad93f94e64ff4adb455bde5e75fa7b4e78a855730f94f2bb4074e"} 13:46:51 INFO - Running post-run listener: copy_logs_to_upload_dir 13:46:51 INFO - Copying logs to upload dir... 13:46:51 INFO - mkdir: /builds/slave/test/build/upload/logs 13:46:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.828705 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2017-03-31 13:46:51.490664) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 13:46:51.494143) ========= 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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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/Pine/sha512/9682146a1e28368782d02e4c1dc93f96a2f00e0f61372b0d872f598db465b8ffa9ef3418733fed22601457087fa694839a78e9ec5b5dbcbe4b0a8a62794431d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/013723b1b7b73297954249e8183955abefd5cadfb087d297bc591a89e98264d06024f341b39ad6eb213f9942cd3aab99b64fb92cdce89a1005620f3ce7bb0261", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5a5d025b61ecd05d15353fc2b314ad607009e49c2ed13bc2301b18aaf03619f98a131b09f8071c826e8f7e8f00f7a34600c1f9cb8ea341e8b4518310a146aef4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/17313e395fc9771c6e7fb6ded578fa7a64071bfb101cb955a3472ae859161380c3b8f07a7adad93f94e64ff4adb455bde5e75fa7b4e78a855730f94f2bb4074e"} build_url:https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011029 build_url: 'https://queue.taskcluster.net/v1/task/IWAzSnLsRvW3IDEbMnhqpA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/9682146a1e28368782d02e4c1dc93f96a2f00e0f61372b0d872f598db465b8ffa9ef3418733fed22601457087fa694839a78e9ec5b5dbcbe4b0a8a62794431d7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/013723b1b7b73297954249e8183955abefd5cadfb087d297bc591a89e98264d06024f341b39ad6eb213f9942cd3aab99b64fb92cdce89a1005620f3ce7bb0261", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/5a5d025b61ecd05d15353fc2b314ad607009e49c2ed13bc2301b18aaf03619f98a131b09f8071c826e8f7e8f00f7a34600c1f9cb8ea341e8b4518310a146aef4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/17313e395fc9771c6e7fb6ded578fa7a64071bfb101cb955a3472ae859161380c3b8f07a7adad93f94e64ff4adb455bde5e75fa7b4e78a855730f94f2bb4074e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-31 13:46:51.528426) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 13:46:51.528912) ========= 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.P0jN4Nsw4G/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.UDSptHK4Pm/Listeners TMPDIR=/var/folders/m4/d0n5fftn6ks85y96r7kgw23r00000w/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.005299 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-31 13:46:51.577674) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 13:46:51.578038) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-31 13:46:51.578432) ========= ========= Total master_lag: 0.18 =========