builder: pine_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0379 starttime: 1491982620.18 results: success (0) buildid: 20170411153607 builduid: 4654b5365f2e4eba86a8e1001345804d revision: 099d239a4f861e204320e2c7fa81001fce31b2cf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 00:37:00.176093) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-12 00:37:00.176644) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 00:37:00.176963) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-12 00:37:00.204264) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:37:00.204708) ========= 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.7XZMRAZE08/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.lHbwDcL1wL/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-12 00:37:00-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.0M=0.001s 2017-04-12 00:37:00 (18.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.093334 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:37:00.324319) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:37:00.324979) ========= 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.7XZMRAZE08/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.lHbwDcL1wL/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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.025837 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:37:00.374452) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 00:37:00.374883) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 099d239a4f861e204320e2c7fa81001fce31b2cf --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 099d239a4f861e204320e2c7fa81001fce31b2cf --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7XZMRAZE08/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.lHbwDcL1wL/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-12 00:37:00,481 truncating revision to first 12 chars 2017-04-12 00:37:00,481 Setting DEBUG logging. 2017-04-12 00:37:00,481 attempt 1/10 2017-04-12 00:37:00,481 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/099d239a4f86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-12 00:37:01,513 unpacking tar archive at: pine-099d239a4f86/testing/mozharness/ program finished with exit code 0 elapsedTime=1.326494 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-12 00:37:01.727180) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 00:37:01.727833) ========= script_repo_revision: 099d239a4f861e204320e2c7fa81001fce31b2cf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-12 00:37:01.728635) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 00:37:01.729168) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-12 00:37:01.750583) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-12 00:37:01.751079) ========= /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.7XZMRAZE08/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.lHbwDcL1wL/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 00:37:01 INFO - MultiFileLogger online at 20170412 00:37:01 in /builds/slave/test 00:37:01 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 00:37:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:37:01 INFO - {'append_to_log': False, 00:37:01 INFO - 'base_work_dir': '/builds/slave/test', 00:37:01 INFO - 'blob_upload_branch': 'Pine', 00:37:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:37:01 INFO - 'branch': 'Pine', 00:37:01 INFO - 'buildbot_json_path': 'buildprops.json', 00:37:01 INFO - 'config_files': ('talos/mac_config.py',), 00:37:01 INFO - 'default_actions': ('clobber', 00:37:01 INFO - 'read-buildbot-config', 00:37:01 INFO - 'download-and-extract', 00:37:01 INFO - 'populate-webroot', 00:37:01 INFO - 'create-virtualenv', 00:37:01 INFO - 'install', 00:37:01 INFO - 'run-tests'), 00:37:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:37:01 INFO - 'download_minidump_stackwalk': True, 00:37:01 INFO - 'download_symbols': 'ondemand', 00:37:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:37:01 INFO - 'tooltool.py': '/tools/tooltool.py', 00:37:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:37:01 INFO - '/tools/misc-python/virtualenv.py')}, 00:37:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:37:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:37:01 INFO - 'gecko_profile': False, 00:37:01 INFO - 'gecko_profile_interval': 0, 00:37:01 INFO - 'installer_path': 'installer.exe', 00:37:01 INFO - 'log_level': 'info', 00:37:01 INFO - 'log_name': 'talos', 00:37:01 INFO - 'log_to_console': True, 00:37:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:37:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:37:01 INFO - 'opt_config_files': (), 00:37:01 INFO - 'pip_index': False, 00:37:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:37:01 INFO - 'cmd': ('bash', 00:37:01 INFO - '-c', 00:37:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:37:01 INFO - 'enabled': True, 00:37:01 INFO - 'halt_on_failure': False, 00:37:01 INFO - 'name': 'check_screen_resolution'},), 00:37:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:37:01 INFO - 'cmd': ('bash', 00:37:01 INFO - '-c', 00:37:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:37:01 INFO - 'enabled': True, 00:37:01 INFO - 'halt_on_failure': False, 00:37:01 INFO - 'name': 'check_screen_resolution'},), 00:37:01 INFO - 'run_cmd_checks_enabled': True, 00:37:01 INFO - 'suite': 'dromaeojs-e10s', 00:37:01 INFO - 'system_bits': '32', 00:37:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:37:01 INFO - 'title': 't-yosemite-r7-0379', 00:37:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:37:01 INFO - 'use_talos_json': True, 00:37:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:37:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:37:01 INFO - 'work_dir': 'build'} 00:37:01 INFO - [mozharness: 2017-04-12 07:37:01.950884Z] Running clobber step. 00:37:01 INFO - Running pre-action listener: _resource_record_pre_action 00:37:01 INFO - Running main action method: clobber 00:37:01 INFO - rmtree: /builds/slave/test/build 00:37:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:37:04 INFO - Running post-action listener: _resource_record_post_action 00:37:04 INFO - [mozharness: 2017-04-12 07:37:04.350094Z] Finished clobber step (success) 00:37:04 INFO - [mozharness: 2017-04-12 07:37:04.350372Z] Running read-buildbot-config step. 00:37:04 INFO - Running pre-action listener: _resource_record_pre_action 00:37:04 INFO - Running main action method: read_buildbot_config 00:37:04 INFO - Using buildbot properties: 00:37:04 INFO - { 00:37:04 INFO - "project": "", 00:37:04 INFO - "product": "firefox", 00:37:04 INFO - "script_repo_revision": "default", 00:37:04 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs-e10s", 00:37:04 INFO - "repository": "", 00:37:04 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs-e10s", 00:37:04 INFO - "buildid": "20170411153607", 00:37:04 INFO - "pgo_build": "False", 00:37:04 INFO - "basedir": "/builds/slave/test", 00:37:04 INFO - "buildnumber": 9, 00:37:04 INFO - "slavename": "t-yosemite-r7-0379", 00:37:04 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 00:37:04 INFO - "platform": "yosemite_r7", 00:37:04 INFO - "scheduler": "tests-pine-macosx64-talos", 00:37:04 INFO - "branch": "pine", 00:37:04 INFO - "repo_path": "projects/pine", 00:37:04 INFO - "revision": "099d239a4f861e204320e2c7fa81001fce31b2cf", 00:37:04 INFO - "stage_platform": "macosx64", 00:37:04 INFO - "builduid": "4654b5365f2e4eba86a8e1001345804d", 00:37:04 INFO - "slavebuilddir": "test" 00:37:04 INFO - } 00:37:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 00:37:04 INFO - Running post-action listener: _resource_record_post_action 00:37:04 INFO - [mozharness: 2017-04-12 07:37:04.356105Z] Finished read-buildbot-config step (success) 00:37:04 INFO - [mozharness: 2017-04-12 07:37:04.356320Z] Running download-and-extract step. 00:37:04 INFO - Running pre-action listener: _resource_record_pre_action 00:37:04 INFO - Running main action method: download_and_extract 00:37:04 INFO - mkdir: /builds/slave/test/build/tests 00:37: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')]} 00:37:04 INFO - trying https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 00:37:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/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 00:37:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/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 00:37:04 INFO - Downloaded 1325 bytes. 00:37:04 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 00:37:04 INFO - Using the following test package requirements: 00:37:04 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:37:04 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 00:37:04 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 00:37:04 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:37:04 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 00:37:04 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:37:04 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 00:37:04 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:37:04 INFO - u'jsshell-mac.zip'], 00:37:04 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:37:04 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 00:37:04 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 00:37:04 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:37:04 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 00:37:04 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:37:04 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 00:37:04 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:37:04 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 00:37:04 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 00:37:04 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 00:37:04 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:37:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 00:37:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:37:04 INFO - Fetch https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 00:37:06 INFO - Expected file size: 52581320 00:37:06 INFO - Obtained file size: 52581320 00:37:22 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 00:37:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 00:37:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 00:37:22 INFO - Fetch https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 00:37:24 INFO - Expected file size: 52581320 00:37:24 INFO - Obtained file size: 52581320 00:37:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 00:37:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:37:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 00:37:40 INFO - Expected file size: 14405596 00:37:40 INFO - Obtained file size: 14405596 00:37:40 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')]} 00:37:40 INFO - trying https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 00:37:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 00:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/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 00:37:42 INFO - Downloaded 71000210 bytes. 00:37:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 00:37:42 INFO - mkdir: /builds/slave/test/properties 00:37:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:37:42 INFO - Writing to file /builds/slave/test/properties/build_url 00:37:42 INFO - Contents: 00:37:42 INFO - build_url:https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 00:37:43 INFO - Running post-action listener: _resource_record_post_action 00:37:43 INFO - Running post-action listener: set_extra_try_arguments 00:37:43 INFO - [mozharness: 2017-04-12 07:37:43.606069Z] Finished download-and-extract step (success) 00:37:43 INFO - [mozharness: 2017-04-12 07:37:43.606198Z] Running populate-webroot step. 00:37:43 INFO - Running pre-action listener: _resource_record_pre_action 00:37:43 INFO - Running main action method: populate_webroot 00:37:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:37:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:37:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:37:43 INFO - '--tppagecycles', 00:37:43 INFO - '7'], 00:37:43 INFO - 'tests': ['tsvgm']}}, 00:37:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:37:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:37:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:37:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:37:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:37:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:37:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:37:43 INFO - 'talos_options': ['--disable-e10s'], 00:37:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:37:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:37:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:37:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:37:43 INFO - 'talos_options': ['--disable-e10s'], 00:37:43 INFO - 'tests': ['damp', 'tps']}, 00:37:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:37:43 INFO - 'tests': ['damp', 'tps']}, 00:37:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:37:43 INFO - 'tests': ['dromaeo_dom']}, 00:37:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:37:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:37:43 INFO - 'tests': ['basic_compositor_video']}, 00:37:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:37:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:37:43 INFO - 'tests': ['a11yr', 00:37:43 INFO - 'ts_paint', 00:37:43 INFO - 'tpaint', 00:37:43 INFO - 'sessionrestore', 00:37:43 INFO - 'sessionrestore_no_auto_restore', 00:37:43 INFO - 'tabpaint']}, 00:37:43 INFO - 'other-e10s': {'tests': ['a11yr', 00:37:43 INFO - 'ts_paint', 00:37:43 INFO - 'tpaint', 00:37:43 INFO - 'sessionrestore', 00:37:43 INFO - 'sessionrestore_no_auto_restore', 00:37:43 INFO - 'tabpaint']}, 00:37:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:37:43 INFO - 'ts_paint', 00:37:43 INFO - 'tpaint', 00:37:43 INFO - 'sessionrestore', 00:37:43 INFO - 'sessionrestore_no_auto_restore', 00:37:43 INFO - 'tabpaint']}, 00:37:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:37:43 INFO - 'ts_paint', 00:37:43 INFO - 'tpaint', 00:37:43 INFO - 'sessionrestore', 00:37:43 INFO - 'sessionrestore_no_auto_restore', 00:37:43 INFO - 'tabpaint']}, 00:37:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:37:43 INFO - 'tests': ['a11yr', 00:37:43 INFO - 'ts_paint', 00:37:43 INFO - 'tpaint', 00:37:43 INFO - 'sessionrestore', 00:37:43 INFO - 'sessionrestore_no_auto_restore', 00:37:43 INFO - 'tabpaint']}, 00:37:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:37:43 INFO - 'tests': ['a11yr', 00:37:43 INFO - 'ts_paint', 00:37:43 INFO - 'tpaint', 00:37:43 INFO - 'sessionrestore', 00:37:43 INFO - 'sessionrestore_no_auto_restore', 00:37:43 INFO - 'tabpaint']}, 00:37:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:37:43 INFO - 'tests': ['tsvgx', 00:37:43 INFO - 'tsvgr_opacity', 00:37:43 INFO - 'tart', 00:37:43 INFO - 'tscrollx', 00:37:43 INFO - 'cart', 00:37:43 INFO - 'tsvg_static']}, 00:37:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:37:43 INFO - 'tsvgr_opacity', 00:37:43 INFO - 'tart', 00:37:43 INFO - 'tscrollx', 00:37:43 INFO - 'cart', 00:37:43 INFO - 'tsvg_static']}, 00:37:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:37:43 INFO - 'talos_options': ['--disable-e10s'], 00:37:43 INFO - 'tests': ['tp5o']}, 00:37:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:37:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:37:43 INFO - 'talos_options': ['--disable-e10s', 00:37:43 INFO - '--xperf_path', 00:37:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:37:43 INFO - 'tests': ['tp5n']}, 00:37:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:37:43 INFO - 'talos_options': ['--xperf_path', 00:37:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:37:43 INFO - 'tests': ['tp5n']}}, 00:37:43 INFO - 'talos.zip': {'path': '', 00:37:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:37:43 INFO - Running post-action listener: _resource_record_post_action 00:37:43 INFO - [mozharness: 2017-04-12 07:37:43.624844Z] Finished populate-webroot step (success) 00:37:43 INFO - [mozharness: 2017-04-12 07:37:43.624976Z] Running create-virtualenv step. 00:37:43 INFO - Running pre-action listener: _resource_record_pre_action 00:37:43 INFO - Running main action method: create_virtualenv 00:37:43 INFO - Creating virtualenv /builds/slave/test/build/venv 00:37:43 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 00:37:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:37:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:37:43 INFO - Using real prefix '/tools/python27' 00:37:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:37:44 INFO - Installing distribute.............................................................................................................................................................................................done. 00:37:47 INFO - Installing pip.................done. 00:37:47 INFO - Return code: 0 00:37:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:37:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:37:47 INFO - Reading from file tmpfile_stdout 00:37:47 INFO - Output received: 00:37:47 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) 00:37:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:37:47 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')]} 00:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:47 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')]} 00:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:47 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 0x10c865b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c868768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa66ad7db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c643d30>, '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 0x10c56adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c638be8>, '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.7XZMRAZE08/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.lHbwDcL1wL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 00:37:47 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 00:37:47 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 00:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7XZMRAZE08/Render', 00:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:47 INFO - 'HOME': '/Users/cltbld', 00:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:47 INFO - 'LOGNAME': 'cltbld', 00:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:47 INFO - 'MOZ_NO_REMOTE': '1', 00:37:47 INFO - 'NO_EM_RESTART': '1', 00:37:47 INFO - 'PAGER': '/bin/cat', 00:37:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:47 INFO - 'PWD': '/builds/slave/test', 00:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:47 INFO - 'SHELL': '/bin/bash', 00:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHbwDcL1wL/Listeners', 00:37:47 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 00:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:47 INFO - 'USER': 'cltbld', 00:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:47 INFO - 'XPC_FLAGS': '0x0', 00:37:47 INFO - 'XPC_SERVICE_NAME': '0', 00:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:47 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 00:37:47 INFO - Cleaning up... 00:37:47 INFO - Return code: 0 00:37:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:37:47 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')]} 00:37:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:47 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')]} 00:37:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:47 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 0x10c865b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c868768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa66ad7db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c643d30>, '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 0x10c56adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c638be8>, '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.7XZMRAZE08/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.lHbwDcL1wL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 00:37:47 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 00:37:47 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 00:37:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7XZMRAZE08/Render', 00:37:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:47 INFO - 'HOME': '/Users/cltbld', 00:37:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:47 INFO - 'LOGNAME': 'cltbld', 00:37:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:47 INFO - 'MOZ_NO_REMOTE': '1', 00:37:47 INFO - 'NO_EM_RESTART': '1', 00:37:47 INFO - 'PAGER': '/bin/cat', 00:37:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:47 INFO - 'PWD': '/builds/slave/test', 00:37:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:47 INFO - 'SHELL': '/bin/bash', 00:37:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHbwDcL1wL/Listeners', 00:37:47 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 00:37:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:47 INFO - 'USER': 'cltbld', 00:37:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:47 INFO - 'XPC_FLAGS': '0x0', 00:37:47 INFO - 'XPC_SERVICE_NAME': '0', 00:37:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:48 INFO - Downloading/unpacking psutil>=3.1.1 00:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:37:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:37:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:37:51 INFO - Installing collected packages: psutil 00:37:51 INFO - Running setup.py install for psutil 00:37:51 INFO - building 'psutil._psutil_osx' extension 00:37:51 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 00:37:52 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 00:37:52 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 00:37:52 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 00:37:52 INFO - building 'psutil._psutil_posix' extension 00:37:52 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 00:37:52 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:37:52 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:37:52 INFO - ^ 00:37:52 INFO - 1 warning generated. 00:37:52 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 00:37:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:37:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:37:52 INFO - Successfully installed psutil 00:37:52 INFO - Cleaning up... 00:37:52 INFO - Return code: 0 00:37:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:37:52 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')]} 00:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:52 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')]} 00:37:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:52 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 0x10c865b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c868768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa66ad7db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c643d30>, '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 0x10c56adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c638be8>, '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.7XZMRAZE08/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.lHbwDcL1wL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 00:37:52 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 00:37:52 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 00:37:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7XZMRAZE08/Render', 00:37:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:52 INFO - 'HOME': '/Users/cltbld', 00:37:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:52 INFO - 'LOGNAME': 'cltbld', 00:37:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:52 INFO - 'MOZ_NO_REMOTE': '1', 00:37:52 INFO - 'NO_EM_RESTART': '1', 00:37:52 INFO - 'PAGER': '/bin/cat', 00:37:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:52 INFO - 'PWD': '/builds/slave/test', 00:37:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:52 INFO - 'SHELL': '/bin/bash', 00:37:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHbwDcL1wL/Listeners', 00:37:52 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 00:37:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:52 INFO - 'USER': 'cltbld', 00:37:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:52 INFO - 'XPC_FLAGS': '0x0', 00:37:52 INFO - 'XPC_SERVICE_NAME': '0', 00:37:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:37:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:37:55 INFO - Installing collected packages: mozsystemmonitor 00:37:55 INFO - Running setup.py install for mozsystemmonitor 00:37:55 INFO - Successfully installed mozsystemmonitor 00:37:55 INFO - Cleaning up... 00:37:56 INFO - Return code: 0 00:37:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:37:57 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 0x10c865b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c868768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa66ad7db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c643d30>, '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 0x10c56adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c638be8>, '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.7XZMRAZE08/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.lHbwDcL1wL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 00:37:57 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 00:37:57 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 00:37:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7XZMRAZE08/Render', 00:37:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:37:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:37:57 INFO - 'HOME': '/Users/cltbld', 00:37:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:37:57 INFO - 'LOGNAME': 'cltbld', 00:37:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:37:57 INFO - 'MOZ_NO_REMOTE': '1', 00:37:57 INFO - 'NO_EM_RESTART': '1', 00:37:57 INFO - 'PAGER': '/bin/cat', 00:37:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:37:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:37:57 INFO - 'PWD': '/builds/slave/test', 00:37:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:37:57 INFO - 'SHELL': '/bin/bash', 00:37:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHbwDcL1wL/Listeners', 00:37:57 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 00:37:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:37:57 INFO - 'USER': 'cltbld', 00:37:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:37:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:37:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:37:57 INFO - 'XPC_FLAGS': '0x0', 00:37:57 INFO - 'XPC_SERVICE_NAME': '0', 00:37:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:37:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:37:57 INFO - Downloading/unpacking jsonschema==2.5.1 00:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:37:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:37:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:37:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:38:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:38:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:38:00 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 00:38:00 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 00:38:00 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 00:38:00 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 00:38:00 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 00:38:00 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 00:38:00 INFO - Downloading functools32-3.2.3-2.tar.gz 00:38:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:38:01 INFO - warning: no files found matching '*.txt' 00:38:01 INFO - no previously-included directories found matching 'build' 00:38:01 INFO - no previously-included directories found matching 'dist' 00:38:01 INFO - no previously-included directories found matching '.git*' 00:38:01 INFO - Installing collected packages: jsonschema, functools32 00:38:01 INFO - Running setup.py install for functools32 00:38:01 INFO - warning: no files found matching '*.txt' 00:38:01 INFO - no previously-included directories found matching 'build' 00:38:01 INFO - no previously-included directories found matching 'dist' 00:38:01 INFO - no previously-included directories found matching '.git*' 00:38:01 INFO - Successfully installed jsonschema functools32 00:38:01 INFO - Cleaning up... 00:38:01 INFO - Return code: 0 00:38:01 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:38:01 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')]} 00:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:01 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')]} 00:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:01 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 0x10c865b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c868768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa66ad7db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c643d30>, '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 0x10c56adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c638be8>, '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.7XZMRAZE08/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.lHbwDcL1wL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 00:38:01 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 00:38:01 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 00:38:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7XZMRAZE08/Render', 00:38:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:01 INFO - 'HOME': '/Users/cltbld', 00:38:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:01 INFO - 'LOGNAME': 'cltbld', 00:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:01 INFO - 'MOZ_NO_REMOTE': '1', 00:38:01 INFO - 'NO_EM_RESTART': '1', 00:38:01 INFO - 'PAGER': '/bin/cat', 00:38:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:01 INFO - 'PWD': '/builds/slave/test', 00:38:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:01 INFO - 'SHELL': '/bin/bash', 00:38:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHbwDcL1wL/Listeners', 00:38:01 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 00:38:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:01 INFO - 'USER': 'cltbld', 00:38:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:01 INFO - 'XPC_FLAGS': '0x0', 00:38:01 INFO - 'XPC_SERVICE_NAME': '0', 00:38:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:38:01 INFO - Cleaning up... 00:38:01 INFO - Return code: 0 00:38:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:38:01 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')]} 00:38:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:01 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')]} 00:38:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:01 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 0x10c865b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c868768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa66ad7db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c643d30>, '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 0x10c56adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c638be8>, '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.7XZMRAZE08/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.lHbwDcL1wL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 00:38:01 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 00:38:01 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 00:38:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7XZMRAZE08/Render', 00:38:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:01 INFO - 'HOME': '/Users/cltbld', 00:38:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:01 INFO - 'LOGNAME': 'cltbld', 00:38:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:01 INFO - 'MOZ_NO_REMOTE': '1', 00:38:01 INFO - 'NO_EM_RESTART': '1', 00:38:01 INFO - 'PAGER': '/bin/cat', 00:38:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:01 INFO - 'PWD': '/builds/slave/test', 00:38:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:01 INFO - 'SHELL': '/bin/bash', 00:38:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHbwDcL1wL/Listeners', 00:38:01 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 00:38:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:01 INFO - 'USER': 'cltbld', 00:38:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:01 INFO - 'XPC_FLAGS': '0x0', 00:38:01 INFO - 'XPC_SERVICE_NAME': '0', 00:38:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:01 INFO - Downloading/unpacking blobuploader==1.2.4 00:38:01 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 00:38:01 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 00:38:01 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 00:38:01 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 00:38:01 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 00:38:01 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 00:38:04 INFO - Downloading blobuploader-1.2.4.tar.gz 00:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:38:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:38:04 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 00:38:04 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 00:38:04 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 00:38:04 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 00:38:04 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 00:38:04 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 00:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:38:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:38:05 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 00:38:05 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 00:38:05 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 00:38:05 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 00:38:05 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 00:38:05 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 00:38:05 INFO - Downloading docopt-0.6.1.tar.gz 00:38:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:38:05 INFO - Installing collected packages: blobuploader, requests, docopt 00:38:05 INFO - Running setup.py install for blobuploader 00:38:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:38:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:38:05 INFO - Running setup.py install for requests 00:38:06 INFO - Running setup.py install for docopt 00:38:06 INFO - Successfully installed blobuploader requests docopt 00:38:06 INFO - Cleaning up... 00:38:06 INFO - Return code: 0 00:38:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:38:06 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')]} 00:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:06 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')]} 00:38:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:06 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 0x10c865b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c868768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa66ad7db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c643d30>, '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 0x10c56adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c638be8>, '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.7XZMRAZE08/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.lHbwDcL1wL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 00:38:06 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 00:38:06 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 00:38:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7XZMRAZE08/Render', 00:38:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:06 INFO - 'HOME': '/Users/cltbld', 00:38:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:06 INFO - 'LOGNAME': 'cltbld', 00:38:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:06 INFO - 'MOZ_NO_REMOTE': '1', 00:38:06 INFO - 'NO_EM_RESTART': '1', 00:38:06 INFO - 'PAGER': '/bin/cat', 00:38:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:06 INFO - 'PWD': '/builds/slave/test', 00:38:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:06 INFO - 'SHELL': '/bin/bash', 00:38:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHbwDcL1wL/Listeners', 00:38:06 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 00:38:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:06 INFO - 'USER': 'cltbld', 00:38:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:06 INFO - 'XPC_FLAGS': '0x0', 00:38:06 INFO - 'XPC_SERVICE_NAME': '0', 00:38:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:38:06 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-VAODcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:38:07 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-yeV7Jx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:38:07 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-fn8iJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:38:07 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-Ul1zjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:38:07 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-RkpBY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:38:07 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-n1z0Ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:38:07 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-AQMGK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:38:07 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-yW8SkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:38:07 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-XOQ2zx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:38:07 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-07huq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:38:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:38:07 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-UNN4n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:38:08 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-VREhEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:38:08 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-03ZAhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:38:08 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-8IxORQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:38:08 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-zJpwjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:38:08 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-FkjqHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:38:08 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-UhHAan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:38:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:38:08 INFO - Running setup.py install for manifestparser 00:38:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:38:08 INFO - Running setup.py install for mozcrash 00:38:08 INFO - Running setup.py install for mozdebug 00:38:09 INFO - Running setup.py install for mozdevice 00:38:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:38:09 INFO - Running setup.py install for mozfile 00:38:09 INFO - Running setup.py install for mozhttpd 00:38:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:38:09 INFO - Running setup.py install for mozinfo 00:38:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:38:09 INFO - Running setup.py install for mozInstall 00:38:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:38:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:38:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:38:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:38:09 INFO - Running setup.py install for mozleak 00:38:09 INFO - Running setup.py install for mozlog 00:38:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:38:10 INFO - Running setup.py install for moznetwork 00:38:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:38:10 INFO - Running setup.py install for mozprocess 00:38:10 INFO - Running setup.py install for mozprofile 00:38:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:38:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:38:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:38:10 INFO - Running setup.py install for mozrunner 00:38:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:38:10 INFO - Running setup.py install for mozscreenshot 00:38:10 INFO - Running setup.py install for moztest 00:38:11 INFO - Running setup.py install for mozversion 00:38:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:38:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:38:11 INFO - Cleaning up... 00:38:11 INFO - Return code: 0 00:38:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:11 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 0x10c865b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c868768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa66ad7db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c643d30>, '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 0x10c56adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c638be8>, '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.7XZMRAZE08/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.lHbwDcL1wL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 00:38:11 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 00:38:11 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 00:38:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7XZMRAZE08/Render', 00:38:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:11 INFO - 'HOME': '/Users/cltbld', 00:38:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:11 INFO - 'LOGNAME': 'cltbld', 00:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:11 INFO - 'MOZ_NO_REMOTE': '1', 00:38:11 INFO - 'NO_EM_RESTART': '1', 00:38:11 INFO - 'PAGER': '/bin/cat', 00:38:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:11 INFO - 'PWD': '/builds/slave/test', 00:38:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:11 INFO - 'SHELL': '/bin/bash', 00:38:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHbwDcL1wL/Listeners', 00:38:11 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 00:38:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:11 INFO - 'USER': 'cltbld', 00:38:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:11 INFO - 'XPC_FLAGS': '0x0', 00:38:11 INFO - 'XPC_SERVICE_NAME': '0', 00:38:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:38:11 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-a2ekjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:38:11 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)) 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:38:11 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-XMc0Xl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:38:11 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)) 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:38:11 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-8BkdI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:38:11 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)) 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:38:11 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-LVz5vU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:38:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:38:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:38:11 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-ghXYPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:38:12 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)) 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:38:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-VWk1qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:38:12 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)) 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:38:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-tkIg4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:38:12 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)) 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:38:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-e7PmLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:38:12 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)) 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:38:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-nP4v4D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:38:12 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)) 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:38:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-O3gKPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:38:12 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)) 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:38:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-POdFNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:38:12 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)) 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:38:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-Xxb0sS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:38:12 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)) 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:38:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-5fA_AV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:38:12 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)) 00:38:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:38:12 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-cxcR6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:38:13 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)) 00:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:38:13 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-LW4q25-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:38:13 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)) 00:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:38:13 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-f_4Eh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:38:13 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)) 00:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:38:13 INFO - Running setup.py (path:/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/pip-0TKkpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:38:13 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)) 00:38:13 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)) 00:38:13 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)) 00:38:13 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)) 00:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:38:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:38:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:38:13 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 00:38:13 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 00:38:13 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 00:38:13 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 00:38:13 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 00:38:13 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 00:38:15 INFO - Downloading blessings-1.6.tar.gz 00:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:38:16 INFO - Installing collected packages: blessings 00:38:16 INFO - Running setup.py install for blessings 00:38:16 INFO - Successfully installed blessings 00:38:16 INFO - Cleaning up... 00:38:16 INFO - Return code: 0 00:38:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:38:16 INFO - Reading from file tmpfile_stdout 00:38:16 INFO - Current package versions: 00:38:16 INFO - blessings == 1.6 00:38:16 INFO - blobuploader == 1.2.4 00:38:16 INFO - docopt == 0.6.1 00:38:16 INFO - functools32 == 3.2.3-2 00:38:16 INFO - jsonschema == 2.5.1 00:38:16 INFO - manifestparser == 1.1 00:38:16 INFO - mozInstall == 1.12 00:38:16 INFO - mozcrash == 1.0 00:38:16 INFO - mozdebug == 0.1 00:38:16 INFO - mozdevice == 0.50 00:38:16 INFO - mozfile == 1.2 00:38:16 INFO - mozhttpd == 0.7 00:38:16 INFO - mozinfo == 0.9 00:38:16 INFO - mozleak == 0.1 00:38:16 INFO - mozlog == 3.4 00:38:16 INFO - moznetwork == 0.27 00:38:16 INFO - mozprocess == 0.25 00:38:16 INFO - mozprofile == 0.28 00:38:16 INFO - mozrunner == 6.13 00:38:16 INFO - mozscreenshot == 0.1 00:38:16 INFO - mozsystemmonitor == 0.3 00:38:16 INFO - moztest == 0.8 00:38:16 INFO - mozversion == 1.4 00:38:16 INFO - psutil == 3.1.1 00:38:16 INFO - requests == 1.2.3 00:38:16 INFO - wsgiref == 0.1.2 00:38:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:16 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 0x10c865b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c868768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa66ad7db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c643d30>, '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 0x10c56adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c638be8>, '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.7XZMRAZE08/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.lHbwDcL1wL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 00:38:16 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 00:38:16 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 00:38:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7XZMRAZE08/Render', 00:38:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:16 INFO - 'HOME': '/Users/cltbld', 00:38:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:16 INFO - 'LOGNAME': 'cltbld', 00:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:16 INFO - 'MOZ_NO_REMOTE': '1', 00:38:16 INFO - 'NO_EM_RESTART': '1', 00:38:16 INFO - 'PAGER': '/bin/cat', 00:38:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:16 INFO - 'PWD': '/builds/slave/test', 00:38:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:16 INFO - 'SHELL': '/bin/bash', 00:38:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHbwDcL1wL/Listeners', 00:38:16 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 00:38:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:16 INFO - 'USER': 'cltbld', 00:38:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:16 INFO - 'XPC_FLAGS': '0x0', 00:38:16 INFO - 'XPC_SERVICE_NAME': '0', 00:38:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:16 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)) 00:38:16 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)) 00:38:16 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)) 00:38:16 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)) 00:38:16 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)) 00:38:16 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)) 00:38:16 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)) 00:38:16 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)) 00:38:16 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)) 00:38:16 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)) 00:38:16 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)) 00:38:16 INFO - Cleaning up... 00:38:16 INFO - Return code: 0 00:38:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:38:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:38:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:38:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:38:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c865b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c868768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa66ad7db60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c643d30>, '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 0x10c56adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c638be8>, '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.7XZMRAZE08/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.lHbwDcL1wL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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 00:38:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:38:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7XZMRAZE08/Render', 00:38:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:16 INFO - 'HOME': '/Users/cltbld', 00:38:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:16 INFO - 'LOGNAME': 'cltbld', 00:38:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:16 INFO - 'MOZ_NO_REMOTE': '1', 00:38:16 INFO - 'NO_EM_RESTART': '1', 00:38:16 INFO - 'PAGER': '/bin/cat', 00:38:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:16 INFO - 'PWD': '/builds/slave/test', 00:38:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:16 INFO - 'SHELL': '/bin/bash', 00:38:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHbwDcL1wL/Listeners', 00:38:16 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 00:38:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:16 INFO - 'USER': 'cltbld', 00:38:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:16 INFO - 'XPC_FLAGS': '0x0', 00:38:16 INFO - 'XPC_SERVICE_NAME': '0', 00:38:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:38:17 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:38:17 INFO - Cleaning up... 00:38:17 INFO - Return code: 0 00:38:17 INFO - Running post-action listener: _resource_record_post_action 00:38:17 INFO - Running post-action listener: _start_resource_monitoring 00:38:17 INFO - Starting resource monitoring. 00:38:17 INFO - [mozharness: 2017-04-12 07:38:17.125503Z] Finished create-virtualenv step (success) 00:38:17 INFO - [mozharness: 2017-04-12 07:38:17.126439Z] Running install step. 00:38:17 INFO - Running pre-action listener: _resource_record_pre_action 00:38:17 INFO - Running main action method: install 00:38:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:38:17 INFO - Reading from file tmpfile_stdout 00:38:17 INFO - Detecting whether we're running mozinstall >=1.0... 00:38:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:38:17 INFO - Reading from file tmpfile_stdout 00:38:17 INFO - Output received: 00:38:17 INFO - Usage: mozinstall [options] installer 00:38:17 INFO - Options: 00:38:17 INFO - -h, --help show this help message and exit 00:38:17 INFO - -d DEST, --destination=DEST 00:38:17 INFO - Directory to install application into. [default: 00:38:17 INFO - "/builds/slave/test"] 00:38:17 INFO - --app=APP Application being installed. [default: firefox] 00:38:17 INFO - mkdir: /builds/slave/test/build/application 00:38:17 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'] 00:38:17 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 00:38:37 INFO - Reading from file tmpfile_stdout 00:38:37 INFO - Output received: 00:38:37 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:38:37 INFO - Running post-action listener: _resource_record_post_action 00:38:37 INFO - [mozharness: 2017-04-12 07:38:37.988744Z] Finished install step (success) 00:38:37 INFO - [mozharness: 2017-04-12 07:38:37.988868Z] Running run-tests step. 00:38:37 INFO - Running pre-action listener: _resource_record_pre_action 00:38:37 INFO - Running main action method: run_tests 00:38:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:38:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:38:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:38:38 INFO - 2017-04-12 00:38:38.003 screenresolution[1623:7433] starting screenresolution argv=screenresolution get 00:38:38 INFO - 2017-04-12 00:38:38.006 screenresolution[1623:7433] Display 0: 1600x1200x32@60 00:38:38 INFO - 2017-04-12 00:38:38.012 screenresolution[1624:7435] starting screenresolution argv=screenresolution list 00:38:38 INFO - Available Modes on Display 0 00:38:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:38:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:38:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:38:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:38:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:38:38 INFO - Intel Iris: 00:38:38 INFO - Chipset Model: Intel Iris 00:38:38 INFO - Type: GPU 00:38:38 INFO - Bus: Built-In 00:38:38 INFO - VRAM (Dynamic, Max): 1536 MB 00:38:38 INFO - Vendor: Intel (0x8086) 00:38:38 INFO - Device ID: 0x0a2e 00:38:38 INFO - Revision ID: 0x0009 00:38:38 INFO - Displays: 00:38:38 INFO - Display: 00:38:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:38:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:38:38 INFO - Display Serial Number: 1600x1200 60 00:38:38 INFO - Main Display: Yes 00:38:38 INFO - Mirror: Off 00:38:38 INFO - Online: Yes 00:38:38 INFO - Rotation: Supported 00:38:38 INFO - Return code: 0 00:38:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:38:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:38:38 INFO - Python 2.7.3 00:38:38 INFO - Return code: 0 00:38:38 INFO - grabbing minidump binary from tooltool 00:38: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')]} 00:38:38 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 0x10c643d30>, '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 0x10c56adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c638be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:38:38 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 00:38:38 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 00:38:38 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 00:38:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:38:38 INFO - Return code: 0 00:38:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:38:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:38:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:38:38 INFO - ENV: RUST_BACKTRACE is now 1 00:38:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:38:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:38:38 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/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0379', '--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 00:38:38 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/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0379 --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 00:38:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7XZMRAZE08/Render', 00:38:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:38:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:38:38 INFO - 'HOME': '/Users/cltbld', 00:38:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:38:38 INFO - 'LOGNAME': 'cltbld', 00:38:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:38:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:38:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:38:38 INFO - 'MOZ_NO_REMOTE': '1', 00:38:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:38:38 INFO - 'NO_EM_RESTART': '1', 00:38:38 INFO - 'PAGER': '/bin/cat', 00:38:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:38:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:38:38 INFO - 'PWD': '/builds/slave/test', 00:38:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:38:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:38:38 INFO - 'RUST_BACKTRACE': '1', 00:38:38 INFO - 'SHELL': '/bin/bash', 00:38:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lHbwDcL1wL/Listeners', 00:38:38 INFO - 'TMPDIR': '/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/', 00:38:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:38:38 INFO - 'USER': 'cltbld', 00:38:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:38:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:38:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:38:38 INFO - 'XPC_FLAGS': '0x0', 00:38:38 INFO - 'XPC_SERVICE_NAME': '0', 00:38:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:38:38 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/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0379', '--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 00:38:38 INFO - mozversion application_buildid: 20170411153607 00:38:38 INFO - mozversion application_changeset: 099d239a4f861e204320e2c7fa81001fce31b2cf 00:38:38 INFO - mozversion application_display_name: Nightly 00:38:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:38:38 INFO - mozversion application_name: Firefox 00:38:38 INFO - mozversion application_remotingname: firefox 00:38:38 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 00:38:38 INFO - mozversion application_vendor: Mozilla 00:38:38 INFO - mozversion application_version: 55.0a1 00:38:38 INFO - mozversion platform_buildid: 20170411153607 00:38:38 INFO - mozversion platform_changeset: 099d239a4f861e204320e2c7fa81001fce31b2cf 00:38:38 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 00:38:38 INFO - mozversion platform_version: 55.0a1 00:38:38 INFO - using testdate: 1491982718 00:38:38 INFO - actual date: 1491982718 00:38:38 INFO - starting webserver on 'localhost:49249' 00:38:38 INFO - SUITE-START | Running 2 tests 00:38:38 INFO - TEST-START | dromaeo_css 00:38:38 INFO - operating with platform_type : mac_ 00:38:38 INFO - Initialising browser for dromaeo_css test... 00:38:38 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpY6yCp_/profile http://localhost:49249/getInfo.html) 00:38:41 INFO - PID 1634 | 2017-04-12 00:38:41.885 plugin-container[1636:7612] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e47, name = 'com.apple.tsm.portname' 00:38:41 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:38:41 INFO - PID 1634 | 2017-04-12 00:38:41.888 plugin-container[1636:7612] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4923, name = 'com.apple.CFPasteboardClient' 00:38:41 INFO - PID 1634 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:38:41 INFO - PID 1634 | 2017-04-12 00:38:41.888 plugin-container[1636:7612] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:38:41 INFO - PID 1634 | __metrics Screen width/height:1600/1200 00:38:41 INFO - PID 1634 | colorDepth:24 00:38:41 INFO - PID 1634 | Browser inner width/height: 1024/689 00:38:41 INFO - PID 1634 | __metrics 00:38:42 ERROR - PID 1634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 00:38:43 INFO - TEST-INFO | 1634: exit 0 00:38:43 INFO - Browser initialized. 00:38:43 INFO - Running cycle 1/1 for dromaeo_css test... 00:38:43 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpY6yCp_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:38:45 INFO - PID 1637 | 2017-04-12 00:38:45.576 plugin-container[1638:7744] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.tsm.portname' 00:38:45 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:38:45 INFO - PID 1637 | 2017-04-12 00:38:45.577 plugin-container[1638:7744] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b1b, name = 'com.apple.CFPasteboardClient' 00:38:45 INFO - PID 1637 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:38:45 INFO - PID 1637 | 2017-04-12 00:38:45.577 plugin-container[1638:7744] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:38:55 INFO - PID 1637 | RSS: Main: 235814912 00:38:55 INFO - PID 1637 | 00:41:59 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 00:42:01 INFO - PID 1637 | RSS: Main: 254070784 00:42:01 INFO - PID 1637 | 00:43:43 INFO - PID 1637 | ************************* 00:43:43 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 00:43:43 INFO - PID 1637 | 00:43:43 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 00:43:43 INFO - PID 1637 | Full stack: 00:43:43 INFO - PID 1637 | ************************* 00:43:43 INFO - PID 1637 | ************************* 00:43:43 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 00:43:43 INFO - PID 1637 | 00:43:43 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 00:43:43 INFO - PID 1637 | Full stack: 00:43:43 INFO - PID 1637 | ************************* 00:43:43 INFO - PID 1637 | ************************* 00:43:43 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 00:43:43 INFO - PID 1637 | 00:43:43 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 00:43:43 INFO - PID 1637 | Full stack: 00:43:43 INFO - PID 1637 | ************************* 00:43:43 INFO - PID 1637 | ************************* 00:43:43 INFO - PID 1637 | A coding exception was thrown and uncaught in a Task. 00:43:43 INFO - PID 1637 | 00:43:43 ERROR - PID 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 00:43:43 INFO - PID 1637 | Full stack: 00:43:43 INFO - PID 1637 | ************************* 00:45:03 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 00:45:03 INFO - PID 1637 | RSS: Main: 263045120 00:45:03 INFO - PID 1637 | 00:48:05 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 00:48:06 INFO - PID 1637 | RSS: Main: 275087360 00:48:06 INFO - PID 1637 | 00:51:07 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 00:51:08 INFO - PID 1637 | RSS: Main: 270573568 00:51:08 INFO - PID 1637 | 00:54:11 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 00:54:12 INFO - PID 1637 | RSS: Main: 281481216 00:54:12 INFO - PID 1637 | 00:57:13 INFO - PID 1637 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 00:57:14 INFO - PID 1637 | RSS: Main: 275091456 00:57:14 INFO - PID 1637 | 00:57:14 INFO - PID 1637 | __start_tp_report 00:57:14 INFO - PID 1637 | _x_x_mozilla_page_load 00:57:14 INFO - PID 1637 | _x_x_mozilla_page_load_details 00:57:14 INFO - PID 1637 | |i|pagename|runs| 00:57:14 INFO - PID 1637 | |0;dojo.html;3384.661533846616;3460.8615655373787;3544.184837487378;3558.9466158007617;3602.171500554871;5289.391719952202;5591.804286849956;6164.599301045429;6279;6303.495720342373;6175.536834737391;6212.751489940409;6232.84417889553;6264.21697287839;6302.1177035215105;4573.908521829561;5512.531434828034;5535.114381698929;5585.413531579186;5650.067738823089;5449.809256676017;5551.9722401387935;5634;5666.801661941833;5692.146178073281;5425.104857698475;5517.724113794295;5544.722763861791;5568.053430916713;5583.134614134816;5513.5864810139;5524.309461317335;5530.5852061095575;5550.5282051025715;5553;5420.186971954199;5468.179773034037;5487.149491828773;5490.258815059956;5523.088690366085;4755.619550435957;5924.259467566554;6219.720112594944;6236.844078898019;6251.531135164835;6707;6741.292164322774;6751.797446076625;6756.966215168942;6774.796756097325;6827.897581536281;6834.692438840264;6835.418989385858;6847.246802851682;6864.107666003438;6155.230596175478;6301.243850737941;6337;6364.1408409865;6366.458850997625;6878.449724022166;6921.48088893335;6946.861062778716;6953.721851126;6989.510734248655;6351.396617321347;6439.645819479973;6447;6607.900881486781;6663.300353462913;6303.212098487689;6572.07990881277;6669.733210671616;6801.65991700413;6834.4874134440115;6685.264620891698;6689.866202675919;6696.096027036385;6700.262971073178;6710.698018589175;6461.903071453838;6550.312217217219;6646.302138275508;6652.833679157963;6701.128853249046;5383.43473935239;5397.082495975694;5403.432639572867;5434.483724046209;5436.103042997861;4785.856424307276;4791.281307803788;4803.663743537989;4807.471178170398;4828.66199366041;5684.34630017545;5802.854928626733;6285.962816135378;6293.842653933597;6358.904616430757;6794.150731158606;6795.966020169867;6831.487638427038;6853;6865.5537390070485;6315.652639104802;6338.492920566344;6348.587341822767;6373.681315934185;6387.457066149336;5806.361300256968;5869.442402971711;5900.734466948912;6023.759049637965;6028.367021462771;6779.2542820288745;6871.690773915286;6924.3421874921805;6947.861042779217;6954.617496037767;6803.829904252235;6813.1142951415995;6828.897566536407;6831.28271531482;6835.521513494008;6857.897131543131;6910.619915904674;6953.721851126101;6976.058232138596;6987.021816945733;5507.917381239365;6444.838879027874;6524.575902566318;6548.672566371758;6624.30444803308;6810.118232607366;6834.384905358542;6840.692168852314;6843.589384636938;6845.828854278683;6257.561970662192;6435.806925792233;6444.548881578245;6535.738570457129;6582.473402127914;6501.317361676955;6604.240512341143;6608.339166083546;6614.636195009129;6617.305182955721;6251.374862513712;6289.654069026247;6326.810195694136;6359.20509936258;6453.580517266362;5398.595105367034;5559.360673522597;6473;6545.967270163619;6603.273639899511;5470.495613706263;5502.422245664147;5697.344805347272;6282.717277722422;6395.968020159869 00:57:14 INFO - PID 1637 | |1;ext.html;730.123851378346;1122.079894486521;1124.1175677093484;1124.9943750281248;1278.0733967873298;30186.849065754694;36735.81632091839;37423.87728368147;37477.25045499092;37535.81232093839;37212.44181337282;37373;37484.43773343395;37627.247455050885;37695.623043769556;7816.413768967322;8434.662613495453;8681.34889883258;8726.258268047224;8759.474431534096;8593.44142630727;8633.740987770378;8712.172343627377;8723.432976856515;8758.693445729401;8678.522681252529;8704.608292626846;8721.651133954634;8749.125087491264;8752.431091979;8642.13578642137;8691.304695624367;8733.432326898732;8734.86897696532;8741.388102832805;7049.436045116429;8452.408331416804;8498.70254541088;8510.48937063778;8510.978682558132;37038.88883333504;37260.62739372599;37298.813505932565;37317.81341093304;37446.25107497835;3679.9264014719824;3713.517242758424;3715.5912849586794;3716.8327425265657;3719.181780008421;30361.356637203455;30527.542086868714;30549.847250763603;30550.388992220254;30631.234219144477;3066.23344163959;3149.1969547765175;3150.889718859829;3169.984150079235;3181.109289398972;232984.50523242165;286351;295765.5211723949;295855.99999999785;298144;37229.627703723156;38396;45257.321140182925;45898.311525327146;46289.30566041512;49745.75127124414;49924;49968.750156248985;50033.9993200134;50051;11701.824472632918;14572.562823115324;14585.635359115895;14586.978911476306;14632.341544630517;9659.661911833193;9810.117089461983;11838.88161118395;11971;11972.700682483008;12726.981841452662;13181.934090329678;13234.536791212455;13239.404226809816;13249;5160.48395160481;5929.377415371324;5952.642841429528;5973.820785376446;5979.5515336349945;1002.8194924913586;1043.6868939318174;1072.860528131338;1095.8191898336686;1098.3629494892944;23016.424589385064;24009.91955362013;24189.879050604635;24369.756302437105;24493.75506244915;1149.844770955927;1158.8145896656495;1193.9223950443368;1199.064729510983;1205.3430880170329;12279.631611051684;12361;12368.505259789688;12392.62822115338;12407.627771166879;373707;373950;374769;378060;378498;43246.56753432488;53182;53479.395618131515;53636.46363536393;53815.923681526154;1353.35715535122;1367.412012834471;1536.9001014933995;1541.429671021729;1579.1867188397985;23533.882330588236;23533.882330588236;23624.763752362258;23690.763092369547;23701.28896133119;38122.809385952896;38156.04609884775;38256.426153607164;38265.852024439315;38333.616663834124;323790;324536;324620;324713.75286246836;325600;33847.83076084604;34048;34069;34863.30273394569;34917.650823491436;34634.48048279227;45396.31905521486;45457.77271113623;45567;45636.63090107302;24642;28747;29452.852735736185;31134.68865311318;31646.050618481484;24636.753632463446;30271.848640756656;30831.38337233198;30897.382052359277;31446.52830207503;35724.749633762694;35815.283694325444;35931.922042338774;36142.8192859034;36688.61524000931;31169;31229.063128106194;31398.372032558764;31529.21176970594;31620;22551.774482255623;22887.656685149403;24047.27858164188;24146.51706965886;24202 00:57:14 INFO - PID 1637 | |2;jquery.html;351.404369593539;415.2774172939085;429.89897374117095;432.6236174528161;436.8667556395299;20132.496687582818;21584.1366345346;22477.10091596336;22544.43638909024;22614.96465318121;18755.437336879917;22323.44191395216;22391.664125038136;22464.45592334667;22673;5250.921236181461;6304.369563043682;6343.397377249177;6352.301246862841;6354.110424540545;5992.5505587080925;6166.537509686769;6238.064290356438;6263.592866463688;6294.339094395092;6268.435840774329;6274.058891166339;6280.811575652738;6289.654069026202;6296.401841825019;6059.151718759377;6234.064890266473;6275.7489700411925;6285.3400392958765;6374.713137908805;4651.674382793206;5347.41178470368;5503.257060296889;5574.080276754331;5606.943930560683;19029.858208507532;24688.506229875482;27106.593401099;27120.32199195016;27145.45709085827;2250.7524172341027;2252.121672547708;2257.4807794207422;2296.7703229677068;2298.8965496552696;17869.642607147915;18037.549061273443;18178.454646360497;18349.99075050885;18498;2181.7709140540333;2199.0763879170786;2210.2706106984815;2237.496563273267;2239.104358256694;140868;140878.2956085223;141097.29451352678;141701;173700;12169.878301217052;12757.617271481871;12770.744585108247;13095.017873659513;13121.934390328179;16628.6674266514;16629.251683674265;16636.417725379553;16648.83351166473;16665.833341666672;8264.297534709496;8609.61256743448;8969.820603587892;9271.90728092724;9311.208547273558;8765.4740715556;8828.51443170619;8895.73312800617;9001.459912405277;9023.684171053981;6610.8016759497295;8056.274935255855;8056.959715201387;8068.919310806934;8079.515229086273;1989.5821877405906;2247.943801404978;2256.559970805677;2260.9321720348416;2435.293764808221;942.3544871762864;964.8842138943231;970.4613939263635;990.4552496127245;1012.3217444312328;21025.843578603017;21506.784932150793;21531.67702484464;21664.025118869373;21983.780162198495;981.7741919358588;1003.2142785841214;1004.5479534209635;1026.4662375564665;1026.8151732688038;11048.447577621248;11289.774204515863;11331.943340283411;11399.316041037564;11420;643630;678056.6097169482;714363;715946;732926;113431.86568134213;156390.4360956376;156819;158759.20620396824;168498;1147.2944139354404;1212.4362171590253;1241.075398827861;1254.5170109507906;1257.3147634539198;21924.671129932743;22689.886550567142;23063.88468057649;23717.288481345586;23737.64393534064;66836.99744503933;68072.6596367015;68132.82016301314;68307.31692683208;69532.3046769546;88474.11525884659;89861;89950;90008.5499572498;92138.53930730303;8795.956020219857;8894.955525222333;8927.508987005776;9181.495017774087;9347.672831451138;14378.568642940729;14466.710665786835;14564.708705826037;14766;14785.852141478448;9445.913719922297;11949.581764638197;12205.145639805129;12314.568990085305;12424.254544727346;10324.587016519255;10539.473026348805;11037.889621103686;11605.30368177912;11766.647000589996;12176.147669663038;12308.384580770746;12355.444005019976;12504.187227830162;12663.430145643653;9008.279337653103;9081.636734530544;9105.499197544199;9194.862077068716;9198.310126740387;11984.940075299568;12123.696907577028;12225.755484890431;12326.81509777372;12354.505819767468 00:57:14 INFO - PID 1637 | |3;mootools.html;1286.2218357893473;1383.8062671226028;1393.6306878677153;1407.9792150690748;1437.2382637202286;9251.352405331629;11487.081033517308;11766.588169414072;11837.526498940053;11979.101567382448;11801.7639647207;11875.51556055493;12035.578754743587;12055.51777928884;12090.274583524995;2501.399664080626;2522.419843436011;2532.7973762098986;2539.1240022192405;2545.5036267927762;2115.7249557557498;2449.534588428193;2526.6715327007464;2528.6080657498023;2530.8987640494356;2467.457159424933;2483.639872218527;2495.463475352799;2522.9747702523014;2527.9873600632063;2429.380507970456;2444.230067528723;2467.8272520923542;2478.1821998740375;2491.8911084567376;2414.215380001489;2471.53040922226;2486.614574740918;2489.751024897514;2530.8734563271946;11982.221155624857;12067.456964436622;12083.033357331393;12088.456019479057;12092;5768.7980920668;5839.8540036499;6468.223813142406;6700.994850772423;6796.286389929085;3949.3878448840474;4187.581241875819;4190.832366705328;4252.08580155265;4263.957360426387;1013.1793247469574;1077.8598782158347;1120.2942146447685;1129.170060005895;1238.9752204955942;14886.255687215596;15380.53858384239;16722.916385417993;16789.66420671592;16844.915775421043;5451.318585176853;5456.7544460499375;5640.830775076673;5641.717914104361;5653.378128405872;12223.572174973833;12413.44139513706;12426.5650702225;12439.440225189888;12440.875591244152;6545.672716364163;6624.337566243337;6627.966860165669;6636.336366363325;6638.20341559016;5997.630935780342;6182;6229.159063526366;6229.937700622936;6245.5628106033055;3806.4480650306105;4278.486581610165;4436.977815110904;4478.350639157304;4478.843240486567;1115.938623375722;1288.5232463988198;1313.507434711983;1319.5802421220692;1333.1534475607864;787.5550314072531;791.0902462168552;807.2976510435958;816.2082779703678;827.4786884262876;6148.477379422709;6172;6390.4248617624635;6393.424591786761;6405.615663060138;587.5417174603816;597.4622839444535;604.585858686801;610.984725381869;611.9143319935213;3495.4582039783872;3962.9405558916637;4187.664986801049;4244.1723863846255;4384.583464570861;13550.728985420237;14978.850211497964;15071.246437678072;15648.530544083696;15706.607334816492;14776;15486.922565387102;15504.379824807107;15520.767188492182;15552.611184720246;8963.596638151168;11130.888691112985;11198.888011119947;11206.159538034517;11217.551297948154;6038.909416358671;6995.510314277952;7111.293289610353;7180.748673796392;7221.350078492961;13038.348082596021;13045.412956416794;13203.66990825237;13277.804997550267;13364.064515483822;13319.600411987656;13560.98292628037;13887.541808110003;14266.64333391632;14418.567442976728;9551.665691700757;9652.372595781251;9663.565139568596;9733.659321923698;9801.16690081351;10810.513526891466;10851.240413171003;10949.890501094887;10958.726031849268;10961.83557246626;9099.272058235458;9306.348555601313;9357.298202634693;9366.859497107685;9531.189848862647;7483.289087536676;9096.909030909606;9111.043340449158;9159.084091590788;9177.036411176998;8187.345012398875;8187.345012399113;8249.505029697997;8305.83388332242;8316.916830831615;6005.909911351246;6018.277806663228;6110.633361998294;6217.751289948352;6239.438450539473;6054.1826853376;6101.450869421773;6169.321374648695;6295.150154729053;6309.1137173693305 00:57:14 INFO - PID 1637 | |4;prototype.html;333.0059771581828;386.50720331577236;399.50461427829464;413.00465877235865;413.0396827376349;5146.433892271856;5831.446012628804;6330.366963303667;6387.776427825027;6390.0605721368165;5078.978008085192;6026.866029664572;6162.630242185461;6178.845528861781;6184.659843708594;4492.820287188509;4504.932426013613;4512.887177820556;4526.7283962962165;4552.886177845564;3718.553773547178;4406.933895991563;4479.820807167709;4529.230030894756;4560.8403705870305;3632.946445530793;4444.511103778582;4456.442944631921;4462.531434199411;4472.038511719979;3876.9224615507533;4456.621187199092;4474.955250447487;4481.215787237221;4494.483134439549;3721.3859713147567;3787.5833658297565;3891.5330160380654;3897.279003384383;3898.9805050974564;5360.624756267063;5866.853328666817;5919.437653422918;5941.70291485424;5970.432808883149;4708.670393072486;4711.93981354196;5368.221607866876;5370.624056316059;5395.190721391783;5540.307461567304;5658.688772117532;5771.740271687784;6068.362821903681;6543.476521878239;3637.636236376341;3702.148505843671;4400.977995110036;4419.734815911023;4421.4694236691485;5474.72626368684;6856.6228857412325;6887.896681549781;6942.514024018321;7080.114985626797;4806.182948898696;4837.467878533358;4897.510248975074;4919.87700307488;4922.90154196914;4404.700613319079;4841.685290456109;5015.297858299841;5034.270030845507;5039.823606173766;5344.9732751336;5602.915956260659;5607.80372686954;5631.071842641803;5653.897489989413;5406.567474602101;6523.478121750249;6760.3239676032;6765.391114799691;6796.35434633709;1513.0240994558449;1584.7781310616524;1674.9413770517974;1696.9902907769858;1730.7057800174;886.5788750343535;1174.8883856033663;1180.8840645590008;1193.5046955513365;1201.7381749163344;5902.2622172228475;5959.851003724942;6257.2804127525005;6258.897574864471;6288.339724328879;5533.122776156376;6000.669963152069;6497.220333559909;6859.416949559343;6992.370686638227;6015.699215039231;6141.96929015361;6262.279837818709;6281.780137695158;6283.905741413882;3419.4186988212064;3528.541289632383;3578.982105089458;3585.8027808470783;3598.5501812273465;6549.919263321499;6729.461643068543;6744.898826517606;6817.5909445433435;7055.435565154775;5821.592488525763;6817.5227734059135;7010.228874823765;7084.185318688416;7135.785926422215;6492.805215843532;6673.833154171185;6929.1684997800585;6965.233824279427;7143.749968751069;5750.539956803362;5961.463468287875;6540.920748076514;6673.466122710074;6709.261981182163;5318.952203401641;5782.855428614318;6428.871422571616;6783.762568310085;6821.693023813841;6793.320667933167;7000.964995175195;7010.917085113456;7070.36366726997;7114.359707626339;3980.681545476413;4193.664506839506;4756.6908150970075;4886.65793394459;4909.9263511048075;6009.377468083506;6619.635920024445;6817.625030623363;6829.760958366433;6966.442684585119;6593.274739778524;6598;6602.22706463277;6642.90035649456;6717.261101278953;6036.8188954331445;6050.848728781815;6344.555881088464;6597.967010165111;6610.8016759497295;5950.315713692808;5963.0459126539545;6444.742210311535;6499.3175716549085;6500.154979852589;4883.90232195347;5553.4724201200825;5682.37493875665;6684.315684315684;6719.428848547928;4898.779554920108;6066.636001839904;6530.542861999805;6572.507061970276;6597.80206593803 00:57:14 INFO - PID 1637 | |5;yui.html;746.9626518674066;815.311062152481;823.0945959444615;837.8198687282234;863.6933888469594;13507.189568625878;14542.418303267857;15244.542663720078;15900.20498975051;16499.917500412495;14252.928735356309;16827.41104061358;17289.30842766291;17669.116544172804;17901.925884446944;789.4394979564516;981.5582987655548;986.1469828598283;986.2898712926682;987.9901200988006;1006.4011912911806;1007.7531004903772;1008.2891561449161;1008.4000019988132;1009.4296722351885;1049.6168898352084;1056.0706578211202;1061.2677252695653;1061.3578784835179;1062.2776511971856;1016.7254841192911;1040.2874031288554;1051.3796859852648;1054.1250761867632;1055.0293729768555;772.9381649468029;777.6850375597892;782.4444644302552;783.1307248953657;783.4241832253289;16558.83441165597;17139.057351845644;17381.478555643353;17441.953482790945;17454.912725436418;13461.865381346159;16758.74861877073;16795.412160574444;16964.575885602837;16998.3200671973;12296.20074695142;13594.524191653245;13985.510507132201;14164.716705665829;14199.929000355036;2967.887042359115;3351.6480769519335;3392.6946574808385;3412.2493051528872;3421.4354631485776;100152;117801;119105;119891;120859.39570302093;11761.588344407905;11842.230255033395;12223.877761222451;12233.082518811125;12271;20320.390388288375;20466.692999605017;20469.692954605693;20539.28112516055;20561.588768224552;8791.120887911158;9127.178553930178;9169.358144929924;9170.770730731785;9173.174414302612;4769.4753577107185;4820.108279968217;4847.854564363075;4855.781489832966;4867;4205.684573656988;4251.213525497793;4410.7353558785935;4414.521135419606;4414.779261037;923.6490133749267;952.1620973543238;952.8951815300311;963.677168148664;967.4437198610686;554.9472800083986;641.3394203969918;646.424682032991;648.7210499485267;692.2039654397483;10896.891031089746;11704.648860534198;11759.706007349885;11824.704382390337;12016.819747703792;588.3498733899065;620.2649859916014;621.9875602487925;653.5915053091818;663.787587971854;4600.493945665974;4860.1251774680895;5508.862278442991;5518.751656175482;5594.608377413623;103962.48018760009;105203.47398263113;106359;107016;109914.35128473079;95360;95557;96352.55471167938;96692.68190249604;97414;79633;83633.16366836375;85367;85508.57245713731;86005.56997214974;8950;9859.901400986186;10865.565377384815;11066;11119.999200072032;33496.83251583727;41566.168676626905;42604;43521.56478435302;43715.56284437115;43974.78012609916;54490.18264725953;54598.7270063663;54799.452005479434;55413;13114.934425327812;13689.31553422305;13847.099938503965;15457.768133478232;15724.371025159324;17675.171972484342;17750.822491774918;17775.466735997423;17933.103344832965;18003.459896203134;15865.52403427899;15949.043057416593;16045.67908641844;16274.67450651004;16373.93569417984;14071.296435177996;15781.842181578037;15926.920365398099;16079.67840643204;16138.515844524683;13146.539871104465;15506.457273995356;15656.843431565538;15988.840111598734;16018.599535011717;9794.363366381162;9839.704808855746;10011.699649010541;10099.192064634664;10167.542460589439;10801.567937282422;10849.511771970438;10969.616063437741;11030.393328367018;11058.336499810037 00:57:14 INFO - PID 1637 | __end_tp_report 00:57:14 INFO - PID 1637 | __start_cc_report 00:57:14 INFO - PID 1637 | _x_x_mozilla_cycle_collect,428 00:57:14 INFO - PID 1637 | __end_cc_report 00:57:14 INFO - PID 1637 | __startTimestamp1491983834193__endTimestamp 00:57:14 INFO - PID 1637 | 00:57:14 INFO - PID 1637 | ------- Summary: start ------- 00:57:14 INFO - PID 1637 | Number of tests: 6 00:57:14 INFO - PID 1637 | 00:57:14 INFO - PID 1637 | [#0] dojo.html Cycles:165 Average:6149.02 Median:6351.40 stddev:750.51 (11.8%) stddev-sans-first:720.80 00:57:14 INFO - PID 1637 | Values: 3384.7 3460.9 3544.2 3558.9 3602.2 5289.4 5591.8 6164.6 6279.0 6303.5 6175.5 6212.8 6232.8 6264.2 6302.1 4573.9 5512.5 5535.1 5585.4 5650.1 5449.8 5552.0 5634.0 5666.8 5692.1 5425.1 5517.7 5544.7 5568.1 5583.1 5513.6 5524.3 5530.6 5550.5 5553.0 5420.2 5468.2 5487.1 5490.3 5523.1 4755.6 5924.3 6219.7 6236.8 6251.5 6707.0 6741.3 6751.8 6757.0 6774.8 6827.9 6834.7 6835.4 6847.2 6864.1 6155.2 6301.2 6337.0 6364.1 6366.5 6878.4 6921.5 6946.9 6953.7 6989.5 6351.4 6439.6 6447.0 6607.9 6663.3 6303.2 6572.1 6669.7 6801.7 6834.5 6685.3 6689.9 6696.1 6700.3 6710.7 6461.9 6550.3 6646.3 6652.8 6701.1 5383.4 5397.1 5403.4 5434.5 5436.1 4785.9 4791.3 4803.7 4807.5 4828.7 5684.3 5802.9 6286.0 6293.8 6358.9 6794.2 6796.0 6831.5 6853.0 6865.6 6315.7 6338.5 6348.6 6373.7 6387.5 5806.4 5869.4 5900.7 6023.8 6028.4 6779.3 6871.7 6924.3 6947.9 6954.6 6803.8 6813.1 6828.9 6831.3 6835.5 6857.9 6910.6 6953.7 6976.1 6987.0 5507.9 6444.8 6524.6 6548.7 6624.3 6810.1 6834.4 6840.7 6843.6 6845.8 6257.6 6435.8 6444.5 6535.7 6582.5 6501.3 6604.2 6608.3 6614.6 6617.3 6251.4 6289.7 6326.8 6359.2 6453.6 5398.6 5559.4 6473.0 6546.0 6603.3 5470.5 5502.4 5697.3 6282.7 6396.0 00:57:14 INFO - PID 1637 | 00:57:14 INFO - PID 1637 | [#1] ext.html Cycles:180 Average:46987.68 Median:34351.74 stddev:86928.05 (253.1%) stddev-sans-first:87102.52 00:57:14 INFO - PID 1637 | Values: 730.1 1122.1 1124.1 1125.0 1278.1 30186.8 36735.8 37423.9 37477.3 37535.8 37212.4 37373.0 37484.4 37627.2 37695.6 7816.4 8434.7 8681.3 8726.3 8759.5 8593.4 8633.7 8712.2 8723.4 8758.7 8678.5 8704.6 8721.7 8749.1 8752.4 8642.1 8691.3 8733.4 8734.9 8741.4 7049.4 8452.4 8498.7 8510.5 8511.0 37038.9 37260.6 37298.8 37317.8 37446.3 3679.9 3713.5 3715.6 3716.8 3719.2 30361.4 30527.5 30549.8 30550.4 30631.2 3066.2 3149.2 3150.9 3170.0 3181.1 232984.5 286351.0 295765.5 295856.0 298144.0 37229.6 38396.0 45257.3 45898.3 46289.3 49745.8 49924.0 49968.8 50034.0 50051.0 11701.8 14572.6 14585.6 14587.0 14632.3 9659.7 9810.1 11838.9 11971.0 11972.7 12727.0 13181.9 13234.5 13239.4 13249.0 5160.5 5929.4 5952.6 5973.8 5979.6 1002.8 1043.7 1072.9 1095.8 1098.4 23016.4 24009.9 24189.9 24369.8 24493.8 1149.8 1158.8 1193.9 1199.1 1205.3 12279.6 12361.0 12368.5 12392.6 12407.6 373707.0 373950.0 374769.0 378060.0 378498.0 43246.6 53182.0 53479.4 53636.5 53815.9 1353.4 1367.4 1536.9 1541.4 1579.2 23533.9 23533.9 23624.8 23690.8 23701.3 38122.8 38156.0 38256.4 38265.9 38333.6 323790.0 324536.0 324620.0 324713.8 325600.0 33847.8 34048.0 34069.0 34863.3 34917.7 34634.5 45396.3 45457.8 45567.0 45636.6 24642.0 28747.0 29452.9 31134.7 31646.1 24636.8 30271.8 30831.4 30897.4 31446.5 35724.7 35815.3 35931.9 36142.8 36688.6 31169.0 31229.1 31398.4 31529.2 31620.0 22551.8 22887.7 24047.3 24146.5 24202.0 00:57:14 INFO - PID 1637 | 00:57:14 INFO - PID 1637 | [#2] jquery.html Cycles:180 Average:40886.50 Median:12437.95 stddev:116910.87 (940.0%) stddev-sans-first:117199.22 00:57:14 INFO - PID 1637 | Values: 351.4 415.3 429.9 432.6 436.9 20132.5 21584.1 22477.1 22544.4 22615.0 18755.4 22323.4 22391.7 22464.5 22673.0 5250.9 6304.4 6343.4 6352.3 6354.1 5992.6 6166.5 6238.1 6263.6 6294.3 6268.4 6274.1 6280.8 6289.7 6296.4 6059.2 6234.1 6275.7 6285.3 6374.7 4651.7 5347.4 5503.3 5574.1 5606.9 19029.9 24688.5 27106.6 27120.3 27145.5 2250.8 2252.1 2257.5 2296.8 2298.9 17869.6 18037.5 18178.5 18350.0 18498.0 2181.8 2199.1 2210.3 2237.5 2239.1 140868.0 140878.3 141097.3 141701.0 173700.0 12169.9 12757.6 12770.7 13095.0 13121.9 16628.7 16629.3 16636.4 16648.8 16665.8 8264.3 8609.6 8969.8 9271.9 9311.2 8765.5 8828.5 8895.7 9001.5 9023.7 6610.8 8056.3 8057.0 8068.9 8079.5 1989.6 2247.9 2256.6 2260.9 2435.3 942.4 964.9 970.5 990.5 1012.3 21025.8 21506.8 21531.7 21664.0 21983.8 981.8 1003.2 1004.5 1026.5 1026.8 11048.4 11289.8 11331.9 11399.3 11420.0 643630.0 678056.6 714363.0 715946.0 732926.0 113431.9 156390.4 156819.0 158759.2 168498.0 1147.3 1212.4 1241.1 1254.5 1257.3 21924.7 22689.9 23063.9 23717.3 23737.6 66837.0 68072.7 68132.8 68307.3 69532.3 88474.1 89861.0 89950.0 90008.5 92138.5 8796.0 8895.0 8927.5 9181.5 9347.7 14378.6 14466.7 14564.7 14766.0 14785.9 9445.9 11949.6 12205.1 12314.6 12424.3 10324.6 10539.5 11037.9 11605.3 11766.6 12176.1 12308.4 12355.4 12504.2 12663.4 9008.3 9081.6 9105.5 9194.9 9198.3 11984.9 12123.7 12225.8 12326.8 12354.5 00:57:14 INFO - PID 1637 | 00:57:14 INFO - PID 1637 | [#3] mootools.html Cycles:180 Average:7201.53 Median:2535.96 stddev:4607.42 (181.7%) stddev-sans-first:4598.90 00:57:14 INFO - PID 1637 | Values: 1286.2 1383.8 1393.6 1408.0 1437.2 9251.4 11487.1 11766.6 11837.5 11979.1 11801.8 11875.5 12035.6 12055.5 12090.3 2501.4 2522.4 2532.8 2539.1 2545.5 2115.7 2449.5 2526.7 2528.6 2530.9 2467.5 2483.6 2495.5 2523.0 2528.0 2429.4 2444.2 2467.8 2478.2 2491.9 2414.2 2471.5 2486.6 2489.8 2530.9 11982.2 12067.5 12083.0 12088.5 12092.0 5768.8 5839.9 6468.2 6701.0 6796.3 3949.4 4187.6 4190.8 4252.1 4264.0 1013.2 1077.9 1120.3 1129.2 1239.0 14886.3 15380.5 16722.9 16789.7 16844.9 5451.3 5456.8 5640.8 5641.7 5653.4 12223.6 12413.4 12426.6 12439.4 12440.9 6545.7 6624.3 6628.0 6636.3 6638.2 5997.6 6182.0 6229.2 6229.9 6245.6 3806.4 4278.5 4437.0 4478.4 4478.8 1115.9 1288.5 1313.5 1319.6 1333.2 787.6 791.1 807.3 816.2 827.5 6148.5 6172.0 6390.4 6393.4 6405.6 587.5 597.5 604.6 611.0 611.9 3495.5 3962.9 4187.7 4244.2 4384.6 13550.7 14978.9 15071.2 15648.5 15706.6 14776.0 15486.9 15504.4 15520.8 15552.6 8963.6 11130.9 11198.9 11206.2 11217.6 6038.9 6995.5 7111.3 7180.7 7221.4 13038.3 13045.4 13203.7 13277.8 13364.1 13319.6 13561.0 13887.5 14266.6 14418.6 9551.7 9652.4 9663.6 9733.7 9801.2 10810.5 10851.2 10949.9 10958.7 10961.8 9099.3 9306.3 9357.3 9366.9 9531.2 7483.3 9096.9 9111.0 9159.1 9177.0 8187.3 8187.3 8249.5 8305.8 8316.9 6005.9 6018.3 6110.6 6217.8 6239.4 6054.2 6101.5 6169.3 6295.2 6309.1 00:57:14 INFO - PID 1637 | 00:57:14 INFO - PID 1637 | [#4] prototype.html Cycles:180 Average:5290.89 Median:5826.52 stddev:1636.47 (28.1%) stddev-sans-first:1598.19 00:57:14 INFO - PID 1637 | Values: 333.0 386.5 399.5 413.0 413.0 5146.4 5831.4 6330.4 6387.8 6390.1 5079.0 6026.9 6162.6 6178.8 6184.7 4492.8 4504.9 4512.9 4526.7 4552.9 3718.6 4406.9 4479.8 4529.2 4560.8 3632.9 4444.5 4456.4 4462.5 4472.0 3876.9 4456.6 4475.0 4481.2 4494.5 3721.4 3787.6 3891.5 3897.3 3899.0 5360.6 5866.9 5919.4 5941.7 5970.4 4708.7 4711.9 5368.2 5370.6 5395.2 5540.3 5658.7 5771.7 6068.4 6543.5 3637.6 3702.1 4401.0 4419.7 4421.5 5474.7 6856.6 6887.9 6942.5 7080.1 4806.2 4837.5 4897.5 4919.9 4922.9 4404.7 4841.7 5015.3 5034.3 5039.8 5345.0 5602.9 5607.8 5631.1 5653.9 5406.6 6523.5 6760.3 6765.4 6796.4 1513.0 1584.8 1674.9 1697.0 1730.7 886.6 1174.9 1180.9 1193.5 1201.7 5902.3 5959.9 6257.3 6258.9 6288.3 5533.1 6000.7 6497.2 6859.4 6992.4 6015.7 6142.0 6262.3 6281.8 6283.9 3419.4 3528.5 3579.0 3585.8 3598.6 6549.9 6729.5 6744.9 6817.6 7055.4 5821.6 6817.5 7010.2 7084.2 7135.8 6492.8 6673.8 6929.2 6965.2 7143.7 5750.5 5961.5 6540.9 6673.5 6709.3 5319.0 5782.9 6428.9 6783.8 6821.7 6793.3 7001.0 7010.9 7070.4 7114.4 3980.7 4193.7 4756.7 4886.7 4909.9 6009.4 6619.6 6817.6 6829.8 6966.4 6593.3 6598.0 6602.2 6642.9 6717.3 6036.8 6050.8 6344.6 6598.0 6610.8 5950.3 5963.0 6444.7 6499.3 6500.2 4883.9 5553.5 5682.4 6684.3 6719.4 4898.8 6066.6 6530.5 6572.5 6597.8 00:57:14 INFO - PID 1637 | 00:57:14 INFO - PID 1637 | [#5] yui.html Cycles:180 Average:21229.14 Median:17713.00 stddev:30396.79 (171.6%) stddev-sans-first:30443.16 00:57:14 INFO - PID 1637 | Values: 747.0 815.3 823.1 837.8 863.7 13507.2 14542.4 15244.5 15900.2 16499.9 14252.9 16827.4 17289.3 17669.1 17901.9 789.4 981.6 986.1 986.3 988.0 1006.4 1007.8 1008.3 1008.4 1009.4 1049.6 1056.1 1061.3 1061.4 1062.3 1016.7 1040.3 1051.4 1054.1 1055.0 772.9 777.7 782.4 783.1 783.4 16558.8 17139.1 17381.5 17442.0 17454.9 13461.9 16758.7 16795.4 16964.6 16998.3 12296.2 13594.5 13985.5 14164.7 14199.9 2967.9 3351.6 3392.7 3412.2 3421.4 100152.0 117801.0 119105.0 119891.0 120859.4 11761.6 11842.2 12223.9 12233.1 12271.0 20320.4 20466.7 20469.7 20539.3 20561.6 8791.1 9127.2 9169.4 9170.8 9173.2 4769.5 4820.1 4847.9 4855.8 4867.0 4205.7 4251.2 4410.7 4414.5 4414.8 923.6 952.2 952.9 963.7 967.4 554.9 641.3 646.4 648.7 692.2 10896.9 11704.6 11759.7 11824.7 12016.8 588.3 620.3 622.0 653.6 663.8 4600.5 4860.1 5508.9 5518.8 5594.6 103962.5 105203.5 106359.0 107016.0 109914.4 95360.0 95557.0 96352.6 96692.7 97414.0 79633.0 83633.2 85367.0 85508.6 86005.6 8950.0 9859.9 10865.6 11066.0 11120.0 33496.8 41566.2 42604.0 43521.6 43715.6 43974.8 54490.2 54598.7 54799.5 55413.0 13114.9 13689.3 13847.1 15457.8 15724.4 17675.2 17750.8 17775.5 17933.1 18003.5 15865.5 15949.0 16045.7 16274.7 16373.9 14071.3 15781.8 15926.9 16079.7 16138.5 13146.5 15506.5 15656.8 15988.8 16018.6 9794.4 9839.7 10011.7 10099.2 10167.5 10801.6 10849.5 10969.6 11030.4 11058.3 00:57:14 INFO - PID 1637 | -------- Summary: end -------- 00:57:14 INFO - PID 1637 | 00:57:14 INFO - TEST-INFO | 1637: exit 0 00:57:15 INFO - TEST-OK | dromaeo_css | took 1116414ms 00:57:15 INFO - TEST-START | kraken 00:57:15 INFO - operating with platform_type : mac_ 00:57:15 INFO - Initialising browser for kraken test... 00:57:15 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpRZjsiK/profile http://localhost:49249/getInfo.html) 00:57:17 INFO - PID 1649 | 2017-04-12 00:57:17.704 plugin-container[1650:10151] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 00:57:17 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:57:17 INFO - PID 1649 | 2017-04-12 00:57:17.707 plugin-container[1650:10151] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 00:57:17 INFO - PID 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:57:17 INFO - PID 1649 | 2017-04-12 00:57:17.707 plugin-container[1650:10151] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:57:17 INFO - PID 1649 | __metrics Screen width/height:1600/1200 00:57:17 INFO - PID 1649 | colorDepth:24 00:57:17 INFO - PID 1649 | Browser inner width/height: 1024/689 00:57:17 INFO - PID 1649 | __metrics 00:57:17 ERROR - PID 1649 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 00:57:18 INFO - TEST-INFO | 1649: exit 0 00:57:18 INFO - Browser initialized. 00:57:18 INFO - Running cycle 1/1 for kraken test... 00:57:18 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c3/8q485yn95ydb1p5724v877vr00000w/T/tmpRZjsiK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:57:21 INFO - PID 1651 | 2017-04-12 00:57:21.517 plugin-container[1652:10273] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8833, name = 'com.apple.tsm.portname' 00:57:21 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:57:21 INFO - PID 1651 | 2017-04-12 00:57:21.518 plugin-container[1652:10273] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a17, name = 'com.apple.CFPasteboardClient' 00:57:21 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:57:21 INFO - PID 1651 | 2017-04-12 00:57:21.518 plugin-container[1652:10273] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:57:31 INFO - PID 1651 | RSS: Main: 235249664 00:57:31 INFO - PID 1651 | 00:57:34 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 00:57:35 INFO - PID 1651 | RSS: Main: 250343424 00:57:35 INFO - PID 1651 | 00:57:37 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 00:57:38 INFO - PID 1651 | RSS: Main: 259137536 00:57:38 INFO - PID 1651 | 00:57:42 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 00:57:42 INFO - PID 1651 | RSS: Main: 260927488 00:57:42 INFO - PID 1651 | 00:57:44 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 00:57:45 INFO - PID 1651 | RSS: Main: 261943296 00:57:45 INFO - PID 1651 | 00:57:47 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:57:48 INFO - PID 1651 | RSS: Main: 263622656 00:57:48 INFO - PID 1651 | 00:57:51 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 00:57:52 INFO - PID 1651 | RSS: Main: 268951552 00:57:52 INFO - PID 1651 | 00:57:55 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 00:57:55 INFO - PID 1651 | RSS: Main: 269787136 00:57:55 INFO - PID 1651 | 00:57:59 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 00:57:59 INFO - PID 1651 | RSS: Main: 269602816 00:57:59 INFO - PID 1651 | 00:58:01 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:58:02 INFO - PID 1651 | RSS: Main: 269242368 00:58:02 INFO - PID 1651 | 00:58:04 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:58:04 INFO - PID 1651 | RSS: Main: 269168640 00:58:04 INFO - PID 1651 | 00:58:07 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:58:07 INFO - PID 1651 | RSS: Main: 269271040 00:58:07 INFO - PID 1651 | 00:58:10 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:58:11 INFO - PID 1651 | RSS: Main: 269557760 00:58:11 INFO - PID 1651 | 00:58:15 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:58:15 INFO - PID 1651 | RSS: Main: 267026432 00:58:15 INFO - PID 1651 | 00:58:17 INFO - PID 1651 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 00:58:18 INFO - PID 1651 | RSS: Main: 270118912 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | __start_tp_report 00:58:18 INFO - PID 1651 | _x_x_mozilla_page_load 00:58:18 INFO - PID 1651 | _x_x_mozilla_page_load_details 00:58:18 INFO - PID 1651 | |i|pagename|runs| 00:58:18 INFO - PID 1651 | |0;ai-astar;113;126;126;124;145;184;125;125;125;126 00:58:18 INFO - PID 1651 | |1;audio-beat-detection;204;120;157;200;123;117;131;112;127;122 00:58:18 INFO - PID 1651 | |2;audio-dft;286;293;231;216;220;214;214;214;209;217 00:58:18 INFO - PID 1651 | |3;audio-fft;79;60;65;94;63;62;59;61;68;83 00:58:18 INFO - PID 1651 | |4;audio-oscillator;94;107;120;75;74;75;94;67;74;87 00:58:18 INFO - PID 1651 | |5;imaging-gaussian-blur;88;97;96;96;97;98;102;141;104;142 00:58:18 INFO - PID 1651 | |6;imaging-darkroom;109;163;103;103;105;102;103;104;102;105 00:58:18 INFO - PID 1651 | |7;imaging-desaturate;106;105;102;102;102;148;103;102;102;129 00:58:18 INFO - PID 1651 | |8;json-parse-financial;46;48;75;84;86;66;53;54;55;55 00:58:18 INFO - PID 1651 | |9;json-stringify-tinderbox;62;61;70;68;104;100;91;89;69;60 00:58:18 INFO - PID 1651 | |10;stanford-crypto-aes;98;116;117;118;100;119;117;84;115;117 00:58:18 INFO - PID 1651 | |11;stanford-crypto-ccm;193;150;169;157;145;146;146;157;211;185 00:58:18 INFO - PID 1651 | |12;stanford-crypto-pbkdf2;209;210;201;195;197;198;199;196;229;259 00:58:18 INFO - PID 1651 | |13;stanford-crypto-sha256-iterative;77;74;98;108;88;114;105;101;101;74 00:58:18 INFO - PID 1651 | __end_tp_report 00:58:18 INFO - PID 1651 | __start_cc_report 00:58:18 INFO - PID 1651 | _x_x_mozilla_cycle_collect,1054 00:58:18 INFO - PID 1651 | __end_cc_report 00:58:18 INFO - PID 1651 | __startTimestamp1491983898027__endTimestamp 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | ------- Summary: start ------- 00:58:18 INFO - PID 1651 | Number of tests: 14 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#0] ai-astar Cycles:10 Average:131.90 Median:126.00 stddev:19.87 (15.8%) stddev-sans-first:19.86 00:58:18 INFO - PID 1651 | Values: 113.0 126.0 126.0 124.0 145.0 184.0 125.0 125.0 125.0 126.0 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#1] audio-beat-detection Cycles:10 Average:141.30 Median:129.00 stddev:34.23 (26.5%) stddev-sans-first:27.78 00:58:18 INFO - PID 1651 | Values: 204.0 120.0 157.0 200.0 123.0 117.0 131.0 112.0 127.0 122.0 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#2] audio-dft Cycles:10 Average:231.40 Median:218.50 stddev:31.20 (14.3%) stddev-sans-first:26.10 00:58:18 INFO - PID 1651 | Values: 286.0 293.0 231.0 216.0 220.0 214.0 214.0 214.0 209.0 217.0 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#3] audio-fft Cycles:10 Average:69.40 Median:66.50 stddev:11.86 (17.8%) stddev-sans-first:12.06 00:58:18 INFO - PID 1651 | Values: 79.0 60.0 65.0 94.0 63.0 62.0 59.0 61.0 68.0 83.0 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#4] audio-oscillator Cycles:10 Average:86.70 Median:75.00 stddev:17.04 (22.7%) stddev-sans-first:17.86 00:58:18 INFO - PID 1651 | Values: 94.0 107.0 120.0 75.0 74.0 75.0 94.0 67.0 74.0 87.0 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:106.10 Median:96.00 stddev:19.12 (19.9%) stddev-sans-first:19.13 00:58:18 INFO - PID 1651 | Values: 88.0 97.0 96.0 96.0 97.0 98.0 102.0 141.0 104.0 142.0 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#6] imaging-darkroom Cycles:10 Average:109.90 Median:104.50 stddev:18.77 (18.0%) stddev-sans-first:19.91 00:58:18 INFO - PID 1651 | Values: 109.0 163.0 103.0 103.0 105.0 102.0 103.0 104.0 102.0 105.0 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#7] imaging-desaturate Cycles:10 Average:110.10 Median:104.00 stddev:15.69 (15.1%) stddev-sans-first:16.57 00:58:18 INFO - PID 1651 | Values: 106.0 105.0 102.0 102.0 102.0 148.0 103.0 102.0 102.0 129.0 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:60.50 stddev:14.68 (24.3%) stddev-sans-first:14.35 00:58:18 INFO - PID 1651 | Values: 46.0 48.0 75.0 84.0 86.0 66.0 53.0 54.0 55.0 55.0 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:77.40 Median:68.50 stddev:16.87 (24.6%) stddev-sans-first:16.94 00:58:18 INFO - PID 1651 | Values: 62.0 61.0 70.0 68.0 104.0 100.0 91.0 89.0 69.0 60.0 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#10] stanford-crypto-aes Cycles:10 Average:110.10 Median:117.50 stddev:11.89 (10.1%) stddev-sans-first:11.78 00:58:18 INFO - PID 1651 | Values: 98.0 116.0 117.0 118.0 100.0 119.0 117.0 84.0 115.0 117.0 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:165.90 Median:163.00 stddev:23.05 (14.1%) stddev-sans-first:22.27 00:58:18 INFO - PID 1651 | Values: 193.0 150.0 169.0 157.0 145.0 146.0 146.0 157.0 211.0 185.0 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:209.30 Median:205.00 stddev:20.26 (9.9%) stddev-sans-first:21.49 00:58:18 INFO - PID 1651 | Values: 209.0 210.0 201.0 195.0 197.0 198.0 199.0 196.0 229.0 259.0 00:58:18 INFO - PID 1651 | 00:58:18 INFO - PID 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:94.00 Median:74.00 stddev:14.74 (19.9%) stddev-sans-first:14.30 00:58:18 INFO - PID 1651 | Values: 77.0 74.0 98.0 108.0 88.0 114.0 105.0 101.0 101.0 74.0 00:58:18 INFO - PID 1651 | -------- Summary: end -------- 00:58:18 INFO - PID 1651 | 00:58:19 INFO - TEST-INFO | 1651: exit 0 00:58:19 INFO - TEST-OK | kraken | took 64084ms 00:58:19 INFO - SUITE-END | took 1180s 00:58:19 INFO - Completed test suite (00:19:40) 00:58:19 INFO - javascript benchmark 00:58:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7889.338730169116, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3384.661533846616, 3460.8615655373787, 3544.184837487378, 3558.9466158007617, 3602.171500554871, 5289.391719952202, 5591.804286849956, 6164.599301045429, 6279.0, 6303.495720342373, 6175.536834737391, 6212.751489940409, 6232.84417889553, 6264.21697287839, 6302.1177035215105, 4573.908521829561, 5512.531434828034, 5535.114381698929, 5585.413531579186, 5650.067738823089, 5449.809256676017, 5551.9722401387935, 5634.0, 5666.801661941833, 5692.146178073281, 5425.104857698475, 5517.724113794295, 5544.722763861791, 5568.053430916713, 5583.134614134816, 5513.5864810139, 5524.309461317335, 5530.5852061095575, 5550.5282051025715, 5553.0, 5420.186971954199, 5468.179773034037, 5487.149491828773, 5490.258815059956, 5523.088690366085, 4755.619550435957, 5924.259467566554, 6219.720112594944, 6236.844078898019, 6251.531135164835, 6707.0, 6741.292164322774, 6751.797446076625, 6756.966215168942, 6774.796756097325, 6827.897581536281, 6834.692438840264, 6835.418989385858, 6847.246802851682, 6864.107666003438, 6155.230596175478, 6301.243850737941, 6337.0, 6364.1408409865, 6366.458850997625, 6878.449724022166, 6921.48088893335, 6946.861062778716, 6953.721851126, 6989.510734248655, 6351.396617321347, 6439.645819479973, 6447.0, 6607.900881486781, 6663.300353462913, 6303.212098487689, 6572.07990881277, 6669.733210671616, 6801.65991700413, 6834.4874134440115, 6685.264620891698, 6689.866202675919, 6696.096027036385, 6700.262971073178, 6710.698018589175, 6461.903071453838, 6550.312217217219, 6646.302138275508, 6652.833679157963, 6701.128853249046, 5383.43473935239, 5397.082495975694, 5403.432639572867, 5434.483724046209, 5436.103042997861, 4785.856424307276, 4791.281307803788, 4803.663743537989, 4807.471178170398, 4828.66199366041, 5684.34630017545, 5802.854928626733, 6285.962816135378, 6293.842653933597, 6358.904616430757, 6794.150731158606, 6795.966020169867, 6831.487638427038, 6853.0, 6865.5537390070485, 6315.652639104802, 6338.492920566344, 6348.587341822767, 6373.681315934185, 6387.457066149336, 5806.361300256968, 5869.442402971711, 5900.734466948912, 6023.759049637965, 6028.367021462771, 6779.2542820288745, 6871.690773915286, 6924.3421874921805, 6947.861042779217, 6954.617496037767, 6803.829904252235, 6813.1142951415995, 6828.897566536407, 6831.28271531482, 6835.521513494008, 6857.897131543131, 6910.619915904674, 6953.721851126101, 6976.058232138596, 6987.021816945733, 5507.917381239365, 6444.838879027874, 6524.575902566318, 6548.672566371758, 6624.30444803308, 6810.118232607366, 6834.384905358542, 6840.692168852314, 6843.589384636938, 6845.828854278683, 6257.561970662192, 6435.806925792233, 6444.548881578245, 6535.738570457129, 6582.473402127914, 6501.317361676955, 6604.240512341143, 6608.339166083546, 6614.636195009129, 6617.305182955721, 6251.374862513712, 6289.654069026247, 6326.810195694136, 6359.20509936258, 6453.580517266362, 5398.595105367034, 5559.360673522597, 6473.0, 6545.967270163619, 6603.273639899511, 5470.495613706263, 5502.422245664147, 5697.344805347272, 6282.717277722422, 6395.968020159869], "value": 6099.491798793839, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [730.123851378346, 1122.079894486521, 1124.1175677093484, 1124.9943750281248, 1278.0733967873298, 30186.849065754694, 36735.81632091839, 37423.87728368147, 37477.25045499092, 37535.81232093839, 37212.44181337282, 37373.0, 37484.43773343395, 37627.247455050885, 37695.623043769556, 7816.413768967322, 8434.662613495453, 8681.34889883258, 8726.258268047224, 8759.474431534096, 8593.44142630727, 8633.740987770378, 8712.172343627377, 8723.432976856515, 8758.693445729401, 8678.522681252529, 8704.608292626846, 8721.651133954634, 8749.125087491264, 8752.431091979, 8642.13578642137, 8691.304695624367, 8733.432326898732, 8734.86897696532, 8741.388102832805, 7049.436045116429, 8452.408331416804, 8498.70254541088, 8510.48937063778, 8510.978682558132, 37038.88883333504, 37260.62739372599, 37298.813505932565, 37317.81341093304, 37446.25107497835, 3679.9264014719824, 3713.517242758424, 3715.5912849586794, 3716.8327425265657, 3719.181780008421, 30361.356637203455, 30527.542086868714, 30549.847250763603, 30550.388992220254, 30631.234219144477, 3066.23344163959, 3149.1969547765175, 3150.889718859829, 3169.984150079235, 3181.109289398972, 232984.50523242165, 286351.0, 295765.5211723949, 295855.99999999785, 298144.0, 37229.627703723156, 38396.0, 45257.321140182925, 45898.311525327146, 46289.30566041512, 49745.75127124414, 49924.0, 49968.750156248985, 50033.9993200134, 50051.0, 11701.824472632918, 14572.562823115324, 14585.635359115895, 14586.978911476306, 14632.341544630517, 9659.661911833193, 9810.117089461983, 11838.88161118395, 11971.0, 11972.700682483008, 12726.981841452662, 13181.934090329678, 13234.536791212455, 13239.404226809816, 13249.0, 5160.48395160481, 5929.377415371324, 5952.642841429528, 5973.820785376446, 5979.5515336349945, 1002.8194924913586, 1043.6868939318174, 1072.860528131338, 1095.8191898336686, 1098.3629494892944, 23016.424589385064, 24009.91955362013, 24189.879050604635, 24369.756302437105, 24493.75506244915, 1149.844770955927, 1158.8145896656495, 1193.9223950443368, 1199.064729510983, 1205.3430880170329, 12279.631611051684, 12361.0, 12368.505259789688, 12392.62822115338, 12407.627771166879, 373707.0, 373950.0, 374769.0, 378060.0, 378498.0, 43246.56753432488, 53182.0, 53479.395618131515, 53636.46363536393, 53815.923681526154, 1353.35715535122, 1367.412012834471, 1536.9001014933995, 1541.429671021729, 1579.1867188397985, 23533.882330588236, 23533.882330588236, 23624.763752362258, 23690.763092369547, 23701.28896133119, 38122.809385952896, 38156.04609884775, 38256.426153607164, 38265.852024439315, 38333.616663834124, 323790.0, 324536.0, 324620.0, 324713.75286246836, 325600.0, 33847.83076084604, 34048.0, 34069.0, 34863.30273394569, 34917.650823491436, 34634.48048279227, 45396.31905521486, 45457.77271113623, 45567.0, 45636.63090107302, 24642.0, 28747.0, 29452.852735736185, 31134.68865311318, 31646.050618481484, 24636.753632463446, 30271.848640756656, 30831.38337233198, 30897.382052359277, 31446.52830207503, 35724.749633762694, 35815.283694325444, 35931.922042338774, 36142.8192859034, 36688.61524000931, 31169.0, 31229.063128106194, 31398.372032558764, 31529.21176970594, 31620.0, 22551.774482255623, 22887.656685149403, 24047.27858164188, 24146.51706965886, 24202.0], "value": 17584.377788003003, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.404369593539, 415.2774172939085, 429.89897374117095, 432.6236174528161, 436.8667556395299, 20132.496687582818, 21584.1366345346, 22477.10091596336, 22544.43638909024, 22614.96465318121, 18755.437336879917, 22323.44191395216, 22391.664125038136, 22464.45592334667, 22673.0, 5250.921236181461, 6304.369563043682, 6343.397377249177, 6352.301246862841, 6354.110424540545, 5992.5505587080925, 6166.537509686769, 6238.064290356438, 6263.592866463688, 6294.339094395092, 6268.435840774329, 6274.058891166339, 6280.811575652738, 6289.654069026202, 6296.401841825019, 6059.151718759377, 6234.064890266473, 6275.7489700411925, 6285.3400392958765, 6374.713137908805, 4651.674382793206, 5347.41178470368, 5503.257060296889, 5574.080276754331, 5606.943930560683, 19029.858208507532, 24688.506229875482, 27106.593401099, 27120.32199195016, 27145.45709085827, 2250.7524172341027, 2252.121672547708, 2257.4807794207422, 2296.7703229677068, 2298.8965496552696, 17869.642607147915, 18037.549061273443, 18178.454646360497, 18349.99075050885, 18498.0, 2181.7709140540333, 2199.0763879170786, 2210.2706106984815, 2237.496563273267, 2239.104358256694, 140868.0, 140878.2956085223, 141097.29451352678, 141701.0, 173700.0, 12169.878301217052, 12757.617271481871, 12770.744585108247, 13095.017873659513, 13121.934390328179, 16628.6674266514, 16629.251683674265, 16636.417725379553, 16648.83351166473, 16665.833341666672, 8264.297534709496, 8609.61256743448, 8969.820603587892, 9271.90728092724, 9311.208547273558, 8765.4740715556, 8828.51443170619, 8895.73312800617, 9001.459912405277, 9023.684171053981, 6610.8016759497295, 8056.274935255855, 8056.959715201387, 8068.919310806934, 8079.515229086273, 1989.5821877405906, 2247.943801404978, 2256.559970805677, 2260.9321720348416, 2435.293764808221, 942.3544871762864, 964.8842138943231, 970.4613939263635, 990.4552496127245, 1012.3217444312328, 21025.843578603017, 21506.784932150793, 21531.67702484464, 21664.025118869373, 21983.780162198495, 981.7741919358588, 1003.2142785841214, 1004.5479534209635, 1026.4662375564665, 1026.8151732688038, 11048.447577621248, 11289.774204515863, 11331.943340283411, 11399.316041037564, 11420.0, 643630.0, 678056.6097169482, 714363.0, 715946.0, 732926.0, 113431.86568134213, 156390.4360956376, 156819.0, 158759.20620396824, 168498.0, 1147.2944139354404, 1212.4362171590253, 1241.075398827861, 1254.5170109507906, 1257.3147634539198, 21924.671129932743, 22689.886550567142, 23063.88468057649, 23717.288481345586, 23737.64393534064, 66836.99744503933, 68072.6596367015, 68132.82016301314, 68307.31692683208, 69532.3046769546, 88474.11525884659, 89861.0, 89950.0, 90008.5499572498, 92138.53930730303, 8795.956020219857, 8894.955525222333, 8927.508987005776, 9181.495017774087, 9347.672831451138, 14378.568642940729, 14466.710665786835, 14564.708705826037, 14766.0, 14785.852141478448, 9445.913719922297, 11949.581764638197, 12205.145639805129, 12314.568990085305, 12424.254544727346, 10324.587016519255, 10539.473026348805, 11037.889621103686, 11605.30368177912, 11766.647000589996, 12176.147669663038, 12308.384580770746, 12355.444005019976, 12504.187227830162, 12663.430145643653, 9008.279337653103, 9081.636734530544, 9105.499197544199, 9194.862077068716, 9198.310126740387, 11984.940075299568, 12123.696907577028, 12225.755484890431, 12326.81509777372, 12354.505819767468], "value": 10797.112922480157, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1286.2218357893473, 1383.8062671226028, 1393.6306878677153, 1407.9792150690748, 1437.2382637202286, 9251.352405331629, 11487.081033517308, 11766.588169414072, 11837.526498940053, 11979.101567382448, 11801.7639647207, 11875.51556055493, 12035.578754743587, 12055.51777928884, 12090.274583524995, 2501.399664080626, 2522.419843436011, 2532.7973762098986, 2539.1240022192405, 2545.5036267927762, 2115.7249557557498, 2449.534588428193, 2526.6715327007464, 2528.6080657498023, 2530.8987640494356, 2467.457159424933, 2483.639872218527, 2495.463475352799, 2522.9747702523014, 2527.9873600632063, 2429.380507970456, 2444.230067528723, 2467.8272520923542, 2478.1821998740375, 2491.8911084567376, 2414.215380001489, 2471.53040922226, 2486.614574740918, 2489.751024897514, 2530.8734563271946, 11982.221155624857, 12067.456964436622, 12083.033357331393, 12088.456019479057, 12092.0, 5768.7980920668, 5839.8540036499, 6468.223813142406, 6700.994850772423, 6796.286389929085, 3949.3878448840474, 4187.581241875819, 4190.832366705328, 4252.08580155265, 4263.957360426387, 1013.1793247469574, 1077.8598782158347, 1120.2942146447685, 1129.170060005895, 1238.9752204955942, 14886.255687215596, 15380.53858384239, 16722.916385417993, 16789.66420671592, 16844.915775421043, 5451.318585176853, 5456.7544460499375, 5640.830775076673, 5641.717914104361, 5653.378128405872, 12223.572174973833, 12413.44139513706, 12426.5650702225, 12439.440225189888, 12440.875591244152, 6545.672716364163, 6624.337566243337, 6627.966860165669, 6636.336366363325, 6638.20341559016, 5997.630935780342, 6182.0, 6229.159063526366, 6229.937700622936, 6245.5628106033055, 3806.4480650306105, 4278.486581610165, 4436.977815110904, 4478.350639157304, 4478.843240486567, 1115.938623375722, 1288.5232463988198, 1313.507434711983, 1319.5802421220692, 1333.1534475607864, 787.5550314072531, 791.0902462168552, 807.2976510435958, 816.2082779703678, 827.4786884262876, 6148.477379422709, 6172.0, 6390.4248617624635, 6393.424591786761, 6405.615663060138, 587.5417174603816, 597.4622839444535, 604.585858686801, 610.984725381869, 611.9143319935213, 3495.4582039783872, 3962.9405558916637, 4187.664986801049, 4244.1723863846255, 4384.583464570861, 13550.728985420237, 14978.850211497964, 15071.246437678072, 15648.530544083696, 15706.607334816492, 14776.0, 15486.922565387102, 15504.379824807107, 15520.767188492182, 15552.611184720246, 8963.596638151168, 11130.888691112985, 11198.888011119947, 11206.159538034517, 11217.551297948154, 6038.909416358671, 6995.510314277952, 7111.293289610353, 7180.748673796392, 7221.350078492961, 13038.348082596021, 13045.412956416794, 13203.66990825237, 13277.804997550267, 13364.064515483822, 13319.600411987656, 13560.98292628037, 13887.541808110003, 14266.64333391632, 14418.567442976728, 9551.665691700757, 9652.372595781251, 9663.565139568596, 9733.659321923698, 9801.16690081351, 10810.513526891466, 10851.240413171003, 10949.890501094887, 10958.726031849268, 10961.83557246626, 9099.272058235458, 9306.348555601313, 9357.298202634693, 9366.859497107685, 9531.189848862647, 7483.289087536676, 9096.909030909606, 9111.043340449158, 9159.084091590788, 9177.036411176998, 8187.345012398875, 8187.345012399113, 8249.505029697997, 8305.83388332242, 8316.916830831615, 6005.909911351246, 6018.277806663228, 6110.633361998294, 6217.751289948352, 6239.438450539473, 6054.1826853376, 6101.450869421773, 6169.321374648695, 6295.150154729053, 6309.1137173693305], "value": 5346.8373498363, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.0059771581828, 386.50720331577236, 399.50461427829464, 413.00465877235865, 413.0396827376349, 5146.433892271856, 5831.446012628804, 6330.366963303667, 6387.776427825027, 6390.0605721368165, 5078.978008085192, 6026.866029664572, 6162.630242185461, 6178.845528861781, 6184.659843708594, 4492.820287188509, 4504.932426013613, 4512.887177820556, 4526.7283962962165, 4552.886177845564, 3718.553773547178, 4406.933895991563, 4479.820807167709, 4529.230030894756, 4560.8403705870305, 3632.946445530793, 4444.511103778582, 4456.442944631921, 4462.531434199411, 4472.038511719979, 3876.9224615507533, 4456.621187199092, 4474.955250447487, 4481.215787237221, 4494.483134439549, 3721.3859713147567, 3787.5833658297565, 3891.5330160380654, 3897.279003384383, 3898.9805050974564, 5360.624756267063, 5866.853328666817, 5919.437653422918, 5941.70291485424, 5970.432808883149, 4708.670393072486, 4711.93981354196, 5368.221607866876, 5370.624056316059, 5395.190721391783, 5540.307461567304, 5658.688772117532, 5771.740271687784, 6068.362821903681, 6543.476521878239, 3637.636236376341, 3702.148505843671, 4400.977995110036, 4419.734815911023, 4421.4694236691485, 5474.72626368684, 6856.6228857412325, 6887.896681549781, 6942.514024018321, 7080.114985626797, 4806.182948898696, 4837.467878533358, 4897.510248975074, 4919.87700307488, 4922.90154196914, 4404.700613319079, 4841.685290456109, 5015.297858299841, 5034.270030845507, 5039.823606173766, 5344.9732751336, 5602.915956260659, 5607.80372686954, 5631.071842641803, 5653.897489989413, 5406.567474602101, 6523.478121750249, 6760.3239676032, 6765.391114799691, 6796.35434633709, 1513.0240994558449, 1584.7781310616524, 1674.9413770517974, 1696.9902907769858, 1730.7057800174, 886.5788750343535, 1174.8883856033663, 1180.8840645590008, 1193.5046955513365, 1201.7381749163344, 5902.2622172228475, 5959.851003724942, 6257.2804127525005, 6258.897574864471, 6288.339724328879, 5533.122776156376, 6000.669963152069, 6497.220333559909, 6859.416949559343, 6992.370686638227, 6015.699215039231, 6141.96929015361, 6262.279837818709, 6281.780137695158, 6283.905741413882, 3419.4186988212064, 3528.541289632383, 3578.982105089458, 3585.8027808470783, 3598.5501812273465, 6549.919263321499, 6729.461643068543, 6744.898826517606, 6817.5909445433435, 7055.435565154775, 5821.592488525763, 6817.5227734059135, 7010.228874823765, 7084.185318688416, 7135.785926422215, 6492.805215843532, 6673.833154171185, 6929.1684997800585, 6965.233824279427, 7143.749968751069, 5750.539956803362, 5961.463468287875, 6540.920748076514, 6673.466122710074, 6709.261981182163, 5318.952203401641, 5782.855428614318, 6428.871422571616, 6783.762568310085, 6821.693023813841, 6793.320667933167, 7000.964995175195, 7010.917085113456, 7070.36366726997, 7114.359707626339, 3980.681545476413, 4193.664506839506, 4756.6908150970075, 4886.65793394459, 4909.9263511048075, 6009.377468083506, 6619.635920024445, 6817.625030623363, 6829.760958366433, 6966.442684585119, 6593.274739778524, 6598.0, 6602.22706463277, 6642.90035649456, 6717.261101278953, 6036.8188954331445, 6050.848728781815, 6344.555881088464, 6597.967010165111, 6610.8016759497295, 5950.315713692808, 5963.0459126539545, 6444.742210311535, 6499.3175716549085, 6500.154979852589, 4883.90232195347, 5553.4724201200825, 5682.37493875665, 6684.315684315684, 6719.428848547928, 4898.779554920108, 6066.636001839904, 6530.542861999805, 6572.507061970276, 6597.80206593803], "value": 4793.1864948144, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.9626518674066, 815.311062152481, 823.0945959444615, 837.8198687282234, 863.6933888469594, 13507.189568625878, 14542.418303267857, 15244.542663720078, 15900.20498975051, 16499.917500412495, 14252.928735356309, 16827.41104061358, 17289.30842766291, 17669.116544172804, 17901.925884446944, 789.4394979564516, 981.5582987655548, 986.1469828598283, 986.2898712926682, 987.9901200988006, 1006.4011912911806, 1007.7531004903772, 1008.2891561449161, 1008.4000019988132, 1009.4296722351885, 1049.6168898352084, 1056.0706578211202, 1061.2677252695653, 1061.3578784835179, 1062.2776511971856, 1016.7254841192911, 1040.2874031288554, 1051.3796859852648, 1054.1250761867632, 1055.0293729768555, 772.9381649468029, 777.6850375597892, 782.4444644302552, 783.1307248953657, 783.4241832253289, 16558.83441165597, 17139.057351845644, 17381.478555643353, 17441.953482790945, 17454.912725436418, 13461.865381346159, 16758.74861877073, 16795.412160574444, 16964.575885602837, 16998.3200671973, 12296.20074695142, 13594.524191653245, 13985.510507132201, 14164.716705665829, 14199.929000355036, 2967.887042359115, 3351.6480769519335, 3392.6946574808385, 3412.2493051528872, 3421.4354631485776, 100152.0, 117801.0, 119105.0, 119891.0, 120859.39570302093, 11761.588344407905, 11842.230255033395, 12223.877761222451, 12233.082518811125, 12271.0, 20320.390388288375, 20466.692999605017, 20469.692954605693, 20539.28112516055, 20561.588768224552, 8791.120887911158, 9127.178553930178, 9169.358144929924, 9170.770730731785, 9173.174414302612, 4769.4753577107185, 4820.108279968217, 4847.854564363075, 4855.781489832966, 4867.0, 4205.684573656988, 4251.213525497793, 4410.7353558785935, 4414.521135419606, 4414.779261037, 923.6490133749267, 952.1620973543238, 952.8951815300311, 963.677168148664, 967.4437198610686, 554.9472800083986, 641.3394203969918, 646.424682032991, 648.7210499485267, 692.2039654397483, 10896.891031089746, 11704.648860534198, 11759.706007349885, 11824.704382390337, 12016.819747703792, 588.3498733899065, 620.2649859916014, 621.9875602487925, 653.5915053091818, 663.787587971854, 4600.493945665974, 4860.1251774680895, 5508.862278442991, 5518.751656175482, 5594.608377413623, 103962.48018760009, 105203.47398263113, 106359.0, 107016.0, 109914.35128473079, 95360.0, 95557.0, 96352.55471167938, 96692.68190249604, 97414.0, 79633.0, 83633.16366836375, 85367.0, 85508.57245713731, 86005.56997214974, 8950.0, 9859.901400986186, 10865.565377384815, 11066.0, 11119.999200072032, 33496.83251583727, 41566.168676626905, 42604.0, 43521.56478435302, 43715.56284437115, 43974.78012609916, 54490.18264725953, 54598.7270063663, 54799.452005479434, 55413.0, 13114.934425327812, 13689.31553422305, 13847.099938503965, 15457.768133478232, 15724.371025159324, 17675.171972484342, 17750.822491774918, 17775.466735997423, 17933.103344832965, 18003.459896203134, 15865.52403427899, 15949.043057416593, 16045.67908641844, 16274.67450651004, 16373.93569417984, 14071.296435177996, 15781.842181578037, 15926.920365398099, 16079.67840643204, 16138.515844524683, 13146.539871104465, 15506.457273995356, 15656.843431565538, 15988.840111598734, 16018.599535011717, 9794.363366381162, 9839.704808855746, 10011.699649010541, 10099.192064634664, 10167.542460589439, 10801.567937282422, 10849.511771970438, 10969.616063437741, 11030.393328367018, 11058.336499810037], "value": 8123.868806917322, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1705.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 126.0, 126.0, 124.0, 145.0, 184.0, 125.0, 125.0, 125.0, 126.0], "value": 131.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 120.0, 157.0, 200.0, 123.0, 117.0, 131.0, 112.0, 127.0, 122.0], "value": 141.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [286.0, 293.0, 231.0, 216.0, 220.0, 214.0, 214.0, 214.0, 209.0, 217.0], "value": 231.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 65.0, 94.0, 63.0, 62.0, 59.0, 61.0, 68.0, 83.0], "value": 69.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 107.0, 120.0, 75.0, 74.0, 75.0, 94.0, 67.0, 74.0, 87.0], "value": 86.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 97.0, 96.0, 96.0, 97.0, 98.0, 102.0, 141.0, 104.0, 142.0], "value": 106.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 163.0, 103.0, 103.0, 105.0, 102.0, 103.0, 104.0, 102.0, 105.0], "value": 109.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 105.0, 102.0, 102.0, 102.0, 148.0, 103.0, 102.0, 102.0, 129.0], "value": 110.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 48.0, 75.0, 84.0, 86.0, 66.0, 53.0, 54.0, 55.0, 55.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 70.0, 68.0, 104.0, 100.0, 91.0, 89.0, 69.0, 60.0], "value": 77.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 116.0, 117.0, 118.0, 100.0, 119.0, 117.0, 84.0, 115.0, 117.0], "value": 110.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 150.0, 169.0, 157.0, 145.0, 146.0, 146.0, 157.0, 211.0, 185.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [209.0, 210.0, 201.0, 195.0, 197.0, 198.0, 199.0, 196.0, 229.0, 259.0], "value": 209.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 74.0, 98.0, 108.0, 88.0, 114.0, 105.0, 101.0, 101.0, 74.0], "value": 94.0, "unit": "score"}]}]} 00:58:19 INFO - Return code: 0 00:58:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:58:19 ERROR - # TBPL SUCCESS # 00:58:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:58:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:58:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:58:19 INFO - 2017-04-12 00:58:19.368 screenresolution[1656:10669] starting screenresolution argv=screenresolution get 00:58:19 INFO - 2017-04-12 00:58:19.371 screenresolution[1656:10669] Display 0: 1600x1200x32@60 00:58:19 INFO - 2017-04-12 00:58:19.377 screenresolution[1657:10672] starting screenresolution argv=screenresolution list 00:58:19 INFO - Available Modes on Display 0 00:58:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:58:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:58:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:58:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:58:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:58:19 INFO - Intel Iris: 00:58:19 INFO - Chipset Model: Intel Iris 00:58:19 INFO - Type: GPU 00:58:19 INFO - Bus: Built-In 00:58:19 INFO - VRAM (Dynamic, Max): 1536 MB 00:58:19 INFO - Vendor: Intel (0x8086) 00:58:19 INFO - Device ID: 0x0a2e 00:58:19 INFO - Revision ID: 0x0009 00:58:19 INFO - Displays: 00:58:19 INFO - Display: 00:58:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:58:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:58:19 INFO - Display Serial Number: 1600x1200 60 00:58:19 INFO - Main Display: Yes 00:58:19 INFO - Mirror: Off 00:58:19 INFO - Online: Yes 00:58:19 INFO - Rotation: Supported 00:58:19 INFO - Return code: 0 00:58:19 INFO - Running post-action listener: _resource_record_post_action 00:58:19 INFO - [mozharness: 2017-04-12 07:58:19.625043Z] Finished run-tests step (success) 00:58:19 INFO - Running post-run listener: _resource_record_post_run 00:58:19 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 39365120; Write bytes: 522668032; Read time: 248; Write time: 1658 00:58:19 INFO - TinderboxPrint: CPU usage
54.4% 00:58:19 INFO - TinderboxPrint: I/O read bytes / time
39,365,120 / 248 00:58:19 INFO - TinderboxPrint: I/O write bytes / time
522,668,032 / 1,658 00:58:19 INFO - TinderboxPrint: CPU idle
2,191.5 (45.6%) 00:58:19 INFO - TinderboxPrint: CPU system
976.9 (20.3%) 00:58:19 INFO - TinderboxPrint: CPU user
1,641.2 (34.1%) 00:58:19 INFO - TinderboxPrint: Swap in / out
247,410,688 / 0 00:58:19 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 196487680; Write bytes: 193390592; Read time: 15301; Write time: 424 00:58:19 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 38402560; Write bytes: 312430592; Read time: 235; Write time: 1181 00:58:20 INFO - Running post-run listener: _upload_blobber_files 00:58:20 INFO - Blob upload gear active. 00:58:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:58:20 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 00:58:20 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'] 00:58:20 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 00:58:20 INFO - (blobuploader) - INFO - Open directory for files ... 00:58:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:58:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:58:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:58:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:58:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:58:21 INFO - (blobuploader) - INFO - Done attempting. 00:58:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:58:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:58:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:58:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:58:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:58:22 INFO - (blobuploader) - INFO - Done attempting. 00:58:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 00:58:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:58:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:58:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 00:58:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:58:23 INFO - (blobuploader) - INFO - Done attempting. 00:58:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:58:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:58:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:58:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:58:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:58:25 INFO - (blobuploader) - INFO - Done attempting. 00:58:25 INFO - (blobuploader) - INFO - Iteration through files over. 00:58:25 INFO - Return code: 0 00:58:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:58:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:58:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/d473f2c0b1a94ebe4680d3ad959e4dbe20c34b37946e79cc7f36ddd232ea226c9f84d170534609d34634b9ff4f976009252d823427e5128ba0e639b2268995a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/718340710b4b524b23cbe25adcc844c05dbb8e4a70ec8c36471a6dafeb0880efe79f39e061fb31b424f3d758bdf44f652211b6da71159dacd7432885af46816a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0fec075278a864b466fd3f8a4aabbc5a93154ce106cc090d8e91b748f138e925c4673a0c960a0712091c9066d83099aa6143aea8c1b0cca450a73313849aa2d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/38c92480c6a3761efca2757756fedcade1cd97cadc9e544639d6a35e72257b4478fd179896e2ed5adca7325d56b7b94e0890d921ad0759bd0b1d2b2ad8485875"} 00:58:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:58:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:58:25 INFO - Contents: 00:58:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/d473f2c0b1a94ebe4680d3ad959e4dbe20c34b37946e79cc7f36ddd232ea226c9f84d170534609d34634b9ff4f976009252d823427e5128ba0e639b2268995a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/718340710b4b524b23cbe25adcc844c05dbb8e4a70ec8c36471a6dafeb0880efe79f39e061fb31b424f3d758bdf44f652211b6da71159dacd7432885af46816a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0fec075278a864b466fd3f8a4aabbc5a93154ce106cc090d8e91b748f138e925c4673a0c960a0712091c9066d83099aa6143aea8c1b0cca450a73313849aa2d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/38c92480c6a3761efca2757756fedcade1cd97cadc9e544639d6a35e72257b4478fd179896e2ed5adca7325d56b7b94e0890d921ad0759bd0b1d2b2ad8485875"} 00:58:25 INFO - Running post-run listener: copy_logs_to_upload_dir 00:58:25 INFO - Copying logs to upload dir... 00:58:25 INFO - mkdir: /builds/slave/test/build/upload/logs 00:58:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.813016 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-04-12 00:58:25.614075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 00:58:25.618017) ========= 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.7XZMRAZE08/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.lHbwDcL1wL/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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/d473f2c0b1a94ebe4680d3ad959e4dbe20c34b37946e79cc7f36ddd232ea226c9f84d170534609d34634b9ff4f976009252d823427e5128ba0e639b2268995a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/718340710b4b524b23cbe25adcc844c05dbb8e4a70ec8c36471a6dafeb0880efe79f39e061fb31b424f3d758bdf44f652211b6da71159dacd7432885af46816a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0fec075278a864b466fd3f8a4aabbc5a93154ce106cc090d8e91b748f138e925c4673a0c960a0712091c9066d83099aa6143aea8c1b0cca450a73313849aa2d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/38c92480c6a3761efca2757756fedcade1cd97cadc9e544639d6a35e72257b4478fd179896e2ed5adca7325d56b7b94e0890d921ad0759bd0b1d2b2ad8485875"} build_url:https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/Ro9uj5nrR9y22GYTTTEaEw/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/d473f2c0b1a94ebe4680d3ad959e4dbe20c34b37946e79cc7f36ddd232ea226c9f84d170534609d34634b9ff4f976009252d823427e5128ba0e639b2268995a8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/718340710b4b524b23cbe25adcc844c05dbb8e4a70ec8c36471a6dafeb0880efe79f39e061fb31b424f3d758bdf44f652211b6da71159dacd7432885af46816a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0fec075278a864b466fd3f8a4aabbc5a93154ce106cc090d8e91b748f138e925c4673a0c960a0712091c9066d83099aa6143aea8c1b0cca450a73313849aa2d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/38c92480c6a3761efca2757756fedcade1cd97cadc9e544639d6a35e72257b4478fd179896e2ed5adca7325d56b7b94e0890d921ad0759bd0b1d2b2ad8485875"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-12 00:58:25.655206) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:58:25.655572) ========= 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.7XZMRAZE08/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.lHbwDcL1wL/Listeners TMPDIR=/var/folders/c3/8q485yn95ydb1p5724v877vr00000w/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.005214 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-12 00:58:25.707889) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 00:58:25.708240) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-12 00:58:25.708610) ========= ========= Total master_lag: 0.20 =========