builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0072 starttime: 1471436858.04 results: success (0) buildid: 20160817030202 builduid: 708505a44a004dd7855372fbd5b45df9 revision: fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 05:27:38.043100) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-17 05:27:38.043825) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 05:27:38.044249) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-17 05:27:38.153064) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 05:27:38.153581) ========= 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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 --2016-08-17 05:27:38-- 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: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.2M=0.001s 2016-08-17 05:27:38 (16.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.612502 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 05:27:38.795234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 05:27:38.795590) ========= 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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.029311 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 05:27:38.847796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-17 05:27:38.848237) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 --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 fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 2016-08-17 05:27:38,926 truncating revision to first 12 chars 2016-08-17 05:27:38,926 Setting DEBUG logging. 2016-08-17 05:27:38,927 attempt 1/10 2016-08-17 05:27:38,927 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fe895421dfbe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-17 05:27:39,887 unpacking tar archive at: mozilla-central-fe895421dfbe/testing/mozharness/ program finished with exit code 0 elapsedTime=1.231012 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-17 05:27:40.104439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 05:27:40.104894) ========= script_repo_revision: fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-17 05:27:40.105538) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 05:27:40.105877) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-17 05:27:40.126327) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-17 05:27:40.126741) ========= /tools/buildbot/bin/python 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', '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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:27:40 INFO - MultiFileLogger online at 20160817 05:27:40 in /builds/slave/test 05:27:40 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 05:27:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:27:40 INFO - {'append_to_log': False, 05:27:40 INFO - 'base_work_dir': '/builds/slave/test', 05:27:40 INFO - 'blob_upload_branch': 'Firefox', 05:27:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:27:40 INFO - 'branch': 'Firefox', 05:27:40 INFO - 'buildbot_json_path': 'buildprops.json', 05:27:40 INFO - 'config_files': ('talos/mac_config.py',), 05:27:40 INFO - 'default_actions': ('clobber', 05:27:40 INFO - 'read-buildbot-config', 05:27:40 INFO - 'download-and-extract', 05:27:40 INFO - 'populate-webroot', 05:27:40 INFO - 'create-virtualenv', 05:27:40 INFO - 'install', 05:27:40 INFO - 'run-tests'), 05:27:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:27:40 INFO - 'download_minidump_stackwalk': True, 05:27:40 INFO - 'download_symbols': 'ondemand', 05:27:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:27:40 INFO - 'tooltool.py': '/tools/tooltool.py', 05:27:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:27:40 INFO - '/tools/misc-python/virtualenv.py')}, 05:27:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:27:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:27:40 INFO - 'installer_path': 'installer.exe', 05:27:40 INFO - 'log_level': 'info', 05:27:40 INFO - 'log_name': 'talos', 05:27:40 INFO - 'log_to_console': True, 05:27:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:27:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:27:40 INFO - 'opt_config_files': (), 05:27:40 INFO - 'pip_index': False, 05:27:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:27:40 INFO - 'cmd': ('bash', 05:27:40 INFO - '-c', 05:27:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:27:40 INFO - 'enabled': True, 05:27:40 INFO - 'halt_on_failure': False, 05:27:40 INFO - 'name': 'check_screen_resolution'},), 05:27:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:27:40 INFO - 'cmd': ('bash', 05:27:40 INFO - '-c', 05:27:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:27:40 INFO - 'enabled': True, 05:27:40 INFO - 'halt_on_failure': False, 05:27:40 INFO - 'name': 'check_screen_resolution'},), 05:27:40 INFO - 'run_cmd_checks_enabled': True, 05:27:40 INFO - 'sps_profile': False, 05:27:40 INFO - 'sps_profile_interval': 0, 05:27:40 INFO - 'suite': 'dromaeojs-e10s', 05:27:40 INFO - 'system_bits': '32', 05:27:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:27:40 INFO - 'title': 't-yosemite-r7-0072', 05:27:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:27:40 INFO - 'use_talos_json': True, 05:27:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:27:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:27:40 INFO - 'work_dir': 'build'} 05:27:40 INFO - [mozharness: 2016-08-17 12:27:40.328515Z] Running clobber step. 05:27:40 INFO - Running pre-action listener: _resource_record_pre_action 05:27:40 INFO - Running main action method: clobber 05:27:40 INFO - rmtree: /builds/slave/test/build 05:27:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:27:42 INFO - Running post-action listener: _resource_record_post_action 05:27:42 INFO - [mozharness: 2016-08-17 12:27:42.436708Z] Finished clobber step (success) 05:27:42 INFO - [mozharness: 2016-08-17 12:27:42.436916Z] Running read-buildbot-config step. 05:27:42 INFO - Running pre-action listener: _resource_record_pre_action 05:27:42 INFO - Running main action method: read_buildbot_config 05:27:42 INFO - Using buildbot properties: 05:27:42 INFO - { 05:27:42 INFO - "project": "", 05:27:42 INFO - "product": "firefox", 05:27:42 INFO - "script_repo_revision": "production", 05:27:42 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:27:42 INFO - "repository": "", 05:27:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:27:42 INFO - "buildid": "20160817030202", 05:27:42 INFO - "stage_platform": "macosx64", 05:27:42 INFO - "basedir": "/builds/slave/test", 05:27:42 INFO - "nightly_build": "True", 05:27:42 INFO - "buildnumber": 21, 05:27:42 INFO - "slavename": "t-yosemite-r7-0072", 05:27:42 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:27:42 INFO - "platform": "yosemite_r7", 05:27:42 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:27:42 INFO - "branch": "mozilla-central", 05:27:42 INFO - "repo_path": "mozilla-central", 05:27:42 INFO - "revision": "fe895421dfbe1f1f8f1fc6a39bb20774423a6d74", 05:27:42 INFO - "pgo_build": "False", 05:27:42 INFO - "builduid": "708505a44a004dd7855372fbd5b45df9", 05:27:42 INFO - "slavebuilddir": "test" 05:27:42 INFO - } 05:27:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg. 05:27:42 INFO - Running post-action listener: _resource_record_post_action 05:27:42 INFO - [mozharness: 2016-08-17 12:27:42.442778Z] Finished read-buildbot-config step (success) 05:27:42 INFO - [mozharness: 2016-08-17 12:27:42.443002Z] Running download-and-extract step. 05:27:42 INFO - Running pre-action listener: _resource_record_pre_action 05:27:42 INFO - Running main action method: download_and_extract 05:27:42 INFO - mkdir: /builds/slave/test/build/tests 05:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:42 INFO - trying https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json 05:27:42 INFO - Downloading https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:27:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json'}, attempt #1 05:27:43 INFO - Downloaded 1199 bytes. 05:27:43 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.mac.test_packages.json 05:27:43 INFO - Using the following test package requirements: 05:27:43 INFO - {u'common': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:27:43 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:43 INFO - u'firefox-51.0a1.en-US.mac.cppunittest.tests.zip'], 05:27:43 INFO - u'gtest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:43 INFO - u'firefox-51.0a1.en-US.mac.gtest.tests.zip'], 05:27:43 INFO - u'jittest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:43 INFO - u'jsshell-mac.zip'], 05:27:43 INFO - u'mochitest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:43 INFO - u'firefox-51.0a1.en-US.mac.mochitest.tests.zip'], 05:27:43 INFO - u'mozbase': [u'firefox-51.0a1.en-US.mac.common.tests.zip'], 05:27:43 INFO - u'reftest': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:43 INFO - u'firefox-51.0a1.en-US.mac.reftest.tests.zip'], 05:27:43 INFO - u'talos': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:43 INFO - u'firefox-51.0a1.en-US.mac.talos.tests.zip'], 05:27:43 INFO - u'web-platform': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:43 INFO - u'firefox-51.0a1.en-US.mac.web-platform.tests.zip'], 05:27:43 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.mac.common.tests.zip', 05:27:43 INFO - u'firefox-51.0a1.en-US.mac.xpcshell.tests.zip']} 05:27:43 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:43 INFO - trying https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:27:43 INFO - Downloading https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:27:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:27:44 INFO - Downloaded 16336773 bytes. 05:27:44 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:27:51 INFO - Downloading packages: [u'firefox-51.0a1.en-US.mac.common.tests.zip', u'firefox-51.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:51 INFO - trying https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:27:51 INFO - Downloading https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip 05:27:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:27:52 INFO - Downloaded 16336773 bytes. 05:27:52 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/tests 05:27:58 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')]} 05:27:58 INFO - trying https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:27:58 INFO - Downloading https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip 05:27:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:28:00 INFO - Downloaded 14413719 bytes. 05:28:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/tests 05:28:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:01 INFO - trying https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:28:01 INFO - Downloading https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg 05:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg'}, attempt #1 05:28:08 INFO - Downloaded 111391802 bytes. 05:28:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:28:08 INFO - mkdir: /builds/slave/test/properties 05:28:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:28:08 INFO - Writing to file /builds/slave/test/properties/build_url 05:28:08 INFO - Contents: 05:28:08 INFO - build_url:https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg 05:28:09 INFO - Running post-action listener: _resource_record_post_action 05:28:09 INFO - Running post-action listener: set_extra_try_arguments 05:28:09 INFO - [mozharness: 2016-08-17 12:28:09.055225Z] Finished download-and-extract step (success) 05:28:09 INFO - [mozharness: 2016-08-17 12:28:09.055375Z] Running populate-webroot step. 05:28:09 INFO - Running pre-action listener: _resource_record_pre_action 05:28:09 INFO - Running main action method: populate_webroot 05:28:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:28:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:28:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:28:09 INFO - '--tppagecycles', 05:28:09 INFO - '7'], 05:28:09 INFO - 'tests': ['tsvgm']}}, 05:28:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:28:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:28:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:28:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:28:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:28:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:28:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:09 INFO - 'talos_options': ['--disable-e10s'], 05:28:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:28:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:09 INFO - 'talos_options': ['--disable-e10s'], 05:28:09 INFO - 'tests': ['damp', 'tps']}, 05:28:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:09 INFO - 'tests': ['damp', 'tps']}, 05:28:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:28:09 INFO - 'tests': ['dromaeo_dom']}, 05:28:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:28:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:28:09 INFO - 'tests': ['basic_compositor_video']}, 05:28:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:28:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:28:09 INFO - 'tests': ['a11yr', 05:28:09 INFO - 'ts_paint', 05:28:09 INFO - 'tpaint', 05:28:09 INFO - 'sessionrestore', 05:28:09 INFO - 'sessionrestore_no_auto_restore', 05:28:09 INFO - 'tabpaint']}, 05:28:09 INFO - 'other-e10s': {'tests': ['a11yr', 05:28:09 INFO - 'ts_paint', 05:28:09 INFO - 'tpaint', 05:28:09 INFO - 'sessionrestore', 05:28:09 INFO - 'sessionrestore_no_auto_restore', 05:28:09 INFO - 'tabpaint']}, 05:28:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:28:09 INFO - 'ts_paint', 05:28:09 INFO - 'tpaint', 05:28:09 INFO - 'sessionrestore', 05:28:09 INFO - 'sessionrestore_no_auto_restore', 05:28:09 INFO - 'tabpaint']}, 05:28:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:28:09 INFO - 'ts_paint', 05:28:09 INFO - 'tpaint', 05:28:09 INFO - 'sessionrestore', 05:28:09 INFO - 'sessionrestore_no_auto_restore', 05:28:09 INFO - 'tabpaint']}, 05:28:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:28:09 INFO - 'tests': ['a11yr', 05:28:09 INFO - 'ts_paint', 05:28:09 INFO - 'tpaint', 05:28:09 INFO - 'sessionrestore', 05:28:09 INFO - 'sessionrestore_no_auto_restore', 05:28:09 INFO - 'tabpaint']}, 05:28:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:28:09 INFO - 'tests': ['a11yr', 05:28:09 INFO - 'ts_paint', 05:28:09 INFO - 'tpaint', 05:28:09 INFO - 'sessionrestore', 05:28:09 INFO - 'sessionrestore_no_auto_restore', 05:28:09 INFO - 'tabpaint']}, 05:28:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:28:09 INFO - 'tests': ['tsvgx', 05:28:09 INFO - 'tsvgr_opacity', 05:28:09 INFO - 'tart', 05:28:09 INFO - 'tscrollx', 05:28:09 INFO - 'cart']}, 05:28:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:28:09 INFO - 'tsvgr_opacity', 05:28:09 INFO - 'tart', 05:28:09 INFO - 'tscrollx', 05:28:09 INFO - 'cart']}, 05:28:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:09 INFO - 'talos_options': ['--disable-e10s'], 05:28:09 INFO - 'tests': ['tp5o']}, 05:28:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:09 INFO - 'tests': ['tp5o']}, 05:28:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:09 INFO - 'talos_options': ['--disable-e10s', 05:28:09 INFO - '--xperf_path', 05:28:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:09 INFO - 'tests': ['tp5n']}, 05:28:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:28:09 INFO - 'talos_options': ['--xperf_path', 05:28:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:28:09 INFO - 'tests': ['tp5n']}}, 05:28:09 INFO - 'talos.zip': {'path': '', 05:28:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:28:09 INFO - Running post-action listener: _resource_record_post_action 05:28:09 INFO - [mozharness: 2016-08-17 12:28:09.074267Z] Finished populate-webroot step (success) 05:28:09 INFO - [mozharness: 2016-08-17 12:28:09.074395Z] Running create-virtualenv step. 05:28:09 INFO - Running pre-action listener: _resource_record_pre_action 05:28:09 INFO - Running main action method: create_virtualenv 05:28:09 INFO - Creating virtualenv /builds/slave/test/build/venv 05:28:09 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 05:28:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:28:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:28:09 INFO - Using real prefix '/tools/python27' 05:28:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:28:09 INFO - Installing distribute.............................................................................................................................................................................................done. 05:28:12 INFO - Installing pip.................done. 05:28:12 INFO - Return code: 0 05:28:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:28:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:12 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 0x100ce0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d75618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feadad57d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c44d30>, '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 0x1009a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3cb20>, '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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:28:12 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 05:28:12 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 05:28:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nZ3aPmZ2SU/Render', 05:28:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:12 INFO - 'HOME': '/Users/cltbld', 05:28:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:12 INFO - 'LOGNAME': 'cltbld', 05:28:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:12 INFO - 'MOZ_NO_REMOTE': '1', 05:28:12 INFO - 'NO_EM_RESTART': '1', 05:28:12 INFO - 'PAGER': '/bin/cat', 05:28:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:12 INFO - 'PWD': '/builds/slave/test', 05:28:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:12 INFO - 'SHELL': '/bin/bash', 05:28:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tV8kGvjVT7/Listeners', 05:28:12 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:28:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:12 INFO - 'USER': 'cltbld', 05:28:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:12 INFO - 'XPC_FLAGS': '0x0', 05:28:12 INFO - 'XPC_SERVICE_NAME': '0', 05:28:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:13 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 05:28:13 INFO - Cleaning up... 05:28:13 INFO - Return code: 0 05:28:13 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:28:13 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')]} 05:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:13 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')]} 05:28:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:13 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 0x100ce0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d75618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feadad57d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c44d30>, '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 0x1009a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3cb20>, '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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:28:13 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 05:28:13 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 05:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nZ3aPmZ2SU/Render', 05:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:13 INFO - 'HOME': '/Users/cltbld', 05:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:13 INFO - 'LOGNAME': 'cltbld', 05:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:13 INFO - 'MOZ_NO_REMOTE': '1', 05:28:13 INFO - 'NO_EM_RESTART': '1', 05:28:13 INFO - 'PAGER': '/bin/cat', 05:28:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:13 INFO - 'PWD': '/builds/slave/test', 05:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:13 INFO - 'SHELL': '/bin/bash', 05:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tV8kGvjVT7/Listeners', 05:28:13 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:13 INFO - 'USER': 'cltbld', 05:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:13 INFO - 'XPC_FLAGS': '0x0', 05:28:13 INFO - 'XPC_SERVICE_NAME': '0', 05:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:13 INFO - Downloading/unpacking psutil>=3.1.1 05:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:28:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:17 INFO - Installing collected packages: psutil 05:28:17 INFO - Running setup.py install for psutil 05:28:17 INFO - building 'psutil._psutil_osx' extension 05:28:17 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 05:28:18 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 05:28:18 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 05:28:18 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 05:28:18 INFO - building 'psutil._psutil_posix' extension 05:28:18 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 05:28:18 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:28:18 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:28:18 INFO - ^ 05:28:18 INFO - 1 warning generated. 05:28:18 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 05:28:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:28:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:28:18 INFO - Successfully installed psutil 05:28:18 INFO - Cleaning up... 05:28:18 INFO - Return code: 0 05:28:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:28:18 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')]} 05:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:18 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')]} 05:28:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:18 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 0x100ce0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d75618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feadad57d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c44d30>, '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 0x1009a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3cb20>, '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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:28:18 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 05:28:18 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 05:28:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nZ3aPmZ2SU/Render', 05:28:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:18 INFO - 'HOME': '/Users/cltbld', 05:28:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:18 INFO - 'LOGNAME': 'cltbld', 05:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:18 INFO - 'MOZ_NO_REMOTE': '1', 05:28:18 INFO - 'NO_EM_RESTART': '1', 05:28:18 INFO - 'PAGER': '/bin/cat', 05:28:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:18 INFO - 'PWD': '/builds/slave/test', 05:28:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:18 INFO - 'SHELL': '/bin/bash', 05:28:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tV8kGvjVT7/Listeners', 05:28:18 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:28:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:18 INFO - 'USER': 'cltbld', 05:28:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:18 INFO - 'XPC_FLAGS': '0x0', 05:28:18 INFO - 'XPC_SERVICE_NAME': '0', 05:28:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:28:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:28:22 INFO - Installing collected packages: mozsystemmonitor 05:28:22 INFO - Running setup.py install for mozsystemmonitor 05:28:22 INFO - Successfully installed mozsystemmonitor 05:28:22 INFO - Cleaning up... 05:28:22 INFO - Return code: 0 05:28:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:28:22 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')]} 05:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:22 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')]} 05:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:22 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 0x100ce0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d75618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feadad57d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c44d30>, '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 0x1009a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3cb20>, '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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:28:22 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 05:28:22 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 05:28:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nZ3aPmZ2SU/Render', 05:28:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:22 INFO - 'HOME': '/Users/cltbld', 05:28:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:22 INFO - 'LOGNAME': 'cltbld', 05:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:22 INFO - 'MOZ_NO_REMOTE': '1', 05:28:22 INFO - 'NO_EM_RESTART': '1', 05:28:22 INFO - 'PAGER': '/bin/cat', 05:28:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:22 INFO - 'PWD': '/builds/slave/test', 05:28:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:22 INFO - 'SHELL': '/bin/bash', 05:28:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tV8kGvjVT7/Listeners', 05:28:22 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:28:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:22 INFO - 'USER': 'cltbld', 05:28:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:22 INFO - 'XPC_FLAGS': '0x0', 05:28:22 INFO - 'XPC_SERVICE_NAME': '0', 05:28:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:22 INFO - Downloading/unpacking jsonschema==2.5.1 05:28:22 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 05:28:22 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 05:28:22 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 05:28:22 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 05:28:22 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 05:28:22 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 05:28:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:28:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:25 INFO - Downloading functools32-3.2.3-2.tar.gz 05:28:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:28:25 INFO - warning: no files found matching '*.txt' 05:28:25 INFO - no previously-included directories found matching 'build' 05:28:25 INFO - no previously-included directories found matching 'dist' 05:28:25 INFO - no previously-included directories found matching '.git*' 05:28:25 INFO - Installing collected packages: jsonschema, functools32 05:28:25 INFO - Running setup.py install for functools32 05:28:25 INFO - warning: no files found matching '*.txt' 05:28:25 INFO - no previously-included directories found matching 'build' 05:28:25 INFO - no previously-included directories found matching 'dist' 05:28:25 INFO - no previously-included directories found matching '.git*' 05:28:25 INFO - Successfully installed jsonschema functools32 05:28:25 INFO - Cleaning up... 05:28:26 INFO - Return code: 0 05:28:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:28:26 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')]} 05:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:26 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')]} 05:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:26 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 0x100ce0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d75618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feadad57d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c44d30>, '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 0x1009a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3cb20>, '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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:28:26 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 05:28:26 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 05:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nZ3aPmZ2SU/Render', 05:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:26 INFO - 'HOME': '/Users/cltbld', 05:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:26 INFO - 'LOGNAME': 'cltbld', 05:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:26 INFO - 'MOZ_NO_REMOTE': '1', 05:28:26 INFO - 'NO_EM_RESTART': '1', 05:28:26 INFO - 'PAGER': '/bin/cat', 05:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:26 INFO - 'PWD': '/builds/slave/test', 05:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:26 INFO - 'SHELL': '/bin/bash', 05:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tV8kGvjVT7/Listeners', 05:28:26 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:26 INFO - 'USER': 'cltbld', 05:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:26 INFO - 'XPC_FLAGS': '0x0', 05:28:26 INFO - 'XPC_SERVICE_NAME': '0', 05:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:28:26 INFO - Cleaning up... 05:28:26 INFO - Return code: 0 05:28:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:28:26 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')]} 05:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:26 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')]} 05:28:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:26 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 0x100ce0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d75618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feadad57d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c44d30>, '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 0x1009a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3cb20>, '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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:28:26 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 05:28:26 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 05:28:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nZ3aPmZ2SU/Render', 05:28:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:26 INFO - 'HOME': '/Users/cltbld', 05:28:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:26 INFO - 'LOGNAME': 'cltbld', 05:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:26 INFO - 'MOZ_NO_REMOTE': '1', 05:28:26 INFO - 'NO_EM_RESTART': '1', 05:28:26 INFO - 'PAGER': '/bin/cat', 05:28:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:26 INFO - 'PWD': '/builds/slave/test', 05:28:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:26 INFO - 'SHELL': '/bin/bash', 05:28:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tV8kGvjVT7/Listeners', 05:28:26 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:28:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:26 INFO - 'USER': 'cltbld', 05:28:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:26 INFO - 'XPC_FLAGS': '0x0', 05:28:26 INFO - 'XPC_SERVICE_NAME': '0', 05:28:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:26 INFO - Downloading/unpacking blobuploader==1.2.4 05:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:29 INFO - Downloading blobuploader-1.2.4.tar.gz 05:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:28:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:28:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:28:30 INFO - Downloading docopt-0.6.1.tar.gz 05:28:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:28:30 INFO - Installing collected packages: blobuploader, requests, docopt 05:28:30 INFO - Running setup.py install for blobuploader 05:28:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:28:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:28:30 INFO - Running setup.py install for requests 05:28:30 INFO - Running setup.py install for docopt 05:28:31 INFO - Successfully installed blobuploader requests docopt 05:28:31 INFO - Cleaning up... 05:28:31 INFO - Return code: 0 05:28:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28:31 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')]} 05:28:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:31 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')]} 05:28:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:31 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 0x100ce0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d75618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feadad57d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c44d30>, '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 0x1009a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3cb20>, '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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:28:31 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 05:28:31 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 05:28:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nZ3aPmZ2SU/Render', 05:28:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:31 INFO - 'HOME': '/Users/cltbld', 05:28:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:31 INFO - 'LOGNAME': 'cltbld', 05:28:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:31 INFO - 'MOZ_NO_REMOTE': '1', 05:28:31 INFO - 'NO_EM_RESTART': '1', 05:28:31 INFO - 'PAGER': '/bin/cat', 05:28:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:31 INFO - 'PWD': '/builds/slave/test', 05:28:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:31 INFO - 'SHELL': '/bin/bash', 05:28:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tV8kGvjVT7/Listeners', 05:28:31 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:28:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:31 INFO - 'USER': 'cltbld', 05:28:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:31 INFO - 'XPC_FLAGS': '0x0', 05:28:31 INFO - 'XPC_SERVICE_NAME': '0', 05:28:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:31 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-seDWvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:31 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ATsGWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:31 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-wBUG8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:31 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-DHmtSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:31 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-McsHX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:31 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-t0EBlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:32 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-7NOQ_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:32 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Wywenm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:32 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-oqYwOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:32 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-IsJYqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:32 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-JKG0z5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:32 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Sw7t00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:32 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-eIf2mW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:32 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-qi9FCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:32 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-fmpnZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:33 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-uZ8gUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:33 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-R7ycPs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:28:33 INFO - Running setup.py install for manifestparser 05:28:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:28:33 INFO - Running setup.py install for mozcrash 05:28:33 INFO - Running setup.py install for mozdebug 05:28:33 INFO - Running setup.py install for mozdevice 05:28:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:28:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:28:33 INFO - Running setup.py install for mozfile 05:28:33 INFO - Running setup.py install for mozhttpd 05:28:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:28:34 INFO - Running setup.py install for mozinfo 05:28:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:28:34 INFO - Running setup.py install for mozInstall 05:28:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:28:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:28:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:28:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:28:34 INFO - Running setup.py install for mozleak 05:28:34 INFO - Running setup.py install for mozlog 05:28:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:28:34 INFO - Running setup.py install for moznetwork 05:28:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:28:34 INFO - Running setup.py install for mozprocess 05:28:35 INFO - Running setup.py install for mozprofile 05:28:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:28:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:28:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:28:35 INFO - Running setup.py install for mozrunner 05:28:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:28:35 INFO - Running setup.py install for mozscreenshot 05:28:35 INFO - Running setup.py install for moztest 05:28:35 INFO - Running setup.py install for mozversion 05:28:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:28:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:28:35 INFO - Cleaning up... 05:28:35 INFO - Return code: 0 05:28:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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')]} 05:28:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:35 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 0x100ce0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d75618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feadad57d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c44d30>, '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 0x1009a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3cb20>, '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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:28:35 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 05:28:35 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 05:28:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nZ3aPmZ2SU/Render', 05:28:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:35 INFO - 'HOME': '/Users/cltbld', 05:28:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:35 INFO - 'LOGNAME': 'cltbld', 05:28:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:35 INFO - 'MOZ_NO_REMOTE': '1', 05:28:35 INFO - 'NO_EM_RESTART': '1', 05:28:35 INFO - 'PAGER': '/bin/cat', 05:28:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:35 INFO - 'PWD': '/builds/slave/test', 05:28:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:35 INFO - 'SHELL': '/bin/bash', 05:28:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tV8kGvjVT7/Listeners', 05:28:35 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:28:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:35 INFO - 'USER': 'cltbld', 05:28:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:35 INFO - 'XPC_FLAGS': '0x0', 05:28:35 INFO - 'XPC_SERVICE_NAME': '0', 05:28:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:28:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-iqh7si-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:28:36 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)) 05:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:28:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ilzl9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:28:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-bgPVgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:28:36 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)) 05:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:28:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-fCfpJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:28:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-Ayld45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:28:36 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)) 05:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:28:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-liksvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:28:36 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)) 05:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:28:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-rvUWuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:28:36 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)) 05:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:28:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-kkqnWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:28:36 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)) 05:28:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:28:36 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-4wZlCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:28:37 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)) 05:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:28:37 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-gga0yu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 05:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:28:37 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-9yUGXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:28:37 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)) 05:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:28:37 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-mcTBtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 05:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:28:37 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-MQ1m6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:28:37 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)) 05:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:28:37 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-bGLdrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 05:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:37 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-QeVGcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:28:37 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)) 05:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:28:37 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-ASQ613-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 05:28:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:28:37 INFO - Running setup.py (path:/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/pip-rQ296w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:28:37 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)) 05:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:28:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:28:37 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)) 05:28:37 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:28:37 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:28:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:28:37 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 05:28:37 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 05:28:37 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 05:28:37 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 05:28:37 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 05:28:37 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 05:28:40 INFO - Downloading blessings-1.6.tar.gz 05:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:28:40 INFO - Installing collected packages: blessings 05:28:40 INFO - Running setup.py install for blessings 05:28:40 INFO - Successfully installed blessings 05:28:40 INFO - Cleaning up... 05:28:40 INFO - Return code: 0 05:28:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:28:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:40 INFO - Reading from file tmpfile_stdout 05:28:40 INFO - Current package versions: 05:28:40 INFO - blessings == 1.6 05:28:40 INFO - blobuploader == 1.2.4 05:28:40 INFO - docopt == 0.6.1 05:28:40 INFO - functools32 == 3.2.3-2 05:28:40 INFO - jsonschema == 2.5.1 05:28:40 INFO - manifestparser == 1.1 05:28:40 INFO - mozInstall == 1.12 05:28:40 INFO - mozcrash == 0.17 05:28:40 INFO - mozdebug == 0.1 05:28:40 INFO - mozdevice == 0.48 05:28:40 INFO - mozfile == 1.2 05:28:40 INFO - mozhttpd == 0.7 05:28:40 INFO - mozinfo == 0.9 05:28:40 INFO - mozleak == 0.1 05:28:40 INFO - mozlog == 3.3 05:28:40 INFO - moznetwork == 0.27 05:28:40 INFO - mozprocess == 0.23 05:28:40 INFO - mozprofile == 0.28 05:28:40 INFO - mozrunner == 6.12 05:28:40 INFO - mozscreenshot == 0.1 05:28:40 INFO - mozsystemmonitor == 0.3 05:28:40 INFO - moztest == 0.7 05:28:40 INFO - mozversion == 1.4 05:28:40 INFO - psutil == 3.1.1 05:28:40 INFO - requests == 1.2.3 05:28:40 INFO - wsgiref == 0.1.2 05:28:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:28: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')]} 05:28:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28: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')]} 05:28:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:40 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 0x100ce0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d75618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feadad57d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c44d30>, '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 0x1009a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3cb20>, '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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:28:40 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 05:28:40 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 05:28:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nZ3aPmZ2SU/Render', 05:28:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:40 INFO - 'HOME': '/Users/cltbld', 05:28:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:40 INFO - 'LOGNAME': 'cltbld', 05:28:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:40 INFO - 'MOZ_NO_REMOTE': '1', 05:28:40 INFO - 'NO_EM_RESTART': '1', 05:28:40 INFO - 'PAGER': '/bin/cat', 05:28:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:40 INFO - 'PWD': '/builds/slave/test', 05:28:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:40 INFO - 'SHELL': '/bin/bash', 05:28:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tV8kGvjVT7/Listeners', 05:28:40 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:28:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:40 INFO - 'USER': 'cltbld', 05:28:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:40 INFO - 'XPC_FLAGS': '0x0', 05:28:40 INFO - 'XPC_SERVICE_NAME': '0', 05:28:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:41 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)) 05:28:41 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)) 05:28:41 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)) 05:28:41 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)) 05:28:41 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)) 05:28:41 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)) 05:28:41 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)) 05:28:41 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)) 05:28:41 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)) 05:28:41 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)) 05:28:41 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)) 05:28:41 INFO - Cleaning up... 05:28:41 INFO - Return code: 0 05:28:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:28:41 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')]} 05:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:41 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')]} 05:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:28:41 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 0x100ce0a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d75618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feadad57d90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c44d30>, '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 0x1009a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3cb20>, '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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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 05:28:41 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 05:28:41 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 05:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nZ3aPmZ2SU/Render', 05:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:28:41 INFO - 'HOME': '/Users/cltbld', 05:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:28:41 INFO - 'LOGNAME': 'cltbld', 05:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:28:41 INFO - 'MOZ_NO_REMOTE': '1', 05:28:41 INFO - 'NO_EM_RESTART': '1', 05:28:41 INFO - 'PAGER': '/bin/cat', 05:28:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:28:41 INFO - 'PWD': '/builds/slave/test', 05:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:28:41 INFO - 'SHELL': '/bin/bash', 05:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tV8kGvjVT7/Listeners', 05:28:41 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:28:41 INFO - 'USER': 'cltbld', 05:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:28:41 INFO - 'XPC_FLAGS': '0x0', 05:28:41 INFO - 'XPC_SERVICE_NAME': '0', 05:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:28:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:28:41 INFO - Cleaning up... 05:28:41 INFO - Return code: 0 05:28:41 INFO - Running post-action listener: _resource_record_post_action 05:28:41 INFO - Running post-action listener: _start_resource_monitoring 05:28:41 INFO - Starting resource monitoring. 05:28:41 INFO - [mozharness: 2016-08-17 12:28:41.504771Z] Finished create-virtualenv step (success) 05:28:41 INFO - [mozharness: 2016-08-17 12:28:41.505740Z] Running install step. 05:28:41 INFO - Running pre-action listener: _resource_record_pre_action 05:28:41 INFO - Running main action method: install 05:28:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:28:41 INFO - Reading from file tmpfile_stdout 05:28:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:28:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:28:41 INFO - Reading from file tmpfile_stdout 05:28:41 INFO - Output received: 05:28:41 INFO - Usage: mozinstall [options] installer 05:28:41 INFO - Options: 05:28:41 INFO - -h, --help show this help message and exit 05:28:41 INFO - -d DEST, --destination=DEST 05:28:41 INFO - Directory to install application into. [default: 05:28:41 INFO - "/builds/slave/test"] 05:28:41 INFO - --app=APP Application being installed. [default: firefox] 05:28:41 INFO - mkdir: /builds/slave/test/build/application 05:28:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:29:16 INFO - Reading from file tmpfile_stdout 05:29:16 INFO - Output received: 05:29:16 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:29:16 INFO - Running post-action listener: _resource_record_post_action 05:29:16 INFO - [mozharness: 2016-08-17 12:29:16.187974Z] Finished install step (success) 05:29:16 INFO - [mozharness: 2016-08-17 12:29:16.188154Z] Running run-tests step. 05:29:16 INFO - Running pre-action listener: _resource_record_pre_action 05:29:16 INFO - Running main action method: run_tests 05:29:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:29:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:29:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:29:16 INFO - 2016-08-17 05:29:16.202 screenresolution[1632:8165] starting screenresolution argv=screenresolution get 05:29:16 INFO - 2016-08-17 05:29:16.205 screenresolution[1632:8165] Display 0: 1600x1200x32@60 05:29:16 INFO - 2016-08-17 05:29:16.210 screenresolution[1633:8167] starting screenresolution argv=screenresolution list 05:29:16 INFO - Available Modes on Display 0 05:29:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:29:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:29:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:29:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:29:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:29:16 INFO - Intel Iris: 05:29:16 INFO - Chipset Model: Intel Iris 05:29:16 INFO - Type: GPU 05:29:16 INFO - Bus: Built-In 05:29:16 INFO - VRAM (Dynamic, Max): 1536 MB 05:29:16 INFO - Vendor: Intel (0x8086) 05:29:16 INFO - Device ID: 0x0a2e 05:29:16 INFO - Revision ID: 0x0009 05:29:16 INFO - Displays: 05:29:16 INFO - Display: 05:29:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:29:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:29:16 INFO - Display Serial Number: 1600x1200 60 05:29:16 INFO - Main Display: Yes 05:29:16 INFO - Mirror: Off 05:29:16 INFO - Online: Yes 05:29:16 INFO - Rotation: Supported 05:29:16 INFO - Return code: 0 05:29:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:29:16 INFO - Python 2.7.3 05:29:16 INFO - Return code: 0 05:29:16 INFO - grabbing minidump binary from tooltool 05:29: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')]} 05:29: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 0x100c44d30>, '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 0x1009a9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100c3cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:29: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 05:29: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 05:29: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 05:29:16 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:29:16 INFO - Return code: 0 05:29:16 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:29:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:29:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:29:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:29:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:29: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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--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 05:29: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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0072 --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 05:29:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nZ3aPmZ2SU/Render', 05:29:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:29:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:29:16 INFO - 'HOME': '/Users/cltbld', 05:29:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:29:16 INFO - 'LOGNAME': 'cltbld', 05:29:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:29:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:29:16 INFO - 'MOZ_NO_REMOTE': '1', 05:29:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:29:16 INFO - 'NO_EM_RESTART': '1', 05:29:16 INFO - 'PAGER': '/bin/cat', 05:29:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:29:16 INFO - 'PWD': '/builds/slave/test', 05:29:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:29:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:29:16 INFO - 'SHELL': '/bin/bash', 05:29:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tV8kGvjVT7/Listeners', 05:29:16 INFO - 'TMPDIR': '/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/', 05:29:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:29:16 INFO - 'USER': 'cltbld', 05:29:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:29:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:29:16 INFO - 'XPC_FLAGS': '0x0', 05:29:16 INFO - 'XPC_SERVICE_NAME': '0', 05:29:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:29: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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0072', '--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 05:29:16 INFO - mozversion application_buildid: 20160817030202 05:29:16 INFO - mozversion application_changeset: fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 05:29:16 INFO - mozversion application_display_name: Nightly 05:29:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:29:16 INFO - mozversion application_name: Firefox 05:29:16 INFO - mozversion application_remotingname: firefox 05:29:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:29:16 INFO - mozversion application_vendor: Mozilla 05:29:16 INFO - mozversion application_version: 51.0a1 05:29:16 INFO - mozversion platform_buildid: 20160817030202 05:29:16 INFO - mozversion platform_changeset: fe895421dfbe1f1f8f1fc6a39bb20774423a6d74 05:29:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:29:16 INFO - mozversion platform_version: 51.0a1 05:29:16 INFO - using testdate: 1471436956 05:29:16 INFO - actual date: 1471436956 05:29:16 INFO - starting webserver on 'localhost:49266' 05:29:16 INFO - SUITE-START | Running 2 tests 05:29:16 INFO - TEST-START | dromaeo_css 05:29:16 INFO - operating with platform_type : mac_ 05:29:16 INFO - Initialising browser for dromaeo_css test... 05:29:16 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpuThROj/profile http://localhost:49266/getInfo.html) 05:29:19 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 05:29:19 INFO - PROCESS | 1643 | colorDepth:24 05:29:19 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 05:29:19 INFO - PROCESS | 1643 | __metrics 05:29:20 ERROR - PROCESS | 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:29:20 INFO - TEST-INFO | 1643: exit 0 05:29:20 INFO - Browser initialized. 05:29:20 INFO - Running cycle 1/1 for dromaeo_css test... 05:29:20 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpuThROj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:32 INFO - PROCESS | 1648 | RSS: Main: 239288320 05:29:32 INFO - PROCESS | 1648 | 05:30:22 INFO - PROCESS | 1648 | 1471437022328 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:32:34 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 05:32:35 INFO - PROCESS | 1648 | RSS: Main: 254033920 05:32:35 INFO - PROCESS | 1648 | 05:35:37 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 05:35:38 INFO - PROCESS | 1648 | RSS: Main: 267284480 05:35:38 INFO - PROCESS | 1648 | 05:38:40 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 05:38:40 INFO - PROCESS | 1648 | RSS: Main: 271974400 05:38:40 INFO - PROCESS | 1648 | 05:41:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 05:41:43 INFO - PROCESS | 1648 | RSS: Main: 273616896 05:41:43 INFO - PROCESS | 1648 | 05:44:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 05:44:47 INFO - PROCESS | 1648 | RSS: Main: 278781952 05:44:47 INFO - PROCESS | 1648 | 05:47:49 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 05:47:50 INFO - PROCESS | 1648 | RSS: Main: 281210880 05:47:50 INFO - PROCESS | 1648 | 05:47:50 INFO - PROCESS | 1648 | __start_tp_report 05:47:50 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 05:47:50 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 05:47:50 INFO - PROCESS | 1648 | |i|pagename|runs| 05:47:50 INFO - PROCESS | 1648 | |0;dojo.html;2766;3433.0387491502356;3449.9482507762373;3458.948115778262;3471.045462497814;5496.258005169296;5765.625234359769;5768.365479797224;5862.560307976897;5936.376680448545;5641.605087643857;5774.797882074128;5839.678817665027;5852.473277405033;5888.5877988540815;4350.54319296474;5183.041137389586;5242.239875218091;5364.973175134119;5374.435684253156;5296.443873393296;5442.755076021588;5453.836384908459;5462.071447853875;5483.643563168382;3999.7400168989216;5165.070287348276;5309.920351194735;5316.5746740261075;5332.920006199891;5227.79088836446;5305.3898801637915;5313.893722125575;5315.468453154692;5328.6802791832615;5210.400803907562;5244.685318880879;5270.947290527084;5275.762590683428;5320.361556613192;5688.260526131577;5722.828315150552;5751.913721294184;5841.707914604295;5868.97065514674;6226.875462490725;6249.2813326467585;6324.7470101195895;6325.652089135096;6338.0492926061;6300.086487459339;6312.400321969406;6326.68366581669;6330.493560515148;6349.492040636738;5776.624519406225;5820.534357251409;5967.283925928873;5977.641341519479;5985.461308482258;6275.215598050244;6385.106085148083;6404;6414.743410263537;6422.389872962061;6222.284437289679;6248.50011999039;6273.96863015682;6293.087502312139;6294.433500984934;6188.845278867974;6235.220597425322;6242.219722534684;6342.936570634327;6361.395667411589;6182.721777520022;6289.905651415233;6304.621722696653;6313.715882785194;6333.303336632966;6277.2153480814895;6302.432781049728;6302.527310451735;6302.684865756693;6307.432331090224;4866.732329721899;4919.852404427873;4955.2567114933045;4992.0015996800785;5049.293098966147;4097.606813683362;4426.004149066434;4462.821487140543;4540.500544940054;4549.727016379028;5301.204819277139;5910.645361278337;5931.4958228550195;5985.6408615483215;6016.037434010537;6167.290761562388;6255.56211065221;6277.843053923689;6323.747050117944;6328.050792381179;5926;6059.697015149225;6082.057281121433;6083.452489275986;6095.207623008981;5472.699001554953;5480.534154596904;5515.61390702655;5521.309836270466;5525.834224973177;6235.532335074797;6308.179936608211;6468.288488266381;6468.708908099147;6489.513286503531;6260.718267678057;6307.621542707452;6319.52603554726;6330.683465826783;6348.555601108063;6412.1023056771155;6463.25672547663;6472.546921715623;6487.448566871869;6488.675566221765;4950.183219768698;6165.0444181152;6217.564770466024;6263.874722505433;6290.968545157245;5777.566682498746;6188.319284878569;6307.432331090224;6312.779052733133;6355.269144048309;6213.409726076015;6253.249610046823;6254.249490061222;6266.37336266388;6273.74905003813;6034.487068599218;6086.72609732572;6115.816525504242;6253.718582663882;6274.843128921813;6020.367861374492;6024;6100;6118.908216376669;6139.216166136355;6117.939168218498;6175.104609831459;6220.284667263322;6221.035739460391;6240.719167637377;5957.940420595739;6083.117947897618;6121.296050954197;6150.323464418821;6166.969165154145 05:47:50 INFO - PROCESS | 1648 | |1;ext.html;434.28776806038104;496.6821234409977;500.04990518015745;549.1543023743435;549.3051290118001;38409.65566205183;41215;41283.9679008025;41332.38001429981;41550.75347739565;42252.36621450681;42356;42782;42886.57113428865;42998.785006075006;9673.516324183816;9801.70594882151;9830.361026533288;9882;9906.950465247664;7418.8871669249775;8744.650213991432;9099.04460031697;9811.558479868387;9970.700878973643;8188.713395031175;8254.628541715638;9920.801583968316;9938.15525680318;9973.252006099536;9884.308098433112;9891.774350771091;9901.25740569453;9918.454485003322;9941.304108712393;9726.319157658967;9796.510174491246;9805;9813.411195328303;9826.06652368024;40097.39853902194;40157.196856063005;40322;40420.595794041976;40499;2626.4090579619624;3265.804051756902;3512.8946131616094;3653.196296814723;4155.646770024551;23934.521309573884;29418.852905735333;30747.846260768776;30844.38311233785;31626;3152.4798408262836;3153.907496012768;3161.462551366273;3170.952435713466;3240.6111266648154;431364;467293.66353168356;468105.65947170387;468123;469385;33122.83438582792;33363.165920852174;33385;33399.666003339655;33461.83269083639;32948.83525582357;34089.14777130542;34454.82772586121;34820;35858.8207058963;13905;13907.304634768221;16579.50261492157;16592;16669.24988375502;12849.935750321189;12927;12954.417051232716;12998.805017924738;13026.2835544046;18864.905675471535;18979.145938432805;18985.525361866064;19040.71438928417;19047.80952190488;7921.960390198012;7934.087579928267;7989.320907722792;8032.558209298428;8063.758087257392;818.8362327534517;966.4539535162611;984.3995162950595;1013.8986101389802;1086.5545126498255;24184.87907560451;27921;30801;31096.22259443532;31212.843935780176;1062.5643486170634;1065.211743309945;1067.1622776120707;1069.315637991686;1090.4983707494482;13643.863561364458;14180.85819141816;14357.497487587885;15939.203039848193;16316.75524867128;685652.5717371381;688022;696606;697365;700843.4957825178;58283;58475;58848.7057564718;58951.41048589545;59164;1319.0502837956656;1321.6365499487526;1357.165343313855;1360.088740543838;1363.7477066742883;27719.861400693673;29163.854180728962;30381;30591.54112688356;31284.530732038584;50115;50565;50858;50867;50875.745621273134;601060;601818;603516;606368;607233.963830178;21858.781412186312;26584.468310634067;26958.191254262405;27009.054683085997;27056.32359190957;45860.770696146305;46745.29882051704;47869.28196076992;48181.759091204316;48293.792655183905;27459.725402745717;34992.82503587568;37563.24873502569;39771;40935.59064409437;36627.633723663486;39588.01029974158;39786.60213397829;41035.7948210257;41550;38757.80621096877;38876.8336949892;39518.20963580655;39621.80189099036;39717.2056558873;32223;35030.12424689403;35520;35556.82221588876;35592.46611300884;20168.596628067062;23866.88066559656;26080.73919260859;26289.07988220403;26792.33019174536 05:47:50 INFO - PROCESS | 1648 | |2;jquery.html;372.7651579504913;376.7475791219882;381.5592990096438;388.03960198508713;402.1313961842421;19892;21377;21511.784882151172;21807.345779626598;21994.670079948795;20340.491487712814;20794.584108317824;21006.579868402623;21086.578268434623;21231.15075396986;5901.203337549429;6001.969990150065;6012.488938440238;6045.546584006217;6170.413810688;4149.834006639746;4975.875603109933;6063.696815159225;6114;6455.967720161392;6224.8132556023165;6740.224874139463;6764.154480689914;6777.593344399327;6799.388055075042;6590.901136482957;6654.500912431563;6714.664266786665;6754.425873800733;6772.695228714695;5122.564582010534;5418.458154184589;5766.308043034821;5879.647221166743;5889.469947704684;13381.330933453288;13518.797218041736;13609.727805443934;14500.709985800331;24697.506049878903;2312.433453803812;2341.4965782356876;2365.7870791628666;2366.8224883133835;2595.545779488582;10162.983701629852;10325.380477171393;10344.63793767222;10370.585176592927;10421.218408619308;1857.944261672152;1858.1081081081156;1895.668258054835;1898.0699457265978;1922.7884932657396;125470;126029.36985315106;127794;129604;131565.99999999904;11157.38634375101;11473.942630286962;11730.472128754056;11761.294322340687;11989.160758746804;14513.31503671824;14581.489647862487;14586.54134586533;14637.194954277404;14644.974851760275;8329.916700832913;8602;8613.138686131462;8731.738047858575;8754.387192896436;8523.06246312905;8547.700830471029;8579.742607721779;8594.52730099838;8798.032216456184;3581.5881173664843;3713.665770080706;3728.3102626014274;4591.977040114845;4703.929441058387;1407.8732914037785;1516.6435887566413;1571.591386239563;1608.340580362046;1962.391658585843;910.3763921713515;960.3181740963854;978.9070038346346;1015.786684796201;1079.4494807648;20945.790542094383;21156.576868462853;21303.36089917305;21427.46431339229;21451.78548214529;868.1925808997693;890.7995700967231;961.6057416459219;965.6137544982064;1050.3697781331293;9168.587413566405;11191.832122518168;11201.719957000978;11385.430728463543;11445.198836081561;597201;597204;599241;600016;603975;134065.32967335102;138890.61109388978;139344;139529.30235348758;139981;967.579103090158;983.1937810994915;1031.1235449867702;1031.5925209542188;1034.539629864718;17692.29230830804;19082.52293692669;19136.043197840332;19238.03809809532;19242.71135932934;40591.79704101461;58101.128483071945;58141.70929145327;58576.4142358571;59635.70182149061;85203.147968522;85351.71972420295;85489;87298.5635071846;88368;6538.869222615426;8075.394345423999;8124.106348301801;8313.542755148525;8408.813708435728;9422.905770942203;10701.839472408075;12858.0999330046;13327.466901324226;13436.731265374443;9891.159251463418;10237.948810256199;11009.944950275198;11280.435978201222;11568.537258509565;11095.500702468247;11097.056750176325;11276.774464510829;11367.147463940073;11524.59663911759;11308.943455282671;11479.770404592029;11745.47145378477;11761.353125578175;11945.880541194478;8110.270075693216;8181.140980196994;8263.132371101188;8384.245417912418;8446.239838414573;10883.891161088288;10926.399048052433;11301.503076969268;11368.772624547628;11371.715707107389 05:47:50 INFO - PROCESS | 1648 | |3;mootools.html;1478.6155599544118;1525.786389905413;1666.9499915002555;1717.450415866923;1750.5798608334003;7779.766607001785;7936.325412339944;8523.744287671365;8947.731568052961;8954.776130596738;8586.09845966174;8707.738767836974;8711.259542938858;8719.389642725011;8725.47647141172;2371.27676058802;2391.366287933699;2391.9043238270447;2392.8923198456023;2398.8680622565753;1965.7419251678937;2369.763023697625;2411.577973854577;2418.467937053845;2458.545169143705;2211.9336419907427;2217.724808235263;2410.1805386168785;2421.092090466075;2424.0425032112307;1960.558874253296;2353.8587684738973;2378.9524209515885;2381.6308472186925;2411.5056413435204;2360.681308023429;2386.5107652931106;2386.7016622922133;2394.7964423024064;2399.5200959808108;8854.822903541957;8881;8902.332325075646;8906.688265910727;8969.237614802685;5192.870178245536;5247.86880327991;5374.274472946141;5393.78424863005;5404.756785944642;3516.226430185355;3687.2072504411412;3725.4225595032813;3733.6453036961716;3748.212875296191;1082.9620963266248;1114.3258328711174;1121.9270747401392;1127.3855748617023;1131.3607811586428;11664.35846028468;11795.823062654066;11801.055915526736;11822.645320640395;11825.645230643095;4694.36626055485;4734.341169005442;4742.5731684148595;4835.226363781849;4898.975505122452;9779.65771198019;9796.216302695768;9915.30592858493;9918.553665085088;9918.702438926844;5328.49379308965;5348.679079255179;5362.088444964365;5363.839084827461;5383.031054410244;4423.668224883082;4747.881302967454;4850.563449289581;4903.41159060915;4918.827841025547;3877.6122387760997;3982.283189026003;4039;4052.9392059119136;4093.9385909211387;1317.953871614508;1334.359507436436;1334.6129622409587;1340.2293681133388;1340.7117469744053;819.0089991110823;890.6036813618007;899.3974037394961;925.7454200095028;952.9231967876256;5695.7436915338085;5716.314042314949;5807.186993820868;5942.465178133989;6028.879422411527;435.5231022030871;439.9384086227931;443.23099422502577;444.6242924728599;460.900906305146;3378.493226016117;3763.8870833875026;3812.027932877154;3844.1200826091817;3986.7641031280396;10842.620508282173;10996.560137594406;11001;11043.83434248487;11053.447327633587;10938.726531836608;10944.671659850217;10955.83566246507;10966.616168434066;10968.506417211245;8022;8044.155363686728;8274.213949674771;8308.252257296872;8353.20644538768;5770.013400168843;5786.30564332266;5811.82564523065;5839.970800145972;5897.3807750185615;9990.10089091956;9998.750031249278;10076.496175191065;10149.695509134737;10154.949225253826;7548.962255188909;8630.654773808978;9518.524073796421;10316.226283028953;10351.84472232902;6336.398042185985;6402.295747467868;6952.582845029315;7328.267173282629;7505.211952745101;7049.471289653194;8468.110848360833;8491.278241349555;8556.358273129665;8574.3997920145;5948.940510594839;7524.736634217776;7535.886961695469;7578.09062912454;7597.886031709419;6327.462165715781;7405.8148546286775;7449.962750186214;7464.104307483137;7527.510711803715;6748.493862960199;6922.688479018356;7076.681549330189;7111.111111111111;7113.57318560888;4267.67992400565;4833.9274910875665;4883.438404583376;4895.755212239303;4932;4767.094252092092;4858.222684370484;4952.77712502931;5000.399952005782;5116.9744151279 05:47:50 INFO - PROCESS | 1648 | |4;prototype.html;264.5291381341213;299.3414488126123;309.2438986677574;310.92382366320254;313.2044606698985;4914.557689807916;5314.92027619585;5527.55779537637;5571.136473846555;5599.748011339484;4474.910501789962;4969.925451118236;5415.64798288112;5428.285857071464;5491.972540137293;4213.5786421357925;4230.3865939438765;4256.425382573344;4257.659387249028;4258.765767882765;3498.4052711039058;3835.3671644178817;4126.649234815044;4262.339337402707;4263.908666216998;3527.805970671612;3904.863329783458;4083.060895993908;4118.670506359484;4123.546409894924;3528.8002079292905;4107.527634322061;4115.485564304462;4135.77253251071;4159.2169005643445;3072.6773688762582;3496.108492334464;3569.803660798655;3591.6408359164134;3592.904164229909;5098.872528186788;5291.894162116736;5329.786808527654;5345.545628621572;5398.784048638089;3529.8058606776617;3709.647583479592;4664.183767840615;4680.836170734008;4729;5777.631171219779;5788.565857560699;5792.4497172768515;5836.095405212199;5844.824655260349;3204.295055087877;3740.682042026431;3838.9808050959846;3850.403187505941;3911.550171730259;4834.975825120887;5313.38896026958;5873.089671100986;5971.462568368867;6068.605540639845;3114.797538160012;3797.7531460454984;3898.941515877264;3917.6278253565865;3942.6254505821903;3152.8896488623245;3914.745541539791;3953.881383558498;3995.8611795638103;4014;4632.3977882875015;4653.837115700934;4654.488006319302;4658.930116048262;4659.974805542775;4716.151092803259;5790;5830.300363956352;5831.854203644858;5882;1278.5333353326155;1327.4093028602372;1348.5482363408369;1357.5520078374113;1357.8710022547841;889.1272027102731;899.3434792601438;913.821804748081;918.5131880103556;920.181038875388;4390.978045109754;4626.930596041062;4641.6054635355695;4851.830185943475;5165.328507294103;5878.676672783038;5887.705614719247;5895.4399332063385;5910.231669882974;5935.614185077956;5003.974980125076;5034.16936205522;5359.732013399314;5378.865528361744;5386.353637563439;2403.327068420845;2515.779846774313;2546.859922704232;2579.5614745493313;2627.500774852772;4294.7852607369505;5037.672551284155;5147.871303217449;5157.63896527247;5176.7411629418375;4149;4167.74993500391;4894.559489645878;4944;5178.436673846395;4664.65015123867;4680.672352935398;5159.509846564571;5224.320838291073;5250.107481728115;4394.296912494114;4621.491635919979;4963.205887058053;4975.278584605285;5005.424376196784;4179.158172442647;4826.975865120652;4864.197407427876;4963.255511673278;4976.776045078052;4989;5108.208227724708;5122;5134.845954621367;5155.3654673454375;2917.8832846686746;3395.286989732085;3437.4500079987083;3440.208751987107;3449.430843910827;4173.686973476941;4597.551771192064;4610.930836037529;4825.3485779419325;5009.949900501094;3987.960120398759;4520.389747384193;4603.309503574491;4854.053459575349;4857.465678775261;4001.039750459927;4224.964883603537;4759.596888224935;4813.278008298643;4828.285958484687;4442.600165985077;4685.765711714469;4732.952670473252;4737.620990320697;4743.952560474351;4304.010077682088;4314.188041022715;4428.114377124523;4794.904101918012;4839.443464001544;3872.7482713623526;4193.664506839385;4430.933535997027;4495.7976891039325;4749.216379297377 05:47:50 INFO - PROCESS | 1648 | |5;yui.html;659.1134923527853;705.8023753349062;713.5611598866692;761.406103239473;807.4267270238131;15294.694106117871;15818;16136.838631613666;16181.190940452989;16203;14720.89593280503;14847.257637118155;14863.479778207766;14894.776578351333;14899.32953017114;683.0983102304959;827.7930517370658;840.9243168114868;850.7107583421666;854.4702284583567;844.8183640517287;845.8392905347995;846.4032856835915;849.2823564088335;854.6965827131372;885.9335549833756;909.2816674826912;912.6760000199934;918.9982918618704;921.7879887625817;739.8002539314382;768.3660979691749;874.2525141004477;907.0385391484981;914.0037359278418;656.0847617573459;668.84616538196;677.8779819632464;679.9558028728117;682.7371461987121;12256;14680.339384727713;14900.925495372561;15096.56582624649;15153.393864245418;11562.884371156264;14783.482578109715;14947.103173809606;14962.775558366633;15008;11411;12080;12146.696332591668;12376.504939802397;12614.936925315407;3114.7819652624325;3852.460655508231;3967.6230758077936;4024.63778259958;4036.354183330682;93018.20945371718;119139.12068750779;120402;121546;122226.77773222243;9932.10611044995;10626.415547144981;10831.729206769895;11052.281601695864;11107.500162492708;23073.307800766004;23134.768652313596;23312.65031024536;23416.64875026876;23538.529229415315;8345.457545259538;8387.370947178986;8479.643257078838;8550.358723095793;8666.306695464475;4395.934060989088;4447.3329000650165;4485.932711009337;4531.478879928784;4587.449506059294;3280.917977050593;3570.803605801706;3733.160038991205;3856.903577410531;4002.5597184310286;667.9213070890573;727.7889412070546;732.5934106570904;742.476554029408;742.8328626059093;475.65039695823543;495.6703791978366;584.5031723035386;596.7374355283662;603.6438501284175;7755.573443460551;9335;9423.434593924387;9445.197158241626;9494.85757713621;633.5565104426828;657.6826358888345;670.4870773858003;682.3415404135034;699.6187078042377;4382.9342559861625;4413.668974826836;4593.438087257455;4710.29345598163;4739.265413860788;74832;105577.94422055835;155267;158766.64751005813;164380;75726;104112;108301.29246768737;116690;125466;72742;84417;108786.91213087927;111875;112352;8682.78293042679;9038.548072596212;9590.184834288884;9685.41887486753;9875.604975800887;56312.436875630716;59351.1097333549;61216.69391653013;63126.05310920432;63959;83794.74307885264;86045;86150;96060;96523;13184.406701698255;13399.866001339862;13466.124701894345;13469.461221551028;13712.17726936347;14717.705645887236;14772.261386930826;15041.699166016837;15072.321745521696;15880.285387157375;9376.921654009604;10387.68836934893;11532.538698451968;12344.567940122053;12512.499500019898;11960.278488829681;13742.519011834538;13907.443702252202;13909.443622254996;14009.649758756113;13008.674783130498;13360.799588005993;13501.59495215145;13839.396866814775;14192.690238430663;10488.895111048792;10492.317999330018;10610.416427096583;10686.412247326472;10830.40432776205;11004;11325.093992480417;11456.599019034295;11724.824127637921;11784.292942423483 05:47:50 INFO - PROCESS | 1648 | __end_tp_report 05:47:50 INFO - PROCESS | 1648 | __start_cc_report 05:47:50 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,414 05:47:50 INFO - PROCESS | 1648 | __end_cc_report 05:47:50 INFO - PROCESS | 1648 | __startTimestamp1471438070107__endTimestamp 05:47:50 INFO - PROCESS | 1648 | 05:47:50 INFO - PROCESS | 1648 | ------- Summary: start ------- 05:47:50 INFO - PROCESS | 1648 | Number of tests: 6 05:47:50 INFO - PROCESS | 1648 | 05:47:50 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5816.34 Median:6095.21 stddev:690.02 (11.3%) stddev-sans-first:649.32 05:47:50 INFO - PROCESS | 1648 | Values: 2766.0 3433.0 3449.9 3458.9 3471.0 5496.3 5765.6 5768.4 5862.6 5936.4 5641.6 5774.8 5839.7 5852.5 5888.6 4350.5 5183.0 5242.2 5365.0 5374.4 5296.4 5442.8 5453.8 5462.1 5483.6 3999.7 5165.1 5309.9 5316.6 5332.9 5227.8 5305.4 5313.9 5315.5 5328.7 5210.4 5244.7 5270.9 5275.8 5320.4 5688.3 5722.8 5751.9 5841.7 5869.0 6226.9 6249.3 6324.7 6325.7 6338.0 6300.1 6312.4 6326.7 6330.5 6349.5 5776.6 5820.5 5967.3 5977.6 5985.5 6275.2 6385.1 6404.0 6414.7 6422.4 6222.3 6248.5 6274.0 6293.1 6294.4 6188.8 6235.2 6242.2 6342.9 6361.4 6182.7 6289.9 6304.6 6313.7 6333.3 6277.2 6302.4 6302.5 6302.7 6307.4 4866.7 4919.9 4955.3 4992.0 5049.3 4097.6 4426.0 4462.8 4540.5 4549.7 5301.2 5910.6 5931.5 5985.6 6016.0 6167.3 6255.6 6277.8 6323.7 6328.1 5926.0 6059.7 6082.1 6083.5 6095.2 5472.7 5480.5 5515.6 5521.3 5525.8 6235.5 6308.2 6468.3 6468.7 6489.5 6260.7 6307.6 6319.5 6330.7 6348.6 6412.1 6463.3 6472.5 6487.4 6488.7 4950.2 6165.0 6217.6 6263.9 6291.0 5777.6 6188.3 6307.4 6312.8 6355.3 6213.4 6253.2 6254.2 6266.4 6273.7 6034.5 6086.7 6115.8 6253.7 6274.8 6020.4 6024.0 6100.0 6118.9 6139.2 6117.9 6175.1 6220.3 6221.0 6240.7 5957.9 6083.1 6121.3 6150.3 6167.0 05:47:50 INFO - PROCESS | 1648 | 05:47:50 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:70114.95 Median:39669.50 stddev:159299.33 (401.6%) stddev-sans-first:159660.30 05:47:50 INFO - PROCESS | 1648 | Values: 434.3 496.7 500.0 549.2 549.3 38409.7 41215.0 41284.0 41332.4 41550.8 42252.4 42356.0 42782.0 42886.6 42998.8 9673.5 9801.7 9830.4 9882.0 9907.0 7418.9 8744.7 9099.0 9811.6 9970.7 8188.7 8254.6 9920.8 9938.2 9973.3 9884.3 9891.8 9901.3 9918.5 9941.3 9726.3 9796.5 9805.0 9813.4 9826.1 40097.4 40157.2 40322.0 40420.6 40499.0 2626.4 3265.8 3512.9 3653.2 4155.6 23934.5 29418.9 30747.8 30844.4 31626.0 3152.5 3153.9 3161.5 3171.0 3240.6 431364.0 467293.7 468105.7 468123.0 469385.0 33122.8 33363.2 33385.0 33399.7 33461.8 32948.8 34089.1 34454.8 34820.0 35858.8 13905.0 13907.3 16579.5 16592.0 16669.2 12849.9 12927.0 12954.4 12998.8 13026.3 18864.9 18979.1 18985.5 19040.7 19047.8 7922.0 7934.1 7989.3 8032.6 8063.8 818.8 966.5 984.4 1013.9 1086.6 24184.9 27921.0 30801.0 31096.2 31212.8 1062.6 1065.2 1067.2 1069.3 1090.5 13643.9 14180.9 14357.5 15939.2 16316.8 685652.6 688022.0 696606.0 697365.0 700843.5 58283.0 58475.0 58848.7 58951.4 59164.0 1319.1 1321.6 1357.2 1360.1 1363.7 27719.9 29163.9 30381.0 30591.5 31284.5 50115.0 50565.0 50858.0 50867.0 50875.7 601060.0 601818.0 603516.0 606368.0 607234.0 21858.8 26584.5 26958.2 27009.1 27056.3 45860.8 46745.3 47869.3 48181.8 48293.8 27459.7 34992.8 37563.2 39771.0 40935.6 36627.6 39588.0 39786.6 41035.8 41550.0 38757.8 38876.8 39518.2 39621.8 39717.2 32223.0 35030.1 35520.0 35556.8 35592.5 20168.6 23866.9 26080.7 26289.1 26792.3 05:47:50 INFO - PROCESS | 1648 | 05:47:50 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:35752.84 Median:21901.01 stddev:100725.81 (459.9%) stddev-sans-first:100973.35 05:47:50 INFO - PROCESS | 1648 | Values: 372.8 376.7 381.6 388.0 402.1 19892.0 21377.0 21511.8 21807.3 21994.7 20340.5 20794.6 21006.6 21086.6 21231.2 5901.2 6002.0 6012.5 6045.5 6170.4 4149.8 4975.9 6063.7 6114.0 6456.0 6224.8 6740.2 6764.2 6777.6 6799.4 6590.9 6654.5 6714.7 6754.4 6772.7 5122.6 5418.5 5766.3 5879.6 5889.5 13381.3 13518.8 13609.7 14500.7 24697.5 2312.4 2341.5 2365.8 2366.8 2595.5 10163.0 10325.4 10344.6 10370.6 10421.2 1857.9 1858.1 1895.7 1898.1 1922.8 125470.0 126029.4 127794.0 129604.0 131566.0 11157.4 11473.9 11730.5 11761.3 11989.2 14513.3 14581.5 14586.5 14637.2 14645.0 8329.9 8602.0 8613.1 8731.7 8754.4 8523.1 8547.7 8579.7 8594.5 8798.0 3581.6 3713.7 3728.3 4592.0 4703.9 1407.9 1516.6 1571.6 1608.3 1962.4 910.4 960.3 978.9 1015.8 1079.4 20945.8 21156.6 21303.4 21427.5 21451.8 868.2 890.8 961.6 965.6 1050.4 9168.6 11191.8 11201.7 11385.4 11445.2 597201.0 597204.0 599241.0 600016.0 603975.0 134065.3 138890.6 139344.0 139529.3 139981.0 967.6 983.2 1031.1 1031.6 1034.5 17692.3 19082.5 19136.0 19238.0 19242.7 40591.8 58101.1 58141.7 58576.4 59635.7 85203.1 85351.7 85489.0 87298.6 88368.0 6538.9 8075.4 8124.1 8313.5 8408.8 9422.9 10701.8 12858.1 13327.5 13436.7 9891.2 10237.9 11009.9 11280.4 11568.5 11095.5 11097.1 11276.8 11367.1 11524.6 11308.9 11479.8 11745.5 11761.4 11945.9 8110.3 8181.1 8263.1 8384.2 8446.2 10883.9 10926.4 11301.5 11368.8 11371.7 05:47:50 INFO - PROCESS | 1648 | 05:47:50 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5665.30 Median:4870.83 stddev:3212.94 (66.0%) stddev-sans-first:3206.55 05:47:50 INFO - PROCESS | 1648 | Values: 1478.6 1525.8 1666.9 1717.5 1750.6 7779.8 7936.3 8523.7 8947.7 8954.8 8586.1 8707.7 8711.3 8719.4 8725.5 2371.3 2391.4 2391.9 2392.9 2398.9 1965.7 2369.8 2411.6 2418.5 2458.5 2211.9 2217.7 2410.2 2421.1 2424.0 1960.6 2353.9 2379.0 2381.6 2411.5 2360.7 2386.5 2386.7 2394.8 2399.5 8854.8 8881.0 8902.3 8906.7 8969.2 5192.9 5247.9 5374.3 5393.8 5404.8 3516.2 3687.2 3725.4 3733.6 3748.2 1083.0 1114.3 1121.9 1127.4 1131.4 11664.4 11795.8 11801.1 11822.6 11825.6 4694.4 4734.3 4742.6 4835.2 4899.0 9779.7 9796.2 9915.3 9918.6 9918.7 5328.5 5348.7 5362.1 5363.8 5383.0 4423.7 4747.9 4850.6 4903.4 4918.8 3877.6 3982.3 4039.0 4052.9 4093.9 1318.0 1334.4 1334.6 1340.2 1340.7 819.0 890.6 899.4 925.7 952.9 5695.7 5716.3 5807.2 5942.5 6028.9 435.5 439.9 443.2 444.6 460.9 3378.5 3763.9 3812.0 3844.1 3986.8 10842.6 10996.6 11001.0 11043.8 11053.4 10938.7 10944.7 10955.8 10966.6 10968.5 8022.0 8044.2 8274.2 8308.3 8353.2 5770.0 5786.3 5811.8 5840.0 5897.4 9990.1 9998.8 10076.5 10149.7 10154.9 7549.0 8630.7 9518.5 10316.2 10351.8 6336.4 6402.3 6952.6 7328.3 7505.2 7049.5 8468.1 8491.3 8556.4 8574.4 5948.9 7524.7 7535.9 7578.1 7597.9 6327.5 7405.8 7450.0 7464.1 7527.5 6748.5 6922.7 7076.7 7111.1 7113.6 4267.7 4833.9 4883.4 4895.8 4932.0 4767.1 4858.2 4952.8 5000.4 5117.0 05:47:50 INFO - PROCESS | 1648 | 05:47:50 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4264.93 Median:4656.71 stddev:1291.77 (27.7%) stddev-sans-first:1260.01 05:47:50 INFO - PROCESS | 1648 | Values: 264.5 299.3 309.2 310.9 313.2 4914.6 5314.9 5527.6 5571.1 5599.7 4474.9 4969.9 5415.6 5428.3 5492.0 4213.6 4230.4 4256.4 4257.7 4258.8 3498.4 3835.4 4126.6 4262.3 4263.9 3527.8 3904.9 4083.1 4118.7 4123.5 3528.8 4107.5 4115.5 4135.8 4159.2 3072.7 3496.1 3569.8 3591.6 3592.9 5098.9 5291.9 5329.8 5345.5 5398.8 3529.8 3709.6 4664.2 4680.8 4729.0 5777.6 5788.6 5792.4 5836.1 5844.8 3204.3 3740.7 3839.0 3850.4 3911.6 4835.0 5313.4 5873.1 5971.5 6068.6 3114.8 3797.8 3898.9 3917.6 3942.6 3152.9 3914.7 3953.9 3995.9 4014.0 4632.4 4653.8 4654.5 4658.9 4660.0 4716.2 5790.0 5830.3 5831.9 5882.0 1278.5 1327.4 1348.5 1357.6 1357.9 889.1 899.3 913.8 918.5 920.2 4391.0 4626.9 4641.6 4851.8 5165.3 5878.7 5887.7 5895.4 5910.2 5935.6 5004.0 5034.2 5359.7 5378.9 5386.4 2403.3 2515.8 2546.9 2579.6 2627.5 4294.8 5037.7 5147.9 5157.6 5176.7 4149.0 4167.7 4894.6 4944.0 5178.4 4664.7 4680.7 5159.5 5224.3 5250.1 4394.3 4621.5 4963.2 4975.3 5005.4 4179.2 4827.0 4864.2 4963.3 4976.8 4989.0 5108.2 5122.0 5134.8 5155.4 2917.9 3395.3 3437.5 3440.2 3449.4 4173.7 4597.6 4610.9 4825.3 5009.9 3988.0 4520.4 4603.3 4854.1 4857.5 4001.0 4225.0 4759.6 4813.3 4828.3 4442.6 4685.8 4733.0 4737.6 4744.0 4304.0 4314.2 4428.1 4794.9 4839.4 3872.7 4193.7 4430.9 4495.8 4749.2 05:47:50 INFO - PROCESS | 1648 | 05:47:50 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:23511.08 Median:4013.60 stddev:36798.89 (916.9%) stddev-sans-first:36862.12 05:47:50 INFO - PROCESS | 1648 | Values: 659.1 705.8 713.6 761.4 807.4 15294.7 15818.0 16136.8 16181.2 16203.0 14720.9 14847.3 14863.5 14894.8 14899.3 683.1 827.8 840.9 850.7 854.5 844.8 845.8 846.4 849.3 854.7 885.9 909.3 912.7 919.0 921.8 739.8 768.4 874.3 907.0 914.0 656.1 668.8 677.9 680.0 682.7 12256.0 14680.3 14900.9 15096.6 15153.4 11562.9 14783.5 14947.1 14962.8 15008.0 11411.0 12080.0 12146.7 12376.5 12614.9 3114.8 3852.5 3967.6 4024.6 4036.4 93018.2 119139.1 120402.0 121546.0 122226.8 9932.1 10626.4 10831.7 11052.3 11107.5 23073.3 23134.8 23312.7 23416.6 23538.5 8345.5 8387.4 8479.6 8550.4 8666.3 4395.9 4447.3 4485.9 4531.5 4587.4 3280.9 3570.8 3733.2 3856.9 4002.6 667.9 727.8 732.6 742.5 742.8 475.7 495.7 584.5 596.7 603.6 7755.6 9335.0 9423.4 9445.2 9494.9 633.6 657.7 670.5 682.3 699.6 4382.9 4413.7 4593.4 4710.3 4739.3 74832.0 105577.9 155267.0 158766.6 164380.0 75726.0 104112.0 108301.3 116690.0 125466.0 72742.0 84417.0 108786.9 111875.0 112352.0 8682.8 9038.5 9590.2 9685.4 9875.6 56312.4 59351.1 61216.7 63126.1 63959.0 83794.7 86045.0 86150.0 96060.0 96523.0 13184.4 13399.9 13466.1 13469.5 13712.2 14717.7 14772.3 15041.7 15072.3 15880.3 9376.9 10387.7 11532.5 12344.6 12512.5 11960.3 13742.5 13907.4 13909.4 14009.6 13008.7 13360.8 13501.6 13839.4 14192.7 10488.9 10492.3 10610.4 10686.4 10830.4 11004.0 11325.1 11456.6 11724.8 11784.3 05:47:50 INFO - PROCESS | 1648 | -------- Summary: end -------- 05:47:50 INFO - PROCESS | 1648 | 05:47:50 INFO - TEST-INFO | 1648: exit 0 05:47:50 INFO - TEST-OK | dromaeo_css | took 1113899ms 05:47:50 INFO - TEST-START | kraken 05:47:50 INFO - operating with platform_type : mac_ 05:47:50 INFO - Initialising browser for kraken test... 05:47:50 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpFhYIym/profile http://localhost:49266/getInfo.html) 05:47:53 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 05:47:53 INFO - PROCESS | 1657 | colorDepth:24 05:47:53 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 05:47:53 INFO - PROCESS | 1657 | __metrics 05:47:53 ERROR - PROCESS | 1657 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 05:47:54 INFO - TEST-INFO | 1657: exit 0 05:47:54 INFO - Browser initialized. 05:47:54 INFO - Running cycle 1/1 for kraken test... 05:47:54 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/T/tmpFhYIym/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:48:06 INFO - PROCESS | 1660 | RSS: Main: 239017984 05:48:06 INFO - PROCESS | 1660 | 05:48:08 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 05:48:09 INFO - PROCESS | 1660 | RSS: Main: 251838464 05:48:09 INFO - PROCESS | 1660 | 05:48:12 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 05:48:13 INFO - PROCESS | 1660 | RSS: Main: 260575232 05:48:13 INFO - PROCESS | 1660 | 05:48:16 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 05:48:17 INFO - PROCESS | 1660 | RSS: Main: 263331840 05:48:17 INFO - PROCESS | 1660 | 05:48:19 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 05:48:19 INFO - PROCESS | 1660 | RSS: Main: 264609792 05:48:19 INFO - PROCESS | 1660 | 05:48:21 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:48:22 INFO - PROCESS | 1660 | RSS: Main: 266334208 05:48:22 INFO - PROCESS | 1660 | 05:48:25 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 05:48:25 INFO - PROCESS | 1660 | RSS: Main: 266432512 05:48:25 INFO - PROCESS | 1660 | 05:48:28 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 05:48:29 INFO - PROCESS | 1660 | RSS: Main: 266022912 05:48:29 INFO - PROCESS | 1660 | 05:48:32 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 05:48:33 INFO - PROCESS | 1660 | RSS: Main: 267001856 05:48:33 INFO - PROCESS | 1660 | 05:48:34 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:48:35 INFO - PROCESS | 1660 | RSS: Main: 266457088 05:48:35 INFO - PROCESS | 1660 | 05:48:37 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:48:38 INFO - PROCESS | 1660 | RSS: Main: 266465280 05:48:38 INFO - PROCESS | 1660 | 05:48:40 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:48:41 INFO - PROCESS | 1660 | RSS: Main: 266612736 05:48:41 INFO - PROCESS | 1660 | 05:48:44 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:48:44 INFO - PROCESS | 1660 | RSS: Main: 266821632 05:48:44 INFO - PROCESS | 1660 | 05:48:47 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:48:48 INFO - PROCESS | 1660 | RSS: Main: 266878976 05:48:48 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 05:48:50 INFO - PROCESS | 1660 | RSS: Main: 268136448 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | __start_tp_report 05:48:50 INFO - PROCESS | 1660 | _x_x_mozilla_page_load 05:48:50 INFO - PROCESS | 1660 | _x_x_mozilla_page_load_details 05:48:50 INFO - PROCESS | 1660 | |i|pagename|runs| 05:48:50 INFO - PROCESS | 1660 | |0;ai-astar;104;118;110;115;126;117;118;119;116;127 05:48:50 INFO - PROCESS | 1660 | |1;audio-beat-detection;142;110;155;160;110;132;129;109;162;134 05:48:50 INFO - PROCESS | 1660 | |2;audio-dft;194;200;211;265;278;198;203;205;235;199 05:48:50 INFO - PROCESS | 1660 | |3;audio-fft;69;86;76;139;60;59;60;62;139;79 05:48:50 INFO - PROCESS | 1660 | |4;audio-oscillator;70;71;121;73;71;73;108;70;72;114 05:48:50 INFO - PROCESS | 1660 | |5;imaging-gaussian-blur;106;86;89;88;90;87;89;88;90;85 05:48:50 INFO - PROCESS | 1660 | |6;imaging-darkroom;96;97;96;114;151;104;151;151;103;94 05:48:50 INFO - PROCESS | 1660 | |7;imaging-desaturate;150;140;112;150;115;90;92;91;91;90 05:48:50 INFO - PROCESS | 1660 | |8;json-parse-financial;56;58;63;59;81;93;92;68;52;52 05:48:50 INFO - PROCESS | 1660 | |9;json-stringify-tinderbox;69;68;66;69;85;73;65;65;70;69 05:48:50 INFO - PROCESS | 1660 | |10;stanford-crypto-aes;92;88;88;91;87;81;96;112;77;76 05:48:50 INFO - PROCESS | 1660 | |11;stanford-crypto-ccm;146;167;166;145;140;148;140;165;178;147 05:48:50 INFO - PROCESS | 1660 | |12;stanford-crypto-pbkdf2;175;175;171;175;177;174;176;175;175;174 05:48:50 INFO - PROCESS | 1660 | |13;stanford-crypto-sha256-iterative;69;69;68;67;72;71;70;66;71;69 05:48:50 INFO - PROCESS | 1660 | __end_tp_report 05:48:50 INFO - PROCESS | 1660 | __start_cc_report 05:48:50 INFO - PROCESS | 1660 | _x_x_mozilla_cycle_collect,1066 05:48:50 INFO - PROCESS | 1660 | __end_cc_report 05:48:50 INFO - PROCESS | 1660 | __startTimestamp1471438130261__endTimestamp 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | ------- Summary: start ------- 05:48:50 INFO - PROCESS | 1660 | Number of tests: 14 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#0] ai-astar Cycles:10 Average:117.00 Median:118.00 stddev:6.75 (5.7%) stddev-sans-first:5.27 05:48:50 INFO - PROCESS | 1660 | Values: 104.0 118.0 110.0 115.0 126.0 117.0 118.0 119.0 116.0 127.0 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:138.00 stddev:20.47 (14.8%) stddev-sans-first:21.52 05:48:50 INFO - PROCESS | 1660 | Values: 142.0 110.0 155.0 160.0 110.0 132.0 129.0 109.0 162.0 134.0 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#2] audio-dft Cycles:10 Average:218.80 Median:208.00 stddev:30.18 (14.5%) stddev-sans-first:30.64 05:48:50 INFO - PROCESS | 1660 | Values: 194.0 200.0 211.0 265.0 278.0 198.0 203.0 205.0 235.0 199.0 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#3] audio-fft Cycles:10 Average:82.90 Median:65.50 stddev:30.94 (47.2%) stddev-sans-first:32.41 05:48:50 INFO - PROCESS | 1660 | Values: 69.0 86.0 76.0 139.0 60.0 59.0 60.0 62.0 139.0 79.0 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#4] audio-oscillator Cycles:10 Average:84.30 Median:71.00 stddev:20.98 (29.5%) stddev-sans-first:21.60 05:48:50 INFO - PROCESS | 1660 | Values: 70.0 71.0 121.0 73.0 71.0 73.0 108.0 70.0 72.0 114.0 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#5] imaging-gaussian-blur Cycles:10 Average:89.80 Median:88.50 stddev:5.92 (6.7%) stddev-sans-first:1.73 05:48:50 INFO - PROCESS | 1660 | Values: 106.0 86.0 89.0 88.0 90.0 87.0 89.0 88.0 90.0 85.0 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#6] imaging-darkroom Cycles:10 Average:115.70 Median:122.50 stddev:25.02 (20.4%) stddev-sans-first:25.51 05:48:50 INFO - PROCESS | 1660 | Values: 96.0 97.0 96.0 114.0 151.0 104.0 151.0 151.0 103.0 94.0 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#7] imaging-desaturate Cycles:10 Average:112.10 Median:90.00 stddev:25.67 (28.5%) stddev-sans-first:23.28 05:48:50 INFO - PROCESS | 1660 | Values: 150.0 140.0 112.0 150.0 115.0 90.0 92.0 91.0 91.0 90.0 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#8] json-parse-financial Cycles:10 Average:67.40 Median:65.50 stddev:15.74 (24.0%) stddev-sans-first:16.14 05:48:50 INFO - PROCESS | 1660 | Values: 56.0 58.0 63.0 59.0 81.0 93.0 92.0 68.0 52.0 52.0 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:69.00 stddev:5.84 (8.5%) stddev-sans-first:6.18 05:48:50 INFO - PROCESS | 1660 | Values: 69.0 68.0 66.0 69.0 85.0 73.0 65.0 65.0 70.0 69.0 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#10] stanford-crypto-aes Cycles:10 Average:88.80 Median:88.00 stddev:10.40 (11.8%) stddev-sans-first:10.97 05:48:50 INFO - PROCESS | 1660 | Values: 92.0 88.0 88.0 91.0 87.0 81.0 96.0 112.0 77.0 76.0 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#11] stanford-crypto-ccm Cycles:10 Average:154.20 Median:156.50 stddev:13.46 (8.6%) stddev-sans-first:13.95 05:48:50 INFO - PROCESS | 1660 | Values: 146.0 167.0 166.0 145.0 140.0 148.0 140.0 165.0 178.0 147.0 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.70 Median:175.00 stddev:1.57 (0.9%) stddev-sans-first:1.66 05:48:50 INFO - PROCESS | 1660 | Values: 175.0 175.0 171.0 175.0 177.0 174.0 176.0 175.0 175.0 174.0 05:48:50 INFO - PROCESS | 1660 | 05:48:50 INFO - PROCESS | 1660 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.87 (2.7%) stddev-sans-first:1.99 05:48:50 INFO - PROCESS | 1660 | Values: 69.0 69.0 68.0 67.0 72.0 71.0 70.0 66.0 71.0 69.0 05:48:50 INFO - PROCESS | 1660 | -------- Summary: end -------- 05:48:50 INFO - PROCESS | 1660 | 05:48:51 INFO - TEST-INFO | 1660: exit 0 05:48:51 INFO - TEST-OK | kraken | took 60472ms 05:48:51 INFO - SUITE-END | took 1174s 05:48:51 INFO - Completed test suite (00:19:34) 05:48:51 INFO - javascript benchmark 05:48:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7234.390712025444, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2766.0, 3433.0387491502356, 3449.9482507762373, 3458.948115778262, 3471.045462497814, 5496.258005169296, 5765.625234359769, 5768.365479797224, 5862.560307976897, 5936.376680448545, 5641.605087643857, 5774.797882074128, 5839.678817665027, 5852.473277405033, 5888.5877988540815, 4350.54319296474, 5183.041137389586, 5242.239875218091, 5364.973175134119, 5374.435684253156, 5296.443873393296, 5442.755076021588, 5453.836384908459, 5462.071447853875, 5483.643563168382, 3999.7400168989216, 5165.070287348276, 5309.920351194735, 5316.5746740261075, 5332.920006199891, 5227.79088836446, 5305.3898801637915, 5313.893722125575, 5315.468453154692, 5328.6802791832615, 5210.400803907562, 5244.685318880879, 5270.947290527084, 5275.762590683428, 5320.361556613192, 5688.260526131577, 5722.828315150552, 5751.913721294184, 5841.707914604295, 5868.97065514674, 6226.875462490725, 6249.2813326467585, 6324.7470101195895, 6325.652089135096, 6338.0492926061, 6300.086487459339, 6312.400321969406, 6326.68366581669, 6330.493560515148, 6349.492040636738, 5776.624519406225, 5820.534357251409, 5967.283925928873, 5977.641341519479, 5985.461308482258, 6275.215598050244, 6385.106085148083, 6404.0, 6414.743410263537, 6422.389872962061, 6222.284437289679, 6248.50011999039, 6273.96863015682, 6293.087502312139, 6294.433500984934, 6188.845278867974, 6235.220597425322, 6242.219722534684, 6342.936570634327, 6361.395667411589, 6182.721777520022, 6289.905651415233, 6304.621722696653, 6313.715882785194, 6333.303336632966, 6277.2153480814895, 6302.432781049728, 6302.527310451735, 6302.684865756693, 6307.432331090224, 4866.732329721899, 4919.852404427873, 4955.2567114933045, 4992.0015996800785, 5049.293098966147, 4097.606813683362, 4426.004149066434, 4462.821487140543, 4540.500544940054, 4549.727016379028, 5301.204819277139, 5910.645361278337, 5931.4958228550195, 5985.6408615483215, 6016.037434010537, 6167.290761562388, 6255.56211065221, 6277.843053923689, 6323.747050117944, 6328.050792381179, 5926.0, 6059.697015149225, 6082.057281121433, 6083.452489275986, 6095.207623008981, 5472.699001554953, 5480.534154596904, 5515.61390702655, 5521.309836270466, 5525.834224973177, 6235.532335074797, 6308.179936608211, 6468.288488266381, 6468.708908099147, 6489.513286503531, 6260.718267678057, 6307.621542707452, 6319.52603554726, 6330.683465826783, 6348.555601108063, 6412.1023056771155, 6463.25672547663, 6472.546921715623, 6487.448566871869, 6488.675566221765, 4950.183219768698, 6165.0444181152, 6217.564770466024, 6263.874722505433, 6290.968545157245, 5777.566682498746, 6188.319284878569, 6307.432331090224, 6312.779052733133, 6355.269144048309, 6213.409726076015, 6253.249610046823, 6254.249490061222, 6266.37336266388, 6273.74905003813, 6034.487068599218, 6086.72609732572, 6115.816525504242, 6253.718582663882, 6274.843128921813, 6020.367861374492, 6024.0, 6100.0, 6118.908216376669, 6139.216166136355, 6117.939168218498, 6175.104609831459, 6220.284667263322, 6221.035739460391, 6240.719167637377, 5957.940420595739, 6083.117947897618, 6121.296050954197, 6150.323464418821, 6166.969165154145], "value": 5770.355478264979, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [434.28776806038104, 496.6821234409977, 500.04990518015745, 549.1543023743435, 549.3051290118001, 38409.65566205183, 41215.0, 41283.9679008025, 41332.38001429981, 41550.75347739565, 42252.36621450681, 42356.0, 42782.0, 42886.57113428865, 42998.785006075006, 9673.516324183816, 9801.70594882151, 9830.361026533288, 9882.0, 9906.950465247664, 7418.8871669249775, 8744.650213991432, 9099.04460031697, 9811.558479868387, 9970.700878973643, 8188.713395031175, 8254.628541715638, 9920.801583968316, 9938.15525680318, 9973.252006099536, 9884.308098433112, 9891.774350771091, 9901.25740569453, 9918.454485003322, 9941.304108712393, 9726.319157658967, 9796.510174491246, 9805.0, 9813.411195328303, 9826.06652368024, 40097.39853902194, 40157.196856063005, 40322.0, 40420.595794041976, 40499.0, 2626.4090579619624, 3265.804051756902, 3512.8946131616094, 3653.196296814723, 4155.646770024551, 23934.521309573884, 29418.852905735333, 30747.846260768776, 30844.38311233785, 31626.0, 3152.4798408262836, 3153.907496012768, 3161.462551366273, 3170.952435713466, 3240.6111266648154, 431364.0, 467293.66353168356, 468105.65947170387, 468123.0, 469385.0, 33122.83438582792, 33363.165920852174, 33385.0, 33399.666003339655, 33461.83269083639, 32948.83525582357, 34089.14777130542, 34454.82772586121, 34820.0, 35858.8207058963, 13905.0, 13907.304634768221, 16579.50261492157, 16592.0, 16669.24988375502, 12849.935750321189, 12927.0, 12954.417051232716, 12998.805017924738, 13026.2835544046, 18864.905675471535, 18979.145938432805, 18985.525361866064, 19040.71438928417, 19047.80952190488, 7921.960390198012, 7934.087579928267, 7989.320907722792, 8032.558209298428, 8063.758087257392, 818.8362327534517, 966.4539535162611, 984.3995162950595, 1013.8986101389802, 1086.5545126498255, 24184.87907560451, 27921.0, 30801.0, 31096.22259443532, 31212.843935780176, 1062.5643486170634, 1065.211743309945, 1067.1622776120707, 1069.315637991686, 1090.4983707494482, 13643.863561364458, 14180.85819141816, 14357.497487587885, 15939.203039848193, 16316.75524867128, 685652.5717371381, 688022.0, 696606.0, 697365.0, 700843.4957825178, 58283.0, 58475.0, 58848.7057564718, 58951.41048589545, 59164.0, 1319.0502837956656, 1321.6365499487526, 1357.165343313855, 1360.088740543838, 1363.7477066742883, 27719.861400693673, 29163.854180728962, 30381.0, 30591.54112688356, 31284.530732038584, 50115.0, 50565.0, 50858.0, 50867.0, 50875.745621273134, 601060.0, 601818.0, 603516.0, 606368.0, 607233.963830178, 21858.781412186312, 26584.468310634067, 26958.191254262405, 27009.054683085997, 27056.32359190957, 45860.770696146305, 46745.29882051704, 47869.28196076992, 48181.759091204316, 48293.792655183905, 27459.725402745717, 34992.82503587568, 37563.24873502569, 39771.0, 40935.59064409437, 36627.633723663486, 39588.01029974158, 39786.60213397829, 41035.7948210257, 41550.0, 38757.80621096877, 38876.8336949892, 39518.20963580655, 39621.80189099036, 39717.2056558873, 32223.0, 35030.12424689403, 35520.0, 35556.82221588876, 35592.46611300884, 20168.596628067062, 23866.88066559656, 26080.73919260859, 26289.07988220403, 26792.33019174536], "value": 19314.612235225595, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.7651579504913, 376.7475791219882, 381.5592990096438, 388.03960198508713, 402.1313961842421, 19892.0, 21377.0, 21511.784882151172, 21807.345779626598, 21994.670079948795, 20340.491487712814, 20794.584108317824, 21006.579868402623, 21086.578268434623, 21231.15075396986, 5901.203337549429, 6001.969990150065, 6012.488938440238, 6045.546584006217, 6170.413810688, 4149.834006639746, 4975.875603109933, 6063.696815159225, 6114.0, 6455.967720161392, 6224.8132556023165, 6740.224874139463, 6764.154480689914, 6777.593344399327, 6799.388055075042, 6590.901136482957, 6654.500912431563, 6714.664266786665, 6754.425873800733, 6772.695228714695, 5122.564582010534, 5418.458154184589, 5766.308043034821, 5879.647221166743, 5889.469947704684, 13381.330933453288, 13518.797218041736, 13609.727805443934, 14500.709985800331, 24697.506049878903, 2312.433453803812, 2341.4965782356876, 2365.7870791628666, 2366.8224883133835, 2595.545779488582, 10162.983701629852, 10325.380477171393, 10344.63793767222, 10370.585176592927, 10421.218408619308, 1857.944261672152, 1858.1081081081156, 1895.668258054835, 1898.0699457265978, 1922.7884932657396, 125470.0, 126029.36985315106, 127794.0, 129604.0, 131565.99999999904, 11157.38634375101, 11473.942630286962, 11730.472128754056, 11761.294322340687, 11989.160758746804, 14513.31503671824, 14581.489647862487, 14586.54134586533, 14637.194954277404, 14644.974851760275, 8329.916700832913, 8602.0, 8613.138686131462, 8731.738047858575, 8754.387192896436, 8523.06246312905, 8547.700830471029, 8579.742607721779, 8594.52730099838, 8798.032216456184, 3581.5881173664843, 3713.665770080706, 3728.3102626014274, 4591.977040114845, 4703.929441058387, 1407.8732914037785, 1516.6435887566413, 1571.591386239563, 1608.340580362046, 1962.391658585843, 910.3763921713515, 960.3181740963854, 978.9070038346346, 1015.786684796201, 1079.4494807648, 20945.790542094383, 21156.576868462853, 21303.36089917305, 21427.46431339229, 21451.78548214529, 868.1925808997693, 890.7995700967231, 961.6057416459219, 965.6137544982064, 1050.3697781331293, 9168.587413566405, 11191.832122518168, 11201.719957000978, 11385.430728463543, 11445.198836081561, 597201.0, 597204.0, 599241.0, 600016.0, 603975.0, 134065.32967335102, 138890.61109388978, 139344.0, 139529.30235348758, 139981.0, 967.579103090158, 983.1937810994915, 1031.1235449867702, 1031.5925209542188, 1034.539629864718, 17692.29230830804, 19082.52293692669, 19136.043197840332, 19238.03809809532, 19242.71135932934, 40591.79704101461, 58101.128483071945, 58141.70929145327, 58576.4142358571, 59635.70182149061, 85203.147968522, 85351.71972420295, 85489.0, 87298.5635071846, 88368.0, 6538.869222615426, 8075.394345423999, 8124.106348301801, 8313.542755148525, 8408.813708435728, 9422.905770942203, 10701.839472408075, 12858.0999330046, 13327.466901324226, 13436.731265374443, 9891.159251463418, 10237.948810256199, 11009.944950275198, 11280.435978201222, 11568.537258509565, 11095.500702468247, 11097.056750176325, 11276.774464510829, 11367.147463940073, 11524.59663911759, 11308.943455282671, 11479.770404592029, 11745.47145378477, 11761.353125578175, 11945.880541194478, 8110.270075693216, 8181.140980196994, 8263.132371101188, 8384.245417912418, 8446.239838414573, 10883.891161088288, 10926.399048052433, 11301.503076969268, 11368.772624547628, 11371.715707107389], "value": 9597.532665862045, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1478.6155599544118, 1525.786389905413, 1666.9499915002555, 1717.450415866923, 1750.5798608334003, 7779.766607001785, 7936.325412339944, 8523.744287671365, 8947.731568052961, 8954.776130596738, 8586.09845966174, 8707.738767836974, 8711.259542938858, 8719.389642725011, 8725.47647141172, 2371.27676058802, 2391.366287933699, 2391.9043238270447, 2392.8923198456023, 2398.8680622565753, 1965.7419251678937, 2369.763023697625, 2411.577973854577, 2418.467937053845, 2458.545169143705, 2211.9336419907427, 2217.724808235263, 2410.1805386168785, 2421.092090466075, 2424.0425032112307, 1960.558874253296, 2353.8587684738973, 2378.9524209515885, 2381.6308472186925, 2411.5056413435204, 2360.681308023429, 2386.5107652931106, 2386.7016622922133, 2394.7964423024064, 2399.5200959808108, 8854.822903541957, 8881.0, 8902.332325075646, 8906.688265910727, 8969.237614802685, 5192.870178245536, 5247.86880327991, 5374.274472946141, 5393.78424863005, 5404.756785944642, 3516.226430185355, 3687.2072504411412, 3725.4225595032813, 3733.6453036961716, 3748.212875296191, 1082.9620963266248, 1114.3258328711174, 1121.9270747401392, 1127.3855748617023, 1131.3607811586428, 11664.35846028468, 11795.823062654066, 11801.055915526736, 11822.645320640395, 11825.645230643095, 4694.36626055485, 4734.341169005442, 4742.5731684148595, 4835.226363781849, 4898.975505122452, 9779.65771198019, 9796.216302695768, 9915.30592858493, 9918.553665085088, 9918.702438926844, 5328.49379308965, 5348.679079255179, 5362.088444964365, 5363.839084827461, 5383.031054410244, 4423.668224883082, 4747.881302967454, 4850.563449289581, 4903.41159060915, 4918.827841025547, 3877.6122387760997, 3982.283189026003, 4039.0, 4052.9392059119136, 4093.9385909211387, 1317.953871614508, 1334.359507436436, 1334.6129622409587, 1340.2293681133388, 1340.7117469744053, 819.0089991110823, 890.6036813618007, 899.3974037394961, 925.7454200095028, 952.9231967876256, 5695.7436915338085, 5716.314042314949, 5807.186993820868, 5942.465178133989, 6028.879422411527, 435.5231022030871, 439.9384086227931, 443.23099422502577, 444.6242924728599, 460.900906305146, 3378.493226016117, 3763.8870833875026, 3812.027932877154, 3844.1200826091817, 3986.7641031280396, 10842.620508282173, 10996.560137594406, 11001.0, 11043.83434248487, 11053.447327633587, 10938.726531836608, 10944.671659850217, 10955.83566246507, 10966.616168434066, 10968.506417211245, 8022.0, 8044.155363686728, 8274.213949674771, 8308.252257296872, 8353.20644538768, 5770.013400168843, 5786.30564332266, 5811.82564523065, 5839.970800145972, 5897.3807750185615, 9990.10089091956, 9998.750031249278, 10076.496175191065, 10149.695509134737, 10154.949225253826, 7548.962255188909, 8630.654773808978, 9518.524073796421, 10316.226283028953, 10351.84472232902, 6336.398042185985, 6402.295747467868, 6952.582845029315, 7328.267173282629, 7505.211952745101, 7049.471289653194, 8468.110848360833, 8491.278241349555, 8556.358273129665, 8574.3997920145, 5948.940510594839, 7524.736634217776, 7535.886961695469, 7578.09062912454, 7597.886031709419, 6327.462165715781, 7405.8148546286775, 7449.962750186214, 7464.104307483137, 7527.510711803715, 6748.493862960199, 6922.688479018356, 7076.681549330189, 7111.111111111111, 7113.57318560888, 4267.67992400565, 4833.9274910875665, 4883.438404583376, 4895.755212239303, 4932.0, 4767.094252092092, 4858.222684370484, 4952.77712502931, 5000.399952005782, 5116.9744151279], "value": 4484.4657300790805, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [264.5291381341213, 299.3414488126123, 309.2438986677574, 310.92382366320254, 313.2044606698985, 4914.557689807916, 5314.92027619585, 5527.55779537637, 5571.136473846555, 5599.748011339484, 4474.910501789962, 4969.925451118236, 5415.64798288112, 5428.285857071464, 5491.972540137293, 4213.5786421357925, 4230.3865939438765, 4256.425382573344, 4257.659387249028, 4258.765767882765, 3498.4052711039058, 3835.3671644178817, 4126.649234815044, 4262.339337402707, 4263.908666216998, 3527.805970671612, 3904.863329783458, 4083.060895993908, 4118.670506359484, 4123.546409894924, 3528.8002079292905, 4107.527634322061, 4115.485564304462, 4135.77253251071, 4159.2169005643445, 3072.6773688762582, 3496.108492334464, 3569.803660798655, 3591.6408359164134, 3592.904164229909, 5098.872528186788, 5291.894162116736, 5329.786808527654, 5345.545628621572, 5398.784048638089, 3529.8058606776617, 3709.647583479592, 4664.183767840615, 4680.836170734008, 4729.0, 5777.631171219779, 5788.565857560699, 5792.4497172768515, 5836.095405212199, 5844.824655260349, 3204.295055087877, 3740.682042026431, 3838.9808050959846, 3850.403187505941, 3911.550171730259, 4834.975825120887, 5313.38896026958, 5873.089671100986, 5971.462568368867, 6068.605540639845, 3114.797538160012, 3797.7531460454984, 3898.941515877264, 3917.6278253565865, 3942.6254505821903, 3152.8896488623245, 3914.745541539791, 3953.881383558498, 3995.8611795638103, 4014.0, 4632.3977882875015, 4653.837115700934, 4654.488006319302, 4658.930116048262, 4659.974805542775, 4716.151092803259, 5790.0, 5830.300363956352, 5831.854203644858, 5882.0, 1278.5333353326155, 1327.4093028602372, 1348.5482363408369, 1357.5520078374113, 1357.8710022547841, 889.1272027102731, 899.3434792601438, 913.821804748081, 918.5131880103556, 920.181038875388, 4390.978045109754, 4626.930596041062, 4641.6054635355695, 4851.830185943475, 5165.328507294103, 5878.676672783038, 5887.705614719247, 5895.4399332063385, 5910.231669882974, 5935.614185077956, 5003.974980125076, 5034.16936205522, 5359.732013399314, 5378.865528361744, 5386.353637563439, 2403.327068420845, 2515.779846774313, 2546.859922704232, 2579.5614745493313, 2627.500774852772, 4294.7852607369505, 5037.672551284155, 5147.871303217449, 5157.63896527247, 5176.7411629418375, 4149.0, 4167.74993500391, 4894.559489645878, 4944.0, 5178.436673846395, 4664.65015123867, 4680.672352935398, 5159.509846564571, 5224.320838291073, 5250.107481728115, 4394.296912494114, 4621.491635919979, 4963.205887058053, 4975.278584605285, 5005.424376196784, 4179.158172442647, 4826.975865120652, 4864.197407427876, 4963.255511673278, 4976.776045078052, 4989.0, 5108.208227724708, 5122.0, 5134.845954621367, 5155.3654673454375, 2917.8832846686746, 3395.286989732085, 3437.4500079987083, 3440.208751987107, 3449.430843910827, 4173.686973476941, 4597.551771192064, 4610.930836037529, 4825.3485779419325, 5009.949900501094, 3987.960120398759, 4520.389747384193, 4603.309503574491, 4854.053459575349, 4857.465678775261, 4001.039750459927, 4224.964883603537, 4759.596888224935, 4813.278008298643, 4828.285958484687, 4442.600165985077, 4685.765711714469, 4732.952670473252, 4737.620990320697, 4743.952560474351, 4304.010077682088, 4314.188041022715, 4428.114377124523, 4794.904101918012, 4839.443464001544, 3872.7482713623526, 4193.664506839385, 4430.933535997027, 4495.7976891039325, 4749.216379297377], "value": 3866.9897166050205, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.1134923527853, 705.8023753349062, 713.5611598866692, 761.406103239473, 807.4267270238131, 15294.694106117871, 15818.0, 16136.838631613666, 16181.190940452989, 16203.0, 14720.89593280503, 14847.257637118155, 14863.479778207766, 14894.776578351333, 14899.32953017114, 683.0983102304959, 827.7930517370658, 840.9243168114868, 850.7107583421666, 854.4702284583567, 844.8183640517287, 845.8392905347995, 846.4032856835915, 849.2823564088335, 854.6965827131372, 885.9335549833756, 909.2816674826912, 912.6760000199934, 918.9982918618704, 921.7879887625817, 739.8002539314382, 768.3660979691749, 874.2525141004477, 907.0385391484981, 914.0037359278418, 656.0847617573459, 668.84616538196, 677.8779819632464, 679.9558028728117, 682.7371461987121, 12256.0, 14680.339384727713, 14900.925495372561, 15096.56582624649, 15153.393864245418, 11562.884371156264, 14783.482578109715, 14947.103173809606, 14962.775558366633, 15008.0, 11411.0, 12080.0, 12146.696332591668, 12376.504939802397, 12614.936925315407, 3114.7819652624325, 3852.460655508231, 3967.6230758077936, 4024.63778259958, 4036.354183330682, 93018.20945371718, 119139.12068750779, 120402.0, 121546.0, 122226.77773222243, 9932.10611044995, 10626.415547144981, 10831.729206769895, 11052.281601695864, 11107.500162492708, 23073.307800766004, 23134.768652313596, 23312.65031024536, 23416.64875026876, 23538.529229415315, 8345.457545259538, 8387.370947178986, 8479.643257078838, 8550.358723095793, 8666.306695464475, 4395.934060989088, 4447.3329000650165, 4485.932711009337, 4531.478879928784, 4587.449506059294, 3280.917977050593, 3570.803605801706, 3733.160038991205, 3856.903577410531, 4002.5597184310286, 667.9213070890573, 727.7889412070546, 732.5934106570904, 742.476554029408, 742.8328626059093, 475.65039695823543, 495.6703791978366, 584.5031723035386, 596.7374355283662, 603.6438501284175, 7755.573443460551, 9335.0, 9423.434593924387, 9445.197158241626, 9494.85757713621, 633.5565104426828, 657.6826358888345, 670.4870773858003, 682.3415404135034, 699.6187078042377, 4382.9342559861625, 4413.668974826836, 4593.438087257455, 4710.29345598163, 4739.265413860788, 74832.0, 105577.94422055835, 155267.0, 158766.64751005813, 164380.0, 75726.0, 104112.0, 108301.29246768737, 116690.0, 125466.0, 72742.0, 84417.0, 108786.91213087927, 111875.0, 112352.0, 8682.78293042679, 9038.548072596212, 9590.184834288884, 9685.41887486753, 9875.604975800887, 56312.436875630716, 59351.1097333549, 61216.69391653013, 63126.05310920432, 63959.0, 83794.74307885264, 86045.0, 86150.0, 96060.0, 96523.0, 13184.406701698255, 13399.866001339862, 13466.124701894345, 13469.461221551028, 13712.17726936347, 14717.705645887236, 14772.261386930826, 15041.699166016837, 15072.321745521696, 15880.285387157375, 9376.921654009604, 10387.68836934893, 11532.538698451968, 12344.567940122053, 12512.499500019898, 11960.278488829681, 13742.519011834538, 13907.443702252202, 13909.443622254996, 14009.649758756113, 13008.674783130498, 13360.799588005993, 13501.59495215145, 13839.396866814775, 14192.690238430663, 10488.895111048792, 10492.317999330018, 10610.416427096583, 10686.412247326472, 10830.40432776205, 11004.0, 11325.093992480417, 11456.599019034295, 11724.824127637921, 11784.292942423483], "value": 7727.370323792204, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 118.0, 110.0, 115.0, 126.0, 117.0, 118.0, 119.0, 116.0, 127.0], "value": 117.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 110.0, 155.0, 160.0, 110.0, 132.0, 129.0, 109.0, 162.0, 134.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 200.0, 211.0, 265.0, 278.0, 198.0, 203.0, 205.0, 235.0, 199.0], "value": 218.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 86.0, 76.0, 139.0, 60.0, 59.0, 60.0, 62.0, 139.0, 79.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 121.0, 73.0, 71.0, 73.0, 108.0, 70.0, 72.0, 114.0], "value": 84.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 86.0, 89.0, 88.0, 90.0, 87.0, 89.0, 88.0, 90.0, 85.0], "value": 89.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 114.0, 151.0, 104.0, 151.0, 151.0, 103.0, 94.0], "value": 115.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 140.0, 112.0, 150.0, 115.0, 90.0, 92.0, 91.0, 91.0, 90.0], "value": 112.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 63.0, 59.0, 81.0, 93.0, 92.0, 68.0, 52.0, 52.0], "value": 67.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 66.0, 69.0, 85.0, 73.0, 65.0, 65.0, 70.0, 69.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 88.0, 88.0, 91.0, 87.0, 81.0, 96.0, 112.0, 77.0, 76.0], "value": 88.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 167.0, 166.0, 145.0, 140.0, 148.0, 140.0, 165.0, 178.0, 147.0], "value": 154.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 171.0, 175.0, 177.0, 174.0, 176.0, 175.0, 175.0, 174.0], "value": 174.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 67.0, 72.0, 71.0, 70.0, 66.0, 71.0, 69.0], "value": 69.2, "unit": "score"}]}]} 05:48:51 INFO - Return code: 0 05:48:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:48:51 ERROR - # TBPL SUCCESS # 05:48:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:48:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:48:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:48:51 INFO - 2016-08-17 05:48:51.591 screenresolution[1665:11021] starting screenresolution argv=screenresolution get 05:48:51 INFO - 2016-08-17 05:48:51.595 screenresolution[1665:11021] Display 0: 1600x1200x32@60 05:48:51 INFO - 2016-08-17 05:48:51.602 screenresolution[1666:11024] starting screenresolution argv=screenresolution list 05:48:51 INFO - Available Modes on Display 0 05:48:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:48:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:48:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:48:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:48:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:48:51 INFO - Intel Iris: 05:48:51 INFO - Chipset Model: Intel Iris 05:48:51 INFO - Type: GPU 05:48:51 INFO - Bus: Built-In 05:48:51 INFO - VRAM (Dynamic, Max): 1536 MB 05:48:51 INFO - Vendor: Intel (0x8086) 05:48:51 INFO - Device ID: 0x0a2e 05:48:51 INFO - Revision ID: 0x0009 05:48:51 INFO - Displays: 05:48:51 INFO - Display: 05:48:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:48:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:48:51 INFO - Display Serial Number: 1600x1200 60 05:48:51 INFO - Main Display: Yes 05:48:51 INFO - Mirror: Off 05:48:51 INFO - Online: Yes 05:48:51 INFO - Rotation: Supported 05:48:51 INFO - Return code: 0 05:48:51 INFO - Running post-action listener: _resource_record_post_action 05:48:51 INFO - [mozharness: 2016-08-17 12:48:51.848580Z] Finished run-tests step (success) 05:48:51 INFO - Running post-run listener: _resource_record_post_run 05:48:51 INFO - Total resource usage - Wall time: 1209s; CPU: 55.0%; Read bytes: 33983488; Write bytes: 706337792; Read time: 332; Write time: 1890 05:48:51 INFO - TinderboxPrint: CPU usage
54.6% 05:48:51 INFO - TinderboxPrint: I/O read bytes / time
33,983,488 / 332 05:48:51 INFO - TinderboxPrint: I/O write bytes / time
706,337,792 / 1,890 05:48:51 INFO - TinderboxPrint: CPU idle
2,196.7 (45.4%) 05:48:51 INFO - TinderboxPrint: CPU system
979.1 (20.2%) 05:48:51 INFO - TinderboxPrint: CPU user
1,661.9 (34.4%) 05:48:51 INFO - TinderboxPrint: Swap in / out
435,564,544 / 0 05:48:51 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 392411648; Write bytes: 386287616; Read time: 29284; Write time: 690 05:48:51 INFO - run-tests - Wall time: 1176s; CPU: 55.0%; Read bytes: 33041408; Write bytes: 298775552; Read time: 318; Write time: 1152 05:48:52 INFO - Running post-run listener: _upload_blobber_files 05:48:52 INFO - Blob upload gear active. 05:48:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:48:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:48:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:48:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:48:52 INFO - (blobuploader) - INFO - Open directory for files ... 05:48:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:48:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:48:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:53 INFO - (blobuploader) - INFO - Done attempting. 05:48:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:48:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:48:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:54 INFO - (blobuploader) - INFO - Done attempting. 05:48:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:48:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:48:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:48:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:48:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:48:56 INFO - (blobuploader) - INFO - Done attempting. 05:48:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:48:56 INFO - Return code: 0 05:48:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:48:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:48:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbe5b6b428c23b546b0d42f52ea526253398af30e1dfcfeed9bc3d6d820465b4d12d51e9e5429946aa1b3af6991515f25c55b32a781063ef20e0aca1880eba65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31c5eee35394ecc02dff01e71b35604f63ae8d797638f006dbf170681caade6ddcb299b957ba92ad5d945d2834e135d093e28233a4e0070ff9dedf205ff79ea9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f198c19ea7f3d91ba1db5917b13462f63ff5afdb227d9ffbbeba3446646fb1353d71dc61c25ebc06867d4fd3110ea8394be4dbfc23b0ad78a8aa32da20868de7"} 05:48:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:48:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:48:56 INFO - Contents: 05:48:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbe5b6b428c23b546b0d42f52ea526253398af30e1dfcfeed9bc3d6d820465b4d12d51e9e5429946aa1b3af6991515f25c55b32a781063ef20e0aca1880eba65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31c5eee35394ecc02dff01e71b35604f63ae8d797638f006dbf170681caade6ddcb299b957ba92ad5d945d2834e135d093e28233a4e0070ff9dedf205ff79ea9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f198c19ea7f3d91ba1db5917b13462f63ff5afdb227d9ffbbeba3446646fb1353d71dc61c25ebc06867d4fd3110ea8394be4dbfc23b0ad78a8aa32da20868de7"} 05:48:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:48:56 INFO - Copying logs to upload dir... 05:48:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:48:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1276.470816 ========= master_lag: -0.34 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-08-17 05:48:56.260834) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 05:48:56.264040) ========= 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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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/dbe5b6b428c23b546b0d42f52ea526253398af30e1dfcfeed9bc3d6d820465b4d12d51e9e5429946aa1b3af6991515f25c55b32a781063ef20e0aca1880eba65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31c5eee35394ecc02dff01e71b35604f63ae8d797638f006dbf170681caade6ddcb299b957ba92ad5d945d2834e135d093e28233a4e0070ff9dedf205ff79ea9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f198c19ea7f3d91ba1db5917b13462f63ff5afdb227d9ffbbeba3446646fb1353d71dc61c25ebc06867d4fd3110ea8394be4dbfc23b0ad78a8aa32da20868de7"} build_url:https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011132 build_url: 'https://queue.taskcluster.net/v1/task/CeS-dk5HQz-5gL3LLYWl5A/artifacts/public/build/firefox-51.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dbe5b6b428c23b546b0d42f52ea526253398af30e1dfcfeed9bc3d6d820465b4d12d51e9e5429946aa1b3af6991515f25c55b32a781063ef20e0aca1880eba65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/31c5eee35394ecc02dff01e71b35604f63ae8d797638f006dbf170681caade6ddcb299b957ba92ad5d945d2834e135d093e28233a4e0070ff9dedf205ff79ea9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f198c19ea7f3d91ba1db5917b13462f63ff5afdb227d9ffbbeba3446646fb1353d71dc61c25ebc06867d4fd3110ea8394be4dbfc23b0ad78a8aa32da20868de7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-17 05:48:56.297122) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 05:48:56.297521) ========= 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.nZ3aPmZ2SU/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.tV8kGvjVT7/Listeners TMPDIR=/var/folders/_n/kpth4c2s6392plpy6hkyfjq000000w/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.004355 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-17 05:48:56.346823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 05:48:56.347144) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-17 05:48:56.347488) ========= ========= Total master_lag: -0.19 =========