builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0258 starttime: 1493194299.34 results: success (0) buildid: 20170425234025 builduid: 8f008b6a486346298c06bb611cba2400 revision: 08a5a97f615fb65b3455b435c3e56d96c4c12208 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 01:11:39.337475) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-26 01:11:39.337913) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 01:11:39.338198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-26 01:11:39.365537) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 01:11:39.365852) ========= 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.q0bHfBdrCn/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.q11iwYdPDn/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-26 01:11:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 147M=0s 2017-04-26 01:11:39 (147 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112000 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 01:11:39.502859) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 01:11:39.503184) ========= 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.q0bHfBdrCn/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.q11iwYdPDn/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.030187 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 01:11:39.559665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-26 01:11:39.560432) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 08a5a97f615fb65b3455b435c3e56d96c4c12208 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 08a5a97f615fb65b3455b435c3e56d96c4c12208 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.q0bHfBdrCn/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.q11iwYdPDn/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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-26 01:11:39,671 truncating revision to first 12 chars 2017-04-26 01:11:39,671 Setting DEBUG logging. 2017-04-26 01:11:39,671 attempt 1/10 2017-04-26 01:11:39,671 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/08a5a97f615f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-26 01:11:41,170 unpacking tar archive at: mozilla-central-08a5a97f615f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.783755 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-26 01:11:41.371031) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 01:11:41.371595) ========= script_repo_revision: 08a5a97f615fb65b3455b435c3e56d96c4c12208 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-26 01:11:41.372102) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 01:11:41.372409) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-26 01:11:41.393524) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-26 01:11:41.393888) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.q0bHfBdrCn/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.q11iwYdPDn/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 01:11:41 INFO - MultiFileLogger online at 20170426 01:11:41 in /builds/slave/test 01:11:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 01:11:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:11:41 INFO - {'append_to_log': False, 01:11:41 INFO - 'base_work_dir': '/builds/slave/test', 01:11:41 INFO - 'blob_upload_branch': 'Firefox', 01:11:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:11:41 INFO - 'branch': 'Firefox', 01:11:41 INFO - 'buildbot_json_path': 'buildprops.json', 01:11:41 INFO - 'config_files': ('talos/mac_config.py',), 01:11:41 INFO - 'default_actions': ('clobber', 01:11:41 INFO - 'read-buildbot-config', 01:11:41 INFO - 'download-and-extract', 01:11:41 INFO - 'populate-webroot', 01:11:41 INFO - 'create-virtualenv', 01:11:41 INFO - 'install', 01:11:41 INFO - 'run-tests'), 01:11:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:11:41 INFO - 'download_minidump_stackwalk': True, 01:11:41 INFO - 'download_symbols': 'ondemand', 01:11:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:11:41 INFO - 'tooltool.py': '/tools/tooltool.py', 01:11:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:11:41 INFO - '/tools/misc-python/virtualenv.py')}, 01:11:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:11:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:11:41 INFO - 'gecko_profile': False, 01:11:41 INFO - 'gecko_profile_interval': 0, 01:11:41 INFO - 'installer_path': 'installer.exe', 01:11:41 INFO - 'log_level': 'info', 01:11:41 INFO - 'log_name': 'talos', 01:11:41 INFO - 'log_to_console': True, 01:11:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:11:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:11:41 INFO - 'opt_config_files': (), 01:11:41 INFO - 'pip_index': False, 01:11:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:11:41 INFO - 'cmd': ('bash', 01:11:41 INFO - '-c', 01:11:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:11:41 INFO - 'enabled': True, 01:11:41 INFO - 'halt_on_failure': False, 01:11:41 INFO - 'name': 'check_screen_resolution'},), 01:11:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:11:41 INFO - 'cmd': ('bash', 01:11:41 INFO - '-c', 01:11:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:11:41 INFO - 'enabled': True, 01:11:41 INFO - 'halt_on_failure': False, 01:11:41 INFO - 'name': 'check_screen_resolution'},), 01:11:41 INFO - 'run_cmd_checks_enabled': True, 01:11:41 INFO - 'suite': 'dromaeojs-e10s', 01:11:41 INFO - 'system_bits': '32', 01:11:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:11:41 INFO - 'title': 't-yosemite-r7-0258', 01:11:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:11:41 INFO - 'use_talos_json': True, 01:11:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:11:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:11:41 INFO - 'work_dir': 'build'} 01:11:41 INFO - [mozharness: 2017-04-26 08:11:41.607101Z] Running clobber step. 01:11:41 INFO - Running pre-action listener: _resource_record_pre_action 01:11:41 INFO - Running main action method: clobber 01:11:41 INFO - rmtree: /builds/slave/test/build 01:11:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:11:44 INFO - Running post-action listener: _resource_record_post_action 01:11:44 INFO - [mozharness: 2017-04-26 08:11:44.005044Z] Finished clobber step (success) 01:11:44 INFO - [mozharness: 2017-04-26 08:11:44.005167Z] Running read-buildbot-config step. 01:11:44 INFO - Running pre-action listener: _resource_record_pre_action 01:11:44 INFO - Running main action method: read_buildbot_config 01:11:44 INFO - Using buildbot properties: 01:11:44 INFO - { 01:11:44 INFO - "project": "", 01:11:44 INFO - "product": "firefox", 01:11:44 INFO - "script_repo_revision": "production", 01:11:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 01:11:44 INFO - "repository": "", 01:11:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 01:11:44 INFO - "buildid": "20170425234025", 01:11:44 INFO - "pgo_build": "False", 01:11:44 INFO - "basedir": "/builds/slave/test", 01:11:44 INFO - "buildnumber": 47, 01:11:44 INFO - "slavename": "t-yosemite-r7-0258", 01:11:44 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 01:11:44 INFO - "platform": "yosemite_r7", 01:11:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 01:11:44 INFO - "branch": "mozilla-central", 01:11:44 INFO - "repo_path": "mozilla-central", 01:11:44 INFO - "revision": "08a5a97f615fb65b3455b435c3e56d96c4c12208", 01:11:44 INFO - "stage_platform": "macosx64", 01:11:44 INFO - "builduid": "8f008b6a486346298c06bb611cba2400", 01:11:44 INFO - "slavebuilddir": "test" 01:11:44 INFO - } 01:11:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 01:11:44 INFO - Running post-action listener: _resource_record_post_action 01:11:44 INFO - [mozharness: 2017-04-26 08:11:44.008460Z] Finished read-buildbot-config step (success) 01:11:44 INFO - [mozharness: 2017-04-26 08:11:44.008560Z] Running download-and-extract step. 01:11:44 INFO - Running pre-action listener: _resource_record_pre_action 01:11:44 INFO - Running main action method: download_and_extract 01:11:44 INFO - mkdir: /builds/slave/test/build/tests 01:11:44 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')]} 01:11:44 INFO - trying https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 01:11:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/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 01:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/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 01:11:44 INFO - Downloaded 1325 bytes. 01:11:44 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 01:11:44 INFO - Using the following test package requirements: 01:11:44 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:11:44 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 01:11:44 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 01:11:44 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:11:44 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 01:11:44 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:11:44 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 01:11:44 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:11:44 INFO - u'jsshell-mac.zip'], 01:11:44 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:11:44 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 01:11:44 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 01:11:44 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:11:44 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 01:11:44 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:11:44 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 01:11:44 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:11:44 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 01:11:44 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 01:11:44 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 01:11:44 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:11:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 01:11:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:11:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 01:11:46 INFO - Content-Length response header: 52527592 01:11:46 INFO - Bytes received: 52527592 01:12:02 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 01:12:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 01:12:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:12:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 01:12:04 INFO - Content-Length response header: 52527592 01:12:04 INFO - Bytes received: 52527592 01:12:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 01:12:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:12:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 01:12:21 INFO - Content-Length response header: 14408809 01:12:21 INFO - Bytes received: 14408809 01:12:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:21 INFO - trying https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 01:12:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 01:12:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/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 01:12:23 INFO - Downloaded 71259395 bytes. 01:12:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 01:12:23 INFO - mkdir: /builds/slave/test/properties 01:12:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:12:23 INFO - Writing to file /builds/slave/test/properties/build_url 01:12:23 INFO - Contents: 01:12:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 01:12:24 INFO - Running post-action listener: _resource_record_post_action 01:12:24 INFO - Running post-action listener: set_extra_try_arguments 01:12:24 INFO - [mozharness: 2017-04-26 08:12:24.180116Z] Finished download-and-extract step (success) 01:12:24 INFO - [mozharness: 2017-04-26 08:12:24.180235Z] Running populate-webroot step. 01:12:24 INFO - Running pre-action listener: _resource_record_pre_action 01:12:24 INFO - Running main action method: populate_webroot 01:12:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:12:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:12:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:12:24 INFO - '--tppagecycles', 01:12:24 INFO - '7'], 01:12:24 INFO - 'tests': ['tsvgm']}}, 01:12:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:12:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:12:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:12:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:12:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:12:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:12:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:12:24 INFO - 'talos_options': ['--disable-e10s'], 01:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:12:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:12:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:12:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:12:24 INFO - 'talos_options': ['--disable-e10s'], 01:12:24 INFO - 'tests': ['damp', 'tps']}, 01:12:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:12:24 INFO - 'tests': ['damp', 'tps']}, 01:12:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:12:24 INFO - 'tests': ['dromaeo_dom']}, 01:12:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:12:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:12:24 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 01:12:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 01:12:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:12:24 INFO - 'tests': ['a11yr', 01:12:24 INFO - 'ts_paint', 01:12:24 INFO - 'tpaint', 01:12:24 INFO - 'sessionrestore', 01:12:24 INFO - 'sessionrestore_no_auto_restore', 01:12:24 INFO - 'tabpaint']}, 01:12:24 INFO - 'other-e10s': {'tests': ['a11yr', 01:12:24 INFO - 'ts_paint', 01:12:24 INFO - 'tpaint', 01:12:24 INFO - 'sessionrestore', 01:12:24 INFO - 'sessionrestore_no_auto_restore', 01:12:24 INFO - 'tabpaint']}, 01:12:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:12:24 INFO - 'ts_paint', 01:12:24 INFO - 'tpaint', 01:12:24 INFO - 'sessionrestore', 01:12:24 INFO - 'sessionrestore_no_auto_restore', 01:12:24 INFO - 'tabpaint']}, 01:12:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:12:24 INFO - 'ts_paint', 01:12:24 INFO - 'tpaint', 01:12:24 INFO - 'sessionrestore', 01:12:24 INFO - 'sessionrestore_no_auto_restore', 01:12:24 INFO - 'tabpaint']}, 01:12:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:12:24 INFO - 'tests': ['a11yr', 01:12:24 INFO - 'ts_paint', 01:12:24 INFO - 'tpaint', 01:12:24 INFO - 'sessionrestore', 01:12:24 INFO - 'sessionrestore_no_auto_restore', 01:12:24 INFO - 'tabpaint']}, 01:12:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:12:24 INFO - 'tests': ['a11yr', 01:12:24 INFO - 'ts_paint', 01:12:24 INFO - 'tpaint', 01:12:24 INFO - 'sessionrestore', 01:12:24 INFO - 'sessionrestore_no_auto_restore', 01:12:24 INFO - 'tabpaint']}, 01:12:24 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 01:12:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 01:12:24 INFO - 'bloom_basic_ref']}, 01:12:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:12:24 INFO - 'tests': ['tsvgx', 01:12:24 INFO - 'tsvgr_opacity', 01:12:24 INFO - 'tart', 01:12:24 INFO - 'tscrollx', 01:12:24 INFO - 'cart', 01:12:24 INFO - 'tsvg_static']}, 01:12:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:12:24 INFO - 'tsvgr_opacity', 01:12:24 INFO - 'tart', 01:12:24 INFO - 'tscrollx', 01:12:24 INFO - 'cart', 01:12:24 INFO - 'tsvg_static']}, 01:12:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:12:24 INFO - 'talos_options': ['--disable-e10s'], 01:12:24 INFO - 'tests': ['tp5o']}, 01:12:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:12:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:12:24 INFO - 'talos_options': ['--disable-e10s', 01:12:24 INFO - '--xperf_path', 01:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:12:24 INFO - 'tests': ['tp5n']}, 01:12:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:12:24 INFO - 'talos_options': ['--xperf_path', 01:12:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:12:24 INFO - 'tests': ['tp5n']}}, 01:12:24 INFO - 'talos.zip': {'path': '', 01:12:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:12:24 INFO - Running post-action listener: _resource_record_post_action 01:12:24 INFO - [mozharness: 2017-04-26 08:12:24.199411Z] Finished populate-webroot step (success) 01:12:24 INFO - [mozharness: 2017-04-26 08:12:24.199526Z] Running create-virtualenv step. 01:12:24 INFO - Running pre-action listener: _resource_record_pre_action 01:12:24 INFO - Running main action method: create_virtualenv 01:12:24 INFO - Creating virtualenv /builds/slave/test/build/venv 01:12:24 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 01:12:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:12:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:12:24 INFO - Using real prefix '/tools/python27' 01:12:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:12:25 INFO - Installing distribute.............................................................................................................................................................................................done. 01:12:27 INFO - Installing pip.................done. 01:12:27 INFO - Return code: 0 01:12:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:12:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:12:28 INFO - Reading from file tmpfile_stdout 01:12:28 INFO - Output received: 01:12:28 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) 01:12:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca85ddf30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc28d30>, '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 0x10db4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc1dbe8>, '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.q0bHfBdrCn/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.q11iwYdPDn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 01:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:12:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q0bHfBdrCn/Render', 01:12:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:12:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:12:28 INFO - 'HOME': '/Users/cltbld', 01:12:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:12:28 INFO - 'LOGNAME': 'cltbld', 01:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:28 INFO - 'MOZ_NO_REMOTE': '1', 01:12:28 INFO - 'NO_EM_RESTART': '1', 01:12:28 INFO - 'PAGER': '/bin/cat', 01:12:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:28 INFO - 'PWD': '/builds/slave/test', 01:12:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:12:28 INFO - 'SHELL': '/bin/bash', 01:12:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q11iwYdPDn/Listeners', 01:12:28 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 01:12:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:12:28 INFO - 'USER': 'cltbld', 01:12:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:12:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:28 INFO - 'XPC_FLAGS': '0x0', 01:12:28 INFO - 'XPC_SERVICE_NAME': '0', 01:12:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:28 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 01:12:28 INFO - Cleaning up... 01:12:28 INFO - Return code: 0 01:12:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10de4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca85ddf30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc28d30>, '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 0x10db4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc1dbe8>, '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.q0bHfBdrCn/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.q11iwYdPDn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 01:12:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:12:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:12:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q0bHfBdrCn/Render', 01:12:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:12:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:12:28 INFO - 'HOME': '/Users/cltbld', 01:12:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:12:28 INFO - 'LOGNAME': 'cltbld', 01:12:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:28 INFO - 'MOZ_NO_REMOTE': '1', 01:12:28 INFO - 'NO_EM_RESTART': '1', 01:12:28 INFO - 'PAGER': '/bin/cat', 01:12:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:12:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:28 INFO - 'PWD': '/builds/slave/test', 01:12:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:12:28 INFO - 'SHELL': '/bin/bash', 01:12:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q11iwYdPDn/Listeners', 01:12:28 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 01:12:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:12:28 INFO - 'USER': 'cltbld', 01:12:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:12:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:12:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:28 INFO - 'XPC_FLAGS': '0x0', 01:12:28 INFO - 'XPC_SERVICE_NAME': '0', 01:12:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:12:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:28 INFO - Downloading/unpacking psutil>=3.1.1 01:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:12:32 INFO - Installing collected packages: psutil 01:12:32 INFO - Running setup.py install for psutil 01:12:32 INFO - building 'psutil._psutil_osx' extension 01:12:32 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 01:12:32 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 01:12:32 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 01:12:32 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 01:12:32 INFO - building 'psutil._psutil_posix' extension 01:12:32 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 01:12:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:12:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:12:33 INFO - ^ 01:12:33 INFO - 1 warning generated. 01:12:33 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 01:12:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:12:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:12:33 INFO - Successfully installed psutil 01:12:33 INFO - Cleaning up... 01:12:33 INFO - Return code: 0 01:12:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10de4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca85ddf30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc28d30>, '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 0x10db4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc1dbe8>, '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.q0bHfBdrCn/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.q11iwYdPDn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 01:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:12:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q0bHfBdrCn/Render', 01:12:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:12:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:12:33 INFO - 'HOME': '/Users/cltbld', 01:12:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:12:33 INFO - 'LOGNAME': 'cltbld', 01:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:33 INFO - 'MOZ_NO_REMOTE': '1', 01:12:33 INFO - 'NO_EM_RESTART': '1', 01:12:33 INFO - 'PAGER': '/bin/cat', 01:12:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:33 INFO - 'PWD': '/builds/slave/test', 01:12:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:12:33 INFO - 'SHELL': '/bin/bash', 01:12:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q11iwYdPDn/Listeners', 01:12:33 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 01:12:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:12:33 INFO - 'USER': 'cltbld', 01:12:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:12:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:33 INFO - 'XPC_FLAGS': '0x0', 01:12:33 INFO - 'XPC_SERVICE_NAME': '0', 01:12:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:12:35 INFO - Installing collected packages: mozsystemmonitor 01:12:35 INFO - Running setup.py install for mozsystemmonitor 01:12:35 INFO - Successfully installed mozsystemmonitor 01:12:35 INFO - Cleaning up... 01:12:35 INFO - Return code: 0 01:12:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:36 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')]} 01:12:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:36 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 0x10de4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca85ddf30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc28d30>, '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 0x10db4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc1dbe8>, '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.q0bHfBdrCn/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.q11iwYdPDn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 01:12:36 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 01:12:36 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 01:12:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q0bHfBdrCn/Render', 01:12:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:12:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:12:36 INFO - 'HOME': '/Users/cltbld', 01:12:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:12:36 INFO - 'LOGNAME': 'cltbld', 01:12:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:36 INFO - 'MOZ_NO_REMOTE': '1', 01:12:36 INFO - 'NO_EM_RESTART': '1', 01:12:36 INFO - 'PAGER': '/bin/cat', 01:12:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:12:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:36 INFO - 'PWD': '/builds/slave/test', 01:12:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:12:36 INFO - 'SHELL': '/bin/bash', 01:12:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q11iwYdPDn/Listeners', 01:12:36 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 01:12:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:12:36 INFO - 'USER': 'cltbld', 01:12:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:12:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:12:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:36 INFO - 'XPC_FLAGS': '0x0', 01:12:36 INFO - 'XPC_SERVICE_NAME': '0', 01:12:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:12:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:36 INFO - Downloading/unpacking jsonschema==2.5.1 01:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:12:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:12:39 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 01:12:39 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 01:12:39 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 01:12:39 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 01:12:39 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 01:12:39 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 01:12:40 INFO - Downloading functools32-3.2.3-2.tar.gz 01:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:12:40 INFO - warning: no files found matching '*.txt' 01:12:40 INFO - no previously-included directories found matching 'build' 01:12:40 INFO - no previously-included directories found matching 'dist' 01:12:40 INFO - no previously-included directories found matching '.git*' 01:12:40 INFO - Installing collected packages: jsonschema, functools32 01:12:40 INFO - Running setup.py install for functools32 01:12:40 INFO - warning: no files found matching '*.txt' 01:12:40 INFO - no previously-included directories found matching 'build' 01:12:40 INFO - no previously-included directories found matching 'dist' 01:12:40 INFO - no previously-included directories found matching '.git*' 01:12:40 INFO - Successfully installed jsonschema functools32 01:12:40 INFO - Cleaning up... 01:12:40 INFO - Return code: 0 01:12:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:12: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')]} 01:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12: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')]} 01:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:40 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 0x10de4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca85ddf30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc28d30>, '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 0x10db4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc1dbe8>, '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.q0bHfBdrCn/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.q11iwYdPDn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 01:12:40 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 01:12:40 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 01:12:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q0bHfBdrCn/Render', 01:12:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:12:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:12:40 INFO - 'HOME': '/Users/cltbld', 01:12:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:12:40 INFO - 'LOGNAME': 'cltbld', 01:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:40 INFO - 'MOZ_NO_REMOTE': '1', 01:12:40 INFO - 'NO_EM_RESTART': '1', 01:12:40 INFO - 'PAGER': '/bin/cat', 01:12:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:40 INFO - 'PWD': '/builds/slave/test', 01:12:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:12:40 INFO - 'SHELL': '/bin/bash', 01:12:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q11iwYdPDn/Listeners', 01:12:40 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 01:12:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:12:40 INFO - 'USER': 'cltbld', 01:12:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:12:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:40 INFO - 'XPC_FLAGS': '0x0', 01:12:40 INFO - 'XPC_SERVICE_NAME': '0', 01:12:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:12:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:12:40 INFO - Cleaning up... 01:12:40 INFO - Return code: 0 01:12:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:12: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')]} 01:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12: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')]} 01:12:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:40 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 0x10de4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca85ddf30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc28d30>, '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 0x10db4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc1dbe8>, '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.q0bHfBdrCn/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.q11iwYdPDn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 01:12:40 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 01:12:40 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 01:12:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q0bHfBdrCn/Render', 01:12:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:12:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:12:40 INFO - 'HOME': '/Users/cltbld', 01:12:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:12:40 INFO - 'LOGNAME': 'cltbld', 01:12:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:40 INFO - 'MOZ_NO_REMOTE': '1', 01:12:40 INFO - 'NO_EM_RESTART': '1', 01:12:40 INFO - 'PAGER': '/bin/cat', 01:12:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:12:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:40 INFO - 'PWD': '/builds/slave/test', 01:12:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:12:40 INFO - 'SHELL': '/bin/bash', 01:12:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q11iwYdPDn/Listeners', 01:12:40 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 01:12:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:12:40 INFO - 'USER': 'cltbld', 01:12:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:12:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:12:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:40 INFO - 'XPC_FLAGS': '0x0', 01:12:40 INFO - 'XPC_SERVICE_NAME': '0', 01:12:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:12:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:41 INFO - Downloading/unpacking blobuploader==1.2.4 01:12:41 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 01:12:41 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 01:12:41 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 01:12:41 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 01:12:41 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 01:12:41 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 01:12:43 INFO - Downloading blobuploader-1.2.4.tar.gz 01:12:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:12:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:12:43 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 01:12:43 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 01:12:43 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 01:12:43 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 01:12:43 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 01:12:43 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 01:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:12:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:12:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:12:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:12:44 INFO - Downloading docopt-0.6.1.tar.gz 01:12:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:12:45 INFO - Installing collected packages: blobuploader, requests, docopt 01:12:45 INFO - Running setup.py install for blobuploader 01:12:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:12:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:12:45 INFO - Running setup.py install for requests 01:12:45 INFO - Running setup.py install for docopt 01:12:45 INFO - Successfully installed blobuploader requests docopt 01:12:45 INFO - Cleaning up... 01:12:45 INFO - Return code: 0 01:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:12:45 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')]} 01:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:45 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')]} 01:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:45 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 0x10de4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca85ddf30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc28d30>, '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 0x10db4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc1dbe8>, '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.q0bHfBdrCn/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.q11iwYdPDn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 01:12:45 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 01:12:45 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 01:12:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q0bHfBdrCn/Render', 01:12:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:12:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:12:45 INFO - 'HOME': '/Users/cltbld', 01:12:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:12:45 INFO - 'LOGNAME': 'cltbld', 01:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:45 INFO - 'MOZ_NO_REMOTE': '1', 01:12:45 INFO - 'NO_EM_RESTART': '1', 01:12:45 INFO - 'PAGER': '/bin/cat', 01:12:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:45 INFO - 'PWD': '/builds/slave/test', 01:12:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:12:45 INFO - 'SHELL': '/bin/bash', 01:12:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q11iwYdPDn/Listeners', 01:12:45 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 01:12:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:12:45 INFO - 'USER': 'cltbld', 01:12:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:12:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:45 INFO - 'XPC_FLAGS': '0x0', 01:12:45 INFO - 'XPC_SERVICE_NAME': '0', 01:12:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:12:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:12:46 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-DqmAuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:12:46 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-cVXGBw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:12:46 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-eolIJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:12:46 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-6m0LGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:12:46 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-mq855h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:12:46 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-CIC9LP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:12:46 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-wbp3eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:12:46 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Gwa5kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:12:47 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-5Z4D98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:12:47 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-gVvLXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:12:47 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-NBsTDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:12:47 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-YxeDug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:12:47 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-N_eZGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:12:47 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-YKAfjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:12:47 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-FIAK_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:12:47 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-D5b7BY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:12:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:12:47 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-bxRWr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:12:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:12:47 INFO - Running setup.py install for manifestparser 01:12:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:12:48 INFO - Running setup.py install for mozcrash 01:12:48 INFO - Running setup.py install for mozdebug 01:12:48 INFO - Running setup.py install for mozdevice 01:12:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:12:48 INFO - Running setup.py install for mozfile 01:12:48 INFO - Running setup.py install for mozhttpd 01:12:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:12:48 INFO - Running setup.py install for mozinfo 01:12:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:12:48 INFO - Running setup.py install for mozInstall 01:12:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:12:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:12:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:12:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:12:49 INFO - Running setup.py install for mozleak 01:12:49 INFO - Running setup.py install for mozlog 01:12:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:12:49 INFO - Running setup.py install for moznetwork 01:12:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:12:49 INFO - Running setup.py install for mozprocess 01:12:49 INFO - Running setup.py install for mozprofile 01:12:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:12:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:12:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:12:49 INFO - Running setup.py install for mozrunner 01:12:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:12:50 INFO - Running setup.py install for mozscreenshot 01:12:50 INFO - Running setup.py install for moztest 01:12:50 INFO - Running setup.py install for mozversion 01:12:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:12:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:12:50 INFO - Cleaning up... 01:12:50 INFO - Return code: 0 01:12:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:12:50 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')]} 01:12:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:50 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')]} 01:12:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:50 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 0x10de4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca85ddf30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc28d30>, '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 0x10db4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc1dbe8>, '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.q0bHfBdrCn/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.q11iwYdPDn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 01:12:50 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 01:12:50 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 01:12:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q0bHfBdrCn/Render', 01:12:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:12:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:12:50 INFO - 'HOME': '/Users/cltbld', 01:12:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:12:50 INFO - 'LOGNAME': 'cltbld', 01:12:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:50 INFO - 'MOZ_NO_REMOTE': '1', 01:12:50 INFO - 'NO_EM_RESTART': '1', 01:12:50 INFO - 'PAGER': '/bin/cat', 01:12:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:12:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:50 INFO - 'PWD': '/builds/slave/test', 01:12:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:12:50 INFO - 'SHELL': '/bin/bash', 01:12:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q11iwYdPDn/Listeners', 01:12:50 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 01:12:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:12:50 INFO - 'USER': 'cltbld', 01:12:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:12:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:12:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:50 INFO - 'XPC_FLAGS': '0x0', 01:12:50 INFO - 'XPC_SERVICE_NAME': '0', 01:12:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:12:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:12:50 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-2CVXxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:12:50 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)) 01:12:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:12:50 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-xXw018-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:12:51 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)) 01:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:12:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-5G7xB5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:12:51 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)) 01:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:12:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-Q0br3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:12:51 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)) 01:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:12:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-wTFVbw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:12:51 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)) 01:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:12:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-qexJ2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:12:51 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)) 01:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:12:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-KdmiNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:12:51 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)) 01:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:12:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-m7tt6I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:12:51 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)) 01:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:12:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-9VvjNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:12:51 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)) 01:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:12:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-4N8k78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:12:51 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)) 01:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:12:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-our0XB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:12:51 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)) 01:12:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:12:51 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-smMCqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:12:52 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)) 01:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:12:52 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-akDMDe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:12:52 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)) 01:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:12:52 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-DPU_l9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:12:52 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)) 01:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:12:52 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-GasG4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:12:52 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)) 01:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:12:52 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-3Sz1On-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:12:52 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)) 01:12:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:12:52 INFO - Running setup.py (path:/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/pip-6jsVTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:12:52 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)) 01:12:52 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)) 01:12:52 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)) 01:12:52 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)) 01:12:52 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)) 01:12:52 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)) 01:12:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:12:52 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 01:12:52 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 01:12:52 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 01:12:52 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 01:12:52 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 01:12:52 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 01:12:55 INFO - Downloading blessings-1.6.tar.gz 01:12:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:12:55 INFO - Installing collected packages: blessings 01:12:55 INFO - Running setup.py install for blessings 01:12:55 INFO - Successfully installed blessings 01:12:55 INFO - Cleaning up... 01:12:55 INFO - Return code: 0 01:12:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:12:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:12:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:12:55 INFO - Reading from file tmpfile_stdout 01:12:55 INFO - Current package versions: 01:12:55 INFO - blessings == 1.6 01:12:55 INFO - blobuploader == 1.2.4 01:12:55 INFO - docopt == 0.6.1 01:12:55 INFO - functools32 == 3.2.3-2 01:12:55 INFO - jsonschema == 2.5.1 01:12:55 INFO - manifestparser == 1.1 01:12:55 INFO - mozInstall == 1.12 01:12:55 INFO - mozcrash == 1.0 01:12:55 INFO - mozdebug == 0.1 01:12:55 INFO - mozdevice == 0.50 01:12:55 INFO - mozfile == 1.2 01:12:55 INFO - mozhttpd == 0.7 01:12:55 INFO - mozinfo == 0.9 01:12:55 INFO - mozleak == 0.1 01:12:55 INFO - mozlog == 3.4 01:12:55 INFO - moznetwork == 0.27 01:12:55 INFO - mozprocess == 0.25 01:12:55 INFO - mozprofile == 0.28 01:12:55 INFO - mozrunner == 6.13 01:12:55 INFO - mozscreenshot == 0.1 01:12:55 INFO - mozsystemmonitor == 0.3 01:12:55 INFO - moztest == 0.8 01:12:55 INFO - mozversion == 1.4 01:12:55 INFO - psutil == 3.1.1 01:12:55 INFO - requests == 1.2.3 01:12:55 INFO - wsgiref == 0.1.2 01:12:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:12:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:55 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 0x10de4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca85ddf30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc28d30>, '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 0x10db4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc1dbe8>, '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.q0bHfBdrCn/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.q11iwYdPDn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 01:12:55 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 01:12:55 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 01:12:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q0bHfBdrCn/Render', 01:12:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:12:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:12:55 INFO - 'HOME': '/Users/cltbld', 01:12:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:12:55 INFO - 'LOGNAME': 'cltbld', 01:12:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:55 INFO - 'MOZ_NO_REMOTE': '1', 01:12:55 INFO - 'NO_EM_RESTART': '1', 01:12:55 INFO - 'PAGER': '/bin/cat', 01:12:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:12:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:55 INFO - 'PWD': '/builds/slave/test', 01:12:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:12:55 INFO - 'SHELL': '/bin/bash', 01:12:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q11iwYdPDn/Listeners', 01:12:55 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 01:12:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:12:55 INFO - 'USER': 'cltbld', 01:12:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:12:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:12:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:55 INFO - 'XPC_FLAGS': '0x0', 01:12:55 INFO - 'XPC_SERVICE_NAME': '0', 01:12:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:56 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)) 01:12:56 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)) 01:12:56 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)) 01:12:56 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)) 01:12:56 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)) 01:12:56 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)) 01:12:56 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)) 01:12:56 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)) 01:12:56 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)) 01:12:56 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)) 01:12:56 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)) 01:12:56 INFO - Cleaning up... 01:12:56 INFO - Return code: 0 01:12:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:12: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')]} 01:12:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:12:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12: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')]} 01:12:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:12:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:12:56 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 0x10de4ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de4d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca85ddf30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dc28d30>, '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 0x10db4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc1dbe8>, '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.q0bHfBdrCn/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.q11iwYdPDn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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 01:12:56 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 01:12:56 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 01:12:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q0bHfBdrCn/Render', 01:12:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:12:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:12:56 INFO - 'HOME': '/Users/cltbld', 01:12:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:12:56 INFO - 'LOGNAME': 'cltbld', 01:12:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:12:56 INFO - 'MOZ_NO_REMOTE': '1', 01:12:56 INFO - 'NO_EM_RESTART': '1', 01:12:56 INFO - 'PAGER': '/bin/cat', 01:12:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:12:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:12:56 INFO - 'PWD': '/builds/slave/test', 01:12:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:12:56 INFO - 'SHELL': '/bin/bash', 01:12:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q11iwYdPDn/Listeners', 01:12:56 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 01:12:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:12:56 INFO - 'USER': 'cltbld', 01:12:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:12:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:12:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:12:56 INFO - 'XPC_FLAGS': '0x0', 01:12:56 INFO - 'XPC_SERVICE_NAME': '0', 01:12:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:12:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:12:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:12:56 INFO - Cleaning up... 01:12:56 INFO - Return code: 0 01:12:56 INFO - Running post-action listener: _resource_record_post_action 01:12:56 INFO - Running post-action listener: _start_resource_monitoring 01:12:56 INFO - Starting resource monitoring. 01:12:56 INFO - [mozharness: 2017-04-26 08:12:56.487044Z] Finished create-virtualenv step (success) 01:12:56 INFO - [mozharness: 2017-04-26 08:12:56.487979Z] Running install step. 01:12:56 INFO - Running pre-action listener: _resource_record_pre_action 01:12:56 INFO - Running main action method: install 01:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:12:56 INFO - Reading from file tmpfile_stdout 01:12:56 INFO - Detecting whether we're running mozinstall >=1.0... 01:12:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:12:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:12:56 INFO - Reading from file tmpfile_stdout 01:12:56 INFO - Output received: 01:12:56 INFO - Usage: mozinstall [options] installer 01:12:56 INFO - Options: 01:12:56 INFO - -h, --help show this help message and exit 01:12:56 INFO - -d DEST, --destination=DEST 01:12:56 INFO - Directory to install application into. [default: 01:12:56 INFO - "/builds/slave/test"] 01:12:56 INFO - --app=APP Application being installed. [default: firefox] 01:12:56 INFO - mkdir: /builds/slave/test/build/application 01:12:56 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'] 01:12:56 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 01:13:16 INFO - Reading from file tmpfile_stdout 01:13:16 INFO - Output received: 01:13:16 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:13:16 INFO - Running post-action listener: _resource_record_post_action 01:13:16 INFO - [mozharness: 2017-04-26 08:13:16.350227Z] Finished install step (success) 01:13:16 INFO - [mozharness: 2017-04-26 08:13:16.350352Z] Running run-tests step. 01:13:16 INFO - Running pre-action listener: _resource_record_pre_action 01:13:16 INFO - Running main action method: run_tests 01:13:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:13:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:13:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:13:16 INFO - 2017-04-26 01:13:16.363 screenresolution[1640:7268] starting screenresolution argv=screenresolution get 01:13:16 INFO - 2017-04-26 01:13:16.366 screenresolution[1640:7268] Display 0: 1600x1200x32@60 01:13:16 INFO - 2017-04-26 01:13:16.371 screenresolution[1641:7270] starting screenresolution argv=screenresolution list 01:13:16 INFO - Available Modes on Display 0 01:13:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:13:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:13:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:13:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:13:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:13:16 INFO - Intel Iris: 01:13:16 INFO - Chipset Model: Intel Iris 01:13:16 INFO - Type: GPU 01:13:16 INFO - Bus: Built-In 01:13:16 INFO - VRAM (Dynamic, Max): 1536 MB 01:13:16 INFO - Vendor: Intel (0x8086) 01:13:16 INFO - Device ID: 0x0a2e 01:13:16 INFO - Revision ID: 0x0009 01:13:16 INFO - Displays: 01:13:16 INFO - Display: 01:13:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:13:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:13:16 INFO - Display Serial Number: 1600x1200 60 01:13:16 INFO - Main Display: Yes 01:13:16 INFO - Mirror: Off 01:13:16 INFO - Online: Yes 01:13:16 INFO - Rotation: Supported 01:13:16 INFO - Return code: 0 01:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:13:16 INFO - Python 2.7.3 01:13:16 INFO - Return code: 0 01:13:16 INFO - grabbing minidump binary from tooltool 01:13: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')]} 01:13:16 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 0x10dc28d30>, '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 0x10db4edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10dc1dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:13:16 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 01:13:16 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 01:13:16 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 01:13:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:13:16 INFO - Return code: 0 01:13:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:13:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:13:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:13:16 INFO - ENV: RUST_BACKTRACE is now 1 01:13:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:13:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:13:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 01:13:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0258 --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 01:13:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q0bHfBdrCn/Render', 01:13:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:13:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:13:16 INFO - 'HOME': '/Users/cltbld', 01:13:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:13:16 INFO - 'LOGNAME': 'cltbld', 01:13:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:13:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:13:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:13:16 INFO - 'MOZ_NO_REMOTE': '1', 01:13:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:13:16 INFO - 'NO_EM_RESTART': '1', 01:13:16 INFO - 'PAGER': '/bin/cat', 01:13:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:13:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:13:16 INFO - 'PWD': '/builds/slave/test', 01:13:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:13:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:13:16 INFO - 'RUST_BACKTRACE': '1', 01:13:16 INFO - 'SHELL': '/bin/bash', 01:13:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.q11iwYdPDn/Listeners', 01:13:16 INFO - 'TMPDIR': '/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/', 01:13:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:13:16 INFO - 'USER': 'cltbld', 01:13:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:13:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:13:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:13:16 INFO - 'XPC_FLAGS': '0x0', 01:13:16 INFO - 'XPC_SERVICE_NAME': '0', 01:13:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:13:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0258', '--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 01:13:16 INFO - mozversion application_buildid: 20170425234025 01:13:16 INFO - mozversion application_changeset: 08a5a97f615fb65b3455b435c3e56d96c4c12208 01:13:16 INFO - mozversion application_display_name: Nightly 01:13:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:13:16 INFO - mozversion application_name: Firefox 01:13:16 INFO - mozversion application_remotingname: firefox 01:13:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 01:13:16 INFO - mozversion application_vendor: Mozilla 01:13:16 INFO - mozversion application_version: 55.0a1 01:13:16 INFO - mozversion platform_buildid: 20170425234025 01:13:16 INFO - mozversion platform_changeset: 08a5a97f615fb65b3455b435c3e56d96c4c12208 01:13:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 01:13:16 INFO - mozversion platform_version: 55.0a1 01:13:16 INFO - using testdate: 1493194396 01:13:16 INFO - actual date: 1493194396 01:13:16 INFO - starting webserver on 'localhost:49241' 01:13:16 INFO - SUITE-START | Running 2 tests 01:13:16 INFO - TEST-START | dromaeo_css 01:13:16 INFO - operating with platform_type : mac_ 01:13:16 INFO - Initialising browser for dromaeo_css test... 01:13:16 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpjSY8DW/profile http://localhost:49241/getInfo.html) 01:13:19 INFO - PID 1651 | 2017-04-26 01:13:19.703 plugin-container[1653:7455] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9843, name = 'com.apple.tsm.portname' 01:13:19 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:13:19 INFO - PID 1651 | 2017-04-26 01:13:19.706 plugin-container[1653:7455] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a2f, name = 'com.apple.CFPasteboardClient' 01:13:19 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:13:19 INFO - PID 1651 | 2017-04-26 01:13:19.706 plugin-container[1653:7455] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:13:19 INFO - PID 1651 | __metrics Screen width/height:1600/1200 01:13:19 INFO - PID 1651 | colorDepth:24 01:13:19 INFO - PID 1651 | Browser inner width/height: 1024/689 01:13:19 INFO - PID 1651 | __metrics 01:13:19 ERROR - PID 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 01:13:20 INFO - TEST-INFO | 1651: exit 0 01:13:20 INFO - Browser initialized. 01:13:20 INFO - Running cycle 1/1 for dromaeo_css test... 01:13:20 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmpjSY8DW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:13:23 INFO - PID 1654 | 2017-04-26 01:13:23.269 plugin-container[1655:7588] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 01:13:23 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:13:23 INFO - PID 1654 | 2017-04-26 01:13:23.270 plugin-container[1655:7588] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x460b, name = 'com.apple.CFPasteboardClient' 01:13:23 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:13:23 INFO - PID 1654 | 2017-04-26 01:13:23.270 plugin-container[1655:7588] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:13:33 INFO - PID 1654 | RSS: Main: 236085248 01:13:33 INFO - PID 1654 | 01:16:36 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 01:16:38 INFO - PID 1654 | RSS: Main: 251490304 01:16:38 INFO - PID 1654 | 01:18:21 INFO - PID 1654 | ************************* 01:18:21 INFO - PID 1654 | A coding exception was thrown and uncaught in a Task. 01:18:21 INFO - PID 1654 | 01:18:21 ERROR - PID 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:18:21 INFO - PID 1654 | Full stack: 01:18:21 INFO - PID 1654 | ************************* 01:18:21 INFO - PID 1654 | ************************* 01:18:21 INFO - PID 1654 | A coding exception was thrown and uncaught in a Task. 01:18:21 INFO - PID 1654 | 01:18:21 ERROR - PID 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:18:21 INFO - PID 1654 | Full stack: 01:18:21 INFO - PID 1654 | ************************* 01:18:21 INFO - PID 1654 | ************************* 01:18:21 INFO - PID 1654 | A coding exception was thrown and uncaught in a Task. 01:18:21 INFO - PID 1654 | 01:18:21 ERROR - PID 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:18:21 INFO - PID 1654 | Full stack: 01:18:21 INFO - PID 1654 | ************************* 01:18:21 INFO - PID 1654 | ************************* 01:18:21 INFO - PID 1654 | A coding exception was thrown and uncaught in a Task. 01:18:21 INFO - PID 1654 | 01:18:21 ERROR - PID 1654 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:18:21 INFO - PID 1654 | Full stack: 01:18:21 INFO - PID 1654 | ************************* 01:19:39 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 01:19:40 INFO - PID 1654 | RSS: Main: 256163840 01:19:40 INFO - PID 1654 | 01:22:42 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 01:22:42 INFO - PID 1654 | RSS: Main: 266661888 01:22:42 INFO - PID 1654 | 01:25:44 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 01:25:45 INFO - PID 1654 | RSS: Main: 259678208 01:25:45 INFO - PID 1654 | 01:28:47 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 01:28:48 INFO - PID 1654 | RSS: Main: 268402688 01:28:48 INFO - PID 1654 | 01:31:50 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 01:31:50 INFO - PID 1654 | RSS: Main: 263045120 01:31:50 INFO - PID 1654 | 01:31:50 INFO - PID 1654 | __start_tp_report 01:31:50 INFO - PID 1654 | _x_x_mozilla_page_load 01:31:50 INFO - PID 1654 | _x_x_mozilla_page_load_details 01:31:50 INFO - PID 1654 | |i|pagename|runs| 01:31:50 INFO - PID 1654 | |0;dojo.html;2673.9465210695776;3470.3753324401614;3579.5883473400568;3589.443636236383;3608.585012723536;5600.411956744534;5903.114532820074;6081.604695694777;6133.815985520436;6193.628382297065;5474.7810087596445;5606.607537472379;6115.940154142396;6200.441960223579;6276.340984196662;4307.483102027753;5269.578433725293;5408.864778380533;5409.323834520685;5483.287172667548;5503.064479038573;5513.173024046405;5531.3915469298545;5589.385167631557;5602.355729091146;4286;5150.407703114152;5426.782928682848;5474.124140137598;5528.391876893538;4587.8623641290815;5437.864053398657;5487.396386397493;5497.422770609069;5501.587380946445;5387.138057910715;5426.9185962210595;5446.8910621787345;5465.808696695596;5466.781328746845;4275.935860962088;5991.64050156992;6083.057126145454;6210.565260431772;6241.907666158404;5916.083007133901;6388;6444.742210311582;6558.639274839882;6646.700898459581;6453.548251622388;6742.258351581371;6755.3582409671;6759;6759.188897332302;5463.31708536433;5766.769329226784;6287.779927702554;6321.778737744203;6333.778317758856;5606.467385598362;5646.57650676201;6695.631740254333;6737.52837301394;6846.315368463114;5412.972935135299;6253.1245625612455;6439.356064393617;6494.545381823227;6524.641144737085;5418.91871621926;6686.966565167143;6720.495962802809;6731.259561448237;6743.865122697617;6538.738450462023;6629.86740265192;6640.734370625218;6650.501212409089;6655.534112612071;5638.689872056994;6318.147050148171;6394.8721025579225;6486.962086066207;6550.7707230246715;5122.769475373617;5315.468453154731;5318.44156363584;5324.068288049576;5356.223347614574;3942.704297177723;4712.6229901607785;4724.834630787906;4745.691530050604;4756.881077973078;5214.478552144831;6257.374262573797;6257.43683068526;6324.810255692245;6357.809265722036;6697.263301036882;6740.595564266159;6750.054992301082;6755.4257888080065;6776.593404395752;6311;6345.143405640272;6358.809235722843;6368.840778980562;6394.360563943662;5715.1713001614535;5786.1610066540115;5864.589478736448;5873.618214816109;5902.2327097477055;5831.241938547962;6981.546199497219;6985.860282794417;6991.440684745106;7026.156861176692;5624.690642014729;6729.2934241903895;6734.427573656294;6742.224644165984;6754.763583274562;6669.666516674244;6765.019072234597;6808.693608787517;6901.413379862768;6914.343137401939;6515.706793194223;6590.011498275297;6599.4390476808085;6607.438367738796;6617.470602351897;6721.462283017445;6724.966375168288;6729.0915726376315;6741.089952856301;6743.9325606743305;6297.244330680348;6368.936310636835;6378.330275321025;6464.353564643498;6486.124373209556;6399.520035997226;6495.441094137467;6512.902306465501;6542.084108224947;6563.0811686364905;6297.370262973666;6363.87272254543;6389.329120442472;6413.8717225656155;6446.29090800021;5297.576193904401;6260.968695156677;6429.132067170872;6485.124508191334;6515.478761699147;6328.968355158195;6341.841453963688;6369.331220221995;6370.140031095742;6372.9362706374195 01:31:50 INFO - PID 1654 | |1;ext.html;754.8075240813591;815.6044318505526;834.8872902158208;1267.4739982907095;1292.3473645808865;33700.83149584252;40109.398359024635;40134.19731605366;40166.39750403739;40245.1950960981;26790.464190716175;35864.74473393432;39622.00944976377;40039.39940900889;40248.79875600618;8210.753677389674;8657.783555411102;8872.8669069964;8887.333449991243;8893.822123557526;8827.602757875911;8907.376483646147;8931.464112153259;8948.060453652339;9021.729348119567;6760.323967603225;8825.073367296438;8952.283817294601;9024.32317576181;9040.8643870342;7515.849683006364;8474.661013559482;8874.778130546756;8915.955420222923;8942.239909607692;8609;8683.088275731021;8699.304055675531;8700.173483519056;8707.303415726727;38148.42777358342;38237.85286441411;38303.233935321136;38397.42403863916;38450;3671.6695497405094;3683.410654295327;3710.9814450927574;3713.702903767692;3721.4603882436895;31377;31458;31462.685373146203;31464.685353146404;31503.84248078768;3142.71715545602;3207.3264614430764;3210.4381733196597;3231.9030429087165;3242.7567932404927;249956.75021624958;254412;274059;286756.26487470133;287080;48380.75809620929;48507.272390914164;48968.265476017885;49015.30415827164;49247;51164;51433.48566514287;51473.7426312866;51602;51724.051734050314;12093.818592721116;14426.350814213385;14587.978841481206;14589.343479543446;14609.269536523343;11675.241109327866;11795.823062654066;11896.940515297541;11919.463624136935;11923.523059077714;13538.661533461545;13546.390412431465;13587.86412135866;13620.387082581308;13682.452701891812;4987.301777751118;5925.940740592625;5952.9582323094155;5989.940100599026;5992.790252341147;1025.195221750922;1038.7922415516928;1039.2413538117216;1062.9468526573794;1069.2515239332342;19931.501712457015;21714.348569542937;22307;23340.416489587897;24549.877250613634;1140.310112381997;1142.0977427832086;1175.629676651852;1177.1230433327055;1178.9587364442202;12109.515619375303;12613.936930315473;12660.620181394574;12684.112112152061;12701.491940322469;319420.80579194374;320289;321867;322802;323161.3841930775;54696.45303546914;54811.72594137004;54951;55022;55338;1538.4000239906445;1555.7666350047357;1584.2395650087792;1588.3964093644572;1589.0227510081218;20779.58440831205;20922.581548368642;24088.79556022227;24225.63661545043;24386.634200487362;28243.293917652223;31284.530732038584;35669.286614267054;38150;38721.61278387293;246795;250487;263915;263923.68038159685;264364;34063.4890476648;34069.82965085258;34440.655593444746;34716;34881.12797180091;45124.77437612791;45874.77062614666;45980.7700961493;46044.53955460402;46104.308435372826;24061.398465038514;30142.287194152632;30146.69853301439;31358.52962205523;31752.682473175897;30480.390392192476;30967.845160774952;31162.909298175364;31312;31348.68651313549;30179.849100754356;35938.820305898305;36487.63512364949;36732.632673672924;37426.43860342043;31011.379772404878;31708.84145579257;31754.88857890055;31928.042158735276;31944.52083218707;20013.299534516806;20216.989150542708;23041.65437518472;23962.52074958526;24531 01:31:50 INFO - PID 1654 | |2;jquery.html;434.1880683122561;437.2239275286365;444.0563801920918;447.89250579860834;460.7097528557011;19912.50218744532;21668.56662866744;22274.331770046883;22510.324690259276;22630.54738905223;22662;23048.88475557624;23809.5238095238;23976.76023239767;24194.879025604892;6159.353267906872;6170.382961703816;6186.876262474759;6392.105105285264;6405.103285540004;6163.198784158076;6265.71804268809;6275.403836635513;6279.058141278799;6282.7172777224905;5228.764705588258;6126.571140020201;6137.079438084278;6169.876602467948;6242.375762423767;6200.286966998808;6247.875042499148;6262.561620686553;6276.3409841966395;6284.088807122965;5493.313335833021;5537.335519737658;5593;5602.635828671164;5612.326520817487;27206.911723531033;27476.58785118225;27510.724892751216;27647.86176069127;27666.723332766614;2227.098025299756;2302.4704318006784;2308.815294776414;2310.8844557772045;2313.595120853844;16266.43067492644;17810.55473613157;18216;18407.171677274553;18457.90771046136;2159.1903036361364;2219.655953327237;2233.8659680419064;2236.575050740354;2237.295251995616;160006;161825;161936.19031904882;165035;165634.1718291413;11297.435128243555;12112.15214934946;12893.35533223335;13075.542356017684;13198.010149238846;16604.08677522748;16731.749023764653;16817.32730690783;16827.831721682625;16869.15654217284;8905.417428945662;9191.540422978824;9203.97268036616;9340.392874463274;9403.341766076446;8767.21095101444;8802.691905783267;8836.602352894135;8977.653351997122;9002.414843035182;6502.60984340941;8078.030636323679;8100.50140723968;8133.2680058794995;8277.379196560281;2202.317281642696;2204.7574766775642;2204.911803527841;2205.228170140438;2367.958098436682;965.4834663455018;975.3124047546463;982.2240430060315;1000.7047920863363;1023.9334443261164;21755.67366489504;22163;22231.44421389478;22243.77756222417;22249.998750055962;1021.4433133942019;1034.7949812443421;1048.444324508012;1051.9737006574896;1064.7657515346611;9867.506624668738;11235.83146252807;11285.887141128647;11290.322580645188;11322.660320190407;510290;552752;554840;566733;572699;137906;138878;139171;141030;142814;1162.3490845126755;1169.4152923538231;1193.826895100223;1197.2696655040418;1200.591798788416;17846.375376861746;18242.817571824642;18273.725894111332;18304.72542911884;18707.532311692317;45984.54015459803;59342.703286483295;59608;59865.20404387875;59944;77997.83003254842;80017;81711;82926;83614.16385836064;8173.386995975206;8541.53021583819;8676.609552570024;9079.59141838632;9318.72043838686;11285.153613478858;13769.793453098011;14380.209088500233;14402.279886005448;14458.204798736171;10183.592656293666;11972.820407694066;12008.579699710468;12179.573714919936;12232.633021009384;11348.432578370883;11388.772224555629;11551.844815518381;11690.240134391237;11701.707457313636;11624.941875290908;12136.514539418324;12567.245965242115;12569.811452828031;12572;8678.698195270508;8869.334799890163;8927.598258078531;8999.695044218683;9262.629494820132;10966.342019478856;11832.230904991147;11960.10299227544;12056.75886482283;12231.755364892475 01:31:50 INFO - PID 1654 | |3;mootools.html;1232.5316379775684;1263.65249556372;1440.4526280013592;1458.329168582452;1460.912345259284;10690.358578485286;11110.500027498761;11536.307821530714;12066.517339306429;12272.32502212378;11663.650090497278;11990.7601847963;12020.459079341428;12026.639200823967;12036.638900832968;2556.156468365435;2599.8180127391092;2606.309328028074;2620.4628051249542;2630.5791073428254;2526.5831137862324;2572.2154742803436;2574.11193138367;2581.793456523483;2586.7283935186724;2535.911243106492;2559.36015996001;2568.9229323120335;2585.6767904012;2589.896404143832;2487.788537974265;2497.126005897939;2527.166035208377;2528.115159694092;2533.0880882882147;2363.7045369328835;2463.5442443148077;2472.221250306148;2529.013684662983;2536.847789132658;11989;12074.456649450796;12080.395980200954;12115.878841211563;12116.81824772629;6555.967220163916;6796.76211332601;6825.1809782825885;6831.863362732767;6844.178698556205;3750.362438385481;4040.5151381834075;4370.300751879684;4416.3375493675885;4443.622292105175;1277.9808302875465;1301.8112373705853;1350.702845374016;1350.8108864758844;1355.153029356652;15138.470153544573;15679.764803527842;16425;16576.66846663072;16666.4166754163;5407.297051383295;5513.365962914236;5735.1684005818925;5765.077587585966;5784.797532086441;11787.469563869476;11852.288862668267;11937.28376297425;11962.880371196177;11969.222000569935;6551.574147680385;6553.099601115623;6558.376954189344;6568.671566421755;6569.343065693392;5902.4097590240635;6108.725107370179;6132.908006379907;6254.093156492374;6289.77985770505;4276.550962148992;4376.081022985209;4381.510286502541;4432.512423633398;4434.889127771831;1037.725002874239;1264.1277518512381;1273.828033215504;1274.5793888016933;1281.858995510493;816.0859836982618;817.5421763812284;835.1481488881307;840.0759164918541;863.4171933944563;6234.721882014267;6286.591371560834;6442.742290308429;6498.285188629247;6551.475881929529;544.0967993131383;555.8471420359352;596.4095545410013;618.6968385491167;623.6476390839161;3872.3223435898603;4311.461067366579;4350.129974005212;4387.3857659927635;4573.222552166139;14661.560153195422;15056.623584410478;15075;15188.772168417483;15211.695766084616;12721.745565088831;14456.98801083935;14966.32651530662;15002.94979351435;15130.243487825564;8460.407771456063;8701.782455438539;8705.39062265648;8719.65121395137;8721.127887211229;4658.8136474542;6006.609570377911;7014.614196219257;7184.712611495691;7235.63821808897;12442.191257568229;12485.250884946932;12673.049521285757;12786.232826030468;12828.037897157565;12921.353932303535;13794.310109528948;13894.166350019032;13899.930500347433;14137;9170.724878253663;9397.060293970822;9545.331826772337;9548.52257387114;9553.904460955302;10911.345319280868;11085.113190944867;11112.388818615054;11131.332120072822;11138.665840024812;9088.863892013498;9104.089591040844;9240.214581760625;9280.303977201871;9508.150843069945;7407.259274072765;7554.320111190019;8968.775780605538;9053.502057386644;9121.863172052557;8207.917920820953;8224.917750822655;8245.876311855447;8300.833983320179;8359.749207523784;6112.2970858351855;6120.112583675431;6121.602095863755;6178.907316390168;6216.968915155395;5324.547413469899;5835.299764028344;6102.389761023862;6216.968915155576;6286.591371560834 01:31:50 INFO - PID 1654 | |4;prototype.html;389.77003567894934;412.3052656274176;413.8737685006073;415.5947950748023;419.31232778243685;5287.6034297427705;6194.7831825886105;6302.038042120208;6303.905441418382;6531.804045878619;5190.922136167951;6116.44951954324;6122.663253521055;6124.203853499039;6139.140520327147;3838.251540949502;4312.094460163362;4437.711548749321;4470.41884555009;4479.148961697283;3839.9232015359676;4400.8019639116155;4432.623227025707;4464.682918539039;4501.3022981437925;3597.5503062117236;3851.921461990647;4395.274779661352;4428.40216570762;4439.178751930887;4117.9176416471655;4434.49003364614;4444.955550444486;4466.57567531084;4470.441194850644;3309.4373956427225;3375.9365799772995;3787.6591106800242;3820.9044773880596;3828.617138286177;4895.657303988723;5979.342272350038;5980.401959804029;5982.312034116088;6048.485878700316;4129.961447034613;5194.467632048555;5214.400343960418;5218.921716174261;5226.2944502492055;5297.602679799031;5384.434634363374;6339;6512.6092434454085;6581.440577550914;4238.491381034265;4239.915201695949;4255.489301298026;4266;4267.146570685844;5769.451902069297;6312.526560507934;6765.154355705537;6934.341237582422;7006.124234470692;4167.5832416758085;4323.156984388077;4339;4349.608535231781;4434.312681534368;4410.184115938561;4424.867253982386;4433.714222875395;4442.73343599385;4448.4439445069365;5125.103106956268;5193.584513238932;5223.843284701465;5230.555402790806;5238.476152384731;6361.61830290184;6580.506462015368;6581.703823327962;6590.8352291193105;6598.27418983921;1480.3560451203546;1503.2934520775218;1511.2443778110944;1513.6140284227672;1514.5153550863838;828.2421584250343;954.8042651256615;975.6828281819629;980.1423754215061;1014.8477728340808;5236.711980841091;6156.630602163885;6319.842003949846;6344.6827658616885;6358.936410635834;6837.829054273683;6847.794566163023;6849.691763870638;6856.120429419556;6856.5200435969;5688.772449102073;5811.070228763378;6074.362191969868;6219.036049412348;6425.58233714807;3208.502682084281;3285.3265080658407;3601.7478776485395;3606.296772129462;3614.963850361515;6133.601315914451;6377.457916077093;6948.930510694829;7116.857662846714;7142.392896603743;6305.873882522324;6906.240313565504;7015.263397343308;7095.467839912028;7115.466340024519;7000.69457283777;7049.590081983623;7066.540674856118;7076.681549330293;7136.111763442059;5989.610675306091;6337.334579869232;6862.897056544256;6889;6892.793216203522;6170.876582468236;6649.900251496135;6765.154355705537;6790.287019862843;6809.319068093349;5601.6639001658405;7124.180719217356;7130;7156;7159.57042577447;4136.91726165481;4392.692511524163;4615.330777037378;4861.4895435978715;4884.340614017062;6533.607983521004;6657.4674026078765;6883.896741548981;6885.51801373899;6936.514443989075;5179.611529135254;5533.00405926937;6019.247594050744;6094.481969032505;6632.2372927114;6307.526935479949;6321.399467050623;6338.556301058881;6618.503612229199;6650.733970641314;5694.402087780889;6454.67726613658;6491.285958544462;6521.119648847534;6544.85465043625;6012.458878700938;6071.605345652519;6507.707153178213;6659.933400666125;6676.232233293234;6402.423781859655;6432.2281326241155;6479.319671434431;6482.578632389068;6495.837604059747 01:31:50 INFO - PID 1654 | |5;yui.html;846.1749793950895;851.4295422067215;863.7883718488971;880.357339142426;886.9866951995721;14917.104973701586;15065.62335941602;16158.030518168918;17248.827511724896;17332.826671733277;14148.434062637509;17619.55951101223;17765.289388424448;17827.64344713105;18695.90652046741;1015.7866847961936;1017.1455976979336;1038.2991480750502;1044.9634262800803;1045.592219034577;1060.008891686272;1073.3828048871892;1077.175960390302;1077.6713102503772;1083.8157513222732;1108.501174471487;1116.8715597706287;1119.7368618374676;1123.1239633086166;1127.0589058136466;1106.5076041161685;1113.7215696075982;1117.1286396610656;1118.7035435609612;1118.927269727465;787.4212453846418;809.4374409785142;814.4380377539479;815.4617952151551;822.2271065198754;16881.324747010105;17392.130393480275;17506.824931750773;17577.736333955;17629.7355539667;15479.845201547952;15657.29542170605;15849.811264155234;16099.195040247942;16142.869999100069;13143.408546615425;13434.596962091153;13435.12671676338;13456.730865382735;13459.528916487876;3368.1074515253476;3409.505621684842;3547.1486843157713;3605.080704420382;3605.152789094561;103587.4820625892;128252.71747282594;129416;130211;130479;13356.931445484339;13881.375338109809;13914.234717090454;13929;13957.371918263703;23612.173573925174;24649.507009859703;25818.967241310515;26630;26837.463250734876;7714.421418393643;7808.336291415179;7835.177306382861;7846.489978151402;7853.175416581176;3938.3895496198134;4007.5591684914634;4062.1469491407133;4078.062045729499;4084.1219137885496;4249.915001699948;4377.299632058855;4386.166628340605;4405.735655860659;4425.09285596452;954.8090381923643;983.8327484327682;992.8411454167443;992.980140397188;994.0854413939194;638.3871483376012;658.4436151452015;658.7957733102753;664.6278084272726;682.2427105912433;10263.486825658687;11388.487518061707;11784.528618855149;11892.345920974429;12136.870880205439;530.7187190788889;587.465406480101;637.8692368064628;658.9044588534636;682.6279677575733;5197.22041693749;5253.1857562077175;5267.2889159962915;5348.9732551337775;5640.802571910045;102235;102432;102931.97068029374;104168.43747343795;105122;72889;91938.70153246088;93263;93294.66763330836;94877.5256123715;79683.20316796874;81037.78443323237;81519;81645;82509.63687360303;11050.557977681125;11173.664790056311;11351.886481135083;11400.543978241109;11530.59642912494;24512.632310515;34854.47718284177;38320.23359532849;38506.80746596249;39558.80220598879;75630;76035.23964760282;76810;76999.61500192463;77289.2271077282;16098.11460369691;16244.269007894909;16279.837201627832;16449.013059216486;16501.752473713143;14670.266486675837;17879.910600446914;18118.91286522813;18133.184006719992;18325;13700.725985480036;16543.669126617642;16622.916885415496;16786.916065420082;16875.578110547336;12905.612831615066;16347.509574712778;16438.342466301216;16555.91722041382;16571;15932.601684957504;16154.353825846834;16177.191140443167;16385.098819564562;16458.588535286715;9999.850002250118;11689;11801.763964720485;11838.940805295919;11998.520059197534;12573.811392828931;12615.810762838748;12641.683957901127;12649.241045537297;12714.682132946751 01:31:50 INFO - PID 1654 | __end_tp_report 01:31:50 INFO - PID 1654 | __start_cc_report 01:31:50 INFO - PID 1654 | _x_x_mozilla_cycle_collect,423 01:31:50 INFO - PID 1654 | __end_cc_report 01:31:50 INFO - PID 1654 | __startTimestamp1493195510664__endTimestamp 01:31:50 INFO - PID 1654 | 01:31:50 INFO - PID 1654 | ------- Summary: start ------- 01:31:50 INFO - PID 1654 | Number of tests: 6 01:31:50 INFO - PID 1654 | 01:31:50 INFO - PID 1654 | [#0] dojo.html Cycles:165 Average:6025.30 Median:6324.81 stddev:790.05 (12.5%) stddev-sans-first:747.46 01:31:50 INFO - PID 1654 | Values: 2673.9 3470.4 3579.6 3589.4 3608.6 5600.4 5903.1 6081.6 6133.8 6193.6 5474.8 5606.6 6115.9 6200.4 6276.3 4307.5 5269.6 5408.9 5409.3 5483.3 5503.1 5513.2 5531.4 5589.4 5602.4 4286.0 5150.4 5426.8 5474.1 5528.4 4587.9 5437.9 5487.4 5497.4 5501.6 5387.1 5426.9 5446.9 5465.8 5466.8 4275.9 5991.6 6083.1 6210.6 6241.9 5916.1 6388.0 6444.7 6558.6 6646.7 6453.5 6742.3 6755.4 6759.0 6759.2 5463.3 5766.8 6287.8 6321.8 6333.8 5606.5 5646.6 6695.6 6737.5 6846.3 5413.0 6253.1 6439.4 6494.5 6524.6 5418.9 6687.0 6720.5 6731.3 6743.9 6538.7 6629.9 6640.7 6650.5 6655.5 5638.7 6318.1 6394.9 6487.0 6550.8 5122.8 5315.5 5318.4 5324.1 5356.2 3942.7 4712.6 4724.8 4745.7 4756.9 5214.5 6257.4 6257.4 6324.8 6357.8 6697.3 6740.6 6750.1 6755.4 6776.6 6311.0 6345.1 6358.8 6368.8 6394.4 5715.2 5786.2 5864.6 5873.6 5902.2 5831.2 6981.5 6985.9 6991.4 7026.2 5624.7 6729.3 6734.4 6742.2 6754.8 6669.7 6765.0 6808.7 6901.4 6914.3 6515.7 6590.0 6599.4 6607.4 6617.5 6721.5 6725.0 6729.1 6741.1 6743.9 6297.2 6368.9 6378.3 6464.4 6486.1 6399.5 6495.4 6512.9 6542.1 6563.1 6297.4 6363.9 6389.3 6413.9 6446.3 5297.6 6261.0 6429.1 6485.1 6515.5 6329.0 6341.8 6369.3 6370.1 6372.9 01:31:50 INFO - PID 1654 | 01:31:50 INFO - PID 1654 | [#1] ext.html Cycles:180 Average:43694.33 Median:162538.72 stddev:74599.72 (45.9%) stddev-sans-first:74739.32 01:31:50 INFO - PID 1654 | Values: 754.8 815.6 834.9 1267.5 1292.3 33700.8 40109.4 40134.2 40166.4 40245.2 26790.5 35864.7 39622.0 40039.4 40248.8 8210.8 8657.8 8872.9 8887.3 8893.8 8827.6 8907.4 8931.5 8948.1 9021.7 6760.3 8825.1 8952.3 9024.3 9040.9 7515.8 8474.7 8874.8 8916.0 8942.2 8609.0 8683.1 8699.3 8700.2 8707.3 38148.4 38237.9 38303.2 38397.4 38450.0 3671.7 3683.4 3711.0 3713.7 3721.5 31377.0 31458.0 31462.7 31464.7 31503.8 3142.7 3207.3 3210.4 3231.9 3242.8 249956.8 254412.0 274059.0 286756.3 287080.0 48380.8 48507.3 48968.3 49015.3 49247.0 51164.0 51433.5 51473.7 51602.0 51724.1 12093.8 14426.4 14588.0 14589.3 14609.3 11675.2 11795.8 11896.9 11919.5 11923.5 13538.7 13546.4 13587.9 13620.4 13682.5 4987.3 5925.9 5953.0 5989.9 5992.8 1025.2 1038.8 1039.2 1062.9 1069.3 19931.5 21714.3 22307.0 23340.4 24549.9 1140.3 1142.1 1175.6 1177.1 1179.0 12109.5 12613.9 12660.6 12684.1 12701.5 319420.8 320289.0 321867.0 322802.0 323161.4 54696.5 54811.7 54951.0 55022.0 55338.0 1538.4 1555.8 1584.2 1588.4 1589.0 20779.6 20922.6 24088.8 24225.6 24386.6 28243.3 31284.5 35669.3 38150.0 38721.6 246795.0 250487.0 263915.0 263923.7 264364.0 34063.5 34069.8 34440.7 34716.0 34881.1 45124.8 45874.8 45980.8 46044.5 46104.3 24061.4 30142.3 30146.7 31358.5 31752.7 30480.4 30967.8 31162.9 31312.0 31348.7 30179.8 35938.8 36487.6 36732.6 37426.4 31011.4 31708.8 31754.9 31928.0 31944.5 20013.3 20217.0 23041.7 23962.5 24531.0 01:31:50 INFO - PID 1654 | 01:31:50 INFO - PID 1654 | [#2] jquery.html Cycles:180 Average:36367.39 Median:22646.27 stddev:94219.68 (416.0%) stddev-sans-first:94445.36 01:31:50 INFO - PID 1654 | Values: 434.2 437.2 444.1 447.9 460.7 19912.5 21668.6 22274.3 22510.3 22630.5 22662.0 23048.9 23809.5 23976.8 24194.9 6159.4 6170.4 6186.9 6392.1 6405.1 6163.2 6265.7 6275.4 6279.1 6282.7 5228.8 6126.6 6137.1 6169.9 6242.4 6200.3 6247.9 6262.6 6276.3 6284.1 5493.3 5537.3 5593.0 5602.6 5612.3 27206.9 27476.6 27510.7 27647.9 27666.7 2227.1 2302.5 2308.8 2310.9 2313.6 16266.4 17810.6 18216.0 18407.2 18457.9 2159.2 2219.7 2233.9 2236.6 2237.3 160006.0 161825.0 161936.2 165035.0 165634.2 11297.4 12112.2 12893.4 13075.5 13198.0 16604.1 16731.7 16817.3 16827.8 16869.2 8905.4 9191.5 9204.0 9340.4 9403.3 8767.2 8802.7 8836.6 8977.7 9002.4 6502.6 8078.0 8100.5 8133.3 8277.4 2202.3 2204.8 2204.9 2205.2 2368.0 965.5 975.3 982.2 1000.7 1023.9 21755.7 22163.0 22231.4 22243.8 22250.0 1021.4 1034.8 1048.4 1052.0 1064.8 9867.5 11235.8 11285.9 11290.3 11322.7 510290.0 552752.0 554840.0 566733.0 572699.0 137906.0 138878.0 139171.0 141030.0 142814.0 1162.3 1169.4 1193.8 1197.3 1200.6 17846.4 18242.8 18273.7 18304.7 18707.5 45984.5 59342.7 59608.0 59865.2 59944.0 77997.8 80017.0 81711.0 82926.0 83614.2 8173.4 8541.5 8676.6 9079.6 9318.7 11285.2 13769.8 14380.2 14402.3 14458.2 10183.6 11972.8 12008.6 12179.6 12232.6 11348.4 11388.8 11551.8 11690.2 11701.7 11624.9 12136.5 12567.2 12569.8 12572.0 8678.7 8869.3 8927.6 8999.7 9262.6 10966.3 11832.2 11960.1 12056.8 12231.8 01:31:50 INFO - PID 1654 | 01:31:50 INFO - PID 1654 | [#3] mootools.html Cycles:180 Average:7098.07 Median:3811.34 stddev:4469.70 (117.3%) stddev-sans-first:4460.51 01:31:50 INFO - PID 1654 | Values: 1232.5 1263.7 1440.5 1458.3 1460.9 10690.4 11110.5 11536.3 12066.5 12272.3 11663.7 11990.8 12020.5 12026.6 12036.6 2556.2 2599.8 2606.3 2620.5 2630.6 2526.6 2572.2 2574.1 2581.8 2586.7 2535.9 2559.4 2568.9 2585.7 2589.9 2487.8 2497.1 2527.2 2528.1 2533.1 2363.7 2463.5 2472.2 2529.0 2536.8 11989.0 12074.5 12080.4 12115.9 12116.8 6556.0 6796.8 6825.2 6831.9 6844.2 3750.4 4040.5 4370.3 4416.3 4443.6 1278.0 1301.8 1350.7 1350.8 1355.2 15138.5 15679.8 16425.0 16576.7 16666.4 5407.3 5513.4 5735.2 5765.1 5784.8 11787.5 11852.3 11937.3 11962.9 11969.2 6551.6 6553.1 6558.4 6568.7 6569.3 5902.4 6108.7 6132.9 6254.1 6289.8 4276.6 4376.1 4381.5 4432.5 4434.9 1037.7 1264.1 1273.8 1274.6 1281.9 816.1 817.5 835.1 840.1 863.4 6234.7 6286.6 6442.7 6498.3 6551.5 544.1 555.8 596.4 618.7 623.6 3872.3 4311.5 4350.1 4387.4 4573.2 14661.6 15056.6 15075.0 15188.8 15211.7 12721.7 14457.0 14966.3 15002.9 15130.2 8460.4 8701.8 8705.4 8719.7 8721.1 4658.8 6006.6 7014.6 7184.7 7235.6 12442.2 12485.3 12673.0 12786.2 12828.0 12921.4 13794.3 13894.2 13899.9 14137.0 9170.7 9397.1 9545.3 9548.5 9553.9 10911.3 11085.1 11112.4 11131.3 11138.7 9088.9 9104.1 9240.2 9280.3 9508.2 7407.3 7554.3 8968.8 9053.5 9121.9 8207.9 8224.9 8245.9 8300.8 8359.7 6112.3 6120.1 6121.6 6178.9 6217.0 5324.5 5835.3 6102.4 6217.0 6286.6 01:31:50 INFO - PID 1654 | 01:31:50 INFO - PID 1654 | [#4] prototype.html Cycles:180 Average:5275.29 Median:6060.05 stddev:1702.10 (28.1%) stddev-sans-first:1666.91 01:31:50 INFO - PID 1654 | Values: 389.8 412.3 413.9 415.6 419.3 5287.6 6194.8 6302.0 6303.9 6531.8 5190.9 6116.4 6122.7 6124.2 6139.1 3838.3 4312.1 4437.7 4470.4 4479.1 3839.9 4400.8 4432.6 4464.7 4501.3 3597.6 3851.9 4395.3 4428.4 4439.2 4117.9 4434.5 4445.0 4466.6 4470.4 3309.4 3375.9 3787.7 3820.9 3828.6 4895.7 5979.3 5980.4 5982.3 6048.5 4130.0 5194.5 5214.4 5218.9 5226.3 5297.6 5384.4 6339.0 6512.6 6581.4 4238.5 4239.9 4255.5 4266.0 4267.1 5769.5 6312.5 6765.2 6934.3 7006.1 4167.6 4323.2 4339.0 4349.6 4434.3 4410.2 4424.9 4433.7 4442.7 4448.4 5125.1 5193.6 5223.8 5230.6 5238.5 6361.6 6580.5 6581.7 6590.8 6598.3 1480.4 1503.3 1511.2 1513.6 1514.5 828.2 954.8 975.7 980.1 1014.8 5236.7 6156.6 6319.8 6344.7 6358.9 6837.8 6847.8 6849.7 6856.1 6856.5 5688.8 5811.1 6074.4 6219.0 6425.6 3208.5 3285.3 3601.7 3606.3 3615.0 6133.6 6377.5 6948.9 7116.9 7142.4 6305.9 6906.2 7015.3 7095.5 7115.5 7000.7 7049.6 7066.5 7076.7 7136.1 5989.6 6337.3 6862.9 6889.0 6892.8 6170.9 6649.9 6765.2 6790.3 6809.3 5601.7 7124.2 7130.0 7156.0 7159.6 4136.9 4392.7 4615.3 4861.5 4884.3 6533.6 6657.5 6883.9 6885.5 6936.5 5179.6 5533.0 6019.2 6094.5 6632.2 6307.5 6321.4 6338.6 6618.5 6650.7 5694.4 6454.7 6491.3 6521.1 6544.9 6012.5 6071.6 6507.7 6659.9 6676.2 6402.4 6432.2 6479.3 6482.6 6495.8 01:31:50 INFO - PID 1654 | 01:31:50 INFO - PID 1654 | [#5] yui.html Cycles:180 Average:21982.72 Median:17290.83 stddev:31187.42 (180.4%) stddev-sans-first:31234.52 01:31:50 INFO - PID 1654 | Values: 846.2 851.4 863.8 880.4 887.0 14917.1 15065.6 16158.0 17248.8 17332.8 14148.4 17619.6 17765.3 17827.6 18695.9 1015.8 1017.1 1038.3 1045.0 1045.6 1060.0 1073.4 1077.2 1077.7 1083.8 1108.5 1116.9 1119.7 1123.1 1127.1 1106.5 1113.7 1117.1 1118.7 1118.9 787.4 809.4 814.4 815.5 822.2 16881.3 17392.1 17506.8 17577.7 17629.7 15479.8 15657.3 15849.8 16099.2 16142.9 13143.4 13434.6 13435.1 13456.7 13459.5 3368.1 3409.5 3547.1 3605.1 3605.2 103587.5 128252.7 129416.0 130211.0 130479.0 13356.9 13881.4 13914.2 13929.0 13957.4 23612.2 24649.5 25819.0 26630.0 26837.5 7714.4 7808.3 7835.2 7846.5 7853.2 3938.4 4007.6 4062.1 4078.1 4084.1 4249.9 4377.3 4386.2 4405.7 4425.1 954.8 983.8 992.8 993.0 994.1 638.4 658.4 658.8 664.6 682.2 10263.5 11388.5 11784.5 11892.3 12136.9 530.7 587.5 637.9 658.9 682.6 5197.2 5253.2 5267.3 5349.0 5640.8 102235.0 102432.0 102932.0 104168.4 105122.0 72889.0 91938.7 93263.0 93294.7 94877.5 79683.2 81037.8 81519.0 81645.0 82509.6 11050.6 11173.7 11351.9 11400.5 11530.6 24512.6 34854.5 38320.2 38506.8 39558.8 75630.0 76035.2 76810.0 76999.6 77289.2 16098.1 16244.3 16279.8 16449.0 16501.8 14670.3 17879.9 18118.9 18133.2 18325.0 13700.7 16543.7 16622.9 16786.9 16875.6 12905.6 16347.5 16438.3 16555.9 16571.0 15932.6 16154.4 16177.2 16385.1 16458.6 9999.9 11689.0 11801.8 11838.9 11998.5 12573.8 12615.8 12641.7 12649.2 12714.7 01:31:50 INFO - PID 1654 | -------- Summary: end -------- 01:31:50 INFO - PID 1654 | 01:31:51 INFO - TEST-INFO | 1654: exit 0 01:31:51 INFO - TEST-OK | dromaeo_css | took 1114389ms 01:31:51 INFO - TEST-START | kraken 01:31:51 INFO - operating with platform_type : mac_ 01:31:51 INFO - Initialising browser for kraken test... 01:31:51 INFO - TEST-INFO | started process 1777 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmp5sZowO/profile http://localhost:49241/getInfo.html) 01:31:54 INFO - PID 1777 | 2017-04-26 01:31:54.150 plugin-container[1778:10274] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9237, name = 'com.apple.tsm.portname' 01:31:54 INFO - PID 1777 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:31:54 INFO - PID 1777 | 2017-04-26 01:31:54.154 plugin-container[1778:10274] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 01:31:54 INFO - PID 1777 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:31:54 INFO - PID 1777 | 2017-04-26 01:31:54.154 plugin-container[1778:10274] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:31:54 INFO - PID 1777 | __metrics Screen width/height:1600/1200 01:31:54 INFO - PID 1777 | colorDepth:24 01:31:54 INFO - PID 1777 | Browser inner width/height: 1024/689 01:31:54 INFO - PID 1777 | __metrics 01:31:54 ERROR - PID 1777 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3424: TypeError: this.tabs is undefined 01:31:55 INFO - TEST-INFO | 1777: exit 0 01:31:55 INFO - Browser initialized. 01:31:55 INFO - Running cycle 1/1 for kraken test... 01:31:55 INFO - TEST-INFO | started process 1779 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/tmp5sZowO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:31:57 INFO - PID 1779 | 2017-04-26 01:31:57.564 plugin-container[1781:10401] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 01:31:57 INFO - PID 1779 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:31:57 INFO - PID 1779 | 2017-04-26 01:31:57.564 plugin-container[1781:10401] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x474b, name = 'com.apple.CFPasteboardClient' 01:31:57 INFO - PID 1779 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:31:57 INFO - PID 1779 | 2017-04-26 01:31:57.565 plugin-container[1781:10401] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:32:07 INFO - PID 1779 | RSS: Main: 236380160 01:32:07 INFO - PID 1779 | 01:32:10 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 01:32:11 INFO - PID 1779 | RSS: Main: 248659968 01:32:11 INFO - PID 1779 | 01:32:13 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 01:32:14 INFO - PID 1779 | RSS: Main: 256884736 01:32:14 INFO - PID 1779 | 01:32:17 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 01:32:18 INFO - PID 1779 | RSS: Main: 259416064 01:32:18 INFO - PID 1779 | 01:32:20 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 01:32:20 INFO - PID 1779 | RSS: Main: 261324800 01:32:20 INFO - PID 1779 | 01:32:22 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:32:23 INFO - PID 1779 | RSS: Main: 262168576 01:32:23 INFO - PID 1779 | 01:32:26 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 01:32:27 INFO - PID 1779 | RSS: Main: 268275712 01:32:27 INFO - PID 1779 | 01:32:30 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 01:32:30 INFO - PID 1779 | RSS: Main: 269635584 01:32:30 INFO - PID 1779 | 01:32:33 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 01:32:34 INFO - PID 1779 | RSS: Main: 268861440 01:32:34 INFO - PID 1779 | 01:32:35 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:32:36 INFO - PID 1779 | RSS: Main: 268468224 01:32:36 INFO - PID 1779 | 01:32:38 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:32:38 INFO - PID 1779 | RSS: Main: 268599296 01:32:38 INFO - PID 1779 | 01:32:40 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:32:41 INFO - PID 1779 | RSS: Main: 268103680 01:32:41 INFO - PID 1779 | 01:32:44 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:32:45 INFO - PID 1779 | RSS: Main: 268210176 01:32:45 INFO - PID 1779 | 01:32:48 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:32:49 INFO - PID 1779 | RSS: Main: 265699328 01:32:49 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 01:32:51 INFO - PID 1779 | RSS: Main: 267579392 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | __start_tp_report 01:32:51 INFO - PID 1779 | _x_x_mozilla_page_load 01:32:51 INFO - PID 1779 | _x_x_mozilla_page_load_details 01:32:51 INFO - PID 1779 | |i|pagename|runs| 01:32:51 INFO - PID 1779 | |0;ai-astar;103;117;114;114;113;115;131;119;116;116 01:32:51 INFO - PID 1779 | |1;audio-beat-detection;147;109;110;163;155;143;110;123;159;142 01:32:51 INFO - PID 1779 | |2;audio-dft;229;185;192;244;289;287;225;201;198;198 01:32:51 INFO - PID 1779 | |3;audio-fft;80;58;59;82;59;58;58;63;76;58 01:32:51 INFO - PID 1779 | |4;audio-oscillator;90;72;111;102;90;73;87;72;79;89 01:32:51 INFO - PID 1779 | |5;imaging-gaussian-blur;89;90;91;88;89;96;89;89;90;89 01:32:51 INFO - PID 1779 | |6;imaging-darkroom;97;96;96;97;107;154;96;96;141;96 01:32:51 INFO - PID 1779 | |7;imaging-desaturate;97;94;90;91;90;94;91;90;94;91 01:32:51 INFO - PID 1779 | |8;json-parse-financial;50;54;46;47;49;51;51;51;51;66 01:32:51 INFO - PID 1779 | |9;json-stringify-tinderbox;57;53;64;69;65;61;56;55;59;59 01:32:51 INFO - PID 1779 | |10;stanford-crypto-aes;83;82;101;82;85;81;83;86;77;97 01:32:51 INFO - PID 1779 | |11;stanford-crypto-ccm;140;144;168;129;162;153;157;140;217;146 01:32:51 INFO - PID 1779 | |12;stanford-crypto-pbkdf2;184;226;253;241;188;240;180;168;233;223 01:32:51 INFO - PID 1779 | |13;stanford-crypto-sha256-iterative;67;93;96;66;65;97;96;97;90;67 01:32:51 INFO - PID 1779 | __end_tp_report 01:32:51 INFO - PID 1779 | __start_cc_report 01:32:51 INFO - PID 1779 | _x_x_mozilla_cycle_collect,982 01:32:51 INFO - PID 1779 | __end_cc_report 01:32:51 INFO - PID 1779 | __startTimestamp1493195571467__endTimestamp 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | ------- Summary: start ------- 01:32:51 INFO - PID 1779 | Number of tests: 14 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#0] ai-astar Cycles:10 Average:115.80 Median:116.00 stddev:6.84 (5.9%) stddev-sans-first:5.47 01:32:51 INFO - PID 1779 | Values: 103.0 117.0 114.0 114.0 113.0 115.0 131.0 119.0 116.0 116.0 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#1] audio-beat-detection Cycles:10 Average:136.10 Median:145.00 stddev:21.28 (14.7%) stddev-sans-first:22.20 01:32:51 INFO - PID 1779 | Values: 147.0 109.0 110.0 163.0 155.0 143.0 110.0 123.0 159.0 142.0 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#2] audio-dft Cycles:10 Average:224.80 Median:227.00 stddev:38.06 (16.8%) stddev-sans-first:40.34 01:32:51 INFO - PID 1779 | Values: 229.0 185.0 192.0 244.0 289.0 287.0 225.0 201.0 198.0 198.0 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#3] audio-fft Cycles:10 Average:65.10 Median:61.00 stddev:10.04 (16.5%) stddev-sans-first:9.08 01:32:51 INFO - PID 1779 | Values: 80.0 58.0 59.0 82.0 59.0 58.0 58.0 63.0 76.0 58.0 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#4] audio-oscillator Cycles:10 Average:86.50 Median:83.00 stddev:13.04 (15.7%) stddev-sans-first:13.77 01:32:51 INFO - PID 1779 | Values: 90.0 72.0 111.0 102.0 90.0 73.0 87.0 72.0 79.0 89.0 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:89.50 stddev:2.26 (2.5%) stddev-sans-first:2.37 01:32:51 INFO - PID 1779 | Values: 89.0 90.0 91.0 88.0 89.0 96.0 89.0 89.0 90.0 89.0 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#6] imaging-darkroom Cycles:10 Average:107.60 Median:96.00 stddev:21.52 (22.4%) stddev-sans-first:22.48 01:32:51 INFO - PID 1779 | Values: 97.0 96.0 96.0 97.0 107.0 154.0 96.0 96.0 141.0 96.0 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#7] imaging-desaturate Cycles:10 Average:92.20 Median:92.50 stddev:2.39 (2.6%) stddev-sans-first:1.80 01:32:51 INFO - PID 1779 | Values: 97.0 94.0 90.0 91.0 90.0 94.0 91.0 90.0 94.0 91.0 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:51.00 stddev:5.54 (10.9%) stddev-sans-first:5.85 01:32:51 INFO - PID 1779 | Values: 50.0 54.0 46.0 47.0 49.0 51.0 51.0 51.0 51.0 66.0 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:4.98 (8.3%) stddev-sans-first:5.18 01:32:51 INFO - PID 1779 | Values: 57.0 53.0 64.0 69.0 65.0 61.0 56.0 55.0 59.0 59.0 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:83.00 stddev:7.47 (9.0%) stddev-sans-first:7.86 01:32:51 INFO - PID 1779 | Values: 83.0 82.0 101.0 82.0 85.0 81.0 83.0 86.0 77.0 97.0 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#11] stanford-crypto-ccm Cycles:10 Average:155.60 Median:155.00 stddev:24.48 (15.8%) stddev-sans-first:25.31 01:32:51 INFO - PID 1779 | Values: 140.0 144.0 168.0 129.0 162.0 153.0 157.0 140.0 217.0 146.0 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:213.60 Median:229.50 stddev:30.47 (13.3%) stddev-sans-first:30.38 01:32:51 INFO - PID 1779 | Values: 184.0 226.0 253.0 241.0 188.0 240.0 180.0 168.0 233.0 223.0 01:32:51 INFO - PID 1779 | 01:32:51 INFO - PID 1779 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.40 Median:94.50 stddev:14.92 (15.8%) stddev-sans-first:14.59 01:32:51 INFO - PID 1779 | Values: 67.0 93.0 96.0 66.0 65.0 97.0 96.0 97.0 90.0 67.0 01:32:51 INFO - PID 1779 | -------- Summary: end -------- 01:32:51 INFO - PID 1779 | 01:32:52 INFO - TEST-INFO | 1779: exit 0 01:32:52 INFO - TEST-OK | kraken | took 61211ms 01:32:52 INFO - SUITE-END | took 1175s 01:32:52 INFO - Completed test suite (00:19:35) 01:32:52 INFO - javascript benchmark 01:32:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7870.039245275247, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2673.9465210695776, 3470.3753324401614, 3579.5883473400568, 3589.443636236383, 3608.585012723536, 5600.411956744534, 5903.114532820074, 6081.604695694777, 6133.815985520436, 6193.628382297065, 5474.7810087596445, 5606.607537472379, 6115.940154142396, 6200.441960223579, 6276.340984196662, 4307.483102027753, 5269.578433725293, 5408.864778380533, 5409.323834520685, 5483.287172667548, 5503.064479038573, 5513.173024046405, 5531.3915469298545, 5589.385167631557, 5602.355729091146, 4286.0, 5150.407703114152, 5426.782928682848, 5474.124140137598, 5528.391876893538, 4587.8623641290815, 5437.864053398657, 5487.396386397493, 5497.422770609069, 5501.587380946445, 5387.138057910715, 5426.9185962210595, 5446.8910621787345, 5465.808696695596, 5466.781328746845, 4275.935860962088, 5991.64050156992, 6083.057126145454, 6210.565260431772, 6241.907666158404, 5916.083007133901, 6388.0, 6444.742210311582, 6558.639274839882, 6646.700898459581, 6453.548251622388, 6742.258351581371, 6755.3582409671, 6759.0, 6759.188897332302, 5463.31708536433, 5766.769329226784, 6287.779927702554, 6321.778737744203, 6333.778317758856, 5606.467385598362, 5646.57650676201, 6695.631740254333, 6737.52837301394, 6846.315368463114, 5412.972935135299, 6253.1245625612455, 6439.356064393617, 6494.545381823227, 6524.641144737085, 5418.91871621926, 6686.966565167143, 6720.495962802809, 6731.259561448237, 6743.865122697617, 6538.738450462023, 6629.86740265192, 6640.734370625218, 6650.501212409089, 6655.534112612071, 5638.689872056994, 6318.147050148171, 6394.8721025579225, 6486.962086066207, 6550.7707230246715, 5122.769475373617, 5315.468453154731, 5318.44156363584, 5324.068288049576, 5356.223347614574, 3942.704297177723, 4712.6229901607785, 4724.834630787906, 4745.691530050604, 4756.881077973078, 5214.478552144831, 6257.374262573797, 6257.43683068526, 6324.810255692245, 6357.809265722036, 6697.263301036882, 6740.595564266159, 6750.054992301082, 6755.4257888080065, 6776.593404395752, 6311.0, 6345.143405640272, 6358.809235722843, 6368.840778980562, 6394.360563943662, 5715.1713001614535, 5786.1610066540115, 5864.589478736448, 5873.618214816109, 5902.2327097477055, 5831.241938547962, 6981.546199497219, 6985.860282794417, 6991.440684745106, 7026.156861176692, 5624.690642014729, 6729.2934241903895, 6734.427573656294, 6742.224644165984, 6754.763583274562, 6669.666516674244, 6765.019072234597, 6808.693608787517, 6901.413379862768, 6914.343137401939, 6515.706793194223, 6590.011498275297, 6599.4390476808085, 6607.438367738796, 6617.470602351897, 6721.462283017445, 6724.966375168288, 6729.0915726376315, 6741.089952856301, 6743.9325606743305, 6297.244330680348, 6368.936310636835, 6378.330275321025, 6464.353564643498, 6486.124373209556, 6399.520035997226, 6495.441094137467, 6512.902306465501, 6542.084108224947, 6563.0811686364905, 6297.370262973666, 6363.87272254543, 6389.329120442472, 6413.8717225656155, 6446.29090800021, 5297.576193904401, 6260.968695156677, 6429.132067170872, 6485.124508191334, 6515.478761699147, 6328.968355158195, 6341.841453963688, 6369.331220221995, 6370.140031095742, 6372.9362706374195], "value": 5973.839785831733, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.8075240813591, 815.6044318505526, 834.8872902158208, 1267.4739982907095, 1292.3473645808865, 33700.83149584252, 40109.398359024635, 40134.19731605366, 40166.39750403739, 40245.1950960981, 26790.464190716175, 35864.74473393432, 39622.00944976377, 40039.39940900889, 40248.79875600618, 8210.753677389674, 8657.783555411102, 8872.8669069964, 8887.333449991243, 8893.822123557526, 8827.602757875911, 8907.376483646147, 8931.464112153259, 8948.060453652339, 9021.729348119567, 6760.323967603225, 8825.073367296438, 8952.283817294601, 9024.32317576181, 9040.8643870342, 7515.849683006364, 8474.661013559482, 8874.778130546756, 8915.955420222923, 8942.239909607692, 8609.0, 8683.088275731021, 8699.304055675531, 8700.173483519056, 8707.303415726727, 38148.42777358342, 38237.85286441411, 38303.233935321136, 38397.42403863916, 38450.0, 3671.6695497405094, 3683.410654295327, 3710.9814450927574, 3713.702903767692, 3721.4603882436895, 31377.0, 31458.0, 31462.685373146203, 31464.685353146404, 31503.84248078768, 3142.71715545602, 3207.3264614430764, 3210.4381733196597, 3231.9030429087165, 3242.7567932404927, 249956.75021624958, 254412.0, 274059.0, 286756.26487470133, 287080.0, 48380.75809620929, 48507.272390914164, 48968.265476017885, 49015.30415827164, 49247.0, 51164.0, 51433.48566514287, 51473.7426312866, 51602.0, 51724.051734050314, 12093.818592721116, 14426.350814213385, 14587.978841481206, 14589.343479543446, 14609.269536523343, 11675.241109327866, 11795.823062654066, 11896.940515297541, 11919.463624136935, 11923.523059077714, 13538.661533461545, 13546.390412431465, 13587.86412135866, 13620.387082581308, 13682.452701891812, 4987.301777751118, 5925.940740592625, 5952.9582323094155, 5989.940100599026, 5992.790252341147, 1025.195221750922, 1038.7922415516928, 1039.2413538117216, 1062.9468526573794, 1069.2515239332342, 19931.501712457015, 21714.348569542937, 22307.0, 23340.416489587897, 24549.877250613634, 1140.310112381997, 1142.0977427832086, 1175.629676651852, 1177.1230433327055, 1178.9587364442202, 12109.515619375303, 12613.936930315473, 12660.620181394574, 12684.112112152061, 12701.491940322469, 319420.80579194374, 320289.0, 321867.0, 322802.0, 323161.3841930775, 54696.45303546914, 54811.72594137004, 54951.0, 55022.0, 55338.0, 1538.4000239906445, 1555.7666350047357, 1584.2395650087792, 1588.3964093644572, 1589.0227510081218, 20779.58440831205, 20922.581548368642, 24088.79556022227, 24225.63661545043, 24386.634200487362, 28243.293917652223, 31284.530732038584, 35669.286614267054, 38150.0, 38721.61278387293, 246795.0, 250487.0, 263915.0, 263923.68038159685, 264364.0, 34063.4890476648, 34069.82965085258, 34440.655593444746, 34716.0, 34881.12797180091, 45124.77437612791, 45874.77062614666, 45980.7700961493, 46044.53955460402, 46104.308435372826, 24061.398465038514, 30142.287194152632, 30146.69853301439, 31358.52962205523, 31752.682473175897, 30480.390392192476, 30967.845160774952, 31162.909298175364, 31312.0, 31348.68651313549, 30179.849100754356, 35938.820305898305, 36487.63512364949, 36732.632673672924, 37426.43860342043, 31011.379772404878, 31708.84145579257, 31754.88857890055, 31928.042158735276, 31944.52083218707, 20013.299534516806, 20216.989150542708, 23041.65437518472, 23962.52074958526, 24531.0], "value": 17544.136593508032, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.1880683122561, 437.2239275286365, 444.0563801920918, 447.89250579860834, 460.7097528557011, 19912.50218744532, 21668.56662866744, 22274.331770046883, 22510.324690259276, 22630.54738905223, 22662.0, 23048.88475557624, 23809.5238095238, 23976.76023239767, 24194.879025604892, 6159.353267906872, 6170.382961703816, 6186.876262474759, 6392.105105285264, 6405.103285540004, 6163.198784158076, 6265.71804268809, 6275.403836635513, 6279.058141278799, 6282.7172777224905, 5228.764705588258, 6126.571140020201, 6137.079438084278, 6169.876602467948, 6242.375762423767, 6200.286966998808, 6247.875042499148, 6262.561620686553, 6276.3409841966395, 6284.088807122965, 5493.313335833021, 5537.335519737658, 5593.0, 5602.635828671164, 5612.326520817487, 27206.911723531033, 27476.58785118225, 27510.724892751216, 27647.86176069127, 27666.723332766614, 2227.098025299756, 2302.4704318006784, 2308.815294776414, 2310.8844557772045, 2313.595120853844, 16266.43067492644, 17810.55473613157, 18216.0, 18407.171677274553, 18457.90771046136, 2159.1903036361364, 2219.655953327237, 2233.8659680419064, 2236.575050740354, 2237.295251995616, 160006.0, 161825.0, 161936.19031904882, 165035.0, 165634.1718291413, 11297.435128243555, 12112.15214934946, 12893.35533223335, 13075.542356017684, 13198.010149238846, 16604.08677522748, 16731.749023764653, 16817.32730690783, 16827.831721682625, 16869.15654217284, 8905.417428945662, 9191.540422978824, 9203.97268036616, 9340.392874463274, 9403.341766076446, 8767.21095101444, 8802.691905783267, 8836.602352894135, 8977.653351997122, 9002.414843035182, 6502.60984340941, 8078.030636323679, 8100.50140723968, 8133.2680058794995, 8277.379196560281, 2202.317281642696, 2204.7574766775642, 2204.911803527841, 2205.228170140438, 2367.958098436682, 965.4834663455018, 975.3124047546463, 982.2240430060315, 1000.7047920863363, 1023.9334443261164, 21755.67366489504, 22163.0, 22231.44421389478, 22243.77756222417, 22249.998750055962, 1021.4433133942019, 1034.7949812443421, 1048.444324508012, 1051.9737006574896, 1064.7657515346611, 9867.506624668738, 11235.83146252807, 11285.887141128647, 11290.322580645188, 11322.660320190407, 510290.0, 552752.0, 554840.0, 566733.0, 572699.0, 137906.0, 138878.0, 139171.0, 141030.0, 142814.0, 1162.3490845126755, 1169.4152923538231, 1193.826895100223, 1197.2696655040418, 1200.591798788416, 17846.375376861746, 18242.817571824642, 18273.725894111332, 18304.72542911884, 18707.532311692317, 45984.54015459803, 59342.703286483295, 59608.0, 59865.20404387875, 59944.0, 77997.83003254842, 80017.0, 81711.0, 82926.0, 83614.16385836064, 8173.386995975206, 8541.53021583819, 8676.609552570024, 9079.59141838632, 9318.72043838686, 11285.153613478858, 13769.793453098011, 14380.209088500233, 14402.279886005448, 14458.204798736171, 10183.592656293666, 11972.820407694066, 12008.579699710468, 12179.573714919936, 12232.633021009384, 11348.432578370883, 11388.772224555629, 11551.844815518381, 11690.240134391237, 11701.707457313636, 11624.941875290908, 12136.514539418324, 12567.245965242115, 12569.811452828031, 12572.0, 8678.698195270508, 8869.334799890163, 8927.598258078531, 8999.695044218683, 9262.629494820132, 10966.342019478856, 11832.230904991147, 11960.10299227544, 12056.75886482283, 12231.755364892475], "value": 10639.572057300838, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1232.5316379775684, 1263.65249556372, 1440.4526280013592, 1458.329168582452, 1460.912345259284, 10690.358578485286, 11110.500027498761, 11536.307821530714, 12066.517339306429, 12272.32502212378, 11663.650090497278, 11990.7601847963, 12020.459079341428, 12026.639200823967, 12036.638900832968, 2556.156468365435, 2599.8180127391092, 2606.309328028074, 2620.4628051249542, 2630.5791073428254, 2526.5831137862324, 2572.2154742803436, 2574.11193138367, 2581.793456523483, 2586.7283935186724, 2535.911243106492, 2559.36015996001, 2568.9229323120335, 2585.6767904012, 2589.896404143832, 2487.788537974265, 2497.126005897939, 2527.166035208377, 2528.115159694092, 2533.0880882882147, 2363.7045369328835, 2463.5442443148077, 2472.221250306148, 2529.013684662983, 2536.847789132658, 11989.0, 12074.456649450796, 12080.395980200954, 12115.878841211563, 12116.81824772629, 6555.967220163916, 6796.76211332601, 6825.1809782825885, 6831.863362732767, 6844.178698556205, 3750.362438385481, 4040.5151381834075, 4370.300751879684, 4416.3375493675885, 4443.622292105175, 1277.9808302875465, 1301.8112373705853, 1350.702845374016, 1350.8108864758844, 1355.153029356652, 15138.470153544573, 15679.764803527842, 16425.0, 16576.66846663072, 16666.4166754163, 5407.297051383295, 5513.365962914236, 5735.1684005818925, 5765.077587585966, 5784.797532086441, 11787.469563869476, 11852.288862668267, 11937.28376297425, 11962.880371196177, 11969.222000569935, 6551.574147680385, 6553.099601115623, 6558.376954189344, 6568.671566421755, 6569.343065693392, 5902.4097590240635, 6108.725107370179, 6132.908006379907, 6254.093156492374, 6289.77985770505, 4276.550962148992, 4376.081022985209, 4381.510286502541, 4432.512423633398, 4434.889127771831, 1037.725002874239, 1264.1277518512381, 1273.828033215504, 1274.5793888016933, 1281.858995510493, 816.0859836982618, 817.5421763812284, 835.1481488881307, 840.0759164918541, 863.4171933944563, 6234.721882014267, 6286.591371560834, 6442.742290308429, 6498.285188629247, 6551.475881929529, 544.0967993131383, 555.8471420359352, 596.4095545410013, 618.6968385491167, 623.6476390839161, 3872.3223435898603, 4311.461067366579, 4350.129974005212, 4387.3857659927635, 4573.222552166139, 14661.560153195422, 15056.623584410478, 15075.0, 15188.772168417483, 15211.695766084616, 12721.745565088831, 14456.98801083935, 14966.32651530662, 15002.94979351435, 15130.243487825564, 8460.407771456063, 8701.782455438539, 8705.39062265648, 8719.65121395137, 8721.127887211229, 4658.8136474542, 6006.609570377911, 7014.614196219257, 7184.712611495691, 7235.63821808897, 12442.191257568229, 12485.250884946932, 12673.049521285757, 12786.232826030468, 12828.037897157565, 12921.353932303535, 13794.310109528948, 13894.166350019032, 13899.930500347433, 14137.0, 9170.724878253663, 9397.060293970822, 9545.331826772337, 9548.52257387114, 9553.904460955302, 10911.345319280868, 11085.113190944867, 11112.388818615054, 11131.332120072822, 11138.665840024812, 9088.863892013498, 9104.089591040844, 9240.214581760625, 9280.303977201871, 9508.150843069945, 7407.259274072765, 7554.320111190019, 8968.775780605538, 9053.502057386644, 9121.863172052557, 8207.917920820953, 8224.917750822655, 8245.876311855447, 8300.833983320179, 8359.749207523784, 6112.2970858351855, 6120.112583675431, 6121.602095863755, 6178.907316390168, 6216.968915155395, 5324.547413469899, 5835.299764028344, 6102.389761023862, 6216.968915155576, 6286.591371560834], "value": 5335.506274585769, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.77003567894934, 412.3052656274176, 413.8737685006073, 415.5947950748023, 419.31232778243685, 5287.6034297427705, 6194.7831825886105, 6302.038042120208, 6303.905441418382, 6531.804045878619, 5190.922136167951, 6116.44951954324, 6122.663253521055, 6124.203853499039, 6139.140520327147, 3838.251540949502, 4312.094460163362, 4437.711548749321, 4470.41884555009, 4479.148961697283, 3839.9232015359676, 4400.8019639116155, 4432.623227025707, 4464.682918539039, 4501.3022981437925, 3597.5503062117236, 3851.921461990647, 4395.274779661352, 4428.40216570762, 4439.178751930887, 4117.9176416471655, 4434.49003364614, 4444.955550444486, 4466.57567531084, 4470.441194850644, 3309.4373956427225, 3375.9365799772995, 3787.6591106800242, 3820.9044773880596, 3828.617138286177, 4895.657303988723, 5979.342272350038, 5980.401959804029, 5982.312034116088, 6048.485878700316, 4129.961447034613, 5194.467632048555, 5214.400343960418, 5218.921716174261, 5226.2944502492055, 5297.602679799031, 5384.434634363374, 6339.0, 6512.6092434454085, 6581.440577550914, 4238.491381034265, 4239.915201695949, 4255.489301298026, 4266.0, 4267.146570685844, 5769.451902069297, 6312.526560507934, 6765.154355705537, 6934.341237582422, 7006.124234470692, 4167.5832416758085, 4323.156984388077, 4339.0, 4349.608535231781, 4434.312681534368, 4410.184115938561, 4424.867253982386, 4433.714222875395, 4442.73343599385, 4448.4439445069365, 5125.103106956268, 5193.584513238932, 5223.843284701465, 5230.555402790806, 5238.476152384731, 6361.61830290184, 6580.506462015368, 6581.703823327962, 6590.8352291193105, 6598.27418983921, 1480.3560451203546, 1503.2934520775218, 1511.2443778110944, 1513.6140284227672, 1514.5153550863838, 828.2421584250343, 954.8042651256615, 975.6828281819629, 980.1423754215061, 1014.8477728340808, 5236.711980841091, 6156.630602163885, 6319.842003949846, 6344.6827658616885, 6358.936410635834, 6837.829054273683, 6847.794566163023, 6849.691763870638, 6856.120429419556, 6856.5200435969, 5688.772449102073, 5811.070228763378, 6074.362191969868, 6219.036049412348, 6425.58233714807, 3208.502682084281, 3285.3265080658407, 3601.7478776485395, 3606.296772129462, 3614.963850361515, 6133.601315914451, 6377.457916077093, 6948.930510694829, 7116.857662846714, 7142.392896603743, 6305.873882522324, 6906.240313565504, 7015.263397343308, 7095.467839912028, 7115.466340024519, 7000.69457283777, 7049.590081983623, 7066.540674856118, 7076.681549330293, 7136.111763442059, 5989.610675306091, 6337.334579869232, 6862.897056544256, 6889.0, 6892.793216203522, 6170.876582468236, 6649.900251496135, 6765.154355705537, 6790.287019862843, 6809.319068093349, 5601.6639001658405, 7124.180719217356, 7130.0, 7156.0, 7159.57042577447, 4136.91726165481, 4392.692511524163, 4615.330777037378, 4861.4895435978715, 4884.340614017062, 6533.607983521004, 6657.4674026078765, 6883.896741548981, 6885.51801373899, 6936.514443989075, 5179.611529135254, 5533.00405926937, 6019.247594050744, 6094.481969032505, 6632.2372927114, 6307.526935479949, 6321.399467050623, 6338.556301058881, 6618.503612229199, 6650.733970641314, 5694.402087780889, 6454.67726613658, 6491.285958544462, 6521.119648847534, 6544.85465043625, 6012.458878700938, 6071.605345652519, 6507.707153178213, 6659.933400666125, 6676.232233293234, 6402.423781859655, 6432.2281326241155, 6479.319671434431, 6482.578632389068, 6495.837604059747], "value": 4743.9710841822825, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [846.1749793950895, 851.4295422067215, 863.7883718488971, 880.357339142426, 886.9866951995721, 14917.104973701586, 15065.62335941602, 16158.030518168918, 17248.827511724896, 17332.826671733277, 14148.434062637509, 17619.55951101223, 17765.289388424448, 17827.64344713105, 18695.90652046741, 1015.7866847961936, 1017.1455976979336, 1038.2991480750502, 1044.9634262800803, 1045.592219034577, 1060.008891686272, 1073.3828048871892, 1077.175960390302, 1077.6713102503772, 1083.8157513222732, 1108.501174471487, 1116.8715597706287, 1119.7368618374676, 1123.1239633086166, 1127.0589058136466, 1106.5076041161685, 1113.7215696075982, 1117.1286396610656, 1118.7035435609612, 1118.927269727465, 787.4212453846418, 809.4374409785142, 814.4380377539479, 815.4617952151551, 822.2271065198754, 16881.324747010105, 17392.130393480275, 17506.824931750773, 17577.736333955, 17629.7355539667, 15479.845201547952, 15657.29542170605, 15849.811264155234, 16099.195040247942, 16142.869999100069, 13143.408546615425, 13434.596962091153, 13435.12671676338, 13456.730865382735, 13459.528916487876, 3368.1074515253476, 3409.505621684842, 3547.1486843157713, 3605.080704420382, 3605.152789094561, 103587.4820625892, 128252.71747282594, 129416.0, 130211.0, 130479.0, 13356.931445484339, 13881.375338109809, 13914.234717090454, 13929.0, 13957.371918263703, 23612.173573925174, 24649.507009859703, 25818.967241310515, 26630.0, 26837.463250734876, 7714.421418393643, 7808.336291415179, 7835.177306382861, 7846.489978151402, 7853.175416581176, 3938.3895496198134, 4007.5591684914634, 4062.1469491407133, 4078.062045729499, 4084.1219137885496, 4249.915001699948, 4377.299632058855, 4386.166628340605, 4405.735655860659, 4425.09285596452, 954.8090381923643, 983.8327484327682, 992.8411454167443, 992.980140397188, 994.0854413939194, 638.3871483376012, 658.4436151452015, 658.7957733102753, 664.6278084272726, 682.2427105912433, 10263.486825658687, 11388.487518061707, 11784.528618855149, 11892.345920974429, 12136.870880205439, 530.7187190788889, 587.465406480101, 637.8692368064628, 658.9044588534636, 682.6279677575733, 5197.22041693749, 5253.1857562077175, 5267.2889159962915, 5348.9732551337775, 5640.802571910045, 102235.0, 102432.0, 102931.97068029374, 104168.43747343795, 105122.0, 72889.0, 91938.70153246088, 93263.0, 93294.66763330836, 94877.5256123715, 79683.20316796874, 81037.78443323237, 81519.0, 81645.0, 82509.63687360303, 11050.557977681125, 11173.664790056311, 11351.886481135083, 11400.543978241109, 11530.59642912494, 24512.632310515, 34854.47718284177, 38320.23359532849, 38506.80746596249, 39558.80220598879, 75630.0, 76035.23964760282, 76810.0, 76999.61500192463, 77289.2271077282, 16098.11460369691, 16244.269007894909, 16279.837201627832, 16449.013059216486, 16501.752473713143, 14670.266486675837, 17879.910600446914, 18118.91286522813, 18133.184006719992, 18325.0, 13700.725985480036, 16543.669126617642, 16622.916885415496, 16786.916065420082, 16875.578110547336, 12905.612831615066, 16347.509574712778, 16438.342466301216, 16555.91722041382, 16571.0, 15932.601684957504, 16154.353825846834, 16177.191140443167, 16385.098819564562, 16458.588535286715, 9999.850002250118, 11689.0, 11801.763964720485, 11838.940805295919, 11998.520059197534, 12573.811392828931, 12615.810762838748, 12641.683957901127, 12649.241045537297, 12714.682132946751], "value": 8417.871431833319, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 117.0, 114.0, 114.0, 113.0, 115.0, 131.0, 119.0, 116.0, 116.0], "value": 115.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 109.0, 110.0, 163.0, 155.0, 143.0, 110.0, 123.0, 159.0, 142.0], "value": 136.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [229.0, 185.0, 192.0, 244.0, 289.0, 287.0, 225.0, 201.0, 198.0, 198.0], "value": 224.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 59.0, 82.0, 59.0, 58.0, 58.0, 63.0, 76.0, 58.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 72.0, 111.0, 102.0, 90.0, 73.0, 87.0, 72.0, 79.0, 89.0], "value": 86.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 91.0, 88.0, 89.0, 96.0, 89.0, 89.0, 90.0, 89.0], "value": 90.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 97.0, 107.0, 154.0, 96.0, 96.0, 141.0, 96.0], "value": 107.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 94.0, 90.0, 91.0, 90.0, 94.0, 91.0, 90.0, 94.0, 91.0], "value": 92.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 54.0, 46.0, 47.0, 49.0, 51.0, 51.0, 51.0, 51.0, 66.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 64.0, 69.0, 65.0, 61.0, 56.0, 55.0, 59.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 101.0, 82.0, 85.0, 81.0, 83.0, 86.0, 77.0, 97.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 144.0, 168.0, 129.0, 162.0, 153.0, 157.0, 140.0, 217.0, 146.0], "value": 155.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 226.0, 253.0, 241.0, 188.0, 240.0, 180.0, 168.0, 233.0, 223.0], "value": 213.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 93.0, 96.0, 66.0, 65.0, 97.0, 96.0, 97.0, 90.0, 67.0], "value": 83.4, "unit": "score"}]}]} 01:32:52 INFO - Return code: 0 01:32:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:32:52 ERROR - # TBPL SUCCESS # 01:32:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:32:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:32:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:32:52 INFO - 2017-04-26 01:32:52.814 screenresolution[1790:10787] starting screenresolution argv=screenresolution get 01:32:52 INFO - 2017-04-26 01:32:52.817 screenresolution[1790:10787] Display 0: 1600x1200x32@60 01:32:52 INFO - 2017-04-26 01:32:52.824 screenresolution[1791:10790] starting screenresolution argv=screenresolution list 01:32:52 INFO - Available Modes on Display 0 01:32:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:32:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:32:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:32:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:32:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:32:53 INFO - Intel Iris: 01:32:53 INFO - Chipset Model: Intel Iris 01:32:53 INFO - Type: GPU 01:32:53 INFO - Bus: Built-In 01:32:53 INFO - VRAM (Dynamic, Max): 1536 MB 01:32:53 INFO - Vendor: Intel (0x8086) 01:32:53 INFO - Device ID: 0x0a2e 01:32:53 INFO - Revision ID: 0x0009 01:32:53 INFO - Displays: 01:32:53 INFO - Display: 01:32:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:32:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:32:53 INFO - Display Serial Number: 1600x1200 60 01:32:53 INFO - Main Display: Yes 01:32:53 INFO - Mirror: Off 01:32:53 INFO - Online: Yes 01:32:53 INFO - Rotation: Supported 01:32:53 INFO - Return code: 0 01:32:53 INFO - Running post-action listener: _resource_record_post_action 01:32:53 INFO - [mozharness: 2017-04-26 08:32:53.070381Z] Finished run-tests step (success) 01:32:53 INFO - Running post-run listener: _resource_record_post_run 01:32:53 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 39418368; Write bytes: 516100096; Read time: 250; Write time: 1694 01:32:53 INFO - TinderboxPrint: CPU usage
54.2% 01:32:53 INFO - TinderboxPrint: I/O read bytes / time
39,418,368 / 250 01:32:53 INFO - TinderboxPrint: I/O write bytes / time
516,100,096 / 1,694 01:32:53 INFO - TinderboxPrint: CPU idle
2,191.9 (45.8%) 01:32:53 INFO - TinderboxPrint: CPU system
964.6 (20.2%) 01:32:53 INFO - TinderboxPrint: CPU user
1,629.0 (34.0%) 01:32:53 INFO - TinderboxPrint: Swap in / out
248,029,184 / 0 01:32:53 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 195238400; Write bytes: 194361344; Read time: 15094; Write time: 424 01:32:53 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 38431232; Write bytes: 304900096; Read time: 236; Write time: 1219 01:32:53 INFO - Running post-run listener: _upload_blobber_files 01:32:53 INFO - Blob upload gear active. 01:32:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:32:53 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 01:32:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:32:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:32:53 INFO - (blobuploader) - INFO - Open directory for files ... 01:32:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:32:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:32:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:32:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:32:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:32:54 INFO - (blobuploader) - INFO - Done attempting. 01:32:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:32:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:32:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:32:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:32:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:32:55 INFO - (blobuploader) - INFO - Done attempting. 01:32:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:32:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:32:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:32:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:32:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:32:56 INFO - (blobuploader) - INFO - Done attempting. 01:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:32:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:32:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:32:58 INFO - (blobuploader) - INFO - Done attempting. 01:32:58 INFO - (blobuploader) - INFO - Iteration through files over. 01:32:58 INFO - Return code: 0 01:32:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:32:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:32:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7667bc0f1e1fe629bf64c87d6fd892b92b27fcca9732c0a587befc8ff5fe8ee3a80481c65149b410eba76550b2d226ebcec74342348f8eebdcb675973810d6c0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d06ec2f842384f911eb476dca7c2dff38db29dd235167d96e711e7b3ba0c463557d57fd00b43193093986d9896e3c5c84006dc15f7a495e53c589eb88e4f192", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08b99f501761ca4781e3e0280c1e7eca41a869b3104c79cf220aa95ae33dedf7e0127db249d85e60531492b2f41da5b155101be1dbc011fd4d6be1961c5eb205", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc73e78a2af28941ee3adb2fb92ea69b2d0a9026301a718c1da3a164d87e1c38d17931d8bd54f704f9adb712617979b119956d793622c698403a330cc8ab8d62"} 01:32:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:32:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:32:58 INFO - Contents: 01:32:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7667bc0f1e1fe629bf64c87d6fd892b92b27fcca9732c0a587befc8ff5fe8ee3a80481c65149b410eba76550b2d226ebcec74342348f8eebdcb675973810d6c0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d06ec2f842384f911eb476dca7c2dff38db29dd235167d96e711e7b3ba0c463557d57fd00b43193093986d9896e3c5c84006dc15f7a495e53c589eb88e4f192", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08b99f501761ca4781e3e0280c1e7eca41a869b3104c79cf220aa95ae33dedf7e0127db249d85e60531492b2f41da5b155101be1dbc011fd4d6be1961c5eb205", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc73e78a2af28941ee3adb2fb92ea69b2d0a9026301a718c1da3a164d87e1c38d17931d8bd54f704f9adb712617979b119956d793622c698403a330cc8ab8d62"} 01:32:58 INFO - Running post-run listener: copy_logs_to_upload_dir 01:32:58 INFO - Copying logs to upload dir... 01:32:58 INFO - mkdir: /builds/slave/test/build/upload/logs 01:32:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.296311 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-04-26 01:32:58.737409) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 01:32:58.741445) ========= 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.q0bHfBdrCn/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.q11iwYdPDn/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7667bc0f1e1fe629bf64c87d6fd892b92b27fcca9732c0a587befc8ff5fe8ee3a80481c65149b410eba76550b2d226ebcec74342348f8eebdcb675973810d6c0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d06ec2f842384f911eb476dca7c2dff38db29dd235167d96e711e7b3ba0c463557d57fd00b43193093986d9896e3c5c84006dc15f7a495e53c589eb88e4f192", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08b99f501761ca4781e3e0280c1e7eca41a869b3104c79cf220aa95ae33dedf7e0127db249d85e60531492b2f41da5b155101be1dbc011fd4d6be1961c5eb205", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc73e78a2af28941ee3adb2fb92ea69b2d0a9026301a718c1da3a164d87e1c38d17931d8bd54f704f9adb712617979b119956d793622c698403a330cc8ab8d62"} build_url:https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011068 build_url: 'https://queue.taskcluster.net/v1/task/Rha2LtWTR-iJcwutkx_5-w/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7667bc0f1e1fe629bf64c87d6fd892b92b27fcca9732c0a587befc8ff5fe8ee3a80481c65149b410eba76550b2d226ebcec74342348f8eebdcb675973810d6c0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3d06ec2f842384f911eb476dca7c2dff38db29dd235167d96e711e7b3ba0c463557d57fd00b43193093986d9896e3c5c84006dc15f7a495e53c589eb88e4f192", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/08b99f501761ca4781e3e0280c1e7eca41a869b3104c79cf220aa95ae33dedf7e0127db249d85e60531492b2f41da5b155101be1dbc011fd4d6be1961c5eb205", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cc73e78a2af28941ee3adb2fb92ea69b2d0a9026301a718c1da3a164d87e1c38d17931d8bd54f704f9adb712617979b119956d793622c698403a330cc8ab8d62"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-26 01:32:58.780170) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 01:32:58.780524) ========= 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.q0bHfBdrCn/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.q11iwYdPDn/Listeners TMPDIR=/var/folders/sg/rcqyw_k121lg6wmzvvr3_7fm00000w/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.004956 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-26 01:32:58.829123) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 01:32:58.829493) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-26 01:32:58.830006) ========= ========= Total master_lag: 0.20 =========