builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0202 starttime: 1489026778.21 results: success (0) buildid: 20170308164423 builduid: 63bd93bf70ea4a3cbda0161606103dd8 revision: 193989276571a5bd19bc669c6ca42828abe7b4f1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:58.211467) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:58.211954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:58.212237) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:58.238412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:58.238788) ========= 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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-08 18:32:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 37.7M=0s 2017-03-08 18:32:58 (37.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132153 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:58.394944) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:58.395265) ========= 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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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.026759 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:58.444841) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 18:32:58.445195) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 193989276571a5bd19bc669c6ca42828abe7b4f1 --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 193989276571a5bd19bc669c6ca42828abe7b4f1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-08 18:32:58,553 truncating revision to first 12 chars 2017-03-08 18:32:58,553 Setting DEBUG logging. 2017-03-08 18:32:58,553 attempt 1/10 2017-03-08 18:32:58,553 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/193989276571?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-08 18:32:59,621 unpacking tar archive at: mozilla-central-193989276571/testing/mozharness/ program finished with exit code 0 elapsedTime=1.350311 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-08 18:32:59.818740) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:59.822116) ========= script_repo_revision: 193989276571a5bd19bc669c6ca42828abe7b4f1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:59.822520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:59.822838) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 18:32:59.842393) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-08 18:32:59.842752) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 18:33:00 INFO - MultiFileLogger online at 20170308 18:33:00 in /builds/slave/test 18:33:00 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 18:33:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:33:00 INFO - {'append_to_log': False, 18:33:00 INFO - 'base_work_dir': '/builds/slave/test', 18:33:00 INFO - 'blob_upload_branch': 'Firefox', 18:33:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:33:00 INFO - 'branch': 'Firefox', 18:33:00 INFO - 'buildbot_json_path': 'buildprops.json', 18:33:00 INFO - 'config_files': ('talos/mac_config.py',), 18:33:00 INFO - 'default_actions': ('clobber', 18:33:00 INFO - 'read-buildbot-config', 18:33:00 INFO - 'download-and-extract', 18:33:00 INFO - 'populate-webroot', 18:33:00 INFO - 'create-virtualenv', 18:33:00 INFO - 'install', 18:33:00 INFO - 'run-tests'), 18:33:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:33:00 INFO - 'download_minidump_stackwalk': True, 18:33:00 INFO - 'download_symbols': 'ondemand', 18:33:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:33:00 INFO - 'tooltool.py': '/tools/tooltool.py', 18:33:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:33:00 INFO - '/tools/misc-python/virtualenv.py')}, 18:33:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:33:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:33:00 INFO - 'gecko_profile': False, 18:33:00 INFO - 'gecko_profile_interval': 0, 18:33:00 INFO - 'installer_path': 'installer.exe', 18:33:00 INFO - 'log_level': 'info', 18:33:00 INFO - 'log_name': 'talos', 18:33:00 INFO - 'log_to_console': True, 18:33:00 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:33:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:33:00 INFO - 'opt_config_files': (), 18:33:00 INFO - 'pip_index': False, 18:33:00 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:33:00 INFO - 'cmd': ('bash', 18:33:00 INFO - '-c', 18:33:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:33:00 INFO - 'enabled': True, 18:33:00 INFO - 'halt_on_failure': False, 18:33:00 INFO - 'name': 'check_screen_resolution'},), 18:33:00 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:33:00 INFO - 'cmd': ('bash', 18:33:00 INFO - '-c', 18:33:00 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:33:00 INFO - 'enabled': True, 18:33:00 INFO - 'halt_on_failure': False, 18:33:00 INFO - 'name': 'check_screen_resolution'},), 18:33:00 INFO - 'run_cmd_checks_enabled': True, 18:33:00 INFO - 'suite': 'dromaeojs-e10s', 18:33:00 INFO - 'system_bits': '32', 18:33:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:33:00 INFO - 'title': 't-yosemite-r7-0202', 18:33:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:33:00 INFO - 'use_talos_json': True, 18:33:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:33:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:33:00 INFO - 'work_dir': 'build'} 18:33:00 INFO - [mozharness: 2017-03-09 02:33:00.060607Z] Running clobber step. 18:33:00 INFO - Running pre-action listener: _resource_record_pre_action 18:33:00 INFO - Running main action method: clobber 18:33:00 INFO - rmtree: /builds/slave/test/build 18:33:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:33:02 INFO - Running post-action listener: _resource_record_post_action 18:33:02 INFO - [mozharness: 2017-03-09 02:33:02.692738Z] Finished clobber step (success) 18:33:02 INFO - [mozharness: 2017-03-09 02:33:02.692999Z] Running read-buildbot-config step. 18:33:02 INFO - Running pre-action listener: _resource_record_pre_action 18:33:02 INFO - Running main action method: read_buildbot_config 18:33:02 INFO - Using buildbot properties: 18:33:02 INFO - { 18:33:02 INFO - "project": "", 18:33:02 INFO - "product": "firefox", 18:33:02 INFO - "script_repo_revision": "production", 18:33:02 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 18:33:02 INFO - "repository": "", 18:33:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 18:33:02 INFO - "buildid": "20170308164423", 18:33:02 INFO - "pgo_build": "False", 18:33:02 INFO - "basedir": "/builds/slave/test", 18:33:02 INFO - "buildnumber": 89, 18:33:02 INFO - "slavename": "t-yosemite-r7-0202", 18:33:02 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 18:33:02 INFO - "platform": "yosemite_r7", 18:33:02 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:33:02 INFO - "branch": "mozilla-central", 18:33:02 INFO - "repo_path": "mozilla-central", 18:33:02 INFO - "revision": "193989276571a5bd19bc669c6ca42828abe7b4f1", 18:33:02 INFO - "stage_platform": "macosx64", 18:33:02 INFO - "builduid": "63bd93bf70ea4a3cbda0161606103dd8", 18:33:02 INFO - "slavebuilddir": "test" 18:33:02 INFO - } 18:33:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 18:33:02 INFO - Running post-action listener: _resource_record_post_action 18:33:02 INFO - [mozharness: 2017-03-09 02:33:02.698807Z] Finished read-buildbot-config step (success) 18:33:02 INFO - [mozharness: 2017-03-09 02:33:02.698963Z] Running download-and-extract step. 18:33:02 INFO - Running pre-action listener: _resource_record_pre_action 18:33:02 INFO - Running main action method: download_and_extract 18:33:02 INFO - mkdir: /builds/slave/test/build/tests 18:33:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:02 INFO - trying https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 18:33:02 INFO - Downloading https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 18:33:03 INFO - Downloaded 1199 bytes. 18:33:03 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 18:33:03 INFO - Using the following test package requirements: 18:33:03 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:33:03 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:33:03 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 18:33:03 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:33:03 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 18:33:03 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:33:03 INFO - u'jsshell-mac.zip'], 18:33:03 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:33:03 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 18:33:03 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 18:33:03 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:33:03 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 18:33:03 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:33:03 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 18:33:03 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:33:03 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 18:33:03 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 18:33:03 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 18:33:03 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:33:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:33:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:33:03 INFO - Fetch https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:33:05 INFO - Expected file size: 51787417 18:33:05 INFO - Obtained file size: 51787417 18:33:21 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:33:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 18:33:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:33:21 INFO - Fetch https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 18:33:22 INFO - Expected file size: 51787417 18:33:22 INFO - Obtained file size: 51787417 18:33:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 18:33:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:33:37 INFO - Fetch https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 18:33:38 INFO - Expected file size: 14404424 18:33:38 INFO - Obtained file size: 14404424 18:33:39 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')]} 18:33:39 INFO - trying https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:33:39 INFO - Downloading https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 18:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 18:33:41 INFO - Downloaded 75035123 bytes. 18:33:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:33:41 INFO - mkdir: /builds/slave/test/properties 18:33:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:33:41 INFO - Writing to file /builds/slave/test/properties/build_url 18:33:41 INFO - Contents: 18:33:41 INFO - build_url:https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 18:33:41 INFO - Running post-action listener: _resource_record_post_action 18:33:41 INFO - Running post-action listener: set_extra_try_arguments 18:33:41 INFO - [mozharness: 2017-03-09 02:33:41.926338Z] Finished download-and-extract step (success) 18:33:41 INFO - [mozharness: 2017-03-09 02:33:41.926474Z] Running populate-webroot step. 18:33:41 INFO - Running pre-action listener: _resource_record_pre_action 18:33:41 INFO - Running main action method: populate_webroot 18:33:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:33:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:33:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:33:41 INFO - '--tppagecycles', 18:33:41 INFO - '7'], 18:33:41 INFO - 'tests': ['tsvgm']}}, 18:33:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:33:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:33:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:33:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:33:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:33:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:33:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:33:41 INFO - 'talos_options': ['--disable-e10s'], 18:33:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:33:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:33:41 INFO - 'talos_options': ['--disable-e10s'], 18:33:41 INFO - 'tests': ['damp', 'tps']}, 18:33:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:33:41 INFO - 'tests': ['damp', 'tps']}, 18:33:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:33:41 INFO - 'tests': ['dromaeo_dom']}, 18:33:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:33:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:33:41 INFO - 'tests': ['basic_compositor_video']}, 18:33:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:33:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:33:41 INFO - 'tests': ['a11yr', 18:33:41 INFO - 'ts_paint', 18:33:41 INFO - 'tpaint', 18:33:41 INFO - 'sessionrestore', 18:33:41 INFO - 'sessionrestore_no_auto_restore', 18:33:41 INFO - 'tabpaint']}, 18:33:41 INFO - 'other-e10s': {'tests': ['a11yr', 18:33:41 INFO - 'ts_paint', 18:33:41 INFO - 'tpaint', 18:33:41 INFO - 'sessionrestore', 18:33:41 INFO - 'sessionrestore_no_auto_restore', 18:33:41 INFO - 'tabpaint']}, 18:33:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:33:41 INFO - 'ts_paint', 18:33:41 INFO - 'tpaint', 18:33:41 INFO - 'sessionrestore', 18:33:41 INFO - 'sessionrestore_no_auto_restore', 18:33:41 INFO - 'tabpaint']}, 18:33:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:33:41 INFO - 'ts_paint', 18:33:41 INFO - 'tpaint', 18:33:41 INFO - 'sessionrestore', 18:33:41 INFO - 'sessionrestore_no_auto_restore', 18:33:41 INFO - 'tabpaint']}, 18:33:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:33:41 INFO - 'tests': ['a11yr', 18:33:41 INFO - 'ts_paint', 18:33:41 INFO - 'tpaint', 18:33:41 INFO - 'sessionrestore', 18:33:41 INFO - 'sessionrestore_no_auto_restore', 18:33:41 INFO - 'tabpaint']}, 18:33:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:33:41 INFO - 'tests': ['a11yr', 18:33:41 INFO - 'ts_paint', 18:33:41 INFO - 'tpaint', 18:33:41 INFO - 'sessionrestore', 18:33:41 INFO - 'sessionrestore_no_auto_restore', 18:33:41 INFO - 'tabpaint']}, 18:33:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:33:41 INFO - 'tests': ['tsvgx', 18:33:41 INFO - 'tsvgr_opacity', 18:33:41 INFO - 'tart', 18:33:41 INFO - 'tscrollx', 18:33:41 INFO - 'cart', 18:33:41 INFO - 'tsvg_static']}, 18:33:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:33:41 INFO - 'tsvgr_opacity', 18:33:41 INFO - 'tart', 18:33:41 INFO - 'tscrollx', 18:33:41 INFO - 'cart', 18:33:41 INFO - 'tsvg_static']}, 18:33:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:33:41 INFO - 'talos_options': ['--disable-e10s'], 18:33:41 INFO - 'tests': ['tp5o']}, 18:33:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:33:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:33:41 INFO - 'talos_options': ['--disable-e10s', 18:33:41 INFO - '--xperf_path', 18:33:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:41 INFO - 'tests': ['tp5n']}, 18:33:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:33:41 INFO - 'talos_options': ['--xperf_path', 18:33:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:41 INFO - 'tests': ['tp5n']}}, 18:33:41 INFO - 'talos.zip': {'path': '', 18:33:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:33:41 INFO - Running post-action listener: _resource_record_post_action 18:33:41 INFO - [mozharness: 2017-03-09 02:33:41.944826Z] Finished populate-webroot step (success) 18:33:41 INFO - [mozharness: 2017-03-09 02:33:41.944945Z] Running create-virtualenv step. 18:33:41 INFO - Running pre-action listener: _resource_record_pre_action 18:33:41 INFO - Running main action method: create_virtualenv 18:33:41 INFO - Creating virtualenv /builds/slave/test/build/venv 18:33:41 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 18:33:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:33:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:33:42 INFO - Using real prefix '/tools/python27' 18:33:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:33:42 INFO - Installing distribute.............................................................................................................................................................................................done. 18:33:45 INFO - Installing pip.................done. 18:33:45 INFO - Return code: 0 18:33:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:33:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:33:45 INFO - Reading from file tmpfile_stdout 18:33:45 INFO - Output received: 18:33:45 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 18:33:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:45 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 0x10eb3fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb42768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff84bbfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91dd30>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e912be8>, '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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 18:33:45 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 18:33:45 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 18:33:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3QmhyRMsKP/Render', 18:33:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:45 INFO - 'HOME': '/Users/cltbld', 18:33:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:45 INFO - 'LOGNAME': 'cltbld', 18:33:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:45 INFO - 'MOZ_NO_REMOTE': '1', 18:33:45 INFO - 'NO_EM_RESTART': '1', 18:33:45 INFO - 'PAGER': '/bin/cat', 18:33:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:45 INFO - 'PWD': '/builds/slave/test', 18:33:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:45 INFO - 'SHELL': '/bin/bash', 18:33:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqz9R2lcjZ/Listeners', 18:33:45 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 18:33:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:45 INFO - 'USER': 'cltbld', 18:33:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:45 INFO - 'XPC_FLAGS': '0x0', 18:33:45 INFO - 'XPC_SERVICE_NAME': '0', 18:33:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:46 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 18:33:46 INFO - Cleaning up... 18:33:46 INFO - Return code: 0 18:33:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:33:46 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')]} 18:33:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:46 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')]} 18:33:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:46 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 0x10eb3fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb42768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff84bbfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91dd30>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e912be8>, '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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 18:33:46 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 18:33:46 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 18:33:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3QmhyRMsKP/Render', 18:33:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:46 INFO - 'HOME': '/Users/cltbld', 18:33:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:46 INFO - 'LOGNAME': 'cltbld', 18:33:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:46 INFO - 'MOZ_NO_REMOTE': '1', 18:33:46 INFO - 'NO_EM_RESTART': '1', 18:33:46 INFO - 'PAGER': '/bin/cat', 18:33:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:46 INFO - 'PWD': '/builds/slave/test', 18:33:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:46 INFO - 'SHELL': '/bin/bash', 18:33:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqz9R2lcjZ/Listeners', 18:33:46 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 18:33:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:46 INFO - 'USER': 'cltbld', 18:33:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:46 INFO - 'XPC_FLAGS': '0x0', 18:33:46 INFO - 'XPC_SERVICE_NAME': '0', 18:33:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:46 INFO - Downloading/unpacking psutil>=3.1.1 18:33:46 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 18:33:46 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 18:33:46 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 18:33:46 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 18:33:46 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 18:33:46 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 18:33:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:33:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:49 INFO - Installing collected packages: psutil 18:33:49 INFO - Running setup.py install for psutil 18:33:50 INFO - building 'psutil._psutil_osx' extension 18:33:50 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 18:33:50 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 18:33:50 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 18:33:50 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 18:33:50 INFO - building 'psutil._psutil_posix' extension 18:33:50 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 18:33:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:33:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:33:50 INFO - ^ 18:33:50 INFO - 1 warning generated. 18:33:50 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 18:33:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:51 INFO - Successfully installed psutil 18:33:51 INFO - Cleaning up... 18:33:51 INFO - Return code: 0 18:33:51 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:33: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')]} 18:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33: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')]} 18:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:51 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 0x10eb3fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb42768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff84bbfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91dd30>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e912be8>, '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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 18:33:51 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 18:33:51 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 18:33:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3QmhyRMsKP/Render', 18:33:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:51 INFO - 'HOME': '/Users/cltbld', 18:33:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:51 INFO - 'LOGNAME': 'cltbld', 18:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:51 INFO - 'MOZ_NO_REMOTE': '1', 18:33:51 INFO - 'NO_EM_RESTART': '1', 18:33:51 INFO - 'PAGER': '/bin/cat', 18:33:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:51 INFO - 'PWD': '/builds/slave/test', 18:33:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:51 INFO - 'SHELL': '/bin/bash', 18:33:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqz9R2lcjZ/Listeners', 18:33:51 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 18:33:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:51 INFO - 'USER': 'cltbld', 18:33:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:51 INFO - 'XPC_FLAGS': '0x0', 18:33:51 INFO - 'XPC_SERVICE_NAME': '0', 18:33:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:33:51 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 18:33:51 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 18:33:51 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 18:33:51 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 18:33:51 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 18:33:51 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 18:33:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:33:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:33:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:33:54 INFO - Installing collected packages: mozsystemmonitor 18:33:54 INFO - Running setup.py install for mozsystemmonitor 18:33:54 INFO - Successfully installed mozsystemmonitor 18:33:54 INFO - Cleaning up... 18:33:54 INFO - Return code: 0 18:33:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:33:54 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')]} 18:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:54 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')]} 18:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:55 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 0x10eb3fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb42768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff84bbfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91dd30>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e912be8>, '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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 18:33:55 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 18:33:55 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 18:33:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3QmhyRMsKP/Render', 18:33:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:55 INFO - 'HOME': '/Users/cltbld', 18:33:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:55 INFO - 'LOGNAME': 'cltbld', 18:33:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:55 INFO - 'MOZ_NO_REMOTE': '1', 18:33:55 INFO - 'NO_EM_RESTART': '1', 18:33:55 INFO - 'PAGER': '/bin/cat', 18:33:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:55 INFO - 'PWD': '/builds/slave/test', 18:33:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:55 INFO - 'SHELL': '/bin/bash', 18:33:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqz9R2lcjZ/Listeners', 18:33:55 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 18:33:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:55 INFO - 'USER': 'cltbld', 18:33:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:55 INFO - 'XPC_FLAGS': '0x0', 18:33:55 INFO - 'XPC_SERVICE_NAME': '0', 18:33:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:55 INFO - Downloading/unpacking jsonschema==2.5.1 18:33:55 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 18:33:55 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 18:33:55 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 18:33:55 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 18:33:55 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 18:33:55 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 18:33:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:33:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:33:58 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 18:33:58 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 18:33:58 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 18:33:58 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 18:33:58 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 18:33:58 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 18:33:58 INFO - Downloading functools32-3.2.3-2.tar.gz 18:33:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:33:58 INFO - warning: no files found matching '*.txt' 18:33:58 INFO - no previously-included directories found matching 'build' 18:33:58 INFO - no previously-included directories found matching 'dist' 18:33:58 INFO - no previously-included directories found matching '.git*' 18:33:58 INFO - Installing collected packages: jsonschema, functools32 18:33:58 INFO - Running setup.py install for functools32 18:33:59 INFO - warning: no files found matching '*.txt' 18:33:59 INFO - no previously-included directories found matching 'build' 18:33:59 INFO - no previously-included directories found matching 'dist' 18:33:59 INFO - no previously-included directories found matching '.git*' 18:33:59 INFO - Successfully installed jsonschema functools32 18:33:59 INFO - Cleaning up... 18:33:59 INFO - Return code: 0 18:33:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:33:59 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')]} 18:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:59 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')]} 18:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:59 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 0x10eb3fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb42768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff84bbfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91dd30>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e912be8>, '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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 18:33:59 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 18:33:59 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 18:33:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3QmhyRMsKP/Render', 18:33:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:59 INFO - 'HOME': '/Users/cltbld', 18:33:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:59 INFO - 'LOGNAME': 'cltbld', 18:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:59 INFO - 'MOZ_NO_REMOTE': '1', 18:33:59 INFO - 'NO_EM_RESTART': '1', 18:33:59 INFO - 'PAGER': '/bin/cat', 18:33:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:59 INFO - 'PWD': '/builds/slave/test', 18:33:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:59 INFO - 'SHELL': '/bin/bash', 18:33:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqz9R2lcjZ/Listeners', 18:33:59 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 18:33:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:59 INFO - 'USER': 'cltbld', 18:33:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:59 INFO - 'XPC_FLAGS': '0x0', 18:33:59 INFO - 'XPC_SERVICE_NAME': '0', 18:33:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:33:59 INFO - Cleaning up... 18:33:59 INFO - Return code: 0 18:33:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:33:59 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')]} 18:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:59 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')]} 18:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:59 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 0x10eb3fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb42768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff84bbfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91dd30>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e912be8>, '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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 18:33:59 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 18:33:59 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 18:33:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3QmhyRMsKP/Render', 18:33:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:33:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:33:59 INFO - 'HOME': '/Users/cltbld', 18:33:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:33:59 INFO - 'LOGNAME': 'cltbld', 18:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:59 INFO - 'MOZ_NO_REMOTE': '1', 18:33:59 INFO - 'NO_EM_RESTART': '1', 18:33:59 INFO - 'PAGER': '/bin/cat', 18:33:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:59 INFO - 'PWD': '/builds/slave/test', 18:33:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:33:59 INFO - 'SHELL': '/bin/bash', 18:33:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqz9R2lcjZ/Listeners', 18:33:59 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 18:33:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:33:59 INFO - 'USER': 'cltbld', 18:33:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:33:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:59 INFO - 'XPC_FLAGS': '0x0', 18:33:59 INFO - 'XPC_SERVICE_NAME': '0', 18:33:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:59 INFO - Downloading/unpacking blobuploader==1.2.4 18:33:59 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 18:33:59 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 18:33:59 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 18:33:59 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 18:33:59 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 18:33:59 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 18:34:02 INFO - Downloading blobuploader-1.2.4.tar.gz 18:34:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:34:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:34:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:34:03 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 18:34:03 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 18:34:03 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 18:34:03 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 18:34:03 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 18:34:03 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 18:34:03 INFO - Downloading docopt-0.6.1.tar.gz 18:34:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:34:03 INFO - Installing collected packages: blobuploader, requests, docopt 18:34:03 INFO - Running setup.py install for blobuploader 18:34:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:34:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:34:03 INFO - Running setup.py install for requests 18:34:04 INFO - Running setup.py install for docopt 18:34:04 INFO - Successfully installed blobuploader requests docopt 18:34:04 INFO - Cleaning up... 18:34:04 INFO - Return code: 0 18:34:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:04 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 0x10eb3fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb42768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff84bbfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91dd30>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e912be8>, '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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 18:34:04 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 18:34:04 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 18:34:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3QmhyRMsKP/Render', 18:34:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:04 INFO - 'HOME': '/Users/cltbld', 18:34:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:04 INFO - 'LOGNAME': 'cltbld', 18:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:04 INFO - 'MOZ_NO_REMOTE': '1', 18:34:04 INFO - 'NO_EM_RESTART': '1', 18:34:04 INFO - 'PAGER': '/bin/cat', 18:34:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:04 INFO - 'PWD': '/builds/slave/test', 18:34:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:04 INFO - 'SHELL': '/bin/bash', 18:34:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqz9R2lcjZ/Listeners', 18:34:04 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 18:34:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:04 INFO - 'USER': 'cltbld', 18:34:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:04 INFO - 'XPC_FLAGS': '0x0', 18:34:04 INFO - 'XPC_SERVICE_NAME': '0', 18:34:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:34:04 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-w4pp8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:34:04 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-1t_F9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:34:04 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-9Ir9QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:34:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-kz2IbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:34:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-3xn4Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:34:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-qzYxhU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:34:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-MwthvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:34:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-cgj9l2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:34:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-nWOpkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:34:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-qQMdy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:34:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-lB0Bul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:34:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:34:05 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-9uJzC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:34:06 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-4y3ya0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:34:06 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-vdGLw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:06 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-wFcItN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:34:06 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-mEd2tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:34:06 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-loA1nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:34:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:34:06 INFO - Running setup.py install for manifestparser 18:34:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:34:06 INFO - Running setup.py install for mozcrash 18:34:06 INFO - Running setup.py install for mozdebug 18:34:06 INFO - Running setup.py install for mozdevice 18:34:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:34:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:34:07 INFO - Running setup.py install for mozfile 18:34:07 INFO - Running setup.py install for mozhttpd 18:34:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:34:07 INFO - Running setup.py install for mozinfo 18:34:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:34:07 INFO - Running setup.py install for mozInstall 18:34:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:34:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:34:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:34:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:34:07 INFO - Running setup.py install for mozleak 18:34:07 INFO - Running setup.py install for mozlog 18:34:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:34:08 INFO - Running setup.py install for moznetwork 18:34:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:34:08 INFO - Running setup.py install for mozprocess 18:34:08 INFO - Running setup.py install for mozprofile 18:34:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:34:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:34:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:34:08 INFO - Running setup.py install for mozrunner 18:34:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:34:08 INFO - Running setup.py install for mozscreenshot 18:34:08 INFO - Running setup.py install for moztest 18:34:08 INFO - Running setup.py install for mozversion 18:34:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:34:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:34:09 INFO - Cleaning up... 18:34:09 INFO - Return code: 0 18:34:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:34:09 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')]} 18:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:09 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')]} 18:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:09 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 0x10eb3fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb42768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff84bbfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91dd30>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e912be8>, '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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 18:34:09 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 18:34:09 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 18:34:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3QmhyRMsKP/Render', 18:34:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:09 INFO - 'HOME': '/Users/cltbld', 18:34:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:09 INFO - 'LOGNAME': 'cltbld', 18:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:09 INFO - 'MOZ_NO_REMOTE': '1', 18:34:09 INFO - 'NO_EM_RESTART': '1', 18:34:09 INFO - 'PAGER': '/bin/cat', 18:34:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:09 INFO - 'PWD': '/builds/slave/test', 18:34:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:09 INFO - 'SHELL': '/bin/bash', 18:34:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqz9R2lcjZ/Listeners', 18:34:09 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 18:34:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:09 INFO - 'USER': 'cltbld', 18:34:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:09 INFO - 'XPC_FLAGS': '0x0', 18:34:09 INFO - 'XPC_SERVICE_NAME': '0', 18:34:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:34:09 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-wspALp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:34:09 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)) 18:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:34:09 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-t9PCCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:34:09 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-1Lx6WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:34:09 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)) 18:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:34:09 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-xfh7j8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:34:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:34:09 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-h1GHBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:34:09 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)) 18:34:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:34:09 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-OyAcCd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:34:10 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)) 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:34:10 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-RieJaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:34:10 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)) 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:34:10 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-Av9_nJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:34:10 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)) 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:34:10 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-FRvFN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:34:10 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)) 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:34:10 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-qi3l3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:34:10 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-zqv3d0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:34:10 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)) 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:34:10 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-w_NGRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:34:10 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-B2_MZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:34:10 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)) 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:34:10 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-h_xz1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:10 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-B3lxKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:10 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)) 18:34:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:34:10 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-8TxPTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:34:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:34:11 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-S8OSoj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:34:11 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)) 18:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:34:11 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)) 18:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:34:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 18:34:11 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:34:11 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 18:34:11 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 18:34:11 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 18:34:11 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 18:34:11 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 18:34:11 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 18:34:13 INFO - Downloading blessings-1.6.tar.gz 18:34:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:34:13 INFO - Installing collected packages: blessings 18:34:13 INFO - Running setup.py install for blessings 18:34:14 INFO - Successfully installed blessings 18:34:14 INFO - Cleaning up... 18:34:14 INFO - Return code: 0 18:34:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:34:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:34:14 INFO - Reading from file tmpfile_stdout 18:34:14 INFO - Current package versions: 18:34:14 INFO - blessings == 1.6 18:34:14 INFO - blobuploader == 1.2.4 18:34:14 INFO - docopt == 0.6.1 18:34:14 INFO - functools32 == 3.2.3-2 18:34:14 INFO - jsonschema == 2.5.1 18:34:14 INFO - manifestparser == 1.1 18:34:14 INFO - mozInstall == 1.12 18:34:14 INFO - mozcrash == 1.0 18:34:14 INFO - mozdebug == 0.1 18:34:14 INFO - mozdevice == 0.49 18:34:14 INFO - mozfile == 1.2 18:34:14 INFO - mozhttpd == 0.7 18:34:14 INFO - mozinfo == 0.9 18:34:14 INFO - mozleak == 0.1 18:34:14 INFO - mozlog == 3.4 18:34:14 INFO - moznetwork == 0.27 18:34:14 INFO - mozprocess == 0.25 18:34:14 INFO - mozprofile == 0.28 18:34:14 INFO - mozrunner == 6.13 18:34:14 INFO - mozscreenshot == 0.1 18:34:14 INFO - mozsystemmonitor == 0.3 18:34:14 INFO - moztest == 0.8 18:34:14 INFO - mozversion == 1.4 18:34:14 INFO - psutil == 3.1.1 18:34:14 INFO - requests == 1.2.3 18:34:14 INFO - wsgiref == 0.1.2 18:34:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:14 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 0x10eb3fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb42768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff84bbfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91dd30>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e912be8>, '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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 18:34:14 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 18:34:14 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 18:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3QmhyRMsKP/Render', 18:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:14 INFO - 'HOME': '/Users/cltbld', 18:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:14 INFO - 'LOGNAME': 'cltbld', 18:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:14 INFO - 'MOZ_NO_REMOTE': '1', 18:34:14 INFO - 'NO_EM_RESTART': '1', 18:34:14 INFO - 'PAGER': '/bin/cat', 18:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:14 INFO - 'PWD': '/builds/slave/test', 18:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:14 INFO - 'SHELL': '/bin/bash', 18:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqz9R2lcjZ/Listeners', 18:34:14 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 18:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:14 INFO - 'USER': 'cltbld', 18:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:14 INFO - 'XPC_FLAGS': '0x0', 18:34:14 INFO - 'XPC_SERVICE_NAME': '0', 18:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:14 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)) 18:34:14 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)) 18:34:14 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)) 18:34:14 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)) 18:34:14 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)) 18:34:14 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)) 18:34:14 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)) 18:34:14 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)) 18:34:14 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)) 18:34:14 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)) 18:34:14 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)) 18:34:14 INFO - Cleaning up... 18:34:14 INFO - Return code: 0 18:34:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:34:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:34:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10eb3fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb42768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcff84bbfe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e91dd30>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e912be8>, '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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 18:34:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:34:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:34:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3QmhyRMsKP/Render', 18:34:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:14 INFO - 'HOME': '/Users/cltbld', 18:34:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:14 INFO - 'LOGNAME': 'cltbld', 18:34:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:14 INFO - 'MOZ_NO_REMOTE': '1', 18:34:14 INFO - 'NO_EM_RESTART': '1', 18:34:14 INFO - 'PAGER': '/bin/cat', 18:34:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:14 INFO - 'PWD': '/builds/slave/test', 18:34:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:14 INFO - 'SHELL': '/bin/bash', 18:34:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqz9R2lcjZ/Listeners', 18:34:14 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 18:34:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:14 INFO - 'USER': 'cltbld', 18:34:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:14 INFO - 'XPC_FLAGS': '0x0', 18:34:14 INFO - 'XPC_SERVICE_NAME': '0', 18:34:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:34:15 INFO - Cleaning up... 18:34:15 INFO - Return code: 0 18:34:15 INFO - Running post-action listener: _resource_record_post_action 18:34:15 INFO - Running post-action listener: _start_resource_monitoring 18:34:15 INFO - Starting resource monitoring. 18:34:15 INFO - [mozharness: 2017-03-09 02:34:15.052641Z] Finished create-virtualenv step (success) 18:34:15 INFO - [mozharness: 2017-03-09 02:34:15.053593Z] Running install step. 18:34:15 INFO - Running pre-action listener: _resource_record_pre_action 18:34:15 INFO - Running main action method: install 18:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:34:15 INFO - Reading from file tmpfile_stdout 18:34:15 INFO - Detecting whether we're running mozinstall >=1.0... 18:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:34:15 INFO - Reading from file tmpfile_stdout 18:34:15 INFO - Output received: 18:34:15 INFO - Usage: mozinstall [options] installer 18:34:15 INFO - Options: 18:34:15 INFO - -h, --help show this help message and exit 18:34:15 INFO - -d DEST, --destination=DEST 18:34:15 INFO - Directory to install application into. [default: 18:34:15 INFO - "/builds/slave/test"] 18:34:15 INFO - --app=APP Application being installed. [default: firefox] 18:34:15 INFO - mkdir: /builds/slave/test/build/application 18:34:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:34:35 INFO - Reading from file tmpfile_stdout 18:34:35 INFO - Output received: 18:34:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:34:35 INFO - Running post-action listener: _resource_record_post_action 18:34:35 INFO - [mozharness: 2017-03-09 02:34:35.791764Z] Finished install step (success) 18:34:35 INFO - [mozharness: 2017-03-09 02:34:35.791915Z] Running run-tests step. 18:34:35 INFO - Running pre-action listener: _resource_record_pre_action 18:34:35 INFO - Running main action method: run_tests 18:34:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:34:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:34:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:34:35 INFO - 2017-03-08 18:34:35.806 screenresolution[1622:7458] starting screenresolution argv=screenresolution get 18:34:35 INFO - 2017-03-08 18:34:35.809 screenresolution[1622:7458] Display 0: 1600x1200x32@60 18:34:35 INFO - 2017-03-08 18:34:35.814 screenresolution[1623:7460] starting screenresolution argv=screenresolution list 18:34:35 INFO - Available Modes on Display 0 18:34:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:34:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:34:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:34:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:34:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:34:36 INFO - Intel Iris: 18:34:36 INFO - Chipset Model: Intel Iris 18:34:36 INFO - Type: GPU 18:34:36 INFO - Bus: Built-In 18:34:36 INFO - VRAM (Dynamic, Max): 1536 MB 18:34:36 INFO - Vendor: Intel (0x8086) 18:34:36 INFO - Device ID: 0x0a2e 18:34:36 INFO - Revision ID: 0x0009 18:34:36 INFO - Displays: 18:34:36 INFO - Display: 18:34:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:34:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:34:36 INFO - Display Serial Number: 1600x1200 60 18:34:36 INFO - Main Display: Yes 18:34:36 INFO - Mirror: Off 18:34:36 INFO - Online: Yes 18:34:36 INFO - Rotation: Supported 18:34:36 INFO - Return code: 0 18:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:34:36 INFO - Python 2.7.3 18:34:36 INFO - Return code: 0 18:34:36 INFO - grabbing minidump binary from tooltool 18:34:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:34:36 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 0x10e91dd30>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e912be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:34:36 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 18:34:36 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 18:34:36 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 18:34:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:34:36 INFO - Return code: 0 18:34:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:34:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:34:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:34:36 INFO - ENV: RUST_BACKTRACE is now 1 18:34:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:34:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:34:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0202', '--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 18:34:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0202 --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 18:34:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.3QmhyRMsKP/Render', 18:34:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:36 INFO - 'HOME': '/Users/cltbld', 18:34:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:36 INFO - 'LOGNAME': 'cltbld', 18:34:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:34:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:34:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:36 INFO - 'MOZ_NO_REMOTE': '1', 18:34:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:34:36 INFO - 'NO_EM_RESTART': '1', 18:34:36 INFO - 'PAGER': '/bin/cat', 18:34:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:36 INFO - 'PWD': '/builds/slave/test', 18:34:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:34:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:36 INFO - 'RUST_BACKTRACE': '1', 18:34:36 INFO - 'SHELL': '/bin/bash', 18:34:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eqz9R2lcjZ/Listeners', 18:34:36 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 18:34:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:36 INFO - 'USER': 'cltbld', 18:34:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:36 INFO - 'XPC_FLAGS': '0x0', 18:34:36 INFO - 'XPC_SERVICE_NAME': '0', 18:34:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0202', '--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 18:34:36 INFO - mozversion application_buildid: 20170308164423 18:34:36 INFO - mozversion application_changeset: 193989276571a5bd19bc669c6ca42828abe7b4f1 18:34:36 INFO - mozversion application_display_name: Nightly 18:34:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:34:36 INFO - mozversion application_name: Firefox 18:34:36 INFO - mozversion application_remotingname: firefox 18:34:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:34:36 INFO - mozversion application_vendor: Mozilla 18:34:36 INFO - mozversion application_version: 55.0a1 18:34:36 INFO - mozversion platform_buildid: 20170308164423 18:34:36 INFO - mozversion platform_changeset: 193989276571a5bd19bc669c6ca42828abe7b4f1 18:34:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:34:36 INFO - mozversion platform_version: 55.0a1 18:34:36 INFO - using testdate: 1489026876 18:34:36 INFO - actual date: 1489026876 18:34:36 INFO - starting webserver on 'localhost:49243' 18:34:36 INFO - SUITE-START | Running 2 tests 18:34:36 INFO - TEST-START | dromaeo_css 18:34:36 INFO - operating with platform_type : mac_ 18:34:36 INFO - Initialising browser for dromaeo_css test... 18:34:36 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmpCJ4b65/profile http://localhost:49243/getInfo.html) 18:34:39 INFO - PROCESS | 1633 | 2017-03-08 18:34:39.287 plugin-container[1635:7642] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4953, name = 'com.apple.tsm.portname' 18:34:39 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:34:39 INFO - PROCESS | 1633 | 2017-03-08 18:34:39.290 plugin-container[1635:7642] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b0b, name = 'com.apple.CFPasteboardClient' 18:34:39 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:34:39 INFO - PROCESS | 1633 | 2017-03-08 18:34:39.290 plugin-container[1635:7642] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:34:39 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 18:34:39 INFO - PROCESS | 1633 | colorDepth:24 18:34:39 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 18:34:39 INFO - PROCESS | 1633 | __metrics 18:34:39 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 18:34:40 INFO - TEST-INFO | 1633: exit 0 18:34:40 INFO - Browser initialized. 18:34:40 INFO - Running cycle 1/1 for dromaeo_css test... 18:34:40 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmpCJ4b65/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:34:43 INFO - PROCESS | 1636 | 2017-03-08 18:34:43.092 plugin-container[1637:7773] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x433f, name = 'com.apple.tsm.portname' 18:34:43 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:34:43 INFO - PROCESS | 1636 | 2017-03-08 18:34:43.093 plugin-container[1637:7773] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 18:34:43 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:34:43 INFO - PROCESS | 1636 | 2017-03-08 18:34:43.093 plugin-container[1637:7773] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:34:52 INFO - PROCESS | 1636 | RSS: Main: 226955264 18:34:52 INFO - PROCESS | 1636 | 18:37:56 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 18:37:57 INFO - PROCESS | 1636 | RSS: Main: 249790464 18:37:57 INFO - PROCESS | 1636 | 18:39:40 INFO - PROCESS | 1636 | ************************* 18:39:40 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 18:39:40 INFO - PROCESS | 1636 | 18:39:40 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:39:40 INFO - PROCESS | 1636 | Full stack: 18:39:40 INFO - PROCESS | 1636 | ************************* 18:41:00 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 18:41:01 INFO - PROCESS | 1636 | RSS: Main: 259084288 18:41:01 INFO - PROCESS | 1636 | 18:44:03 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 18:44:03 INFO - PROCESS | 1636 | RSS: Main: 270053376 18:44:03 INFO - PROCESS | 1636 | 18:47:05 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 18:47:06 INFO - PROCESS | 1636 | RSS: Main: 262881280 18:47:06 INFO - PROCESS | 1636 | 18:50:09 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 18:50:10 INFO - PROCESS | 1636 | RSS: Main: 272564224 18:50:10 INFO - PROCESS | 1636 | 18:53:13 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 18:53:13 INFO - PROCESS | 1636 | RSS: Main: 266489856 18:53:13 INFO - PROCESS | 1636 | 18:53:13 INFO - PROCESS | 1636 | __start_tp_report 18:53:13 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 18:53:13 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 18:53:13 INFO - PROCESS | 1636 | |i|pagename|runs| 18:53:13 INFO - PROCESS | 1636 | |0;dojo.html;3445.6726610971964;3458.6887180153785;3493.5458390409244;3493.8427770750313;3532.6114127445976;5054.444011158769;5748.425157484249;5928.347881733006;6007.429294217048;6070.453659170674;5923.9407605923925;5987.43119403656;6082;6112.4193201645885;6122.459144589048;5326.493983071602;5342.492463215988;5344.4922732340365;5346.893062138755;5453.945460545384;5470.835874923739;5477.424870388611;5478.233047373371;5485.149801780731;5489.423610520877;5300.151975683911;5304.92042619361;5325;5409.540189083893;5454.481824226692;5321.574274058066;5339.279197308391;5343.385510666245;5453.15476101205;5469.480399362054;4611.216093264153;4894.776305923519;5368.033753924292;5376.91934620981;5377.166539186433;5798.245833229183;5985.4912332451795;6014.3684913083935;6050.96974515129;6106.633601983851;6250.718717657716;6263.812085637438;6264.342244064399;6271.655058971754;6273.99616061428;5402.8919421611745;5897.439743224387;5955.136505206764;6445.291017988017;6473.93526064738;6098.176746139259;6138.171346868205;6173.135760993465;6200.968995154995;6208.099825525319;6251.74993000284;6289.842753931097;6426.582272152295;6447.323031081763;6462.224533056064;6197.845053873599;6230.532710046674;6236.968815155986;6271.874562508816;6300.810975670737;5682.749795045083;6192.938070619236;6455.064015717695;6465.806025819139;6467.708953097122;6247.812565623039;6324.968375158187;6380.330065343165;6380.521460890452;6426.74293028283;6216.316205217422;6234.470070044097;6240.438360547572;6247.3440288769025;6269.404406581368;5196.4803519648485;5207.6875387476875;5208.140656791663;5224.399194092728;5237.266782650432;4620.930686039712;4621.504447192373;4623.69945953512;4659.5573420525;4670.813167473263;5282.788688452496;5599.860003499945;6057.7879774207695;6091.51267898567;6127.724252408652;6294.496440284766;6354.618722876642;6393.968030159913;6429.3570642936265;6433.903491447632;6189.071639254058;6221.440070393686;6234.781782637586;6243.96878015607;6246.843828904313;5081.8729531762;5709.143628455765;5732.885342293131;5743.798967036134;5760.164776107441;6379.138816259839;6425.421712045845;6559.245686745894;6566.6388348639375;6720.126383570105;6115.938840611537;6452.741890324334;6476.579022363531;6483.286838447862;6498.252700939263;6604.570702904296;6684.131062961784;6688.83277918056;6704.229013663296;6724.226713927961;6207.906881396692;6264.436200741773;6265.997440409513;6267.122602835698;6369.490440764635;6344.587601805868;6396.968015159894;6401.64790936503;6430.324815894263;6436.324185960407;6130.785422510191;6153.969230153821;6183;6204.069389591597;6206.875862482815;6218.5647004709235;6272.560920735505;6275.748970041147;6280.466160376419;6284.905726414199;5229.294045303987;5982.88034239304;6119.837693858789;6148.938510614837;6158.753649853956;6174.845628859314;6259.092431597484;6282.905756413566;6283.842903927439;6302.086197501429;6242.438180563771;6259.624422534663;6260.7495700171485;6266;6302.464290535356 18:53:13 INFO - PROCESS | 1636 | |1;ext.html;668.5654324688952;800.3877034068938;822.839546288474;934.5841100710185;959.932804703671;38160;38727.80636096819;38792.22415551691;40018;40034;38533.614663853354;38782;38817.61182388175;38891;38941.805290973505;9047.547622618875;9419.576119074658;9482.857757133648;9490.335676502647;9493.335466517347;9233.722988310361;9287.349885508018;9337.626494940228;9343.439393636403;9343.579538920765;9320.627174912996;9335.859962100574;9344;9359.95320023399;9363.969963304065;9284.675036373763;9312.580933857993;9353.906460935406;9357.812843743155;9374.953125234399;9220.262379009662;9230.953845230799;9254.953725231398;9277.44335339875;9280.257579393632;38372.61627383746;38686;38694;38705.74236833946;38880.22239555221;3200.695933886277;3634.818259087035;3637.5453068366455;3660.560732712065;3662.8901132966053;27752.583711244348;28398.858005710044;28499.43001139986;28545;28601.713982860114;2543.5548778963607;2714.5656694928916;3219.4687876500348;3239.1254361322544;3281.6882396172327;279981;337272;337626;338102;338686.99999999756;43261.783691081975;49785.50214497881;49803.50196498061;50055.74972125116;50141.24788128181;43852.56147438549;51953;52763;52778.472215278125;52831.47168528265;14329.498467553585;14399.42402303896;14433.422663093568;14448.988570799944;14454.494092706705;11458.942705286587;11656.358900260568;11662.650120496399;11684.18210725241;11692.70768230784;12465.75068498625;13586.45654173822;13705.862941370458;13728.93135534316;13818.37817298224;5984.910226346608;6039.909401358983;6054.182685337511;6059.697015149225;6099.542534309856;945.9952700236455;1069.2622090757352;1136.1478890831877;1139.9715007124723;1142.3945308986251;20031.799682003286;25611.61582576263;26019.349516262246;26415.339616509358;26983.730162698514;1065.7016035510069;1099.8946059210443;1246.4079562207878;1292.3990344489857;1292.7931530955002;13086.345682715826;13403.927685785115;13717.931410343084;13733.862661373458;13780.966427517977;462756;462849;464121;465537;465702;53989.1901621476;54068.729656352254;54381.1842822358;54551.45448545543;54696.72651636796;1341.5103487227286;1363.2161507133437;1390.1381143690774;1410.6191328341495;1443.1196969848384;25432.601206933796;26077.478450431263;27941.58087628728;28971.85514072416;29236;44200.894977625816;44482.11035779331;44614.88462788456;44639;44709;400957;401013;401778;401929.99035004637;402157;31348;31481.055568332988;31566.842165789025;32655;33301;44640.41994750656;45200;45409.545904541854;45863.31205031861;46089;35578.46632300569;36668.63331366652;37790.62209377981;37970.81014594909;38280.04299892525;36136.27727445489;36249.45625815668;36896;37149.20894436205;37699.43450848294;36483;36790;36959;37056.62943370532;37069.07327316839;31414;32523.51214731828;32759.022003437254;32868.849590264224;32880.50679239861;23951.401214969766;24574.139905103235;24580;24897.630630315507;24991 18:53:13 INFO - PROCESS | 1636 | |2;jquery.html;333.39156040226595;393.6594845458679;409.5904095904096;424.23849190702686;432.0645801839017;18669.53326166843;20679.483012924666;22011.22960696376;22054.88972555137;22069.558608827814;21973.78026219737;22316.665250021262;22686.319410417673;22927.656085158695;23211.76788232117;6688.632125233123;6912.308769123073;6940.965295173517;6943.236244013155;6970.372666460017;6246.09431632413;6612.966935165317;6695.163104611924;6764.492663050266;6776.830579235534;5700.914486282709;6027.216461859952;6697.93302066978;6712.597244165366;6719.8656026879435;5739.196512488255;6736.191657001143;6770.898436523456;6791.456683465311;6818.215905170894;6648.202215734094;7133.89299160513;7487.962560187164;7495.962520187419;7552.433567482406;26690.19929402121;26717.332066698295;27455.588166177524;27627.171184864284;27640.032598858943;3225.467797813358;3286.342731453719;3323.302106557626;3356.345512625039;3416.6241713411505;12961;14647.780283295759;14953.654171124652;15853.524394268075;16173.514794556182;2086.8539202255847;2126.0539060118253;2128.372130221588;2144.8176904963098;2214.734231892167;139011;150496;160513;161367.19316403344;162077;18960.767550109198;19351;20781.376558703265;21327.25354612612;23499.76500234976;37071.84889284441;37129.70046048376;37156;37194;37302.62697373046;10388.740281493023;10484.790304194026;10693.984071513194;10787.406692631981;10859.511321990529;6890.758823441155;8471.957640211882;8533.53065581399;8683.348748843862;8731.825363492695;8801.47191168532;10771.46142692878;10847.891521084846;10931;11047.508586340902;4273.380359847804;4305.31115021595;4344.56554344563;4351.282038463618;4365.781710914442;844.7803571071565;943.4527973775193;1025.620520407454;1028.711960651004;1067.4716015572342;21923.451913701967;23051.308460746204;23086.307410777703;23145.421364465685;23252.76747232506;929.8186853563625;930.7667340773367;946.3895787217207;961.0965692249264;963.1235575626147;10351.741206469898;11585.942070289595;12014.098942579341;12021.699457513632;12024.977876880563;580011;668162;668763.3123668701;679430.6028469827;686158;110852.4457377708;110879;137613.62386376207;153720;155425;1230.993845030769;1236.486857953957;1281.6091092216964;1284.9421776020101;1290.587012156101;21652.0769696089;21717.457063573536;21962.670559941293;22211.22260720867;22222.88888555547;63151.6842415785;63370;63659.681701591195;64393.71212575628;64405.35594644181;89247;90034.09965900258;90139.54930225307;90396.5480172595;90601;11748.353840538852;12093;12111;12166.209196402206;12232.388380580758;13230;13235.735285294433;13374.732505350034;13589.660258493617;13593.048486605843;9405.341626086109;9579.664711735057;11437.942810285895;11514.36670983104;11631.53473861036;9647.938726739912;10426.478676066015;11204.831927521256;11290.983811457008;11604.187706860439;10447.68656940293;11007.504662290376;11620.88379116198;11826.82259766087;11911.166218364979;9494.85757713621;11514.88485115138;11694.88305116972;11880.287182769061;12089.879101209228;11221.438928053727;11439.942800286279;11747.177697561088;11765.823512647146;12063.39683015828 18:53:13 INFO - PROCESS | 1636 | |3;mootools.html;1318.9538366157183;1423.7508436023697;1468.9559313220593;1528.8394718554553;1567.7334853074976;9165.587548560314;9412.482313472756;10679.252452328341;10992.725181870457;11054.281471704333;9407.576659050343;9703.41779493231;9816;10279.897201028007;10423.114035307008;1879.6428678551065;1927.951801204967;2337.9829774048258;2344.3553022918663;2348.095983046522;2273.795358417742;2305.561943230789;2310.445493081657;2316.9884150579223;2325.2907863101746;2279.418748219202;2289.027163455533;2290.7594702556244;2295.1966811615966;2297.425643589103;2179.4333473296897;2185.0713446785053;2191.660292654641;2198.7471440784357;2201.0755482697305;1867.9719804202948;2296.621057525523;2297.069686776858;2299.321700098475;2303.021215983217;9272.258219342504;10847.945760271148;10911.399873006982;10916.126709863192;10929.508172132273;5419.620626556142;5692.459216374479;5696.401877802812;5701.258836351248;5701.515371193454;3138;3254.6419893811662;3422.828858557087;3426.229098452853;3431.4509678451327;1143.1654891928938;1147.3861484105964;1175.7589694112771;1210.5157936825253;1215.3740823475916;13569.52506662272;13922.512712055131;15100.169490678009;15100.471483498024;15187.62030949224;4431.468223813163;4615.815367385334;4630.513796051366;4668.439787225487;4668.929966050512;9866.01339866022;11473;11529.077673786078;11536.826947595793;11553.768924621461;5483.616146869761;5515.283013208257;5566.55467562594;5576.386597474275;5579.525740312038;4630.930536041962;5134.075866344094;5138.948610513847;5143.485651434827;5144.99672563854;3494.790312581253;3630.7276954228537;3646.1796095878744;3687.3547129252274;3740.831662575191;803.2650125135435;944.3861490031397;957.1481381570408;957.5451660461225;964.4165280005636;761.5454481939469;896.1173244354305;909.8316811389782;927.4110939553298;928.7724507495707;6242.5942313749465;6257.7184026718;6468.450181734511;6482.513811464159;6553.475721942234;939.769756409684;943.0663642993387;974.2644303550774;978.3005151316843;989.3569180033036;3180.3639272145665;3570.8750193743094;3643.7267204959735;3732.738708290394;3742.9812850936114;13012.609621711365;13352.532661356807;13431.328433578283;13449.394777235048;13597.728045439233;12890.097693161577;13091.345432728325;13355.53255636048;13417.12788668753;13432.865671343357;9822.557984890696;9884.851727224097;9919;10020.298579099539;10043.548040338203;6059.33347331802;6216.316205217513;6236.126942228182;6269.529785266214;6345.682715864281;11736.06111511094;11991.400429978292;12075.818862717242;12099.879001210227;12169.026477881926;9358.906410935804;11141.331520108819;11263.26788758728;12027.879721203026;12342.259464431803;7618.885716714364;8224.177582241728;8309.83380332378;8327.833443330977;8327.916720832956;10052.748681283027;10083.14293285079;10152.644657436955;10208.183345332207;10265.024822641837;8953.641854325753;8963;9005.7748556284;9051.547422628973;9068.50123243228;6594.8351291218105;8811.471311721318;8876.068012858557;8968.237699795329;9040.954795225982;7785.104712958082;7799.5320280783335;7823.022122234721;7875.133735289228;7937.960310198412;5498.092814685532;5615.6630602164005;5649.7740090397565;5670.064439367458;5802.622829516068;5779.682117483579;5847.502962248256;5891.381404952418;6092.238470191226;6255.124282600348 18:53:13 INFO - PROCESS | 1636 | |4;prototype.html;365.88840403676903;371.847542507572;375.517460063818;383.0691419849764;384.51935081148554;4630.930536041962;5238.476152384759;5260.473952604742;5293.973530132349;5302.734863256836;4839.951600483994;4852.441969173546;4886.071646387193;5185.974070129653;5296.655717378368;3759.9848041028904;3882.825272862714;3995.7024710791266;4150.564190759972;4351.432654733707;3665.981670091659;3901.200253947934;4361.80371883266;4378.299472084467;4379.146066517031;3371.393149233137;3964.1278918637854;4160.459140311756;4223.831046758126;4390.714603550775;3045.451818672638;4251.171021650779;4295.183915056129;4374.934375984379;4421.9658956879875;3056.5634151948548;3704.407294832814;3834.849545136448;3857.996920800584;3965.266425711253;4106.938395924063;4708.869871230914;5014.323066386028;5138.794448222066;5146.327443580852;4176.394422808706;4447.666425018137;4689.953100468986;5056.519630635084;5099.08216521026;4987.680728461247;5562.525930628387;5606.112851881285;5631.535800691809;5636.323641163046;3570.9107272318142;4050.0839395635094;4272.6154646082;4314.225053078556;4337.479502459693;4975.527324904128;5315.518335490221;5668.829935101953;5769.384492406059;5979.461848433619;4196.538380778112;4345.326474396474;4533.614642755403;4552.271636538138;4585.656075794329;4624.1445332613575;4648.883777905579;4649.256119021008;4714.723267329242;4749.976250118727;5008.398992120896;5015.573676237488;5021.623378246646;5032.723200224023;5056.6713163644245;4646.442426908792;5154.793808247703;5507.191332420494;5697.091474356054;5729.88540229193;1503.6842263124647;1546.7989161408946;1564.5150003498725;1581.2726145972752;1596.4971034124214;1102.4873433853297;1183.0890214534932;1197.939823256407;1199.7780410624061;1210.316171363177;4588.197065513522;4654.581087702123;5350.545203657655;5371.3822910365025;5377.919331209957;5201.630630270591;5364.409914909357;5677.290338707661;5899.439553242435;5968.492678122321;4713.269443236304;5244.587489754679;5308.548773354231;5329.25390445338;5343.4434424526025;2769.9197313047925;2778.3887544740123;3086.120455670123;3089.474789285827;3090.1767956905533;5181.481851814789;5314.787408503694;5615.2700148981185;6064.969675151596;6109.908351374733;4462.888427789331;4656.511066338054;4887.413510378778;5608.355039170466;6017.458428741435;5071.619628527801;5110.821121260738;5739.282589676291;5939.910901336483;6164.414380633743;5012.624053195952;5369.167778994262;5388.164834450667;5929.568876760508;5952.642841429355;5019.146745053276;5379;5408.70191154128;5802.361740208658;5986.640801551921;5447.256877799066;5456.563474922076;5743.770249189985;5923.614965027259;6122.510199184144;4642.744649044335;4673.859784206479;4701.247800351927;4715.764211789328;4742.478327383916;4591.219492686185;5175.4565770593545;5255.500727430888;5863.413658634273;5874.383189765013;4932.679375840559;5666.320041595035;5676.631018983753;5702.771889124555;5743.4256574342235;5010.5240002199735;5284.630075894805;5306.7295554402845;5674.716264186856;5686.943130568807;4755.952440475689;4958.801647934042;5263.36839579253;5338.733063346895;5588.702665427418;4716.858494245178;5468.878879829705;5502.614816962774;5718.971405142947;5775.68972411039;4385;5098.725318670333;5385.75764090609;5589.237023201971;5611.3266408031295 18:53:13 INFO - PROCESS | 1636 | |5;yui.html;705.7812078255741;713.0658836923627;758.582779471291;809.3525179856115;822.1162250580626;15058.171800550965;15792.21038948051;15920.283587238573;15930.601734956617;15971.920140399296;14403.351849166786;15296.31166597503;15301.770473442879;15304.387824487036;15328.386864525433;922.3359181389388;941.5998200764682;945.7115579748174;948.5684013773716;949;914.5335878701843;946.1390134977172;946.3044662173297;960.9135177833994;972.1736523954618;862.3316929379719;913.3606475467167;1018.1345856022396;1018.4653057144984;1020.3979652005315;1006.9144122749575;1008.1078245752489;1008.8839783424927;1009.7475631092227;1012.7063151686039;738.5863916206941;750.1485813601547;750.6847124207845;751.3838652305112;752.9924700753032;13358.866411335859;15087.547373578811;15120.243987800566;15553.455629052929;15656.217189140498;14238.572842814732;14504.637384065483;14625.26873656313;14713.190774507399;14718.274477811707;10061.949690251575;11565.653030409017;11609.593664221797;11692.947634712831;12075.033997280196;3727.049602351383;3742.726216535627;3743.139078012045;3779.338615742234;3915;91314;95071.52464237704;101265.49367253117;114053;114097;11318.60384886525;11431.714207144722;11499.482523286471;11692.824607630891;11837.822432663517;24590.385240369134;24658.630120548205;24881.004759809766;24964.875175624005;25026.624600631007;7687.6156192190165;7796.220377962159;7848.0582330119605;7958.164392738795;8054.556999364974;3696.8890933272046;3973.264945985002;4084.65280451159;4108.075682971307;4183.184279065553;3336.4161271777343;3426.7429942754393;3439.1917899293644;3588.246468241646;3793.8618414475545;668.2916108924555;672.8015235505537;678.4843518925652;689.2556039477453;689.6999805084704;614.2291424262522;616.4328817487922;634.1724050114644;659.5053709717712;665;8889.911100889038;9530;10105.545250463747;10148.238882083726;10194.26429315614;642.2998931164959;644.4747530762413;657.4444594317794;673.7266566189905;677.576514678326;4568;4684.344191813149;4878.341423907798;4988.700677959334;5008.12357837377;92122.53938730263;103707;104140;104685;106838.46580767202;67918.30204244834;73637;76962.84555731557;81722.59138704269;92449.53775231216;55464.44535554673;57482.42517574771;63834.68082659557;64056;65029.67485162544;8497.852789873288;10019.54912028975;10603.681889543326;10653.656195636948;10759.246852720235;36428;45956.310655340865;46765.72639915309;47893.28160077532;49315;41247.58752412438;52004.13977231288;56513.869135826964;58303.708481457325;58482.4151758494;11209;13336.533221337595;13481.191128532319;13483.797743034058;13640.522581709592;11932.642020739391;12672.683182920133;13061.934690326487;13074.215547067206;13248.867511324763;13317.600471985856;13407.597772066854;13527.550712224036;13551.661208469866;14052.297385130907;12799.488020479077;12916.612501624966;13061.804072938723;13494.055416120776;13558.050936434354;13176.538821141214;13183.14309569875;13415.262160581262;13951.441942322599;14056.859431405965;9399;10657.467126643793;10800.189985750943;10817.242793004729;11334.14993875446;9040.864387034331;9312.860307095534;9764.316497845082;11052.944735276273;11099.278546894426 18:53:13 INFO - PROCESS | 1636 | __end_tp_report 18:53:13 INFO - PROCESS | 1636 | __start_cc_report 18:53:13 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,421 18:53:13 INFO - PROCESS | 1636 | __end_cc_report 18:53:13 INFO - PROCESS | 1636 | __startTimestamp1489027993429__endTimestamp 18:53:13 INFO - PROCESS | 1636 | 18:53:13 INFO - PROCESS | 1636 | ------- Summary: start ------- 18:53:13 INFO - PROCESS | 1636 | Number of tests: 6 18:53:13 INFO - PROCESS | 1636 | 18:53:13 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5909.71 Median:6189.07 stddev:653.75 (10.6%) stddev-sans-first:626.53 18:53:13 INFO - PROCESS | 1636 | Values: 3445.7 3458.7 3493.5 3493.8 3532.6 5054.4 5748.4 5928.3 6007.4 6070.5 5923.9 5987.4 6082.0 6112.4 6122.5 5326.5 5342.5 5344.5 5346.9 5453.9 5470.8 5477.4 5478.2 5485.1 5489.4 5300.2 5304.9 5325.0 5409.5 5454.5 5321.6 5339.3 5343.4 5453.2 5469.5 4611.2 4894.8 5368.0 5376.9 5377.2 5798.2 5985.5 6014.4 6051.0 6106.6 6250.7 6263.8 6264.3 6271.7 6274.0 5402.9 5897.4 5955.1 6445.3 6473.9 6098.2 6138.2 6173.1 6201.0 6208.1 6251.7 6289.8 6426.6 6447.3 6462.2 6197.8 6230.5 6237.0 6271.9 6300.8 5682.7 6192.9 6455.1 6465.8 6467.7 6247.8 6325.0 6380.3 6380.5 6426.7 6216.3 6234.5 6240.4 6247.3 6269.4 5196.5 5207.7 5208.1 5224.4 5237.3 4620.9 4621.5 4623.7 4659.6 4670.8 5282.8 5599.9 6057.8 6091.5 6127.7 6294.5 6354.6 6394.0 6429.4 6433.9 6189.1 6221.4 6234.8 6244.0 6246.8 5081.9 5709.1 5732.9 5743.8 5760.2 6379.1 6425.4 6559.2 6566.6 6720.1 6115.9 6452.7 6476.6 6483.3 6498.3 6604.6 6684.1 6688.8 6704.2 6724.2 6207.9 6264.4 6266.0 6267.1 6369.5 6344.6 6397.0 6401.6 6430.3 6436.3 6130.8 6154.0 6183.0 6204.1 6206.9 6218.6 6272.6 6275.7 6280.5 6284.9 5229.3 5982.9 6119.8 6148.9 6158.8 6174.8 6259.1 6282.9 6283.8 6302.1 6242.4 6259.6 6260.7 6266.0 6302.5 18:53:13 INFO - PROCESS | 1636 | 18:53:13 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:54174.19 Median:37745.03 stddev:106336.76 (281.7%) stddev-sans-first:106559.18 18:53:13 INFO - PROCESS | 1636 | Values: 668.6 800.4 822.8 934.6 959.9 38160.0 38727.8 38792.2 40018.0 40034.0 38533.6 38782.0 38817.6 38891.0 38941.8 9047.5 9419.6 9482.9 9490.3 9493.3 9233.7 9287.3 9337.6 9343.4 9343.6 9320.6 9335.9 9344.0 9360.0 9364.0 9284.7 9312.6 9353.9 9357.8 9375.0 9220.3 9231.0 9255.0 9277.4 9280.3 38372.6 38686.0 38694.0 38705.7 38880.2 3200.7 3634.8 3637.5 3660.6 3662.9 27752.6 28398.9 28499.4 28545.0 28601.7 2543.6 2714.6 3219.5 3239.1 3281.7 279981.0 337272.0 337626.0 338102.0 338687.0 43261.8 49785.5 49803.5 50055.7 50141.2 43852.6 51953.0 52763.0 52778.5 52831.5 14329.5 14399.4 14433.4 14449.0 14454.5 11458.9 11656.4 11662.7 11684.2 11692.7 12465.8 13586.5 13705.9 13728.9 13818.4 5984.9 6039.9 6054.2 6059.7 6099.5 946.0 1069.3 1136.1 1140.0 1142.4 20031.8 25611.6 26019.3 26415.3 26983.7 1065.7 1099.9 1246.4 1292.4 1292.8 13086.3 13403.9 13717.9 13733.9 13781.0 462756.0 462849.0 464121.0 465537.0 465702.0 53989.2 54068.7 54381.2 54551.5 54696.7 1341.5 1363.2 1390.1 1410.6 1443.1 25432.6 26077.5 27941.6 28971.9 29236.0 44200.9 44482.1 44614.9 44639.0 44709.0 400957.0 401013.0 401778.0 401930.0 402157.0 31348.0 31481.1 31566.8 32655.0 33301.0 44640.4 45200.0 45409.5 45863.3 46089.0 35578.5 36668.6 37790.6 37970.8 38280.0 36136.3 36249.5 36896.0 37149.2 37699.4 36483.0 36790.0 36959.0 37056.6 37069.1 31414.0 32523.5 32759.0 32868.8 32880.5 23951.4 24574.1 24580.0 24897.6 24991.0 18:53:13 INFO - PROCESS | 1636 | 18:53:13 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:40469.21 Median:22806.99 stddev:110154.56 (483.0%) stddev-sans-first:110422.35 18:53:13 INFO - PROCESS | 1636 | Values: 333.4 393.7 409.6 424.2 432.1 18669.5 20679.5 22011.2 22054.9 22069.6 21973.8 22316.7 22686.3 22927.7 23211.8 6688.6 6912.3 6941.0 6943.2 6970.4 6246.1 6613.0 6695.2 6764.5 6776.8 5700.9 6027.2 6697.9 6712.6 6719.9 5739.2 6736.2 6770.9 6791.5 6818.2 6648.2 7133.9 7488.0 7496.0 7552.4 26690.2 26717.3 27455.6 27627.2 27640.0 3225.5 3286.3 3323.3 3356.3 3416.6 12961.0 14647.8 14953.7 15853.5 16173.5 2086.9 2126.1 2128.4 2144.8 2214.7 139011.0 150496.0 160513.0 161367.2 162077.0 18960.8 19351.0 20781.4 21327.3 23499.8 37071.8 37129.7 37156.0 37194.0 37302.6 10388.7 10484.8 10694.0 10787.4 10859.5 6890.8 8472.0 8533.5 8683.3 8731.8 8801.5 10771.5 10847.9 10931.0 11047.5 4273.4 4305.3 4344.6 4351.3 4365.8 844.8 943.5 1025.6 1028.7 1067.5 21923.5 23051.3 23086.3 23145.4 23252.8 929.8 930.8 946.4 961.1 963.1 10351.7 11585.9 12014.1 12021.7 12025.0 580011.0 668162.0 668763.3 679430.6 686158.0 110852.4 110879.0 137613.6 153720.0 155425.0 1231.0 1236.5 1281.6 1284.9 1290.6 21652.1 21717.5 21962.7 22211.2 22222.9 63151.7 63370.0 63659.7 64393.7 64405.4 89247.0 90034.1 90139.5 90396.5 90601.0 11748.4 12093.0 12111.0 12166.2 12232.4 13230.0 13235.7 13374.7 13589.7 13593.0 9405.3 9579.7 11437.9 11514.4 11631.5 9647.9 10426.5 11204.8 11291.0 11604.2 10447.7 11007.5 11620.9 11826.8 11911.2 9494.9 11514.9 11694.9 11880.3 12089.9 11221.4 11439.9 11747.2 11765.8 12063.4 18:53:13 INFO - PROCESS | 1636 | 18:53:13 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:6448.54 Median:3710.05 stddev:4068.48 (109.7%) stddev-sans-first:4061.63 18:53:13 INFO - PROCESS | 1636 | Values: 1319.0 1423.8 1469.0 1528.8 1567.7 9165.6 9412.5 10679.3 10992.7 11054.3 9407.6 9703.4 9816.0 10279.9 10423.1 1879.6 1928.0 2338.0 2344.4 2348.1 2273.8 2305.6 2310.4 2317.0 2325.3 2279.4 2289.0 2290.8 2295.2 2297.4 2179.4 2185.1 2191.7 2198.7 2201.1 1868.0 2296.6 2297.1 2299.3 2303.0 9272.3 10847.9 10911.4 10916.1 10929.5 5419.6 5692.5 5696.4 5701.3 5701.5 3138.0 3254.6 3422.8 3426.2 3431.5 1143.2 1147.4 1175.8 1210.5 1215.4 13569.5 13922.5 15100.2 15100.5 15187.6 4431.5 4615.8 4630.5 4668.4 4668.9 9866.0 11473.0 11529.1 11536.8 11553.8 5483.6 5515.3 5566.6 5576.4 5579.5 4630.9 5134.1 5138.9 5143.5 5145.0 3494.8 3630.7 3646.2 3687.4 3740.8 803.3 944.4 957.1 957.5 964.4 761.5 896.1 909.8 927.4 928.8 6242.6 6257.7 6468.5 6482.5 6553.5 939.8 943.1 974.3 978.3 989.4 3180.4 3570.9 3643.7 3732.7 3743.0 13012.6 13352.5 13431.3 13449.4 13597.7 12890.1 13091.3 13355.5 13417.1 13432.9 9822.6 9884.9 9919.0 10020.3 10043.5 6059.3 6216.3 6236.1 6269.5 6345.7 11736.1 11991.4 12075.8 12099.9 12169.0 9358.9 11141.3 11263.3 12027.9 12342.3 7618.9 8224.2 8309.8 8327.8 8327.9 10052.7 10083.1 10152.6 10208.2 10265.0 8953.6 8963.0 9005.8 9051.5 9068.5 6594.8 8811.5 8876.1 8968.2 9041.0 7785.1 7799.5 7823.0 7875.1 7938.0 5498.1 5615.7 5649.8 5670.1 5802.6 5779.7 5847.5 5891.4 6092.2 6255.1 18:53:13 INFO - PROCESS | 1636 | 18:53:13 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4616.71 Median:5011.57 stddev:1303.23 (26.0%) stddev-sans-first:1267.23 18:53:13 INFO - PROCESS | 1636 | Values: 365.9 371.8 375.5 383.1 384.5 4630.9 5238.5 5260.5 5294.0 5302.7 4840.0 4852.4 4886.1 5186.0 5296.7 3760.0 3882.8 3995.7 4150.6 4351.4 3666.0 3901.2 4361.8 4378.3 4379.1 3371.4 3964.1 4160.5 4223.8 4390.7 3045.5 4251.2 4295.2 4374.9 4422.0 3056.6 3704.4 3834.8 3858.0 3965.3 4106.9 4708.9 5014.3 5138.8 5146.3 4176.4 4447.7 4690.0 5056.5 5099.1 4987.7 5562.5 5606.1 5631.5 5636.3 3570.9 4050.1 4272.6 4314.2 4337.5 4975.5 5315.5 5668.8 5769.4 5979.5 4196.5 4345.3 4533.6 4552.3 4585.7 4624.1 4648.9 4649.3 4714.7 4750.0 5008.4 5015.6 5021.6 5032.7 5056.7 4646.4 5154.8 5507.2 5697.1 5729.9 1503.7 1546.8 1564.5 1581.3 1596.5 1102.5 1183.1 1197.9 1199.8 1210.3 4588.2 4654.6 5350.5 5371.4 5377.9 5201.6 5364.4 5677.3 5899.4 5968.5 4713.3 5244.6 5308.5 5329.3 5343.4 2769.9 2778.4 3086.1 3089.5 3090.2 5181.5 5314.8 5615.3 6065.0 6109.9 4462.9 4656.5 4887.4 5608.4 6017.5 5071.6 5110.8 5739.3 5939.9 6164.4 5012.6 5369.2 5388.2 5929.6 5952.6 5019.1 5379.0 5408.7 5802.4 5986.6 5447.3 5456.6 5743.8 5923.6 6122.5 4642.7 4673.9 4701.2 4715.8 4742.5 4591.2 5175.5 5255.5 5863.4 5874.4 4932.7 5666.3 5676.6 5702.8 5743.4 5010.5 5284.6 5306.7 5674.7 5686.9 4756.0 4958.8 5263.4 5338.7 5588.7 4716.9 5468.9 5502.6 5719.0 5775.7 4385.0 5098.7 5385.8 5589.2 5611.3 18:53:13 INFO - PROCESS | 1636 | 18:53:13 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:19164.54 Median:3513.72 stddev:27035.63 (769.4%) stddev-sans-first:27075.95 18:53:13 INFO - PROCESS | 1636 | Values: 705.8 713.1 758.6 809.4 822.1 15058.2 15792.2 15920.3 15930.6 15971.9 14403.4 15296.3 15301.8 15304.4 15328.4 922.3 941.6 945.7 948.6 949.0 914.5 946.1 946.3 960.9 972.2 862.3 913.4 1018.1 1018.5 1020.4 1006.9 1008.1 1008.9 1009.7 1012.7 738.6 750.1 750.7 751.4 753.0 13358.9 15087.5 15120.2 15553.5 15656.2 14238.6 14504.6 14625.3 14713.2 14718.3 10061.9 11565.7 11609.6 11692.9 12075.0 3727.0 3742.7 3743.1 3779.3 3915.0 91314.0 95071.5 101265.5 114053.0 114097.0 11318.6 11431.7 11499.5 11692.8 11837.8 24590.4 24658.6 24881.0 24964.9 25026.6 7687.6 7796.2 7848.1 7958.2 8054.6 3696.9 3973.3 4084.7 4108.1 4183.2 3336.4 3426.7 3439.2 3588.2 3793.9 668.3 672.8 678.5 689.3 689.7 614.2 616.4 634.2 659.5 665.0 8889.9 9530.0 10105.5 10148.2 10194.3 642.3 644.5 657.4 673.7 677.6 4568.0 4684.3 4878.3 4988.7 5008.1 92122.5 103707.0 104140.0 104685.0 106838.5 67918.3 73637.0 76962.8 81722.6 92449.5 55464.4 57482.4 63834.7 64056.0 65029.7 8497.9 10019.5 10603.7 10653.7 10759.2 36428.0 45956.3 46765.7 47893.3 49315.0 41247.6 52004.1 56513.9 58303.7 58482.4 11209.0 13336.5 13481.2 13483.8 13640.5 11932.6 12672.7 13061.9 13074.2 13248.9 13317.6 13407.6 13527.6 13551.7 14052.3 12799.5 12916.6 13061.8 13494.1 13558.1 13176.5 13183.1 13415.3 13951.4 14056.9 9399.0 10657.5 10800.2 10817.2 11334.1 9040.9 9312.9 9764.3 11052.9 11099.3 18:53:13 INFO - PROCESS | 1636 | -------- Summary: end -------- 18:53:13 INFO - PROCESS | 1636 | 18:53:14 INFO - TEST-INFO | 1636: exit 0 18:53:14 INFO - TEST-OK | dromaeo_css | took 1117731ms 18:53:14 INFO - TEST-START | kraken 18:53:14 INFO - operating with platform_type : mac_ 18:53:14 INFO - Initialising browser for kraken test... 18:53:14 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmpwhhoTv/profile http://localhost:49243/getInfo.html) 18:53:16 INFO - PROCESS | 1648 | 2017-03-08 18:53:16.855 plugin-container[1649:10259] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 18:53:16 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:53:16 INFO - PROCESS | 1648 | 2017-03-08 18:53:16.858 plugin-container[1649:10259] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 18:53:16 INFO - PROCESS | 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:53:16 INFO - PROCESS | 1648 | 2017-03-08 18:53:16.858 plugin-container[1649:10259] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:53:16 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 18:53:16 INFO - PROCESS | 1648 | colorDepth:24 18:53:16 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 18:53:16 INFO - PROCESS | 1648 | __metrics 18:53:17 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 18:53:17 INFO - TEST-INFO | 1648: exit 0 18:53:17 INFO - Browser initialized. 18:53:17 INFO - Running cycle 1/1 for kraken test... 18:53:17 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmpwhhoTv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:53:20 INFO - PROCESS | 1650 | 2017-03-08 18:53:20.196 plugin-container[1651:10393] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 18:53:20 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:53:20 INFO - PROCESS | 1650 | 2017-03-08 18:53:20.197 plugin-container[1651:10393] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.CFPasteboardClient' 18:53:20 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 18:53:20 INFO - PROCESS | 1650 | 2017-03-08 18:53:20.197 plugin-container[1651:10393] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 18:53:29 INFO - PROCESS | 1650 | RSS: Main: 227680256 18:53:29 INFO - PROCESS | 1650 | 18:53:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 18:53:33 INFO - PROCESS | 1650 | RSS: Main: 241319936 18:53:33 INFO - PROCESS | 1650 | 18:53:36 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 18:53:37 INFO - PROCESS | 1650 | RSS: Main: 249733120 18:53:37 INFO - PROCESS | 1650 | 18:53:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 18:53:41 INFO - PROCESS | 1650 | RSS: Main: 252571648 18:53:41 INFO - PROCESS | 1650 | 18:53:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 18:53:44 INFO - PROCESS | 1650 | RSS: Main: 253722624 18:53:44 INFO - PROCESS | 1650 | 18:53:46 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:53:47 INFO - PROCESS | 1650 | RSS: Main: 254095360 18:53:47 INFO - PROCESS | 1650 | 18:53:50 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 18:53:50 INFO - PROCESS | 1650 | RSS: Main: 260001792 18:53:50 INFO - PROCESS | 1650 | 18:53:54 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 18:53:54 INFO - PROCESS | 1650 | RSS: Main: 261472256 18:53:54 INFO - PROCESS | 1650 | 18:53:58 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 18:53:58 INFO - PROCESS | 1650 | RSS: Main: 258711552 18:53:58 INFO - PROCESS | 1650 | 18:54:00 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:54:01 INFO - PROCESS | 1650 | RSS: Main: 259985408 18:54:01 INFO - PROCESS | 1650 | 18:54:03 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:54:03 INFO - PROCESS | 1650 | RSS: Main: 260583424 18:54:03 INFO - PROCESS | 1650 | 18:54:06 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:54:06 INFO - PROCESS | 1650 | RSS: Main: 260530176 18:54:06 INFO - PROCESS | 1650 | 18:54:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:54:10 INFO - PROCESS | 1650 | RSS: Main: 260792320 18:54:10 INFO - PROCESS | 1650 | 18:54:13 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:54:14 INFO - PROCESS | 1650 | RSS: Main: 260587520 18:54:14 INFO - PROCESS | 1650 | 18:54:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 18:54:16 INFO - PROCESS | 1650 | RSS: Main: 263979008 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | __start_tp_report 18:54:16 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 18:54:16 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 18:54:16 INFO - PROCESS | 1650 | |i|pagename|runs| 18:54:16 INFO - PROCESS | 1650 | |0;ai-astar;120;182;148;122;148;180;119;119;118;118 18:54:16 INFO - PROCESS | 1650 | |1;audio-beat-detection;165;113;116;147;116;99;136;149;166;114 18:54:16 INFO - PROCESS | 1650 | |2;audio-dft;208;230;204;275;191;191;263;261;224;277 18:54:16 INFO - PROCESS | 1650 | |3;audio-fft;80;62;59;85;61;59;69;82;99;87 18:54:16 INFO - PROCESS | 1650 | |4;audio-oscillator;92;58;110;106;106;80;82;73;80;86 18:54:16 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;91;91;94;90;91;91;92;90;91;91 18:54:16 INFO - PROCESS | 1650 | |6;imaging-darkroom;97;97;126;92;120;119;155;156;97;96 18:54:16 INFO - PROCESS | 1650 | |7;imaging-desaturate;145;147;100;89;150;139;149;102;92;91 18:54:16 INFO - PROCESS | 1650 | |8;json-parse-financial;72;66;68;69;68;67;67;68;69;86 18:54:16 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;56;69;82;60;85;89;84;50;65;84 18:54:16 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;88;87;86;82;101;90;88;85;101;109 18:54:16 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;141;138;142;142;151;142;155;173;176;159 18:54:16 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;175;176;180;177;174;195;237;204;172;176 18:54:16 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;68;68;67;68;73;84;91;73;66;66 18:54:16 INFO - PROCESS | 1650 | __end_tp_report 18:54:16 INFO - PROCESS | 1650 | __start_cc_report 18:54:16 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,990 18:54:16 INFO - PROCESS | 1650 | __end_cc_report 18:54:16 INFO - PROCESS | 1650 | __startTimestamp1489028056203__endTimestamp 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | ------- Summary: start ------- 18:54:16 INFO - PROCESS | 1650 | Number of tests: 14 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:137.40 Median:135.00 stddev:25.82 (19.1%) stddev-sans-first:26.60 18:54:16 INFO - PROCESS | 1650 | Values: 120.0 182.0 148.0 122.0 148.0 180.0 119.0 119.0 118.0 118.0 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:148.00 stddev:23.71 (16.0%) stddev-sans-first:21.96 18:54:16 INFO - PROCESS | 1650 | Values: 165.0 113.0 116.0 147.0 116.0 99.0 136.0 149.0 166.0 114.0 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:232.40 Median:245.50 stddev:34.10 (13.9%) stddev-sans-first:35.01 18:54:16 INFO - PROCESS | 1650 | Values: 208.0 230.0 204.0 275.0 191.0 191.0 263.0 261.0 224.0 277.0 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:74.30 Median:81.00 stddev:14.15 (17.5%) stddev-sans-first:14.86 18:54:16 INFO - PROCESS | 1650 | Values: 80.0 62.0 59.0 85.0 61.0 59.0 69.0 82.0 99.0 87.0 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:87.30 Median:80.00 stddev:16.45 (20.6%) stddev-sans-first:17.36 18:54:16 INFO - PROCESS | 1650 | Values: 92.0 58.0 110.0 106.0 106.0 80.0 82.0 73.0 80.0 86.0 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:91.20 Median:91.00 stddev:1.14 (1.2%) stddev-sans-first:1.20 18:54:16 INFO - PROCESS | 1650 | Values: 91.0 91.0 94.0 90.0 91.0 91.0 92.0 90.0 91.0 91.0 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:115.50 Median:94.00 stddev:24.27 (25.8%) stddev-sans-first:24.80 18:54:16 INFO - PROCESS | 1650 | Values: 97.0 97.0 126.0 92.0 120.0 119.0 155.0 156.0 97.0 96.0 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:120.40 Median:149.50 stddev:27.42 (18.3%) stddev-sans-first:27.60 18:54:16 INFO - PROCESS | 1650 | Values: 145.0 147.0 100.0 89.0 150.0 139.0 149.0 102.0 92.0 91.0 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:70.00 Median:68.50 stddev:5.85 (8.5%) stddev-sans-first:6.16 18:54:16 INFO - PROCESS | 1650 | Values: 72.0 66.0 68.0 69.0 68.0 67.0 67.0 68.0 69.0 86.0 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:83.00 stddev:14.09 (17.0%) stddev-sans-first:13.64 18:54:16 INFO - PROCESS | 1650 | Values: 56.0 69.0 82.0 60.0 85.0 89.0 84.0 50.0 65.0 84.0 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:86.50 stddev:8.79 (10.2%) stddev-sans-first:9.23 18:54:16 INFO - PROCESS | 1650 | Values: 88.0 87.0 86.0 82.0 101.0 90.0 88.0 85.0 101.0 109.0 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:151.90 Median:153.00 stddev:13.71 (9.0%) stddev-sans-first:13.97 18:54:16 INFO - PROCESS | 1650 | Values: 141.0 138.0 142.0 142.0 151.0 142.0 155.0 173.0 176.0 159.0 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:186.60 Median:178.50 stddev:20.49 (11.5%) stddev-sans-first:21.30 18:54:16 INFO - PROCESS | 1650 | Values: 175.0 176.0 180.0 177.0 174.0 195.0 237.0 204.0 172.0 176.0 18:54:16 INFO - PROCESS | 1650 | 18:54:16 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:70.50 stddev:8.50 (12.1%) stddev-sans-first:8.87 18:54:16 INFO - PROCESS | 1650 | Values: 68.0 68.0 67.0 68.0 73.0 84.0 91.0 73.0 66.0 66.0 18:54:16 INFO - PROCESS | 1650 | -------- Summary: end -------- 18:54:16 INFO - PROCESS | 1650 | 18:54:17 INFO - TEST-INFO | 1650: exit 0 18:54:17 INFO - TEST-OK | kraken | took 62979ms 18:54:17 INFO - SUITE-END | took 1180s 18:54:17 INFO - Completed test suite (00:19:40) 18:54:17 INFO - javascript benchmark 18:54:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7640.941254101021, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3445.6726610971964, 3458.6887180153785, 3493.5458390409244, 3493.8427770750313, 3532.6114127445976, 5054.444011158769, 5748.425157484249, 5928.347881733006, 6007.429294217048, 6070.453659170674, 5923.9407605923925, 5987.43119403656, 6082.0, 6112.4193201645885, 6122.459144589048, 5326.493983071602, 5342.492463215988, 5344.4922732340365, 5346.893062138755, 5453.945460545384, 5470.835874923739, 5477.424870388611, 5478.233047373371, 5485.149801780731, 5489.423610520877, 5300.151975683911, 5304.92042619361, 5325.0, 5409.540189083893, 5454.481824226692, 5321.574274058066, 5339.279197308391, 5343.385510666245, 5453.15476101205, 5469.480399362054, 4611.216093264153, 4894.776305923519, 5368.033753924292, 5376.91934620981, 5377.166539186433, 5798.245833229183, 5985.4912332451795, 6014.3684913083935, 6050.96974515129, 6106.633601983851, 6250.718717657716, 6263.812085637438, 6264.342244064399, 6271.655058971754, 6273.99616061428, 5402.8919421611745, 5897.439743224387, 5955.136505206764, 6445.291017988017, 6473.93526064738, 6098.176746139259, 6138.171346868205, 6173.135760993465, 6200.968995154995, 6208.099825525319, 6251.74993000284, 6289.842753931097, 6426.582272152295, 6447.323031081763, 6462.224533056064, 6197.845053873599, 6230.532710046674, 6236.968815155986, 6271.874562508816, 6300.810975670737, 5682.749795045083, 6192.938070619236, 6455.064015717695, 6465.806025819139, 6467.708953097122, 6247.812565623039, 6324.968375158187, 6380.330065343165, 6380.521460890452, 6426.74293028283, 6216.316205217422, 6234.470070044097, 6240.438360547572, 6247.3440288769025, 6269.404406581368, 5196.4803519648485, 5207.6875387476875, 5208.140656791663, 5224.399194092728, 5237.266782650432, 4620.930686039712, 4621.504447192373, 4623.69945953512, 4659.5573420525, 4670.813167473263, 5282.788688452496, 5599.860003499945, 6057.7879774207695, 6091.51267898567, 6127.724252408652, 6294.496440284766, 6354.618722876642, 6393.968030159913, 6429.3570642936265, 6433.903491447632, 6189.071639254058, 6221.440070393686, 6234.781782637586, 6243.96878015607, 6246.843828904313, 5081.8729531762, 5709.143628455765, 5732.885342293131, 5743.798967036134, 5760.164776107441, 6379.138816259839, 6425.421712045845, 6559.245686745894, 6566.6388348639375, 6720.126383570105, 6115.938840611537, 6452.741890324334, 6476.579022363531, 6483.286838447862, 6498.252700939263, 6604.570702904296, 6684.131062961784, 6688.83277918056, 6704.229013663296, 6724.226713927961, 6207.906881396692, 6264.436200741773, 6265.997440409513, 6267.122602835698, 6369.490440764635, 6344.587601805868, 6396.968015159894, 6401.64790936503, 6430.324815894263, 6436.324185960407, 6130.785422510191, 6153.969230153821, 6183.0, 6204.069389591597, 6206.875862482815, 6218.5647004709235, 6272.560920735505, 6275.748970041147, 6280.466160376419, 6284.905726414199, 5229.294045303987, 5982.88034239304, 6119.837693858789, 6148.938510614837, 6158.753649853956, 6174.845628859314, 6259.092431597484, 6282.905756413566, 6283.842903927439, 6302.086197501429, 6242.438180563771, 6259.624422534663, 6260.7495700171485, 6266.0, 6302.464290535356], "value": 5869.4440876940835, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.5654324688952, 800.3877034068938, 822.839546288474, 934.5841100710185, 959.932804703671, 38160.0, 38727.80636096819, 38792.22415551691, 40018.0, 40034.0, 38533.614663853354, 38782.0, 38817.61182388175, 38891.0, 38941.805290973505, 9047.547622618875, 9419.576119074658, 9482.857757133648, 9490.335676502647, 9493.335466517347, 9233.722988310361, 9287.349885508018, 9337.626494940228, 9343.439393636403, 9343.579538920765, 9320.627174912996, 9335.859962100574, 9344.0, 9359.95320023399, 9363.969963304065, 9284.675036373763, 9312.580933857993, 9353.906460935406, 9357.812843743155, 9374.953125234399, 9220.262379009662, 9230.953845230799, 9254.953725231398, 9277.44335339875, 9280.257579393632, 38372.61627383746, 38686.0, 38694.0, 38705.74236833946, 38880.22239555221, 3200.695933886277, 3634.818259087035, 3637.5453068366455, 3660.560732712065, 3662.8901132966053, 27752.583711244348, 28398.858005710044, 28499.43001139986, 28545.0, 28601.713982860114, 2543.5548778963607, 2714.5656694928916, 3219.4687876500348, 3239.1254361322544, 3281.6882396172327, 279981.0, 337272.0, 337626.0, 338102.0, 338686.99999999756, 43261.783691081975, 49785.50214497881, 49803.50196498061, 50055.74972125116, 50141.24788128181, 43852.56147438549, 51953.0, 52763.0, 52778.472215278125, 52831.47168528265, 14329.498467553585, 14399.42402303896, 14433.422663093568, 14448.988570799944, 14454.494092706705, 11458.942705286587, 11656.358900260568, 11662.650120496399, 11684.18210725241, 11692.70768230784, 12465.75068498625, 13586.45654173822, 13705.862941370458, 13728.93135534316, 13818.37817298224, 5984.910226346608, 6039.909401358983, 6054.182685337511, 6059.697015149225, 6099.542534309856, 945.9952700236455, 1069.2622090757352, 1136.1478890831877, 1139.9715007124723, 1142.3945308986251, 20031.799682003286, 25611.61582576263, 26019.349516262246, 26415.339616509358, 26983.730162698514, 1065.7016035510069, 1099.8946059210443, 1246.4079562207878, 1292.3990344489857, 1292.7931530955002, 13086.345682715826, 13403.927685785115, 13717.931410343084, 13733.862661373458, 13780.966427517977, 462756.0, 462849.0, 464121.0, 465537.0, 465702.0, 53989.1901621476, 54068.729656352254, 54381.1842822358, 54551.45448545543, 54696.72651636796, 1341.5103487227286, 1363.2161507133437, 1390.1381143690774, 1410.6191328341495, 1443.1196969848384, 25432.601206933796, 26077.478450431263, 27941.58087628728, 28971.85514072416, 29236.0, 44200.894977625816, 44482.11035779331, 44614.88462788456, 44639.0, 44709.0, 400957.0, 401013.0, 401778.0, 401929.99035004637, 402157.0, 31348.0, 31481.055568332988, 31566.842165789025, 32655.0, 33301.0, 44640.41994750656, 45200.0, 45409.545904541854, 45863.31205031861, 46089.0, 35578.46632300569, 36668.63331366652, 37790.62209377981, 37970.81014594909, 38280.04299892525, 36136.27727445489, 36249.45625815668, 36896.0, 37149.20894436205, 37699.43450848294, 36483.0, 36790.0, 36959.0, 37056.62943370532, 37069.07327316839, 31414.0, 32523.51214731828, 32759.022003437254, 32868.849590264224, 32880.50679239861, 23951.401214969766, 24574.139905103235, 24580.0, 24897.630630315507, 24991.0], "value": 18617.037688538676, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.39156040226595, 393.6594845458679, 409.5904095904096, 424.23849190702686, 432.0645801839017, 18669.53326166843, 20679.483012924666, 22011.22960696376, 22054.88972555137, 22069.558608827814, 21973.78026219737, 22316.665250021262, 22686.319410417673, 22927.656085158695, 23211.76788232117, 6688.632125233123, 6912.308769123073, 6940.965295173517, 6943.236244013155, 6970.372666460017, 6246.09431632413, 6612.966935165317, 6695.163104611924, 6764.492663050266, 6776.830579235534, 5700.914486282709, 6027.216461859952, 6697.93302066978, 6712.597244165366, 6719.8656026879435, 5739.196512488255, 6736.191657001143, 6770.898436523456, 6791.456683465311, 6818.215905170894, 6648.202215734094, 7133.89299160513, 7487.962560187164, 7495.962520187419, 7552.433567482406, 26690.19929402121, 26717.332066698295, 27455.588166177524, 27627.171184864284, 27640.032598858943, 3225.467797813358, 3286.342731453719, 3323.302106557626, 3356.345512625039, 3416.6241713411505, 12961.0, 14647.780283295759, 14953.654171124652, 15853.524394268075, 16173.514794556182, 2086.8539202255847, 2126.0539060118253, 2128.372130221588, 2144.8176904963098, 2214.734231892167, 139011.0, 150496.0, 160513.0, 161367.19316403344, 162077.0, 18960.767550109198, 19351.0, 20781.376558703265, 21327.25354612612, 23499.76500234976, 37071.84889284441, 37129.70046048376, 37156.0, 37194.0, 37302.62697373046, 10388.740281493023, 10484.790304194026, 10693.984071513194, 10787.406692631981, 10859.511321990529, 6890.758823441155, 8471.957640211882, 8533.53065581399, 8683.348748843862, 8731.825363492695, 8801.47191168532, 10771.46142692878, 10847.891521084846, 10931.0, 11047.508586340902, 4273.380359847804, 4305.31115021595, 4344.56554344563, 4351.282038463618, 4365.781710914442, 844.7803571071565, 943.4527973775193, 1025.620520407454, 1028.711960651004, 1067.4716015572342, 21923.451913701967, 23051.308460746204, 23086.307410777703, 23145.421364465685, 23252.76747232506, 929.8186853563625, 930.7667340773367, 946.3895787217207, 961.0965692249264, 963.1235575626147, 10351.741206469898, 11585.942070289595, 12014.098942579341, 12021.699457513632, 12024.977876880563, 580011.0, 668162.0, 668763.3123668701, 679430.6028469827, 686158.0, 110852.4457377708, 110879.0, 137613.62386376207, 153720.0, 155425.0, 1230.993845030769, 1236.486857953957, 1281.6091092216964, 1284.9421776020101, 1290.587012156101, 21652.0769696089, 21717.457063573536, 21962.670559941293, 22211.22260720867, 22222.88888555547, 63151.6842415785, 63370.0, 63659.681701591195, 64393.71212575628, 64405.35594644181, 89247.0, 90034.09965900258, 90139.54930225307, 90396.5480172595, 90601.0, 11748.353840538852, 12093.0, 12111.0, 12166.209196402206, 12232.388380580758, 13230.0, 13235.735285294433, 13374.732505350034, 13589.660258493617, 13593.048486605843, 9405.341626086109, 9579.664711735057, 11437.942810285895, 11514.36670983104, 11631.53473861036, 9647.938726739912, 10426.478676066015, 11204.831927521256, 11290.983811457008, 11604.187706860439, 10447.68656940293, 11007.504662290376, 11620.88379116198, 11826.82259766087, 11911.166218364979, 9494.85757713621, 11514.88485115138, 11694.88305116972, 11880.287182769061, 12089.879101209228, 11221.438928053727, 11439.942800286279, 11747.177697561088, 11765.823512647146, 12063.39683015828], "value": 11772.295586356815, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1318.9538366157183, 1423.7508436023697, 1468.9559313220593, 1528.8394718554553, 1567.7334853074976, 9165.587548560314, 9412.482313472756, 10679.252452328341, 10992.725181870457, 11054.281471704333, 9407.576659050343, 9703.41779493231, 9816.0, 10279.897201028007, 10423.114035307008, 1879.6428678551065, 1927.951801204967, 2337.9829774048258, 2344.3553022918663, 2348.095983046522, 2273.795358417742, 2305.561943230789, 2310.445493081657, 2316.9884150579223, 2325.2907863101746, 2279.418748219202, 2289.027163455533, 2290.7594702556244, 2295.1966811615966, 2297.425643589103, 2179.4333473296897, 2185.0713446785053, 2191.660292654641, 2198.7471440784357, 2201.0755482697305, 1867.9719804202948, 2296.621057525523, 2297.069686776858, 2299.321700098475, 2303.021215983217, 9272.258219342504, 10847.945760271148, 10911.399873006982, 10916.126709863192, 10929.508172132273, 5419.620626556142, 5692.459216374479, 5696.401877802812, 5701.258836351248, 5701.515371193454, 3138.0, 3254.6419893811662, 3422.828858557087, 3426.229098452853, 3431.4509678451327, 1143.1654891928938, 1147.3861484105964, 1175.7589694112771, 1210.5157936825253, 1215.3740823475916, 13569.52506662272, 13922.512712055131, 15100.169490678009, 15100.471483498024, 15187.62030949224, 4431.468223813163, 4615.815367385334, 4630.513796051366, 4668.439787225487, 4668.929966050512, 9866.01339866022, 11473.0, 11529.077673786078, 11536.826947595793, 11553.768924621461, 5483.616146869761, 5515.283013208257, 5566.55467562594, 5576.386597474275, 5579.525740312038, 4630.930536041962, 5134.075866344094, 5138.948610513847, 5143.485651434827, 5144.99672563854, 3494.790312581253, 3630.7276954228537, 3646.1796095878744, 3687.3547129252274, 3740.831662575191, 803.2650125135435, 944.3861490031397, 957.1481381570408, 957.5451660461225, 964.4165280005636, 761.5454481939469, 896.1173244354305, 909.8316811389782, 927.4110939553298, 928.7724507495707, 6242.5942313749465, 6257.7184026718, 6468.450181734511, 6482.513811464159, 6553.475721942234, 939.769756409684, 943.0663642993387, 974.2644303550774, 978.3005151316843, 989.3569180033036, 3180.3639272145665, 3570.8750193743094, 3643.7267204959735, 3732.738708290394, 3742.9812850936114, 13012.609621711365, 13352.532661356807, 13431.328433578283, 13449.394777235048, 13597.728045439233, 12890.097693161577, 13091.345432728325, 13355.53255636048, 13417.12788668753, 13432.865671343357, 9822.557984890696, 9884.851727224097, 9919.0, 10020.298579099539, 10043.548040338203, 6059.33347331802, 6216.316205217513, 6236.126942228182, 6269.529785266214, 6345.682715864281, 11736.06111511094, 11991.400429978292, 12075.818862717242, 12099.879001210227, 12169.026477881926, 9358.906410935804, 11141.331520108819, 11263.26788758728, 12027.879721203026, 12342.259464431803, 7618.885716714364, 8224.177582241728, 8309.83380332378, 8327.833443330977, 8327.916720832956, 10052.748681283027, 10083.14293285079, 10152.644657436955, 10208.183345332207, 10265.024822641837, 8953.641854325753, 8963.0, 9005.7748556284, 9051.547422628973, 9068.50123243228, 6594.8351291218105, 8811.471311721318, 8876.068012858557, 8968.237699795329, 9040.954795225982, 7785.104712958082, 7799.5320280783335, 7823.022122234721, 7875.133735289228, 7937.960310198412, 5498.092814685532, 5615.6630602164005, 5649.7740090397565, 5670.064439367458, 5802.622829516068, 5779.682117483579, 5847.502962248256, 5891.381404952418, 6092.238470191226, 6255.124282600348], "value": 4891.804514121643, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.88840403676903, 371.847542507572, 375.517460063818, 383.0691419849764, 384.51935081148554, 4630.930536041962, 5238.476152384759, 5260.473952604742, 5293.973530132349, 5302.734863256836, 4839.951600483994, 4852.441969173546, 4886.071646387193, 5185.974070129653, 5296.655717378368, 3759.9848041028904, 3882.825272862714, 3995.7024710791266, 4150.564190759972, 4351.432654733707, 3665.981670091659, 3901.200253947934, 4361.80371883266, 4378.299472084467, 4379.146066517031, 3371.393149233137, 3964.1278918637854, 4160.459140311756, 4223.831046758126, 4390.714603550775, 3045.451818672638, 4251.171021650779, 4295.183915056129, 4374.934375984379, 4421.9658956879875, 3056.5634151948548, 3704.407294832814, 3834.849545136448, 3857.996920800584, 3965.266425711253, 4106.938395924063, 4708.869871230914, 5014.323066386028, 5138.794448222066, 5146.327443580852, 4176.394422808706, 4447.666425018137, 4689.953100468986, 5056.519630635084, 5099.08216521026, 4987.680728461247, 5562.525930628387, 5606.112851881285, 5631.535800691809, 5636.323641163046, 3570.9107272318142, 4050.0839395635094, 4272.6154646082, 4314.225053078556, 4337.479502459693, 4975.527324904128, 5315.518335490221, 5668.829935101953, 5769.384492406059, 5979.461848433619, 4196.538380778112, 4345.326474396474, 4533.614642755403, 4552.271636538138, 4585.656075794329, 4624.1445332613575, 4648.883777905579, 4649.256119021008, 4714.723267329242, 4749.976250118727, 5008.398992120896, 5015.573676237488, 5021.623378246646, 5032.723200224023, 5056.6713163644245, 4646.442426908792, 5154.793808247703, 5507.191332420494, 5697.091474356054, 5729.88540229193, 1503.6842263124647, 1546.7989161408946, 1564.5150003498725, 1581.2726145972752, 1596.4971034124214, 1102.4873433853297, 1183.0890214534932, 1197.939823256407, 1199.7780410624061, 1210.316171363177, 4588.197065513522, 4654.581087702123, 5350.545203657655, 5371.3822910365025, 5377.919331209957, 5201.630630270591, 5364.409914909357, 5677.290338707661, 5899.439553242435, 5968.492678122321, 4713.269443236304, 5244.587489754679, 5308.548773354231, 5329.25390445338, 5343.4434424526025, 2769.9197313047925, 2778.3887544740123, 3086.120455670123, 3089.474789285827, 3090.1767956905533, 5181.481851814789, 5314.787408503694, 5615.2700148981185, 6064.969675151596, 6109.908351374733, 4462.888427789331, 4656.511066338054, 4887.413510378778, 5608.355039170466, 6017.458428741435, 5071.619628527801, 5110.821121260738, 5739.282589676291, 5939.910901336483, 6164.414380633743, 5012.624053195952, 5369.167778994262, 5388.164834450667, 5929.568876760508, 5952.642841429355, 5019.146745053276, 5379.0, 5408.70191154128, 5802.361740208658, 5986.640801551921, 5447.256877799066, 5456.563474922076, 5743.770249189985, 5923.614965027259, 6122.510199184144, 4642.744649044335, 4673.859784206479, 4701.247800351927, 4715.764211789328, 4742.478327383916, 4591.219492686185, 5175.4565770593545, 5255.500727430888, 5863.413658634273, 5874.383189765013, 4932.679375840559, 5666.320041595035, 5676.631018983753, 5702.771889124555, 5743.4256574342235, 5010.5240002199735, 5284.630075894805, 5306.7295554402845, 5674.716264186856, 5686.943130568807, 4755.952440475689, 4958.801647934042, 5263.36839579253, 5338.733063346895, 5588.702665427418, 4716.858494245178, 5468.878879829705, 5502.614816962774, 5718.971405142947, 5775.68972411039, 4385.0, 5098.725318670333, 5385.75764090609, 5589.237023201971, 5611.3266408031295], "value": 4241.911139666108, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.7812078255741, 713.0658836923627, 758.582779471291, 809.3525179856115, 822.1162250580626, 15058.171800550965, 15792.21038948051, 15920.283587238573, 15930.601734956617, 15971.920140399296, 14403.351849166786, 15296.31166597503, 15301.770473442879, 15304.387824487036, 15328.386864525433, 922.3359181389388, 941.5998200764682, 945.7115579748174, 948.5684013773716, 949.0, 914.5335878701843, 946.1390134977172, 946.3044662173297, 960.9135177833994, 972.1736523954618, 862.3316929379719, 913.3606475467167, 1018.1345856022396, 1018.4653057144984, 1020.3979652005315, 1006.9144122749575, 1008.1078245752489, 1008.8839783424927, 1009.7475631092227, 1012.7063151686039, 738.5863916206941, 750.1485813601547, 750.6847124207845, 751.3838652305112, 752.9924700753032, 13358.866411335859, 15087.547373578811, 15120.243987800566, 15553.455629052929, 15656.217189140498, 14238.572842814732, 14504.637384065483, 14625.26873656313, 14713.190774507399, 14718.274477811707, 10061.949690251575, 11565.653030409017, 11609.593664221797, 11692.947634712831, 12075.033997280196, 3727.049602351383, 3742.726216535627, 3743.139078012045, 3779.338615742234, 3915.0, 91314.0, 95071.52464237704, 101265.49367253117, 114053.0, 114097.0, 11318.60384886525, 11431.714207144722, 11499.482523286471, 11692.824607630891, 11837.822432663517, 24590.385240369134, 24658.630120548205, 24881.004759809766, 24964.875175624005, 25026.624600631007, 7687.6156192190165, 7796.220377962159, 7848.0582330119605, 7958.164392738795, 8054.556999364974, 3696.8890933272046, 3973.264945985002, 4084.65280451159, 4108.075682971307, 4183.184279065553, 3336.4161271777343, 3426.7429942754393, 3439.1917899293644, 3588.246468241646, 3793.8618414475545, 668.2916108924555, 672.8015235505537, 678.4843518925652, 689.2556039477453, 689.6999805084704, 614.2291424262522, 616.4328817487922, 634.1724050114644, 659.5053709717712, 665.0, 8889.911100889038, 9530.0, 10105.545250463747, 10148.238882083726, 10194.26429315614, 642.2998931164959, 644.4747530762413, 657.4444594317794, 673.7266566189905, 677.576514678326, 4568.0, 4684.344191813149, 4878.341423907798, 4988.700677959334, 5008.12357837377, 92122.53938730263, 103707.0, 104140.0, 104685.0, 106838.46580767202, 67918.30204244834, 73637.0, 76962.84555731557, 81722.59138704269, 92449.53775231216, 55464.44535554673, 57482.42517574771, 63834.68082659557, 64056.0, 65029.67485162544, 8497.852789873288, 10019.54912028975, 10603.681889543326, 10653.656195636948, 10759.246852720235, 36428.0, 45956.310655340865, 46765.72639915309, 47893.28160077532, 49315.0, 41247.58752412438, 52004.13977231288, 56513.869135826964, 58303.708481457325, 58482.4151758494, 11209.0, 13336.533221337595, 13481.191128532319, 13483.797743034058, 13640.522581709592, 11932.642020739391, 12672.683182920133, 13061.934690326487, 13074.215547067206, 13248.867511324763, 13317.600471985856, 13407.597772066854, 13527.550712224036, 13551.661208469866, 14052.297385130907, 12799.488020479077, 12916.612501624966, 13061.804072938723, 13494.055416120776, 13558.050936434354, 13176.538821141214, 13183.14309569875, 13415.262160581262, 13951.441942322599, 14056.859431405965, 9399.0, 10657.467126643793, 10800.189985750943, 10817.242793004729, 11334.14993875446, 9040.864387034331, 9312.860307095534, 9764.316497845082, 11052.944735276273, 11099.278546894426], "value": 7454.855100834424, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1635.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 182.0, 148.0, 122.0, 148.0, 180.0, 119.0, 119.0, 118.0, 118.0], "value": 137.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 113.0, 116.0, 147.0, 116.0, 99.0, 136.0, 149.0, 166.0, 114.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [208.0, 230.0, 204.0, 275.0, 191.0, 191.0, 263.0, 261.0, 224.0, 277.0], "value": 232.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 62.0, 59.0, 85.0, 61.0, 59.0, 69.0, 82.0, 99.0, 87.0], "value": 74.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 58.0, 110.0, 106.0, 106.0, 80.0, 82.0, 73.0, 80.0, 86.0], "value": 87.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 94.0, 90.0, 91.0, 91.0, 92.0, 90.0, 91.0, 91.0], "value": 91.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 126.0, 92.0, 120.0, 119.0, 155.0, 156.0, 97.0, 96.0], "value": 115.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 147.0, 100.0, 89.0, 150.0, 139.0, 149.0, 102.0, 92.0, 91.0], "value": 120.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 66.0, 68.0, 69.0, 68.0, 67.0, 67.0, 68.0, 69.0, 86.0], "value": 70.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 69.0, 82.0, 60.0, 85.0, 89.0, 84.0, 50.0, 65.0, 84.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 86.0, 82.0, 101.0, 90.0, 88.0, 85.0, 101.0, 109.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 138.0, 142.0, 142.0, 151.0, 142.0, 155.0, 173.0, 176.0, 159.0], "value": 151.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 180.0, 177.0, 174.0, 195.0, 237.0, 204.0, 172.0, 176.0], "value": 186.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 68.0, 73.0, 84.0, 91.0, 73.0, 66.0, 66.0], "value": 72.4, "unit": "score"}]}]} 18:54:17 INFO - Return code: 0 18:54:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:54:17 ERROR - # TBPL SUCCESS # 18:54:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:54:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:54:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:54:17 INFO - 2017-03-08 18:54:17.572 screenresolution[1655:10781] starting screenresolution argv=screenresolution get 18:54:17 INFO - 2017-03-08 18:54:17.575 screenresolution[1655:10781] Display 0: 1600x1200x32@60 18:54:17 INFO - 2017-03-08 18:54:17.581 screenresolution[1656:10785] starting screenresolution argv=screenresolution list 18:54:17 INFO - Available Modes on Display 0 18:54:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:54:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:54:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:54:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:54:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:54:17 INFO - Intel Iris: 18:54:17 INFO - Chipset Model: Intel Iris 18:54:17 INFO - Type: GPU 18:54:17 INFO - Bus: Built-In 18:54:17 INFO - VRAM (Dynamic, Max): 1536 MB 18:54:17 INFO - Vendor: Intel (0x8086) 18:54:17 INFO - Device ID: 0x0a2e 18:54:17 INFO - Revision ID: 0x0009 18:54:17 INFO - Displays: 18:54:17 INFO - Display: 18:54:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:54:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:54:17 INFO - Display Serial Number: 1600x1200 60 18:54:17 INFO - Main Display: Yes 18:54:17 INFO - Mirror: Off 18:54:17 INFO - Online: Yes 18:54:17 INFO - Rotation: Supported 18:54:17 INFO - Return code: 0 18:54:17 INFO - Running post-action listener: _resource_record_post_action 18:54:17 INFO - [mozharness: 2017-03-09 02:54:17.816006Z] Finished run-tests step (success) 18:54:17 INFO - Running post-run listener: _resource_record_post_run 18:54:17 INFO - Total resource usage - Wall time: 1202s; CPU: 55.0%; Read bytes: 39373312; Write bytes: 517530624; Read time: 354; Write time: 1641 18:54:17 INFO - TinderboxPrint: CPU usage
54.7% 18:54:17 INFO - TinderboxPrint: I/O read bytes / time
39,373,312 / 354 18:54:17 INFO - TinderboxPrint: I/O write bytes / time
517,530,624 / 1,641 18:54:17 INFO - TinderboxPrint: CPU idle
2,178.2 (45.3%) 18:54:17 INFO - TinderboxPrint: CPU system
967.1 (20.1%) 18:54:17 INFO - TinderboxPrint: CPU user
1,664.3 (34.6%) 18:54:17 INFO - TinderboxPrint: Swap in / out
249,827,328 / 0 18:54:17 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202830336; Write bytes: 204531712; Read time: 15567; Write time: 440 18:54:17 INFO - run-tests - Wall time: 1182s; CPU: 55.0%; Read bytes: 38369792; Write bytes: 303090688; Read time: 340; Write time: 1167 18:54:18 INFO - Running post-run listener: _upload_blobber_files 18:54:18 INFO - Blob upload gear active. 18:54:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:54:18 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 18:54:18 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'] 18:54:18 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 18:54:18 INFO - (blobuploader) - INFO - Open directory for files ... 18:54:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:54:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:54:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:54:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:54:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:54:19 INFO - (blobuploader) - INFO - Done attempting. 18:54:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:54:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:54:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:54:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:54:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:54:20 INFO - (blobuploader) - INFO - Done attempting. 18:54:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 18:54:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:54:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:54:21 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 18:54:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:54:21 INFO - (blobuploader) - INFO - Done attempting. 18:54:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:54:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:54:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:54:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:54:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:54:23 INFO - (blobuploader) - INFO - Done attempting. 18:54:23 INFO - (blobuploader) - INFO - Iteration through files over. 18:54:23 INFO - Return code: 0 18:54:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:54:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:54:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9dfb02b8bf90f9aec24ece2736be57281e9fb27131a646388662dedb373830b8992bc2f67001a0926fc2c24e09496f3dd6d17b6ae45912ea5b4e7fc2c892af26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62a3170e40d36a6f1b46e27f4147ee0b08e8246a980af39c03b71aefc1d73801839f9c88df7036698d2bbae5ea1e8d8a0f74ac1be193c69837b2e778a53702f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68dd1e0f77c0a15fb6280f9fd5147afc5ee94cea48b52f74bdde24639ff19db2120c9d853c5baae380e0e1f3671e3d1d02b2d871efac325edbc27ecaddff8389", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a3d1452bf51213b34ccbc2d010566873a5ff667a1f41ab30b30568278a1dd2c2c7257735edd3b9432a2841982a17ec40fed86ab06229146569f936312edcde3"} 18:54:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:54:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:54:23 INFO - Contents: 18:54:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9dfb02b8bf90f9aec24ece2736be57281e9fb27131a646388662dedb373830b8992bc2f67001a0926fc2c24e09496f3dd6d17b6ae45912ea5b4e7fc2c892af26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62a3170e40d36a6f1b46e27f4147ee0b08e8246a980af39c03b71aefc1d73801839f9c88df7036698d2bbae5ea1e8d8a0f74ac1be193c69837b2e778a53702f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68dd1e0f77c0a15fb6280f9fd5147afc5ee94cea48b52f74bdde24639ff19db2120c9d853c5baae380e0e1f3671e3d1d02b2d871efac325edbc27ecaddff8389", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a3d1452bf51213b34ccbc2d010566873a5ff667a1f41ab30b30568278a1dd2c2c7257735edd3b9432a2841982a17ec40fed86ab06229146569f936312edcde3"} 18:54:23 INFO - Running post-run listener: copy_logs_to_upload_dir 18:54:23 INFO - Copying logs to upload dir... 18:54:23 INFO - mkdir: /builds/slave/test/build/upload/logs 18:54:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1283.864687 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2017-03-08 18:54:23.748525) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 18:54:23.752306) ========= 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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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/9dfb02b8bf90f9aec24ece2736be57281e9fb27131a646388662dedb373830b8992bc2f67001a0926fc2c24e09496f3dd6d17b6ae45912ea5b4e7fc2c892af26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62a3170e40d36a6f1b46e27f4147ee0b08e8246a980af39c03b71aefc1d73801839f9c88df7036698d2bbae5ea1e8d8a0f74ac1be193c69837b2e778a53702f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68dd1e0f77c0a15fb6280f9fd5147afc5ee94cea48b52f74bdde24639ff19db2120c9d853c5baae380e0e1f3671e3d1d02b2d871efac325edbc27ecaddff8389", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a3d1452bf51213b34ccbc2d010566873a5ff667a1f41ab30b30568278a1dd2c2c7257735edd3b9432a2841982a17ec40fed86ab06229146569f936312edcde3"} build_url:https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/VBW3CquVQqyzr9-8hs3ZlA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9dfb02b8bf90f9aec24ece2736be57281e9fb27131a646388662dedb373830b8992bc2f67001a0926fc2c24e09496f3dd6d17b6ae45912ea5b4e7fc2c892af26", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62a3170e40d36a6f1b46e27f4147ee0b08e8246a980af39c03b71aefc1d73801839f9c88df7036698d2bbae5ea1e8d8a0f74ac1be193c69837b2e778a53702f8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68dd1e0f77c0a15fb6280f9fd5147afc5ee94cea48b52f74bdde24639ff19db2120c9d853c5baae380e0e1f3671e3d1d02b2d871efac325edbc27ecaddff8389", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1a3d1452bf51213b34ccbc2d010566873a5ff667a1f41ab30b30568278a1dd2c2c7257735edd3b9432a2841982a17ec40fed86ab06229146569f936312edcde3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 18:54:23.787617) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 18:54:23.788021) ========= 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.3QmhyRMsKP/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.eqz9R2lcjZ/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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.005181 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 18:54:23.836680) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 18:54:23.837036) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 18:54:23.837396) ========= ========= Total master_lag: 0.18 =========