builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0084 starttime: 1492855132.56 results: success (0) buildid: 20170422014920 builduid: e13ee837e9994ce2b9ecd72039b83838 revision: 42c8a716081e6a8aa33c1e61944f36f6f89245fb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:52.558802) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:52.559192) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:52.559461) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:52.588330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:52.588668) ========= 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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-22 02:58:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 22.7M=0.001s 2017-04-22 02:58:53 (22.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.509039 ========= master_lag: 0.17 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:53.267725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:53.268044) ========= 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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.028745 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:53.378809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-22 02:58:53.379155) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 42c8a716081e6a8aa33c1e61944f36f6f89245fb --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 42c8a716081e6a8aa33c1e61944f36f6f89245fb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZICkjlKDXk/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.eTzhbOkmBA/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-22 02:58:53,482 truncating revision to first 12 chars 2017-04-22 02:58:53,482 Setting DEBUG logging. 2017-04-22 02:58:53,483 attempt 1/10 2017-04-22 02:58:53,483 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/42c8a716081e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-22 02:58:54,609 unpacking tar archive at: mozilla-central-42c8a716081e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.395337 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-22 02:58:54.799369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:54.799687) ========= script_repo_revision: 42c8a716081e6a8aa33c1e61944f36f6f89245fb ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:54.800110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:54.800376) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-22 02:58:54.820673) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-22 02:58:54.820966) ========= /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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:58:55 INFO - MultiFileLogger online at 20170422 02:58:55 in /builds/slave/test 02:58:55 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 02:58:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:58:55 INFO - {'append_to_log': False, 02:58:55 INFO - 'base_work_dir': '/builds/slave/test', 02:58:55 INFO - 'blob_upload_branch': 'Firefox', 02:58:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:58:55 INFO - 'branch': 'Firefox', 02:58:55 INFO - 'buildbot_json_path': 'buildprops.json', 02:58:55 INFO - 'config_files': ('talos/mac_config.py',), 02:58:55 INFO - 'default_actions': ('clobber', 02:58:55 INFO - 'read-buildbot-config', 02:58:55 INFO - 'download-and-extract', 02:58:55 INFO - 'populate-webroot', 02:58:55 INFO - 'create-virtualenv', 02:58:55 INFO - 'install', 02:58:55 INFO - 'run-tests'), 02:58:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:58:55 INFO - 'download_minidump_stackwalk': True, 02:58:55 INFO - 'download_symbols': 'ondemand', 02:58:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:58:55 INFO - 'tooltool.py': '/tools/tooltool.py', 02:58:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:58:55 INFO - '/tools/misc-python/virtualenv.py')}, 02:58:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:58:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:58:55 INFO - 'gecko_profile': False, 02:58:55 INFO - 'gecko_profile_interval': 0, 02:58:55 INFO - 'installer_path': 'installer.exe', 02:58:55 INFO - 'log_level': 'info', 02:58:55 INFO - 'log_name': 'talos', 02:58:55 INFO - 'log_to_console': True, 02:58:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:58:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:58:55 INFO - 'opt_config_files': (), 02:58:55 INFO - 'pip_index': False, 02:58:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:58:55 INFO - 'cmd': ('bash', 02:58:55 INFO - '-c', 02:58:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:58:55 INFO - 'enabled': True, 02:58:55 INFO - 'halt_on_failure': False, 02:58:55 INFO - 'name': 'check_screen_resolution'},), 02:58:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:58:55 INFO - 'cmd': ('bash', 02:58:55 INFO - '-c', 02:58:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:58:55 INFO - 'enabled': True, 02:58:55 INFO - 'halt_on_failure': False, 02:58:55 INFO - 'name': 'check_screen_resolution'},), 02:58:55 INFO - 'run_cmd_checks_enabled': True, 02:58:55 INFO - 'suite': 'dromaeojs-e10s', 02:58:55 INFO - 'system_bits': '32', 02:58:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:58:55 INFO - 'title': 't-yosemite-r7-0084', 02:58:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:58:55 INFO - 'use_talos_json': True, 02:58:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:58:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:58:55 INFO - 'work_dir': 'build'} 02:58:55 INFO - [mozharness: 2017-04-22 09:58:55.033159Z] Running clobber step. 02:58:55 INFO - Running pre-action listener: _resource_record_pre_action 02:58:55 INFO - Running main action method: clobber 02:58:55 INFO - rmtree: /builds/slave/test/build 02:58:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:58:57 INFO - Running post-action listener: _resource_record_post_action 02:58:57 INFO - [mozharness: 2017-04-22 09:58:57.578451Z] Finished clobber step (success) 02:58:57 INFO - [mozharness: 2017-04-22 09:58:57.578682Z] Running read-buildbot-config step. 02:58:57 INFO - Running pre-action listener: _resource_record_pre_action 02:58:57 INFO - Running main action method: read_buildbot_config 02:58:57 INFO - Using buildbot properties: 02:58:57 INFO - { 02:58:57 INFO - "project": "", 02:58:57 INFO - "product": "firefox", 02:58:57 INFO - "script_repo_revision": "production", 02:58:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 02:58:57 INFO - "repository": "", 02:58:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 02:58:57 INFO - "buildid": "20170422014920", 02:58:57 INFO - "pgo_build": "False", 02:58:57 INFO - "basedir": "/builds/slave/test", 02:58:57 INFO - "buildnumber": 15, 02:58:57 INFO - "slavename": "t-yosemite-r7-0084", 02:58:57 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 02:58:57 INFO - "platform": "yosemite_r7", 02:58:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 02:58:57 INFO - "branch": "mozilla-central", 02:58:57 INFO - "repo_path": "mozilla-central", 02:58:57 INFO - "revision": "42c8a716081e6a8aa33c1e61944f36f6f89245fb", 02:58:57 INFO - "stage_platform": "macosx64", 02:58:57 INFO - "builduid": "e13ee837e9994ce2b9ecd72039b83838", 02:58:57 INFO - "slavebuilddir": "test" 02:58:57 INFO - } 02:58:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 02:58:57 INFO - Running post-action listener: _resource_record_post_action 02:58:57 INFO - [mozharness: 2017-04-22 09:58:57.584413Z] Finished read-buildbot-config step (success) 02:58:57 INFO - [mozharness: 2017-04-22 09:58:57.584643Z] Running download-and-extract step. 02:58:57 INFO - Running pre-action listener: _resource_record_pre_action 02:58:57 INFO - Running main action method: download_and_extract 02:58:57 INFO - mkdir: /builds/slave/test/build/tests 02:58:57 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')]} 02:58:57 INFO - trying https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 02:58:57 INFO - Downloading https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/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 02:58:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/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 02:58:58 INFO - Downloaded 1325 bytes. 02:58:58 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 02:58:58 INFO - Using the following test package requirements: 02:58:58 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:58 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 02:58:58 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:58:58 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:58 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 02:58:58 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:58 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 02:58:58 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:58 INFO - u'jsshell-mac.zip'], 02:58:58 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:58 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 02:58:58 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 02:58:58 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:58 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 02:58:58 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:58 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 02:58:58 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:58 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 02:58:58 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 02:58:58 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 02:58:58 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:58:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:58:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:58:58 INFO - Fetch https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:59:00 INFO - Content-Length response header: 52522819 02:59:00 INFO - Bytes received: 52522819 02:59:16 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 02:59:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 02:59:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 02:59:16 INFO - Fetch https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 02:59:18 INFO - Content-Length response header: 52522819 02:59:18 INFO - Bytes received: 52522819 02:59:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 02:59:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 02:59:34 INFO - Fetch https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 02:59:35 INFO - Content-Length response header: 14408811 02:59:35 INFO - Bytes received: 14408811 02:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:35 INFO - trying https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:59:35 INFO - Downloading https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 02:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/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 02:59:38 INFO - Downloaded 71041025 bytes. 02:59:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:59:38 INFO - mkdir: /builds/slave/test/properties 02:59:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:59:38 INFO - Writing to file /builds/slave/test/properties/build_url 02:59:38 INFO - Contents: 02:59:38 INFO - build_url:https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 02:59:39 INFO - Running post-action listener: _resource_record_post_action 02:59:39 INFO - Running post-action listener: set_extra_try_arguments 02:59:39 INFO - [mozharness: 2017-04-22 09:59:39.155188Z] Finished download-and-extract step (success) 02:59:39 INFO - [mozharness: 2017-04-22 09:59:39.155306Z] Running populate-webroot step. 02:59:39 INFO - Running pre-action listener: _resource_record_pre_action 02:59:39 INFO - Running main action method: populate_webroot 02:59:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:59:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:59:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:59:39 INFO - '--tppagecycles', 02:59:39 INFO - '7'], 02:59:39 INFO - 'tests': ['tsvgm']}}, 02:59:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:59:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:59:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:59:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:59:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:59:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:59:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:59:39 INFO - 'talos_options': ['--disable-e10s'], 02:59:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:59:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:59:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:59:39 INFO - 'talos_options': ['--disable-e10s'], 02:59:39 INFO - 'tests': ['damp', 'tps']}, 02:59:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:59:39 INFO - 'tests': ['damp', 'tps']}, 02:59:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:59:39 INFO - 'tests': ['dromaeo_dom']}, 02:59:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:59:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:59:39 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 02:59:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 02:59:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:59:39 INFO - 'tests': ['a11yr', 02:59:39 INFO - 'ts_paint', 02:59:39 INFO - 'tpaint', 02:59:39 INFO - 'sessionrestore', 02:59:39 INFO - 'sessionrestore_no_auto_restore', 02:59:39 INFO - 'tabpaint']}, 02:59:39 INFO - 'other-e10s': {'tests': ['a11yr', 02:59:39 INFO - 'ts_paint', 02:59:39 INFO - 'tpaint', 02:59:39 INFO - 'sessionrestore', 02:59:39 INFO - 'sessionrestore_no_auto_restore', 02:59:39 INFO - 'tabpaint']}, 02:59:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:59:39 INFO - 'ts_paint', 02:59:39 INFO - 'tpaint', 02:59:39 INFO - 'sessionrestore', 02:59:39 INFO - 'sessionrestore_no_auto_restore', 02:59:39 INFO - 'tabpaint']}, 02:59:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:59:39 INFO - 'ts_paint', 02:59:39 INFO - 'tpaint', 02:59:39 INFO - 'sessionrestore', 02:59:39 INFO - 'sessionrestore_no_auto_restore', 02:59:39 INFO - 'tabpaint']}, 02:59:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:59:39 INFO - 'tests': ['a11yr', 02:59:39 INFO - 'ts_paint', 02:59:39 INFO - 'tpaint', 02:59:39 INFO - 'sessionrestore', 02:59:39 INFO - 'sessionrestore_no_auto_restore', 02:59:39 INFO - 'tabpaint']}, 02:59:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:59:39 INFO - 'tests': ['a11yr', 02:59:39 INFO - 'ts_paint', 02:59:39 INFO - 'tpaint', 02:59:39 INFO - 'sessionrestore', 02:59:39 INFO - 'sessionrestore_no_auto_restore', 02:59:39 INFO - 'tabpaint']}, 02:59:39 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 02:59:39 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 02:59:39 INFO - 'bloom_basic_ref']}, 02:59:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:59:39 INFO - 'tests': ['tsvgx', 02:59:39 INFO - 'tsvgr_opacity', 02:59:39 INFO - 'tart', 02:59:39 INFO - 'tscrollx', 02:59:39 INFO - 'cart', 02:59:39 INFO - 'tsvg_static']}, 02:59:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:59:39 INFO - 'tsvgr_opacity', 02:59:39 INFO - 'tart', 02:59:39 INFO - 'tscrollx', 02:59:39 INFO - 'cart', 02:59:39 INFO - 'tsvg_static']}, 02:59:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:59:39 INFO - 'talos_options': ['--disable-e10s'], 02:59:39 INFO - 'tests': ['tp5o']}, 02:59:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:59:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:59:39 INFO - 'talos_options': ['--disable-e10s', 02:59:39 INFO - '--xperf_path', 02:59:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:39 INFO - 'tests': ['tp5n']}, 02:59:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:59:39 INFO - 'talos_options': ['--xperf_path', 02:59:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:59:39 INFO - 'tests': ['tp5n']}}, 02:59:39 INFO - 'talos.zip': {'path': '', 02:59:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:59:39 INFO - Running post-action listener: _resource_record_post_action 02:59:39 INFO - [mozharness: 2017-04-22 09:59:39.173927Z] Finished populate-webroot step (success) 02:59:39 INFO - [mozharness: 2017-04-22 09:59:39.174063Z] Running create-virtualenv step. 02:59:39 INFO - Running pre-action listener: _resource_record_pre_action 02:59:39 INFO - Running main action method: create_virtualenv 02:59:39 INFO - Creating virtualenv /builds/slave/test/build/venv 02:59:39 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 02:59:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:59:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:59:39 INFO - Using real prefix '/tools/python27' 02:59:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:59:40 INFO - Installing distribute.............................................................................................................................................................................................done. 02:59:42 INFO - Installing pip.................done. 02:59:42 INFO - Return code: 0 02:59:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:59:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:59:43 INFO - Reading from file tmpfile_stdout 02:59:43 INFO - Output received: 02:59:43 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) 02:59:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b18cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa189d95e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10ae90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af5fbe8>, '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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:59:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:59:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZICkjlKDXk/Render', 02:59:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:43 INFO - 'HOME': '/Users/cltbld', 02:59:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:43 INFO - 'LOGNAME': 'cltbld', 02:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:43 INFO - 'MOZ_NO_REMOTE': '1', 02:59:43 INFO - 'NO_EM_RESTART': '1', 02:59:43 INFO - 'PAGER': '/bin/cat', 02:59:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:43 INFO - 'PWD': '/builds/slave/test', 02:59:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:43 INFO - 'SHELL': '/bin/bash', 02:59:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eTzhbOkmBA/Listeners', 02:59:43 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:59:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:43 INFO - 'USER': 'cltbld', 02:59:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:43 INFO - 'XPC_FLAGS': '0x0', 02:59:43 INFO - 'XPC_SERVICE_NAME': '0', 02:59:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:43 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 02:59:43 INFO - Cleaning up... 02:59:43 INFO - Return code: 0 02:59:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b18cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa189d95e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10ae90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af5fbe8>, '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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:59:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:59:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:59:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZICkjlKDXk/Render', 02:59:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:43 INFO - 'HOME': '/Users/cltbld', 02:59:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:43 INFO - 'LOGNAME': 'cltbld', 02:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:43 INFO - 'MOZ_NO_REMOTE': '1', 02:59:43 INFO - 'NO_EM_RESTART': '1', 02:59:43 INFO - 'PAGER': '/bin/cat', 02:59:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:43 INFO - 'PWD': '/builds/slave/test', 02:59:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:43 INFO - 'SHELL': '/bin/bash', 02:59:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eTzhbOkmBA/Listeners', 02:59:43 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:59:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:43 INFO - 'USER': 'cltbld', 02:59:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:43 INFO - 'XPC_FLAGS': '0x0', 02:59:43 INFO - 'XPC_SERVICE_NAME': '0', 02:59:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:43 INFO - Downloading/unpacking psutil>=3.1.1 02:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:59:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:47 INFO - Installing collected packages: psutil 02:59:47 INFO - Running setup.py install for psutil 02:59:47 INFO - building 'psutil._psutil_osx' extension 02:59:47 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 02:59:48 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 02:59:48 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 02:59:48 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 02:59:48 INFO - building 'psutil._psutil_posix' extension 02:59:48 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 02:59:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:59:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:59:48 INFO - ^ 02:59:48 INFO - 1 warning generated. 02:59:48 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 02:59:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:59:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:59:48 INFO - Successfully installed psutil 02:59:48 INFO - Cleaning up... 02:59:48 INFO - Return code: 0 02:59:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:59:48 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')]} 02:59:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:48 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')]} 02:59:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:48 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 0x10b18cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa189d95e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10ae90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af5fbe8>, '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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:59:48 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 02:59:48 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 02:59:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZICkjlKDXk/Render', 02:59:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:49 INFO - 'HOME': '/Users/cltbld', 02:59:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:49 INFO - 'LOGNAME': 'cltbld', 02:59:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:49 INFO - 'MOZ_NO_REMOTE': '1', 02:59:49 INFO - 'NO_EM_RESTART': '1', 02:59:49 INFO - 'PAGER': '/bin/cat', 02:59:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:49 INFO - 'PWD': '/builds/slave/test', 02:59:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:49 INFO - 'SHELL': '/bin/bash', 02:59:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eTzhbOkmBA/Listeners', 02:59:49 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:59:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:49 INFO - 'USER': 'cltbld', 02:59:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:49 INFO - 'XPC_FLAGS': '0x0', 02:59:49 INFO - 'XPC_SERVICE_NAME': '0', 02:59:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:59:49 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 02:59:49 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 02:59:49 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 02:59:49 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 02:59:49 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 02:59:49 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 02:59:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:59:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:59:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:59:51 INFO - Installing collected packages: mozsystemmonitor 02:59:51 INFO - Running setup.py install for mozsystemmonitor 02:59:52 INFO - Successfully installed mozsystemmonitor 02:59:52 INFO - Cleaning up... 02:59:52 INFO - Return code: 0 02:59:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b18cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa189d95e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10ae90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af5fbe8>, '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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:59:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZICkjlKDXk/Render', 02:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:52 INFO - 'HOME': '/Users/cltbld', 02:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:52 INFO - 'LOGNAME': 'cltbld', 02:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:52 INFO - 'MOZ_NO_REMOTE': '1', 02:59:52 INFO - 'NO_EM_RESTART': '1', 02:59:52 INFO - 'PAGER': '/bin/cat', 02:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:52 INFO - 'PWD': '/builds/slave/test', 02:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:52 INFO - 'SHELL': '/bin/bash', 02:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eTzhbOkmBA/Listeners', 02:59:52 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:52 INFO - 'USER': 'cltbld', 02:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:52 INFO - 'XPC_FLAGS': '0x0', 02:59:52 INFO - 'XPC_SERVICE_NAME': '0', 02:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:52 INFO - Downloading/unpacking jsonschema==2.5.1 02:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:59:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:59:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:59:54 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 02:59:54 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 02:59:54 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 02:59:54 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 02:59:54 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 02:59:54 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 02:59:55 INFO - Downloading functools32-3.2.3-2.tar.gz 02:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:59:55 INFO - warning: no files found matching '*.txt' 02:59:55 INFO - no previously-included directories found matching 'build' 02:59:55 INFO - no previously-included directories found matching 'dist' 02:59:55 INFO - no previously-included directories found matching '.git*' 02:59:55 INFO - Installing collected packages: jsonschema, functools32 02:59:55 INFO - Running setup.py install for functools32 02:59:55 INFO - warning: no files found matching '*.txt' 02:59:55 INFO - no previously-included directories found matching 'build' 02:59:55 INFO - no previously-included directories found matching 'dist' 02:59:55 INFO - no previously-included directories found matching '.git*' 02:59:55 INFO - Successfully installed jsonschema functools32 02:59:55 INFO - Cleaning up... 02:59:55 INFO - Return code: 0 02:59:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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', '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 0x10b18cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa189d95e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10ae90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af5fbe8>, '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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:59: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:59: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 functools32==3.2.3-2 02:59:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZICkjlKDXk/Render', 02:59:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:55 INFO - 'HOME': '/Users/cltbld', 02:59:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:55 INFO - 'LOGNAME': 'cltbld', 02:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:55 INFO - 'MOZ_NO_REMOTE': '1', 02:59:55 INFO - 'NO_EM_RESTART': '1', 02:59:55 INFO - 'PAGER': '/bin/cat', 02:59:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:55 INFO - 'PWD': '/builds/slave/test', 02:59:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:55 INFO - 'SHELL': '/bin/bash', 02:59:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eTzhbOkmBA/Listeners', 02:59:55 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:59:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:55 INFO - 'USER': 'cltbld', 02:59:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:55 INFO - 'XPC_FLAGS': '0x0', 02:59:55 INFO - 'XPC_SERVICE_NAME': '0', 02:59:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:59:55 INFO - Cleaning up... 02:59:55 INFO - Return code: 0 02:59:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:59: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', '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 0x10b18cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa189d95e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10ae90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af5fbe8>, '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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 02:59: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:59: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 blobuploader==1.2.4 02:59:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZICkjlKDXk/Render', 02:59:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:59:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:59:55 INFO - 'HOME': '/Users/cltbld', 02:59:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:59:55 INFO - 'LOGNAME': 'cltbld', 02:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:59:55 INFO - 'MOZ_NO_REMOTE': '1', 02:59:55 INFO - 'NO_EM_RESTART': '1', 02:59:55 INFO - 'PAGER': '/bin/cat', 02:59:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:59:55 INFO - 'PWD': '/builds/slave/test', 02:59:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:59:55 INFO - 'SHELL': '/bin/bash', 02:59:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eTzhbOkmBA/Listeners', 02:59:55 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 02:59:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:59:55 INFO - 'USER': 'cltbld', 02:59:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:59:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:59:55 INFO - 'XPC_FLAGS': '0x0', 02:59:55 INFO - 'XPC_SERVICE_NAME': '0', 02:59:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:59:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:59:56 INFO - Downloading/unpacking blobuploader==1.2.4 02:59:56 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 02:59:56 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 02:59:56 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 02:59:56 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 02:59:56 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 02:59:56 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 02:59:58 INFO - Downloading blobuploader-1.2.4.tar.gz 02:59:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:59:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:59:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 02:59: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 03:00:00 INFO - Downloading docopt-0.6.1.tar.gz 03:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:00 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:00 INFO - Running setup.py install for blobuploader 03:00:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:00 INFO - Running setup.py install for requests 03:00:00 INFO - Running setup.py install for docopt 03:00:01 INFO - Successfully installed blobuploader requests docopt 03:00:01 INFO - Cleaning up... 03:00:01 INFO - Return code: 0 03:00:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:01 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 0x10b18cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa189d95e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10ae90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af5fbe8>, '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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 03:00:01 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 03:00:01 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 03:00:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZICkjlKDXk/Render', 03:00:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:01 INFO - 'HOME': '/Users/cltbld', 03:00:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:01 INFO - 'LOGNAME': 'cltbld', 03:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:01 INFO - 'MOZ_NO_REMOTE': '1', 03:00:01 INFO - 'NO_EM_RESTART': '1', 03:00:01 INFO - 'PAGER': '/bin/cat', 03:00:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:01 INFO - 'PWD': '/builds/slave/test', 03:00:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:01 INFO - 'SHELL': '/bin/bash', 03:00:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eTzhbOkmBA/Listeners', 03:00:01 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 03:00:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:01 INFO - 'USER': 'cltbld', 03:00:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:01 INFO - 'XPC_FLAGS': '0x0', 03:00:01 INFO - 'XPC_SERVICE_NAME': '0', 03:00:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-yB3rTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Q6KYFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-e_9zBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-V4woEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-xzDt_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:01 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-fbqLsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-72XMv0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-XCqrKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-PbrRGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-vO6HJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-NkyYx6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-_Y_HMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-hFxzIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Kar1B5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-I1yYn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:02 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-cgEKSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:03 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-zseeGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:03 INFO - Running setup.py install for manifestparser 03:00:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:03 INFO - Running setup.py install for mozcrash 03:00:03 INFO - Running setup.py install for mozdebug 03:00:03 INFO - Running setup.py install for mozdevice 03:00:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:03 INFO - Running setup.py install for mozfile 03:00:03 INFO - Running setup.py install for mozhttpd 03:00:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Running setup.py install for mozinfo 03:00:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Running setup.py install for mozInstall 03:00:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Running setup.py install for mozleak 03:00:04 INFO - Running setup.py install for mozlog 03:00:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Running setup.py install for moznetwork 03:00:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:04 INFO - Running setup.py install for mozprocess 03:00:04 INFO - Running setup.py install for mozprofile 03:00:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:05 INFO - Running setup.py install for mozrunner 03:00:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:05 INFO - Running setup.py install for mozscreenshot 03:00:05 INFO - Running setup.py install for moztest 03:00:05 INFO - Running setup.py install for mozversion 03:00:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:05 INFO - Cleaning up... 03:00:05 INFO - Return code: 0 03:00:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:05 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')]} 03:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:05 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')]} 03:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:05 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 0x10b18cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa189d95e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10ae90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af5fbe8>, '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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 03:00:05 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 03:00:05 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 03:00:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZICkjlKDXk/Render', 03:00:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:05 INFO - 'HOME': '/Users/cltbld', 03:00:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:05 INFO - 'LOGNAME': 'cltbld', 03:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:05 INFO - 'MOZ_NO_REMOTE': '1', 03:00:05 INFO - 'NO_EM_RESTART': '1', 03:00:05 INFO - 'PAGER': '/bin/cat', 03:00:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:05 INFO - 'PWD': '/builds/slave/test', 03:00:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:05 INFO - 'SHELL': '/bin/bash', 03:00:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eTzhbOkmBA/Listeners', 03:00:05 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 03:00:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:05 INFO - 'USER': 'cltbld', 03:00:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:05 INFO - 'XPC_FLAGS': '0x0', 03:00:05 INFO - 'XPC_SERVICE_NAME': '0', 03:00:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:06 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Y9sSof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:06 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)) 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:06 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-fUkH00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:06 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)) 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:06 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-s5WdaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:06 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)) 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:06 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-YfTMtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:06 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ce_Gys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:06 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)) 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:06 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-VKyZ85-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:06 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)) 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:06 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-J_fY_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:06 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)) 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:06 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-AsGtkG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:06 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)) 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:06 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-mQXqR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:06 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)) 03:00:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:06 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-cKaCV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:07 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)) 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-l4TVIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:07 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)) 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-FeYcRs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:07 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)) 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-3eqG6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:07 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)) 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-R69rn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:07 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)) 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-OmVyQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:07 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)) 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-B5mwpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:07 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)) 03:00:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:07 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Nifm6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:07 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)) 03:00:07 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)) 03:00:07 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)) 03:00:07 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)) 03:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:07 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 03:00:07 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 03:00:07 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 03:00:07 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 03:00:07 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 03:00:07 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 03:00:10 INFO - Downloading blessings-1.6.tar.gz 03:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:10 INFO - Installing collected packages: blessings 03:00:10 INFO - Running setup.py install for blessings 03:00:10 INFO - Successfully installed blessings 03:00:10 INFO - Cleaning up... 03:00:10 INFO - Return code: 0 03:00:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:11 INFO - Reading from file tmpfile_stdout 03:00:11 INFO - Current package versions: 03:00:11 INFO - blessings == 1.6 03:00:11 INFO - blobuploader == 1.2.4 03:00:11 INFO - docopt == 0.6.1 03:00:11 INFO - functools32 == 3.2.3-2 03:00:11 INFO - jsonschema == 2.5.1 03:00:11 INFO - manifestparser == 1.1 03:00:11 INFO - mozInstall == 1.12 03:00:11 INFO - mozcrash == 1.0 03:00:11 INFO - mozdebug == 0.1 03:00:11 INFO - mozdevice == 0.50 03:00:11 INFO - mozfile == 1.2 03:00:11 INFO - mozhttpd == 0.7 03:00:11 INFO - mozinfo == 0.9 03:00:11 INFO - mozleak == 0.1 03:00:11 INFO - mozlog == 3.4 03:00:11 INFO - moznetwork == 0.27 03:00:11 INFO - mozprocess == 0.25 03:00:11 INFO - mozprofile == 0.28 03:00:11 INFO - mozrunner == 6.13 03:00:11 INFO - mozscreenshot == 0.1 03:00:11 INFO - mozsystemmonitor == 0.3 03:00:11 INFO - moztest == 0.8 03:00:11 INFO - mozversion == 1.4 03:00:11 INFO - psutil == 3.1.1 03:00:11 INFO - requests == 1.2.3 03:00:11 INFO - wsgiref == 0.1.2 03:00:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:11 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 0x10b18cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa189d95e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10ae90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af5fbe8>, '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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 03:00:11 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 03:00:11 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 03:00:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZICkjlKDXk/Render', 03:00:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:11 INFO - 'HOME': '/Users/cltbld', 03:00:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:11 INFO - 'LOGNAME': 'cltbld', 03:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:11 INFO - 'MOZ_NO_REMOTE': '1', 03:00:11 INFO - 'NO_EM_RESTART': '1', 03:00:11 INFO - 'PAGER': '/bin/cat', 03:00:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:11 INFO - 'PWD': '/builds/slave/test', 03:00:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:11 INFO - 'SHELL': '/bin/bash', 03:00:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eTzhbOkmBA/Listeners', 03:00:11 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 03:00:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:11 INFO - 'USER': 'cltbld', 03:00:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:11 INFO - 'XPC_FLAGS': '0x0', 03:00:11 INFO - 'XPC_SERVICE_NAME': '0', 03:00:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:11 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)) 03:00:11 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)) 03:00:11 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)) 03:00:11 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)) 03:00:11 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)) 03:00:11 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)) 03:00:11 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)) 03:00:11 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)) 03:00:11 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)) 03:00:11 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)) 03:00:11 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)) 03:00:11 INFO - Cleaning up... 03:00:11 INFO - Return code: 0 03:00:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:11 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 0x10b18cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b18f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa189d95e30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af6ad30>, '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 0x10ae90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af5fbe8>, '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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 03:00:11 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 03:00:11 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 03:00:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZICkjlKDXk/Render', 03:00:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:11 INFO - 'HOME': '/Users/cltbld', 03:00:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:11 INFO - 'LOGNAME': 'cltbld', 03:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:11 INFO - 'MOZ_NO_REMOTE': '1', 03:00:11 INFO - 'NO_EM_RESTART': '1', 03:00:11 INFO - 'PAGER': '/bin/cat', 03:00:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:11 INFO - 'PWD': '/builds/slave/test', 03:00:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:11 INFO - 'SHELL': '/bin/bash', 03:00:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eTzhbOkmBA/Listeners', 03:00:11 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 03:00:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:11 INFO - 'USER': 'cltbld', 03:00:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:11 INFO - 'XPC_FLAGS': '0x0', 03:00:11 INFO - 'XPC_SERVICE_NAME': '0', 03:00:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:00:11 INFO - Cleaning up... 03:00:11 INFO - Return code: 0 03:00:11 INFO - Running post-action listener: _resource_record_post_action 03:00:11 INFO - Running post-action listener: _start_resource_monitoring 03:00:11 INFO - Starting resource monitoring. 03:00:11 INFO - [mozharness: 2017-04-22 10:00:11.609346Z] Finished create-virtualenv step (success) 03:00:11 INFO - [mozharness: 2017-04-22 10:00:11.610301Z] Running install step. 03:00:11 INFO - Running pre-action listener: _resource_record_pre_action 03:00:11 INFO - Running main action method: install 03:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:11 INFO - Reading from file tmpfile_stdout 03:00:11 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:11 INFO - Reading from file tmpfile_stdout 03:00:11 INFO - Output received: 03:00:11 INFO - Usage: mozinstall [options] installer 03:00:11 INFO - Options: 03:00:11 INFO - -h, --help show this help message and exit 03:00:11 INFO - -d DEST, --destination=DEST 03:00:11 INFO - Directory to install application into. [default: 03:00:11 INFO - "/builds/slave/test"] 03:00:11 INFO - --app=APP Application being installed. [default: firefox] 03:00:11 INFO - mkdir: /builds/slave/test/build/application 03:00:11 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'] 03:00:11 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 03:00:31 INFO - Reading from file tmpfile_stdout 03:00:31 INFO - Output received: 03:00:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:00:31 INFO - Running post-action listener: _resource_record_post_action 03:00:31 INFO - [mozharness: 2017-04-22 10:00:31.563394Z] Finished install step (success) 03:00:31 INFO - [mozharness: 2017-04-22 10:00:31.563497Z] Running run-tests step. 03:00:31 INFO - Running pre-action listener: _resource_record_pre_action 03:00:31 INFO - Running main action method: run_tests 03:00:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:00:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:00:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:00:31 INFO - 2017-04-22 03:00:31.578 screenresolution[1637:8168] starting screenresolution argv=screenresolution get 03:00:31 INFO - 2017-04-22 03:00:31.581 screenresolution[1637:8168] Display 0: 1600x1200x32@60 03:00:31 INFO - 2017-04-22 03:00:31.586 screenresolution[1638:8171] starting screenresolution argv=screenresolution list 03:00:31 INFO - Available Modes on Display 0 03:00:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:00:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:00:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:00:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:00:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:00:31 INFO - Intel Iris: 03:00:31 INFO - Chipset Model: Intel Iris 03:00:31 INFO - Type: GPU 03:00:31 INFO - Bus: Built-In 03:00:31 INFO - VRAM (Dynamic, Max): 1536 MB 03:00:31 INFO - Vendor: Intel (0x8086) 03:00:31 INFO - Device ID: 0x0a2e 03:00:31 INFO - Revision ID: 0x0009 03:00:31 INFO - Displays: 03:00:31 INFO - Display: 03:00:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:00:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:00:31 INFO - Display Serial Number: 1600x1200 60 03:00:31 INFO - Main Display: Yes 03:00:31 INFO - Mirror: Off 03:00:31 INFO - Online: Yes 03:00:31 INFO - Rotation: Supported 03:00:31 INFO - Return code: 0 03:00:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:00:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:00:31 INFO - Python 2.7.3 03:00:31 INFO - Return code: 0 03:00:31 INFO - grabbing minidump binary from tooltool 03:00:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:31 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 0x10af6ad30>, '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 0x10ae90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af5fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:00:31 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 03:00:31 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 03:00:31 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 03:00:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:31 INFO - Return code: 0 03:00:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:00:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:00:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:00:31 INFO - ENV: RUST_BACKTRACE is now 1 03:00:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:00:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:00:31 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/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 03:00:31 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/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --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 03:00:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZICkjlKDXk/Render', 03:00:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:00:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:00:31 INFO - 'HOME': '/Users/cltbld', 03:00:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:00:31 INFO - 'LOGNAME': 'cltbld', 03:00:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:00:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:31 INFO - 'MOZ_NO_REMOTE': '1', 03:00:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:31 INFO - 'NO_EM_RESTART': '1', 03:00:31 INFO - 'PAGER': '/bin/cat', 03:00:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:00:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:31 INFO - 'PWD': '/builds/slave/test', 03:00:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:00:31 INFO - 'RUST_BACKTRACE': '1', 03:00:31 INFO - 'SHELL': '/bin/bash', 03:00:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.eTzhbOkmBA/Listeners', 03:00:31 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 03:00:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:00:31 INFO - 'USER': 'cltbld', 03:00:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:00:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:00:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:31 INFO - 'XPC_FLAGS': '0x0', 03:00:31 INFO - 'XPC_SERVICE_NAME': '0', 03:00:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:00:31 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/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--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 03:00:32 INFO - mozversion application_buildid: 20170422014920 03:00:32 INFO - mozversion application_changeset: 42c8a716081e6a8aa33c1e61944f36f6f89245fb 03:00:32 INFO - mozversion application_display_name: Nightly 03:00:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:32 INFO - mozversion application_name: Firefox 03:00:32 INFO - mozversion application_remotingname: firefox 03:00:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:00:32 INFO - mozversion application_vendor: Mozilla 03:00:32 INFO - mozversion application_version: 55.0a1 03:00:32 INFO - mozversion platform_buildid: 20170422014920 03:00:32 INFO - mozversion platform_changeset: 42c8a716081e6a8aa33c1e61944f36f6f89245fb 03:00:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:00:32 INFO - mozversion platform_version: 55.0a1 03:00:32 INFO - using testdate: 1492855232 03:00:32 INFO - actual date: 1492855232 03:00:32 INFO - starting webserver on 'localhost:49249' 03:00:32 INFO - SUITE-START | Running 2 tests 03:00:32 INFO - TEST-START | dromaeo_css 03:00:32 INFO - operating with platform_type : mac_ 03:00:32 INFO - Initialising browser for dromaeo_css test... 03:00:32 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmppgRdGF/profile http://localhost:49249/getInfo.html) 03:00:34 INFO - PID 1648 | 2017-04-22 03:00:34.768 plugin-container[1651:8364] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4953, name = 'com.apple.tsm.portname' 03:00:34 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:00:34 INFO - PID 1648 | 2017-04-22 03:00:34.771 plugin-container[1651:8364] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9d0b, name = 'com.apple.CFPasteboardClient' 03:00:34 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:00:34 INFO - PID 1648 | 2017-04-22 03:00:34.771 plugin-container[1651:8364] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:00:35 INFO - PID 1648 | __metrics Screen width/height:1600/1200 03:00:35 INFO - PID 1648 | colorDepth:24 03:00:35 INFO - PID 1648 | Browser inner width/height: 1024/689 03:00:35 INFO - PID 1648 | __metrics 03:00:35 ERROR - PID 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 03:00:36 INFO - TEST-INFO | 1648: exit 0 03:00:36 INFO - Browser initialized. 03:00:36 INFO - Running cycle 1/1 for dromaeo_css test... 03:00:36 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmppgRdGF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:00:38 INFO - PID 1653 | 2017-04-22 03:00:38.598 plugin-container[1654:8501] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 03:00:38 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:00:38 INFO - PID 1653 | 2017-04-22 03:00:38.599 plugin-container[1654:8501] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9817, name = 'com.apple.CFPasteboardClient' 03:00:38 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:00:38 INFO - PID 1653 | 2017-04-22 03:00:38.599 plugin-container[1654:8501] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:00:48 INFO - PID 1653 | RSS: Main: 251994112 03:00:48 INFO - PID 1653 | 03:03:52 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49249/tests/dromaeo/cssquery-ext.html) 03:03:53 INFO - PID 1653 | RSS: Main: 254308352 03:03:53 INFO - PID 1653 | 03:05:36 INFO - PID 1653 | ************************* 03:05:36 INFO - PID 1653 | A coding exception was thrown and uncaught in a Task. 03:05:36 INFO - PID 1653 | 03:05:36 ERROR - PID 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:05:36 INFO - PID 1653 | Full stack: 03:05:36 INFO - PID 1653 | ************************* 03:05:36 INFO - PID 1653 | ************************* 03:05:36 INFO - PID 1653 | A coding exception was thrown and uncaught in a Task. 03:05:36 INFO - PID 1653 | 03:05:36 ERROR - PID 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:05:36 INFO - PID 1653 | Full stack: 03:05:36 INFO - PID 1653 | ************************* 03:05:36 INFO - PID 1653 | ************************* 03:05:36 INFO - PID 1653 | A coding exception was thrown and uncaught in a Task. 03:05:36 INFO - PID 1653 | 03:05:36 ERROR - PID 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:05:36 INFO - PID 1653 | Full stack: 03:05:36 INFO - PID 1653 | ************************* 03:05:36 INFO - PID 1653 | ************************* 03:05:36 INFO - PID 1653 | A coding exception was thrown and uncaught in a Task. 03:05:36 INFO - PID 1653 | 03:05:36 ERROR - PID 1653 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:05:36 INFO - PID 1653 | Full stack: 03:05:36 INFO - PID 1653 | ************************* 03:06:55 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-ext.html (next: http://localhost:49249/tests/dromaeo/cssquery-jquery.html) 03:06:56 INFO - PID 1653 | RSS: Main: 258686976 03:06:56 INFO - PID 1653 | 03:09:57 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49249/tests/dromaeo/cssquery-mootools.html) 03:09:58 INFO - PID 1653 | RSS: Main: 269443072 03:09:58 INFO - PID 1653 | 03:13:00 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49249/tests/dromaeo/cssquery-prototype.html) 03:13:00 INFO - PID 1653 | RSS: Main: 261894144 03:13:00 INFO - PID 1653 | 03:16:03 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49249/tests/dromaeo/cssquery-yui.html) 03:16:04 INFO - PID 1653 | RSS: Main: 271085568 03:16:04 INFO - PID 1653 | 03:19:06 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49249/tests/dromaeo/cssquery-yui.html (next: http://localhost:49249/tests/dromaeo/cssquery-dojo.html) 03:19:06 INFO - PID 1653 | RSS: Main: 265969664 03:19:06 INFO - PID 1653 | 03:19:06 INFO - PID 1653 | __start_tp_report 03:19:06 INFO - PID 1653 | _x_x_mozilla_page_load 03:19:06 INFO - PID 1653 | _x_x_mozilla_page_load_details 03:19:06 INFO - PID 1653 | |i|pagename|runs| 03:19:06 INFO - PID 1653 | |0;dojo.html;3557.608663047066;3562.0916666250105;3569.214772749994;3622.2755448910207;3631.237440137571;5408.91886621701;5799.623024503409;6045.304789949158;6166.321704612489;6231.626102433852;6151.846203844906;6163.10634957932;6178.721957511912;6249.53128515362;6274.686265686709;5272.841814745564;5385.3537575491;5393.9190912136255;5406.324209473816;5421.674699518022;5475.698836563987;5476.507114359707;5485.451454854522;5492.231087647732;5500.28496295481;5250.65870718402;5281.683099014072;5318.069337865897;5431.321084864392;5443.727813609344;5356.866078348034;5384.838454846361;5396.892062158735;5419.566434685215;5446.836594902159;5319.2287118368;5327.280817089682;5336.226247194135;5349.973250133763;5420.91868621971;6008;6040.728167232485;6124.081387791823;6237.282712488077;6253.21680383366;6398.808035758934;6438.291787903327;6575.178102737158;6628.171478565179;6674;6720.49596280276;6728.562643428161;6746.763863264762;6749.122614060141;6765.695543700545;6185.505159587222;6311.8737625247695;6321.968390158066;6337.302896681362;6348.587341822813;6565.606063636197;6707.0610114584;6762.661866906635;6816.318368163144;6870.31296870319;6235.282942461584;6271.529635277372;6307.117003619497;6453.419192272718;6570.178727659043;6646.335366463315;6657.40083392497;6710.429613482908;6711.3288671132495;6716.227633822173;6629.86740265192;6635.8009259722285;6638.369354911276;6640.667966601651;6646.60120392778;6353.396427339396;6434.774782882577;6448.193975753031;6575.539712220194;6637.668116594151;5285.260063591023;5299.655522391032;5323.494268044529;5342.305500284938;5363.436839131913;4744.098621262018;4756.690815097077;4758.809647614126;4765.0946320199055;4810.254410566367;6118.497354391948;6212.378762123752;6294.968525157345;6303.684815759194;6339.492840572743;5450.8909821803345;6558.245801732766;6644.069830223772;6737.663116844138;6741.595504269661;5386.272853164773;6280.497560195174;6280.685965701697;6287.842803929847;6290.276618188876;5812.505936995402;5850.210221620112;5885.6174348668055;5899.793507227312;5942.465178133989;5609.523190528851;6606.834829129214;6679.632620205935;6836.794896153124;6887.276835932155;5055.898882022412;5951.464368206882;6702.83242918931;6733.124693789776;6758.459323254227;6696.062551242732;6850.314968503109;6875.656217189221;6893;6910.20532638753;6234.719437625227;6381.649009304533;6559.180102487189;6596.340365963365;6626.768063117768;6762.628055456997;6771.830704232433;6775.89836152468;6799.9800029995895;6805.829854253683;6260.812175634738;6324.209473815773;6438;6529.281779004401;6535.57518761279;6462.127612772404;6497.480201583957;6530.444912182517;6561.3438656134;6571.047198156336;6314.116023756769;6350.1109844622715;6424.068510066108;6438.323975982455;6461.838454038687;5727.398623144676;5897.056470964625;6281.089242059785;6341.873162536631;6514.120593719977;6320.905186422299;6354.841128971812;6356.872862542816;6366.395192456709;6387.93612063892 03:19:06 INFO - PID 1653 | |1;ext.html;724.8547295273469;747.4095464582979;818.5129847740594;1254.5859866244134;1270.2568997136675;37378.81310593447;37926.24147517048;37927.431088533696;37944;38024.338296319234;38035.19648035202;38309.42535861964;38324.04189895254;38340;38421.231575368474;8000.719974800883;8151.836963260761;8422.957885210566;8668.176523230282;8672.913270867273;8665.740027799144;8709.651613935435;8763.824723505526;8775.473471591693;8799.516026618534;8709.21617054465;8780.385373023859;8794.86807697885;8801.867971980393;8815.382923195379;8726.171013753683;8740.825183496294;8751.081136480641;8763.211310981978;8773.517456539888;7665.271799179069;8053.154418786002;8432.747017589481;8438.02962659296;8487.23614874658;37554;37775.244495109946;37776;37835.24329513394;37901.81049094737;3671.192337685705;3715.405535114369;3717.3308804415196;3717.6096509866616;3730.4404339349044;30543.236419089477;30687.079387618407;30689.846550767103;30768.84615576908;30864.074077777703;3178.078357276387;3213.1324542373663;3215.0515597898443;3215.581974343344;3216.195951012247;260153;263267;271419.6429017862;288447;290968;46563.76718116388;46910.765446172554;46972;47009;47134;39772.60227397747;39884.60115398867;46789.830254243236;48289.034219315414;48354.75822620864;12066.879331206752;14033.1580105194;14169.937254705732;14184.503542376173;14201.869719542152;9901.900980990242;11454.828177577343;11543.422828858524;11562.0172285355;11583.884161158281;11814.46834892432;12554.686132846751;13358;13388.464461421434;13395.866041339657;6035.939640603626;6049.243844519435;6089.451949324582;6106.877862442726;6109.877802443926;920.9861852072224;969.5976169889417;1018.6536577563515;1038.200585549123;1066.248294952057;24095.277141685776;30289.848550757106;31061.68938310633;31315;31797.52303715446;1043.139409986764;1105.950232239551;1106.8616422947132;1138.2373809547623;1152.5159433038143;11868.347240901834;12396.380180990915;12450.051945976264;12473.75052498945;12588.181768185039;276193.61903190357;306186;312243.43878280465;317123;317787.4110629478;53320;53647.19529207065;53663;53706.657333566975;53917.73041134769;1360.768669326217;1492.4477943160882;1530.4490383462166;1540.3222582063856;1554.5336399080231;19808.90095549513;24440.511189776462;24441.144559940316;24441.51116977686;24461.633075504236;34027.80902668395;38457;39595.406068908414;39628;39818.40272395974;286032;286194;286708.3987480379;287416;287570;34553.44509497028;36052.819735901154;36429.45355819612;36723.44914826333;36728.08179795527;37501.81249093737;45212.77393613011;46284.768576158254;46307;46327;30583;31269.530957036117;31497.685023150392;31740;31957.36085278328;30977.225569360948;31079.68920310768;31645.525317119802;31688.207794805316;31729;37772;37919.86240412792;38098.80950595229;38221.235575287785;38269.234615308094;26964.73035269622;30357.392852143275;31003.364713999563;31889.362212756077;31990.84004579962;22753.431164221027;24620.87689561541;24680.01279948782;24901.87549062243;25159.119430819832 03:19:06 INFO - PID 1653 | |2;jquery.html;403.99999999999983;426.86980470956354;437.9693421460495;444.69760562817294;445.6985602042037;17226.91386543067;18683.878967261975;20328.796712032894;21064.052117654704;21082.683759743617;16729.912555683874;19308.51728706783;22364.440888977784;22838.429039274026;22896.542069158608;5494.340679118492;6072.392760723926;6343.873122537547;6344.794489047066;6345.524085693568;5921.467067963882;6158.04550294705;6192.380761923817;6263.749450022016;6269.153664255313;6156.938430615682;6180.3201647818705;6207.131001659771;6216.285127210361;6229.626222426647;5340.519353258206;6027.789027384042;6224.502039836802;6255.655938923357;6255.749770009194;5503.394626591072;5572;5575.275214222166;5581.6371935824445;5588.580856435784;26775.866120669467;27204.863975680193;27276.45447091067;27464.450710985668;27507.58738618922;2086.7182930304366;2272.0230300970575;2279.065583110933;2311;2316.4093156245217;15139.470118545798;17796.199171037333;17884.463466096036;18048.36830710932;18186.363227309474;1762.6210364771507;2157.1910533549917;2180.9345719628436;2188.124750099957;2194.2100843696257;153523;154042;155477.0070693643;155909;157300;12115;12775.297358645177;12777.488900443877;12789.296588687526;12799.680007999874;15803.893727438968;15998.360065597246;16073.115978621054;16099.839001610067;16190.028598284141;8676.045634980148;8699.086595907465;8889.444347239336;8891.555422228992;9020.729378118536;8330.541820199825;8339.082700902896;8369.790755231046;8392.580370981426;8462.957685211535;7745.225477452323;7841.255080767318;7883.0540335159;7894.684212631545;7902.644381002869;1914.1290712725677;2173.195917510531;2203.4821816873023;2221.0893533651124;2239.435845956371;845.1168528887328;1013.3767732844248;1017.4607458047246;1021.7803172317987;1046.1473898772476;20615.69076463854;21436.24973125933;21439.57120857574;21498.24756133528;21521.569568608542;913.1462082952461;1010.8938561451089;1019.5666841592293;1038.901304376083;1062.0919114157439;10427.426491542887;10752;11040.00639942393;11079.612213572647;11083.778324433466;487173;496578.51710741216;540525;550155;552223;128476.43047139005;132903.33548332198;134383;135643;138049.3097534506;1032.5456799008412;1124.2916962313855;1240.9007279417624;1272.1349482351904;1278.277773058219;20538;21478.355649330544;21484;21744.565108698054;21819;54828;55217.171742424696;58081.12878306744;60167.699161503915;60279.397206029134;76017.61991190008;78170.21829781857;78192.60903695445;78789;78947.21052789628;7518.548887066793;8508.91491085106;8897.131602363575;9029.458232506071;9263.258939284706;12732.917701995435;14686.192259425834;14737.484188053366;14802.703945920806;15010.699786004001;11872.76254474923;12418.068644851854;12433.316167610868;12701.42843572023;12714.809277860655;11568.710782230512;11673.649790506299;11728.179027467995;11754.941225293818;11930.164888457724;11174.770775214882;12502.87497125017;12609.621711348675;12724.04569657261;12833.807492887801;8939.73180804577;9137.314701397288;9170.95414522923;9253.58358873839;9312.48781317034;12050.51797928073;12154.298398224433;12336.568220112613;12405.255684658949;12463.813042804184 03:19:06 INFO - PID 1653 | |3;mootools.html;1421.1544131241915;1421.7583010888152;1452.8329242137158;1463.8069972972028;1468.9779653305202;9729.318947673666;11449.084073274138;11812.468438920248;11922.821157682642;12088.637340879766;11157.107431405488;11669.474873630686;11726.589569365075;11857.992070674003;11881.049516038718;2272.988635056822;2556.8465892046443;2560.3215147985798;2565.050931155475;2566.1018643474727;2486.76375744304;2528.8229823912334;2542.2627438042946;2548.694156701189;2551.4514379408424;2505.649209110726;2535.6957165140116;2567.165671156872;2570.0362364113457;2606.569915963864;2321.0135692330778;2376.8336216464854;2498.5877330240487;2557.360659835041;2558.2453176313034;2446.9755302446924;2546.707128680207;2548.6686730725073;2557.1050132453493;2568.794496440299;11877.703057423547;11973.401329933555;11980.64058078259;11994.940025299818;12000.459979300953;6640.634765087918;6889.138857642794;6906.963955406679;6915.792526224171;6945.16658001038;4083.0601966584013;4395.252807022814;4454.688171827974;4474.77626118696;4509.1658043262105;1270.6505710929475;1277.2655722959335;1310.7575098606787;1318.2551858200181;1324.3245944568243;13223.140495867738;16134.112623805686;16474.505764827074;16705.331786728515;16779.916100419665;6014.458698717136;6106.847328816815;6127.172831667757;6269.717862696099;6335.968320158369;13792.517261895986;13877.306134693225;13889.097208681404;13899.16605003703;13936.163830170222;6844.076049733322;6907.447404207652;6908.689108990007;6915.412189963909;6925.272846351161;6045.304789949124;6232.906506402408;6255.218097737783;6298.275698294663;6306;3810.3522401191863;4316.978415107905;4524.660650451229;4535.546445355504;4560.95439045612;1343.5230493174781;1347.3263368315843;1349.2511656030997;1352.8241328627412;1358.7418390505773;782.7573452229827;797.3621103117483;806.5563939833069;811.3630799822112;830.6511265268601;6110.266767987781;6124.38756124384;6320.652364119926;6365.4589359904;6371.585846919936;595.7102872281548;601.6931365003879;603.6559161278029;606.5875204860737;614.717230074162;2887.6101726267107;3369.983150084283;4115.012397024692;4304.289792184254;4334.306510958295;14005.66946140115;14207.573772786833;14547.490837820626;15020.62448438776;15079.396824127132;12336.50653973849;14806.03760755569;14915.776263356058;14950.327235274439;14984.625384365478;7207.9639601801655;8470.364722645827;8597.914020859711;8630.309575233967;8634.179752923463;6530.47756179495;6887.690053947485;6889.276625954202;7017.473689473412;7235.384992275505;11770.3526306054;13151.0136739743;13459.259740714355;13475.46098156102;13746.175229486264;13736.725265494435;13760.31198440054;13787;13830.515931942333;13993.650158745706;9432.103950124727;9670.371425857296;9729.4648794317;9750;9766.951165244129;10538.104261137889;10583.735406614589;10585.259031868003;10694.465276735977;10703.143748500257;9217.216536594464;9232.95383523078;9244.260459163384;9263.980962094029;9436.103570160823;9084.545772711206;9112.134347237003;9118.908810912071;9120.954395228247;9158.496282704515;6492.577982431127;8020.83958320842;8099.797505062421;8107.391945603986;8132.30875375576;5679.403662615366;6019;6053.878922421615;6162.969185154046;6199.783007594712;6081.665508397081;6163.3528479509005;6259.3427690091885;6291.874162516816;6349.206349206349 03:19:06 INFO - PID 1653 | |4;prototype.html;343.7490631838757;400.74953154278575;400.7675548182055;408.39149666996184;412.4843945068664;5606.859828504289;5896.262967129109;6052.7578896844125;6067.452799536112;6284.151639528663;5195.740212989345;5914.792982245623;5959.791407300745;6046.274447066347;6117.2965109012475;4286.807093680792;4413.3379993001145;4426.756528390937;4448.7108337957925;4477.395551600533;3825.368814145663;3849.576546579874;4180.874573762777;4446.333050042487;4448.888777780549;4375.7155784873885;4391.407160033403;4393.538678438766;4400.97799511002;4411;3961.0493481564504;4159.584041595846;4288.099499105192;4392.16548855718;4392.494863090737;3778.2821263960036;3778.565464971536;3779.45197946299;3779.5653499847595;3784.1863999240295;4808.966072294474;5814.738336774855;5834.708264586754;5838.868812883309;5846.824595262149;5034.89930201394;5233.398159211702;5234.81678141267;5251.501107394792;5267.894642107175;5981.401859813984;6338.334474880117;6364.204474440695;6377.394147555975;6382.840428989312;3801.7718936863876;3874.651281384689;3937.940930886039;4287.056847493546;4325.891852703676;5598.384177740445;5772.7113644317615;6456.192266165481;6476.805695829133;6733.528652994292;3731.533558305212;3882.825272862728;4378.978105109454;4388.9466528033045;4417.779111044435;4472;4474.217012022883;4475.910481790346;4476.485204201494;4500.189965806187;4763.237881938942;4927.408710954708;5247.317848679647;5254.714199323306;5280.709560974106;6368;6416.262129855033;6423.6831449553665;6430.614163150132;6513.576617519846;1411.5483045425572;1438.9998950729353;1514.174774747765;1540.690413148837;1546.6235050804792;997.1374760831828;1008.7528555503949;1013.7566983923805;1020.1940467031111;1030.2633616963758;5413.83758487246;5687.943120568824;6039.184710064173;6044.758209671564;6055.545834062463;6616.503762217853;6637.369449902348;6637.639283946779;6648.368405001614;6673.099131617267;5678.290213723285;5997.430244126801;6086.847828804227;6123.4795042421;6131.080337949344;3438.2607739336163;3500.842462089212;3502.2820321833965;3505.230867614556;3511.5762131921683;6016.322736382268;6036.607620504653;6150.446459818638;6412;6547.9046705053925;5771.192033115367;6412.615243085336;6795.286494918061;6822.692978815965;6837.589744615339;5277.947220527745;5599;6652.833679157963;6721.092652491949;6974.163100427981;6234.573452848528;6383.627520083204;6474.935250647433;6680.29448073531;6684.331566843277;6166.845828854314;6228.034654628359;6304.919376605801;6586.736530538725;6652.966735166293;5896.818177274436;6522.706478208397;6527.51043671717;6907.309269073053;6984.650767461505;4197.202531519001;4400.62594679443;4404.405405270376;4407.955920440882;4467.329900514948;5774.364819869895;6387;6712.429443497357;6747.831304217238;6787.490938179558;5414.5668346532975;6217.502599791916;6503.512236582181;6534.248561415498;6583.63789991555;5529.751161197675;6472.417482426604;6514.967425162844;6525.543211975116;6539.967300163468;5651.745671444877;6153.569250152446;6416.486681065597;6432.678366081584;6444.548881578245;5955.813639702738;6198.845028874314;6472.385123413268;6513.674316284072;6542.803715888531;5091.439941606494;5352.35771707382;6140.1710769047395;6314.273858506331;6402.583832050902 03:19:06 INFO - PID 1653 | |5;yui.html;762.7864198024553;842.5660784695879;856.8243510080438;879.9208071273588;881.7751473374291;16104.51686449407;16796.91601541992;16829.41097061603;18585.90707046463;19242.807571924277;17856;17881.642367152683;18039.458816235532;18147.455576332697;18438.81561184388;942.6700654770843;951.7858481841599;956.5934477846922;964.0985678390692;965.9420434773901;967.2310513142033;968.6803354892903;970.4371464550579;970.7184916374243;1006.0040559845737;1034.4103860799348;1045.3466583385384;1046.1735229168946;1047.9476026198697;1048.596290428183;1015.28422462164;1033.3076838518173;1038.6987773545663;1039.8804137524169;1042.7393151712072;754.5736658787822;773.2267732267733;775.2712450296704;775.3913178155121;776.7786180938461;16368.918155409267;16513.752293715603;16646.417375391924;17245.827541724546;17337.739933901;13930.860691393058;16603.66792664152;16693;16872.409465668643;17096;12781.10532262742;13278.66803329915;13809.24049177295;14017.299135043208;14039.719205615933;3425.366307233145;3457.0665920201404;3459.446488561843;3463.2727127303046;3471.9826400867832;105044.81894944084;130175;130336;130785;133311.33344333217;12661.240325580495;12977.675558111123;13009.934950325378;13156.736865262641;13238.4042718076;24082.63876041861;25024;25106.497870042862;25162.87418562932;25377.238682839543;7562.470627056054;7729.265719756614;7736.032995875516;7737.187595302525;7755.844883102306;3736.140687641803;3763.8870833875026;3780.4896338994436;3819.0643292393543;3821.1402434452025;4283.935740963888;4346.8043938022865;4390.626796722315;4396.1867054595;4411.977940110279;931.5528546297815;965.5510187762724;972.2902281334524;973;974.858645496399;643.3823529411817;656.8686262747469;673.1047706550277;680.3162821364497;697.9232284448707;10160.593576256866;10405.58377664885;10944.616938407118;11975.401229938469;12126.333051682243;658.8287045368239;666.8366250268715;666.9366410191024;674.9865002700017;687.5393486364148;5405.8107966221;5464.153056276284;5502.5597952163735;5586.720663966786;5632.915506267409;85796.71304930431;87153;106215.4689226549;107016.92983070225;107569;64580;95043;95113.5244323774;95190.52404737932;97518;61630.69184654048;81490.59254703688;81969;83130;83926.74109888356;8908.663700444986;8921.598528066383;10828.404437755999;11260.211785174959;11486.712832179262;39479.407808883465;41703.58296416997;42263.78868105763;42671.50649727244;42984.570154299305;50979.49020509747;54123;54557.90884182374;55150;55329.44670553243;16093.275802588678;16734.91632541878;16745;16818.57953551171;16828.57928551796;17897.28410863603;18110.456686299432;18176;18667.719984199975;18684.065796710383;15854.365825366856;16184.838151618804;16353;16381.180940953143;16524.917375413046;16622.916885415496;17200.827991720424;17385.82614173842;17419.651606968044;17519.299228031246;13384.397702103623;13906.513272035834;14717.264136793332;15254.542363729106;16967.406140785013;11678.6496405108;11731.178817483036;11785.116116291141;12269.38653067361;12314.938425307817;12866.099373043797;13792.655183620089;13837.377318020915;13860;13884.166949983033 03:19:06 INFO - PID 1653 | __end_tp_report 03:19:06 INFO - PID 1653 | __start_cc_report 03:19:06 INFO - PID 1653 | _x_x_mozilla_cycle_collect,423 03:19:06 INFO - PID 1653 | __end_cc_report 03:19:06 INFO - PID 1653 | __startTimestamp1492856346466__endTimestamp 03:19:06 INFO - PID 1653 | 03:19:06 INFO - PID 1653 | ------- Summary: start ------- 03:19:06 INFO - PID 1653 | Number of tests: 6 03:19:06 INFO - PID 1653 | 03:19:06 INFO - PID 1653 | [#0] dojo.html Cycles:165 Average:6084.96 Median:6311.87 stddev:709.10 (11.2%) stddev-sans-first:682.99 03:19:06 INFO - PID 1653 | Values: 3557.6 3562.1 3569.2 3622.3 3631.2 5408.9 5799.6 6045.3 6166.3 6231.6 6151.8 6163.1 6178.7 6249.5 6274.7 5272.8 5385.4 5393.9 5406.3 5421.7 5475.7 5476.5 5485.5 5492.2 5500.3 5250.7 5281.7 5318.1 5431.3 5443.7 5356.9 5384.8 5396.9 5419.6 5446.8 5319.2 5327.3 5336.2 5350.0 5420.9 6008.0 6040.7 6124.1 6237.3 6253.2 6398.8 6438.3 6575.2 6628.2 6674.0 6720.5 6728.6 6746.8 6749.1 6765.7 6185.5 6311.9 6322.0 6337.3 6348.6 6565.6 6707.1 6762.7 6816.3 6870.3 6235.3 6271.5 6307.1 6453.4 6570.2 6646.3 6657.4 6710.4 6711.3 6716.2 6629.9 6635.8 6638.4 6640.7 6646.6 6353.4 6434.8 6448.2 6575.5 6637.7 5285.3 5299.7 5323.5 5342.3 5363.4 4744.1 4756.7 4758.8 4765.1 4810.3 6118.5 6212.4 6295.0 6303.7 6339.5 5450.9 6558.2 6644.1 6737.7 6741.6 5386.3 6280.5 6280.7 6287.8 6290.3 5812.5 5850.2 5885.6 5899.8 5942.5 5609.5 6606.8 6679.6 6836.8 6887.3 5055.9 5951.5 6702.8 6733.1 6758.5 6696.1 6850.3 6875.7 6893.0 6910.2 6234.7 6381.6 6559.2 6596.3 6626.8 6762.6 6771.8 6775.9 6800.0 6805.8 6260.8 6324.2 6438.0 6529.3 6535.6 6462.1 6497.5 6530.4 6561.3 6571.0 6314.1 6350.1 6424.1 6438.3 6461.8 5727.4 5897.1 6281.1 6341.9 6514.1 6320.9 6354.8 6356.9 6366.4 6387.9 03:19:06 INFO - PID 1653 | 03:19:06 INFO - PID 1653 | [#1] ext.html Cycles:180 Average:44324.61 Median:35303.13 stddev:75784.81 (214.7%) stddev-sans-first:75926.71 03:19:06 INFO - PID 1653 | Values: 724.9 747.4 818.5 1254.6 1270.3 37378.8 37926.2 37927.4 37944.0 38024.3 38035.2 38309.4 38324.0 38340.0 38421.2 8000.7 8151.8 8423.0 8668.2 8672.9 8665.7 8709.7 8763.8 8775.5 8799.5 8709.2 8780.4 8794.9 8801.9 8815.4 8726.2 8740.8 8751.1 8763.2 8773.5 7665.3 8053.2 8432.7 8438.0 8487.2 37554.0 37775.2 37776.0 37835.2 37901.8 3671.2 3715.4 3717.3 3717.6 3730.4 30543.2 30687.1 30689.8 30768.8 30864.1 3178.1 3213.1 3215.1 3215.6 3216.2 260153.0 263267.0 271419.6 288447.0 290968.0 46563.8 46910.8 46972.0 47009.0 47134.0 39772.6 39884.6 46789.8 48289.0 48354.8 12066.9 14033.2 14169.9 14184.5 14201.9 9901.9 11454.8 11543.4 11562.0 11583.9 11814.5 12554.7 13358.0 13388.5 13395.9 6035.9 6049.2 6089.5 6106.9 6109.9 921.0 969.6 1018.7 1038.2 1066.2 24095.3 30289.8 31061.7 31315.0 31797.5 1043.1 1106.0 1106.9 1138.2 1152.5 11868.3 12396.4 12450.1 12473.8 12588.2 276193.6 306186.0 312243.4 317123.0 317787.4 53320.0 53647.2 53663.0 53706.7 53917.7 1360.8 1492.4 1530.4 1540.3 1554.5 19808.9 24440.5 24441.1 24441.5 24461.6 34027.8 38457.0 39595.4 39628.0 39818.4 286032.0 286194.0 286708.4 287416.0 287570.0 34553.4 36052.8 36429.5 36723.4 36728.1 37501.8 45212.8 46284.8 46307.0 46327.0 30583.0 31269.5 31497.7 31740.0 31957.4 30977.2 31079.7 31645.5 31688.2 31729.0 37772.0 37919.9 38098.8 38221.2 38269.2 26964.7 30357.4 31003.4 31889.4 31990.8 22753.4 24620.9 24680.0 24901.9 25159.1 03:19:06 INFO - PID 1653 | 03:19:06 INFO - PID 1653 | [#2] jquery.html Cycles:180 Average:35108.60 Median:12003.56 stddev:89775.06 (747.9%) stddev-sans-first:89989.09 03:19:06 INFO - PID 1653 | Values: 404.0 426.9 438.0 444.7 445.7 17226.9 18683.9 20328.8 21064.1 21082.7 16729.9 19308.5 22364.4 22838.4 22896.5 5494.3 6072.4 6343.9 6344.8 6345.5 5921.5 6158.0 6192.4 6263.7 6269.2 6156.9 6180.3 6207.1 6216.3 6229.6 5340.5 6027.8 6224.5 6255.7 6255.7 5503.4 5572.0 5575.3 5581.6 5588.6 26775.9 27204.9 27276.5 27464.5 27507.6 2086.7 2272.0 2279.1 2311.0 2316.4 15139.5 17796.2 17884.5 18048.4 18186.4 1762.6 2157.2 2180.9 2188.1 2194.2 153523.0 154042.0 155477.0 155909.0 157300.0 12115.0 12775.3 12777.5 12789.3 12799.7 15803.9 15998.4 16073.1 16099.8 16190.0 8676.0 8699.1 8889.4 8891.6 9020.7 8330.5 8339.1 8369.8 8392.6 8463.0 7745.2 7841.3 7883.1 7894.7 7902.6 1914.1 2173.2 2203.5 2221.1 2239.4 845.1 1013.4 1017.5 1021.8 1046.1 20615.7 21436.2 21439.6 21498.2 21521.6 913.1 1010.9 1019.6 1038.9 1062.1 10427.4 10752.0 11040.0 11079.6 11083.8 487173.0 496578.5 540525.0 550155.0 552223.0 128476.4 132903.3 134383.0 135643.0 138049.3 1032.5 1124.3 1240.9 1272.1 1278.3 20538.0 21478.4 21484.0 21744.6 21819.0 54828.0 55217.2 58081.1 60167.7 60279.4 76017.6 78170.2 78192.6 78789.0 78947.2 7518.5 8508.9 8897.1 9029.5 9263.3 12732.9 14686.2 14737.5 14802.7 15010.7 11872.8 12418.1 12433.3 12701.4 12714.8 11568.7 11673.6 11728.2 11754.9 11930.2 11174.8 12502.9 12609.6 12724.0 12833.8 8939.7 9137.3 9171.0 9253.6 9312.5 12050.5 12154.3 12336.6 12405.3 12463.8 03:19:06 INFO - PID 1653 | 03:19:06 INFO - PID 1653 | [#3] mootools.html Cycles:180 Average:7157.18 Median:3590.17 stddev:4507.04 (125.5%) stddev-sans-first:4499.07 03:19:06 INFO - PID 1653 | Values: 1421.2 1421.8 1452.8 1463.8 1469.0 9729.3 11449.1 11812.5 11922.8 12088.6 11157.1 11669.5 11726.6 11858.0 11881.0 2273.0 2556.8 2560.3 2565.1 2566.1 2486.8 2528.8 2542.3 2548.7 2551.5 2505.6 2535.7 2567.2 2570.0 2606.6 2321.0 2376.8 2498.6 2557.4 2558.2 2447.0 2546.7 2548.7 2557.1 2568.8 11877.7 11973.4 11980.6 11994.9 12000.5 6640.6 6889.1 6907.0 6915.8 6945.2 4083.1 4395.3 4454.7 4474.8 4509.2 1270.7 1277.3 1310.8 1318.3 1324.3 13223.1 16134.1 16474.5 16705.3 16779.9 6014.5 6106.8 6127.2 6269.7 6336.0 13792.5 13877.3 13889.1 13899.2 13936.2 6844.1 6907.4 6908.7 6915.4 6925.3 6045.3 6232.9 6255.2 6298.3 6306.0 3810.4 4317.0 4524.7 4535.5 4561.0 1343.5 1347.3 1349.3 1352.8 1358.7 782.8 797.4 806.6 811.4 830.7 6110.3 6124.4 6320.7 6365.5 6371.6 595.7 601.7 603.7 606.6 614.7 2887.6 3370.0 4115.0 4304.3 4334.3 14005.7 14207.6 14547.5 15020.6 15079.4 12336.5 14806.0 14915.8 14950.3 14984.6 7208.0 8470.4 8597.9 8630.3 8634.2 6530.5 6887.7 6889.3 7017.5 7235.4 11770.4 13151.0 13459.3 13475.5 13746.2 13736.7 13760.3 13787.0 13830.5 13993.7 9432.1 9670.4 9729.5 9750.0 9767.0 10538.1 10583.7 10585.3 10694.5 10703.1 9217.2 9233.0 9244.3 9264.0 9436.1 9084.5 9112.1 9118.9 9121.0 9158.5 6492.6 8020.8 8099.8 8107.4 8132.3 5679.4 6019.0 6053.9 6163.0 6199.8 6081.7 6163.4 6259.3 6291.9 6349.2 03:19:06 INFO - PID 1653 | 03:19:06 INFO - PID 1653 | [#4] prototype.html Cycles:180 Average:5153.33 Median:5794.55 stddev:1608.55 (27.8%) stddev-sans-first:1572.03 03:19:06 INFO - PID 1653 | Values: 343.7 400.7 400.8 408.4 412.5 5606.9 5896.3 6052.8 6067.5 6284.2 5195.7 5914.8 5959.8 6046.3 6117.3 4286.8 4413.3 4426.8 4448.7 4477.4 3825.4 3849.6 4180.9 4446.3 4448.9 4375.7 4391.4 4393.5 4401.0 4411.0 3961.0 4159.6 4288.1 4392.2 4392.5 3778.3 3778.6 3779.5 3779.6 3784.2 4809.0 5814.7 5834.7 5838.9 5846.8 5034.9 5233.4 5234.8 5251.5 5267.9 5981.4 6338.3 6364.2 6377.4 6382.8 3801.8 3874.7 3937.9 4287.1 4325.9 5598.4 5772.7 6456.2 6476.8 6733.5 3731.5 3882.8 4379.0 4388.9 4417.8 4472.0 4474.2 4475.9 4476.5 4500.2 4763.2 4927.4 5247.3 5254.7 5280.7 6368.0 6416.3 6423.7 6430.6 6513.6 1411.5 1439.0 1514.2 1540.7 1546.6 997.1 1008.8 1013.8 1020.2 1030.3 5413.8 5687.9 6039.2 6044.8 6055.5 6616.5 6637.4 6637.6 6648.4 6673.1 5678.3 5997.4 6086.8 6123.5 6131.1 3438.3 3500.8 3502.3 3505.2 3511.6 6016.3 6036.6 6150.4 6412.0 6547.9 5771.2 6412.6 6795.3 6822.7 6837.6 5277.9 5599.0 6652.8 6721.1 6974.2 6234.6 6383.6 6474.9 6680.3 6684.3 6166.8 6228.0 6304.9 6586.7 6653.0 5896.8 6522.7 6527.5 6907.3 6984.7 4197.2 4400.6 4404.4 4408.0 4467.3 5774.4 6387.0 6712.4 6747.8 6787.5 5414.6 6217.5 6503.5 6534.2 6583.6 5529.8 6472.4 6515.0 6525.5 6540.0 5651.7 6153.6 6416.5 6432.7 6444.5 5955.8 6198.8 6472.4 6513.7 6542.8 5091.4 5352.4 6140.2 6314.3 6402.6 03:19:06 INFO - PID 1653 | 03:19:06 INFO - PID 1653 | [#5] yui.html Cycles:180 Average:21435.91 Median:18963.44 stddev:30174.83 (159.1%) stddev-sans-first:30219.55 03:19:06 INFO - PID 1653 | Values: 762.8 842.6 856.8 879.9 881.8 16104.5 16796.9 16829.4 18585.9 19242.8 17856.0 17881.6 18039.5 18147.5 18438.8 942.7 951.8 956.6 964.1 965.9 967.2 968.7 970.4 970.7 1006.0 1034.4 1045.3 1046.2 1047.9 1048.6 1015.3 1033.3 1038.7 1039.9 1042.7 754.6 773.2 775.3 775.4 776.8 16368.9 16513.8 16646.4 17245.8 17337.7 13930.9 16603.7 16693.0 16872.4 17096.0 12781.1 13278.7 13809.2 14017.3 14039.7 3425.4 3457.1 3459.4 3463.3 3472.0 105044.8 130175.0 130336.0 130785.0 133311.3 12661.2 12977.7 13009.9 13156.7 13238.4 24082.6 25024.0 25106.5 25162.9 25377.2 7562.5 7729.3 7736.0 7737.2 7755.8 3736.1 3763.9 3780.5 3819.1 3821.1 4283.9 4346.8 4390.6 4396.2 4412.0 931.6 965.6 972.3 973.0 974.9 643.4 656.9 673.1 680.3 697.9 10160.6 10405.6 10944.6 11975.4 12126.3 658.8 666.8 666.9 675.0 687.5 5405.8 5464.2 5502.6 5586.7 5632.9 85796.7 87153.0 106215.5 107016.9 107569.0 64580.0 95043.0 95113.5 95190.5 97518.0 61630.7 81490.6 81969.0 83130.0 83926.7 8908.7 8921.6 10828.4 11260.2 11486.7 39479.4 41703.6 42263.8 42671.5 42984.6 50979.5 54123.0 54557.9 55150.0 55329.4 16093.3 16734.9 16745.0 16818.6 16828.6 17897.3 18110.5 18176.0 18667.7 18684.1 15854.4 16184.8 16353.0 16381.2 16524.9 16622.9 17200.8 17385.8 17419.7 17519.3 13384.4 13906.5 14717.3 15254.5 16967.4 11678.6 11731.2 11785.1 12269.4 12314.9 12866.1 13792.7 13837.4 13860.0 13884.2 03:19:06 INFO - PID 1653 | -------- Summary: end -------- 03:19:06 INFO - PID 1653 | 03:19:07 INFO - TEST-INFO | 1653: exit 0 03:19:07 INFO - TEST-OK | dromaeo_css | took 1114941ms 03:19:07 INFO - TEST-START | kraken 03:19:07 INFO - operating with platform_type : mac_ 03:19:07 INFO - Initialising browser for kraken test... 03:19:07 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpqL4rxU/profile http://localhost:49249/getInfo.html) 03:19:09 INFO - PID 1661 | 2017-04-22 03:19:09.983 plugin-container[1662:10889] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 03:19:09 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:19:09 INFO - PID 1661 | 2017-04-22 03:19:09.985 plugin-container[1662:10889] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 03:19:09 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:19:09 INFO - PID 1661 | 2017-04-22 03:19:09.985 plugin-container[1662:10889] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:19:10 INFO - PID 1661 | __metrics Screen width/height:1600/1200 03:19:10 INFO - PID 1661 | colorDepth:24 03:19:10 INFO - PID 1661 | Browser inner width/height: 1024/689 03:19:10 INFO - PID 1661 | __metrics 03:19:10 ERROR - PID 1661 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 03:19:10 INFO - TEST-INFO | 1661: exit 0 03:19:10 INFO - Browser initialized. 03:19:10 INFO - Running cycle 1/1 for kraken test... 03:19:10 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpqL4rxU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:13 INFO - PID 1663 | 2017-04-22 03:19:13.496 plugin-container[1664:11011] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 03:19:13 INFO - PID 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:19:13 INFO - PID 1663 | 2017-04-22 03:19:13.496 plugin-container[1664:11011] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4717, name = 'com.apple.CFPasteboardClient' 03:19:13 INFO - PID 1663 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:19:13 INFO - PID 1663 | 2017-04-22 03:19:13.496 plugin-container[1664:11011] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:19:23 INFO - PID 1663 | RSS: Main: 237490176 03:19:23 INFO - PID 1663 | 03:19:26 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:27 INFO - PID 1663 | RSS: Main: 249491456 03:19:27 INFO - PID 1663 | 03:19:29 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-dft) 03:19:30 INFO - PID 1663 | RSS: Main: 257622016 03:19:30 INFO - PID 1663 | 03:19:33 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-fft) 03:19:34 INFO - PID 1663 | RSS: Main: 260165632 03:19:34 INFO - PID 1663 | 03:19:36 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator) 03:19:36 INFO - PID 1663 | RSS: Main: 262279168 03:19:36 INFO - PID 1663 | 03:19:38 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:19:39 INFO - PID 1663 | RSS: Main: 262778880 03:19:39 INFO - PID 1663 | 03:19:42 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom) 03:19:42 INFO - PID 1663 | RSS: Main: 268963840 03:19:42 INFO - PID 1663 | 03:19:45 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate) 03:19:46 INFO - PID 1663 | RSS: Main: 270675968 03:19:46 INFO - PID 1663 | 03:19:49 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial) 03:19:49 INFO - PID 1663 | RSS: Main: 270127104 03:19:49 INFO - PID 1663 | 03:19:51 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:19:52 INFO - PID 1663 | RSS: Main: 270041088 03:19:52 INFO - PID 1663 | 03:19:53 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:19:54 INFO - PID 1663 | RSS: Main: 269996032 03:19:54 INFO - PID 1663 | 03:19:56 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:19:57 INFO - PID 1663 | RSS: Main: 269455360 03:19:57 INFO - PID 1663 | 03:20:00 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:00 INFO - PID 1663 | RSS: Main: 269471744 03:20:00 INFO - PID 1663 | 03:20:04 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:04 INFO - PID 1663 | RSS: Main: 266899456 03:20:04 INFO - PID 1663 | 03:20:06 INFO - PID 1663 | Cycle 1(1): loaded http://localhost:49249/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49249/tests/kraken/driver.html?testName=ai-astar) 03:20:07 INFO - PID 1663 | RSS: Main: 268607488 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | __start_tp_report 03:20:07 INFO - PID 1663 | _x_x_mozilla_page_load 03:20:07 INFO - PID 1663 | _x_x_mozilla_page_load_details 03:20:07 INFO - PID 1663 | |i|pagename|runs| 03:20:07 INFO - PID 1663 | |0;ai-astar;105;116;115;113;114;114;119;162;114;118 03:20:07 INFO - PID 1663 | |1;audio-beat-detection;139;109;107;151;113;110;111;112;135;112 03:20:07 INFO - PID 1663 | |2;audio-dft;232;223;200;220;202;219;194;201;228;262 03:20:07 INFO - PID 1663 | |3;audio-fft;82;61;59;104;88;88;50;77;93;84 03:20:07 INFO - PID 1663 | |4;audio-oscillator;92;69;82;71;70;73;85;69;71;90 03:20:07 INFO - PID 1663 | |5;imaging-gaussian-blur;90;90;89;89;89;90;91;103;90;111 03:20:07 INFO - PID 1663 | |6;imaging-darkroom;97;98;97;102;96;97;97;95;104;120 03:20:07 INFO - PID 1663 | |7;imaging-desaturate;89;93;94;92;91;90;91;94;92;90 03:20:07 INFO - PID 1663 | |8;json-parse-financial;50;51;50;49;49;49;48;51;50;51 03:20:07 INFO - PID 1663 | |9;json-stringify-tinderbox;60;61;63;69;60;56;53;56;53;55 03:20:07 INFO - PID 1663 | |10;stanford-crypto-aes;81;86;82;83;83;84;81;85;83;84 03:20:07 INFO - PID 1663 | |11;stanford-crypto-ccm;137;151;163;152;127;154;152;154;270;161 03:20:07 INFO - PID 1663 | |12;stanford-crypto-pbkdf2;182;189;194;245;167;237;246;198;179;234 03:20:07 INFO - PID 1663 | |13;stanford-crypto-sha256-iterative;76;73;90;93;96;99;95;68;70;96 03:20:07 INFO - PID 1663 | __end_tp_report 03:20:07 INFO - PID 1663 | __start_cc_report 03:20:07 INFO - PID 1663 | _x_x_mozilla_cycle_collect,998 03:20:07 INFO - PID 1663 | __end_cc_report 03:20:07 INFO - PID 1663 | __startTimestamp1492856407051__endTimestamp 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | ------- Summary: start ------- 03:20:07 INFO - PID 1663 | Number of tests: 14 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#0] ai-astar Cycles:10 Average:119.00 Median:115.50 stddev:15.57 (13.5%) stddev-sans-first:15.67 03:20:07 INFO - PID 1663 | Values: 105.0 116.0 115.0 113.0 114.0 114.0 119.0 162.0 114.0 118.0 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#1] audio-beat-detection Cycles:10 Average:119.90 Median:112.50 stddev:15.62 (13.9%) stddev-sans-first:14.96 03:20:07 INFO - PID 1663 | Values: 139.0 109.0 107.0 151.0 113.0 110.0 111.0 112.0 135.0 112.0 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#2] audio-dft Cycles:10 Average:218.10 Median:221.50 stddev:20.29 (9.2%) stddev-sans-first:20.89 03:20:07 INFO - PID 1663 | Values: 232.0 223.0 200.0 220.0 202.0 219.0 194.0 201.0 228.0 262.0 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#3] audio-fft Cycles:10 Average:78.60 Median:83.00 stddev:16.95 (20.4%) stddev-sans-first:17.93 03:20:07 INFO - PID 1663 | Values: 82.0 61.0 59.0 104.0 88.0 88.0 50.0 77.0 93.0 84.0 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:77.50 stddev:9.11 (11.8%) stddev-sans-first:7.94 03:20:07 INFO - PID 1663 | Values: 92.0 69.0 82.0 71.0 70.0 73.0 85.0 69.0 71.0 90.0 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:93.20 Median:90.00 stddev:7.54 (8.4%) stddev-sans-first:7.91 03:20:07 INFO - PID 1663 | Values: 90.0 90.0 89.0 89.0 89.0 90.0 91.0 103.0 90.0 111.0 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#6] imaging-darkroom Cycles:10 Average:100.30 Median:97.00 stddev:7.45 (7.7%) stddev-sans-first:7.81 03:20:07 INFO - PID 1663 | Values: 97.0 98.0 97.0 102.0 96.0 97.0 97.0 95.0 104.0 120.0 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#7] imaging-desaturate Cycles:10 Average:91.60 Median:92.00 stddev:1.71 (1.9%) stddev-sans-first:1.54 03:20:07 INFO - PID 1663 | Values: 89.0 93.0 94.0 92.0 91.0 90.0 91.0 94.0 92.0 90.0 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#8] json-parse-financial Cycles:10 Average:49.80 Median:50.00 stddev:1.03 (2.1%) stddev-sans-first:1.09 03:20:07 INFO - PID 1663 | Values: 50.0 51.0 50.0 49.0 49.0 49.0 48.0 51.0 50.0 51.0 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:60.00 stddev:5.02 (8.4%) stddev-sans-first:5.29 03:20:07 INFO - PID 1663 | Values: 60.0 61.0 63.0 69.0 60.0 56.0 53.0 56.0 53.0 55.0 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#10] stanford-crypto-aes Cycles:10 Average:83.20 Median:83.50 stddev:1.62 (1.9%) stddev-sans-first:1.51 03:20:07 INFO - PID 1663 | Values: 81.0 86.0 82.0 83.0 83.0 84.0 81.0 85.0 83.0 84.0 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:162.10 Median:154.00 stddev:39.39 (25.6%) stddev-sans-first:40.72 03:20:07 INFO - PID 1663 | Values: 137.0 151.0 163.0 152.0 127.0 154.0 152.0 154.0 270.0 161.0 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:207.10 Median:216.00 stddev:30.14 (14.0%) stddev-sans-first:30.57 03:20:07 INFO - PID 1663 | Values: 182.0 189.0 194.0 245.0 167.0 237.0 246.0 198.0 179.0 234.0 03:20:07 INFO - PID 1663 | 03:20:07 INFO - PID 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:85.60 Median:94.00 stddev:12.30 (13.1%) stddev-sans-first:12.55 03:20:07 INFO - PID 1663 | Values: 76.0 73.0 90.0 93.0 96.0 99.0 95.0 68.0 70.0 96.0 03:20:07 INFO - PID 1663 | -------- Summary: end -------- 03:20:07 INFO - PID 1663 | 03:20:08 INFO - TEST-INFO | 1663: exit 0 03:20:08 INFO - TEST-OK | kraken | took 60967ms 03:20:08 INFO - SUITE-END | took 1175s 03:20:08 INFO - Completed test suite (00:19:36) 03:20:08 INFO - javascript benchmark 03:20:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7840.475491282028, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3557.608663047066, 3562.0916666250105, 3569.214772749994, 3622.2755448910207, 3631.237440137571, 5408.91886621701, 5799.623024503409, 6045.304789949158, 6166.321704612489, 6231.626102433852, 6151.846203844906, 6163.10634957932, 6178.721957511912, 6249.53128515362, 6274.686265686709, 5272.841814745564, 5385.3537575491, 5393.9190912136255, 5406.324209473816, 5421.674699518022, 5475.698836563987, 5476.507114359707, 5485.451454854522, 5492.231087647732, 5500.28496295481, 5250.65870718402, 5281.683099014072, 5318.069337865897, 5431.321084864392, 5443.727813609344, 5356.866078348034, 5384.838454846361, 5396.892062158735, 5419.566434685215, 5446.836594902159, 5319.2287118368, 5327.280817089682, 5336.226247194135, 5349.973250133763, 5420.91868621971, 6008.0, 6040.728167232485, 6124.081387791823, 6237.282712488077, 6253.21680383366, 6398.808035758934, 6438.291787903327, 6575.178102737158, 6628.171478565179, 6674.0, 6720.49596280276, 6728.562643428161, 6746.763863264762, 6749.122614060141, 6765.695543700545, 6185.505159587222, 6311.8737625247695, 6321.968390158066, 6337.302896681362, 6348.587341822813, 6565.606063636197, 6707.0610114584, 6762.661866906635, 6816.318368163144, 6870.31296870319, 6235.282942461584, 6271.529635277372, 6307.117003619497, 6453.419192272718, 6570.178727659043, 6646.335366463315, 6657.40083392497, 6710.429613482908, 6711.3288671132495, 6716.227633822173, 6629.86740265192, 6635.8009259722285, 6638.369354911276, 6640.667966601651, 6646.60120392778, 6353.396427339396, 6434.774782882577, 6448.193975753031, 6575.539712220194, 6637.668116594151, 5285.260063591023, 5299.655522391032, 5323.494268044529, 5342.305500284938, 5363.436839131913, 4744.098621262018, 4756.690815097077, 4758.809647614126, 4765.0946320199055, 4810.254410566367, 6118.497354391948, 6212.378762123752, 6294.968525157345, 6303.684815759194, 6339.492840572743, 5450.8909821803345, 6558.245801732766, 6644.069830223772, 6737.663116844138, 6741.595504269661, 5386.272853164773, 6280.497560195174, 6280.685965701697, 6287.842803929847, 6290.276618188876, 5812.505936995402, 5850.210221620112, 5885.6174348668055, 5899.793507227312, 5942.465178133989, 5609.523190528851, 6606.834829129214, 6679.632620205935, 6836.794896153124, 6887.276835932155, 5055.898882022412, 5951.464368206882, 6702.83242918931, 6733.124693789776, 6758.459323254227, 6696.062551242732, 6850.314968503109, 6875.656217189221, 6893.0, 6910.20532638753, 6234.719437625227, 6381.649009304533, 6559.180102487189, 6596.340365963365, 6626.768063117768, 6762.628055456997, 6771.830704232433, 6775.89836152468, 6799.9800029995895, 6805.829854253683, 6260.812175634738, 6324.209473815773, 6438.0, 6529.281779004401, 6535.57518761279, 6462.127612772404, 6497.480201583957, 6530.444912182517, 6561.3438656134, 6571.047198156336, 6314.116023756769, 6350.1109844622715, 6424.068510066108, 6438.323975982455, 6461.838454038687, 5727.398623144676, 5897.056470964625, 6281.089242059785, 6341.873162536631, 6514.120593719977, 6320.905186422299, 6354.841128971812, 6356.872862542816, 6366.395192456709, 6387.93612063892], "value": 6040.396302385447, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [724.8547295273469, 747.4095464582979, 818.5129847740594, 1254.5859866244134, 1270.2568997136675, 37378.81310593447, 37926.24147517048, 37927.431088533696, 37944.0, 38024.338296319234, 38035.19648035202, 38309.42535861964, 38324.04189895254, 38340.0, 38421.231575368474, 8000.719974800883, 8151.836963260761, 8422.957885210566, 8668.176523230282, 8672.913270867273, 8665.740027799144, 8709.651613935435, 8763.824723505526, 8775.473471591693, 8799.516026618534, 8709.21617054465, 8780.385373023859, 8794.86807697885, 8801.867971980393, 8815.382923195379, 8726.171013753683, 8740.825183496294, 8751.081136480641, 8763.211310981978, 8773.517456539888, 7665.271799179069, 8053.154418786002, 8432.747017589481, 8438.02962659296, 8487.23614874658, 37554.0, 37775.244495109946, 37776.0, 37835.24329513394, 37901.81049094737, 3671.192337685705, 3715.405535114369, 3717.3308804415196, 3717.6096509866616, 3730.4404339349044, 30543.236419089477, 30687.079387618407, 30689.846550767103, 30768.84615576908, 30864.074077777703, 3178.078357276387, 3213.1324542373663, 3215.0515597898443, 3215.581974343344, 3216.195951012247, 260153.0, 263267.0, 271419.6429017862, 288447.0, 290968.0, 46563.76718116388, 46910.765446172554, 46972.0, 47009.0, 47134.0, 39772.60227397747, 39884.60115398867, 46789.830254243236, 48289.034219315414, 48354.75822620864, 12066.879331206752, 14033.1580105194, 14169.937254705732, 14184.503542376173, 14201.869719542152, 9901.900980990242, 11454.828177577343, 11543.422828858524, 11562.0172285355, 11583.884161158281, 11814.46834892432, 12554.686132846751, 13358.0, 13388.464461421434, 13395.866041339657, 6035.939640603626, 6049.243844519435, 6089.451949324582, 6106.877862442726, 6109.877802443926, 920.9861852072224, 969.5976169889417, 1018.6536577563515, 1038.200585549123, 1066.248294952057, 24095.277141685776, 30289.848550757106, 31061.68938310633, 31315.0, 31797.52303715446, 1043.139409986764, 1105.950232239551, 1106.8616422947132, 1138.2373809547623, 1152.5159433038143, 11868.347240901834, 12396.380180990915, 12450.051945976264, 12473.75052498945, 12588.181768185039, 276193.61903190357, 306186.0, 312243.43878280465, 317123.0, 317787.4110629478, 53320.0, 53647.19529207065, 53663.0, 53706.657333566975, 53917.73041134769, 1360.768669326217, 1492.4477943160882, 1530.4490383462166, 1540.3222582063856, 1554.5336399080231, 19808.90095549513, 24440.511189776462, 24441.144559940316, 24441.51116977686, 24461.633075504236, 34027.80902668395, 38457.0, 39595.406068908414, 39628.0, 39818.40272395974, 286032.0, 286194.0, 286708.3987480379, 287416.0, 287570.0, 34553.44509497028, 36052.819735901154, 36429.45355819612, 36723.44914826333, 36728.08179795527, 37501.81249093737, 45212.77393613011, 46284.768576158254, 46307.0, 46327.0, 30583.0, 31269.530957036117, 31497.685023150392, 31740.0, 31957.36085278328, 30977.225569360948, 31079.68920310768, 31645.525317119802, 31688.207794805316, 31729.0, 37772.0, 37919.86240412792, 38098.80950595229, 38221.235575287785, 38269.234615308094, 26964.73035269622, 30357.392852143275, 31003.364713999563, 31889.362212756077, 31990.84004579962, 22753.431164221027, 24620.87689561541, 24680.01279948782, 24901.87549062243, 25159.119430819832], "value": 17620.518778886948, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.99999999999983, 426.86980470956354, 437.9693421460495, 444.69760562817294, 445.6985602042037, 17226.91386543067, 18683.878967261975, 20328.796712032894, 21064.052117654704, 21082.683759743617, 16729.912555683874, 19308.51728706783, 22364.440888977784, 22838.429039274026, 22896.542069158608, 5494.340679118492, 6072.392760723926, 6343.873122537547, 6344.794489047066, 6345.524085693568, 5921.467067963882, 6158.04550294705, 6192.380761923817, 6263.749450022016, 6269.153664255313, 6156.938430615682, 6180.3201647818705, 6207.131001659771, 6216.285127210361, 6229.626222426647, 5340.519353258206, 6027.789027384042, 6224.502039836802, 6255.655938923357, 6255.749770009194, 5503.394626591072, 5572.0, 5575.275214222166, 5581.6371935824445, 5588.580856435784, 26775.866120669467, 27204.863975680193, 27276.45447091067, 27464.450710985668, 27507.58738618922, 2086.7182930304366, 2272.0230300970575, 2279.065583110933, 2311.0, 2316.4093156245217, 15139.470118545798, 17796.199171037333, 17884.463466096036, 18048.36830710932, 18186.363227309474, 1762.6210364771507, 2157.1910533549917, 2180.9345719628436, 2188.124750099957, 2194.2100843696257, 153523.0, 154042.0, 155477.0070693643, 155909.0, 157300.0, 12115.0, 12775.297358645177, 12777.488900443877, 12789.296588687526, 12799.680007999874, 15803.893727438968, 15998.360065597246, 16073.115978621054, 16099.839001610067, 16190.028598284141, 8676.045634980148, 8699.086595907465, 8889.444347239336, 8891.555422228992, 9020.729378118536, 8330.541820199825, 8339.082700902896, 8369.790755231046, 8392.580370981426, 8462.957685211535, 7745.225477452323, 7841.255080767318, 7883.0540335159, 7894.684212631545, 7902.644381002869, 1914.1290712725677, 2173.195917510531, 2203.4821816873023, 2221.0893533651124, 2239.435845956371, 845.1168528887328, 1013.3767732844248, 1017.4607458047246, 1021.7803172317987, 1046.1473898772476, 20615.69076463854, 21436.24973125933, 21439.57120857574, 21498.24756133528, 21521.569568608542, 913.1462082952461, 1010.8938561451089, 1019.5666841592293, 1038.901304376083, 1062.0919114157439, 10427.426491542887, 10752.0, 11040.00639942393, 11079.612213572647, 11083.778324433466, 487173.0, 496578.51710741216, 540525.0, 550155.0, 552223.0, 128476.43047139005, 132903.33548332198, 134383.0, 135643.0, 138049.3097534506, 1032.5456799008412, 1124.2916962313855, 1240.9007279417624, 1272.1349482351904, 1278.277773058219, 20538.0, 21478.355649330544, 21484.0, 21744.565108698054, 21819.0, 54828.0, 55217.171742424696, 58081.12878306744, 60167.699161503915, 60279.397206029134, 76017.61991190008, 78170.21829781857, 78192.60903695445, 78789.0, 78947.21052789628, 7518.548887066793, 8508.91491085106, 8897.131602363575, 9029.458232506071, 9263.258939284706, 12732.917701995435, 14686.192259425834, 14737.484188053366, 14802.703945920806, 15010.699786004001, 11872.76254474923, 12418.068644851854, 12433.316167610868, 12701.42843572023, 12714.809277860655, 11568.710782230512, 11673.649790506299, 11728.179027467995, 11754.941225293818, 11930.164888457724, 11174.770775214882, 12502.87497125017, 12609.621711348675, 12724.04569657261, 12833.807492887801, 8939.73180804577, 9137.314701397288, 9170.95414522923, 9253.58358873839, 9312.48781317034, 12050.51797928073, 12154.298398224433, 12336.568220112613, 12405.255684658949, 12463.813042804184], "value": 10499.795297930747, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.1544131241915, 1421.7583010888152, 1452.8329242137158, 1463.8069972972028, 1468.9779653305202, 9729.318947673666, 11449.084073274138, 11812.468438920248, 11922.821157682642, 12088.637340879766, 11157.107431405488, 11669.474873630686, 11726.589569365075, 11857.992070674003, 11881.049516038718, 2272.988635056822, 2556.8465892046443, 2560.3215147985798, 2565.050931155475, 2566.1018643474727, 2486.76375744304, 2528.8229823912334, 2542.2627438042946, 2548.694156701189, 2551.4514379408424, 2505.649209110726, 2535.6957165140116, 2567.165671156872, 2570.0362364113457, 2606.569915963864, 2321.0135692330778, 2376.8336216464854, 2498.5877330240487, 2557.360659835041, 2558.2453176313034, 2446.9755302446924, 2546.707128680207, 2548.6686730725073, 2557.1050132453493, 2568.794496440299, 11877.703057423547, 11973.401329933555, 11980.64058078259, 11994.940025299818, 12000.459979300953, 6640.634765087918, 6889.138857642794, 6906.963955406679, 6915.792526224171, 6945.16658001038, 4083.0601966584013, 4395.252807022814, 4454.688171827974, 4474.77626118696, 4509.1658043262105, 1270.6505710929475, 1277.2655722959335, 1310.7575098606787, 1318.2551858200181, 1324.3245944568243, 13223.140495867738, 16134.112623805686, 16474.505764827074, 16705.331786728515, 16779.916100419665, 6014.458698717136, 6106.847328816815, 6127.172831667757, 6269.717862696099, 6335.968320158369, 13792.517261895986, 13877.306134693225, 13889.097208681404, 13899.16605003703, 13936.163830170222, 6844.076049733322, 6907.447404207652, 6908.689108990007, 6915.412189963909, 6925.272846351161, 6045.304789949124, 6232.906506402408, 6255.218097737783, 6298.275698294663, 6306.0, 3810.3522401191863, 4316.978415107905, 4524.660650451229, 4535.546445355504, 4560.95439045612, 1343.5230493174781, 1347.3263368315843, 1349.2511656030997, 1352.8241328627412, 1358.7418390505773, 782.7573452229827, 797.3621103117483, 806.5563939833069, 811.3630799822112, 830.6511265268601, 6110.266767987781, 6124.38756124384, 6320.652364119926, 6365.4589359904, 6371.585846919936, 595.7102872281548, 601.6931365003879, 603.6559161278029, 606.5875204860737, 614.717230074162, 2887.6101726267107, 3369.983150084283, 4115.012397024692, 4304.289792184254, 4334.306510958295, 14005.66946140115, 14207.573772786833, 14547.490837820626, 15020.62448438776, 15079.396824127132, 12336.50653973849, 14806.03760755569, 14915.776263356058, 14950.327235274439, 14984.625384365478, 7207.9639601801655, 8470.364722645827, 8597.914020859711, 8630.309575233967, 8634.179752923463, 6530.47756179495, 6887.690053947485, 6889.276625954202, 7017.473689473412, 7235.384992275505, 11770.3526306054, 13151.0136739743, 13459.259740714355, 13475.46098156102, 13746.175229486264, 13736.725265494435, 13760.31198440054, 13787.0, 13830.515931942333, 13993.650158745706, 9432.103950124727, 9670.371425857296, 9729.4648794317, 9750.0, 9766.951165244129, 10538.104261137889, 10583.735406614589, 10585.259031868003, 10694.465276735977, 10703.143748500257, 9217.216536594464, 9232.95383523078, 9244.260459163384, 9263.980962094029, 9436.103570160823, 9084.545772711206, 9112.134347237003, 9118.908810912071, 9120.954395228247, 9158.496282704515, 6492.577982431127, 8020.83958320842, 8099.797505062421, 8107.391945603986, 8132.30875375576, 5679.403662615366, 6019.0, 6053.878922421615, 6162.969185154046, 6199.783007594712, 6081.665508397081, 6163.3528479509005, 6259.3427690091885, 6291.874162516816, 6349.206349206349], "value": 5378.105008701271, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.7490631838757, 400.74953154278575, 400.7675548182055, 408.39149666996184, 412.4843945068664, 5606.859828504289, 5896.262967129109, 6052.7578896844125, 6067.452799536112, 6284.151639528663, 5195.740212989345, 5914.792982245623, 5959.791407300745, 6046.274447066347, 6117.2965109012475, 4286.807093680792, 4413.3379993001145, 4426.756528390937, 4448.7108337957925, 4477.395551600533, 3825.368814145663, 3849.576546579874, 4180.874573762777, 4446.333050042487, 4448.888777780549, 4375.7155784873885, 4391.407160033403, 4393.538678438766, 4400.97799511002, 4411.0, 3961.0493481564504, 4159.584041595846, 4288.099499105192, 4392.16548855718, 4392.494863090737, 3778.2821263960036, 3778.565464971536, 3779.45197946299, 3779.5653499847595, 3784.1863999240295, 4808.966072294474, 5814.738336774855, 5834.708264586754, 5838.868812883309, 5846.824595262149, 5034.89930201394, 5233.398159211702, 5234.81678141267, 5251.501107394792, 5267.894642107175, 5981.401859813984, 6338.334474880117, 6364.204474440695, 6377.394147555975, 6382.840428989312, 3801.7718936863876, 3874.651281384689, 3937.940930886039, 4287.056847493546, 4325.891852703676, 5598.384177740445, 5772.7113644317615, 6456.192266165481, 6476.805695829133, 6733.528652994292, 3731.533558305212, 3882.825272862728, 4378.978105109454, 4388.9466528033045, 4417.779111044435, 4472.0, 4474.217012022883, 4475.910481790346, 4476.485204201494, 4500.189965806187, 4763.237881938942, 4927.408710954708, 5247.317848679647, 5254.714199323306, 5280.709560974106, 6368.0, 6416.262129855033, 6423.6831449553665, 6430.614163150132, 6513.576617519846, 1411.5483045425572, 1438.9998950729353, 1514.174774747765, 1540.690413148837, 1546.6235050804792, 997.1374760831828, 1008.7528555503949, 1013.7566983923805, 1020.1940467031111, 1030.2633616963758, 5413.83758487246, 5687.943120568824, 6039.184710064173, 6044.758209671564, 6055.545834062463, 6616.503762217853, 6637.369449902348, 6637.639283946779, 6648.368405001614, 6673.099131617267, 5678.290213723285, 5997.430244126801, 6086.847828804227, 6123.4795042421, 6131.080337949344, 3438.2607739336163, 3500.842462089212, 3502.2820321833965, 3505.230867614556, 3511.5762131921683, 6016.322736382268, 6036.607620504653, 6150.446459818638, 6412.0, 6547.9046705053925, 5771.192033115367, 6412.615243085336, 6795.286494918061, 6822.692978815965, 6837.589744615339, 5277.947220527745, 5599.0, 6652.833679157963, 6721.092652491949, 6974.163100427981, 6234.573452848528, 6383.627520083204, 6474.935250647433, 6680.29448073531, 6684.331566843277, 6166.845828854314, 6228.034654628359, 6304.919376605801, 6586.736530538725, 6652.966735166293, 5896.818177274436, 6522.706478208397, 6527.51043671717, 6907.309269073053, 6984.650767461505, 4197.202531519001, 4400.62594679443, 4404.405405270376, 4407.955920440882, 4467.329900514948, 5774.364819869895, 6387.0, 6712.429443497357, 6747.831304217238, 6787.490938179558, 5414.5668346532975, 6217.502599791916, 6503.512236582181, 6534.248561415498, 6583.63789991555, 5529.751161197675, 6472.417482426604, 6514.967425162844, 6525.543211975116, 6539.967300163468, 5651.745671444877, 6153.569250152446, 6416.486681065597, 6432.678366081584, 6444.548881578245, 5955.813639702738, 6198.845028874314, 6472.385123413268, 6513.674316284072, 6542.803715888531, 5091.439941606494, 5352.35771707382, 6140.1710769047395, 6314.273858506331, 6402.583832050902], "value": 4654.555672967241, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.7864198024553, 842.5660784695879, 856.8243510080438, 879.9208071273588, 881.7751473374291, 16104.51686449407, 16796.91601541992, 16829.41097061603, 18585.90707046463, 19242.807571924277, 17856.0, 17881.642367152683, 18039.458816235532, 18147.455576332697, 18438.81561184388, 942.6700654770843, 951.7858481841599, 956.5934477846922, 964.0985678390692, 965.9420434773901, 967.2310513142033, 968.6803354892903, 970.4371464550579, 970.7184916374243, 1006.0040559845737, 1034.4103860799348, 1045.3466583385384, 1046.1735229168946, 1047.9476026198697, 1048.596290428183, 1015.28422462164, 1033.3076838518173, 1038.6987773545663, 1039.8804137524169, 1042.7393151712072, 754.5736658787822, 773.2267732267733, 775.2712450296704, 775.3913178155121, 776.7786180938461, 16368.918155409267, 16513.752293715603, 16646.417375391924, 17245.827541724546, 17337.739933901, 13930.860691393058, 16603.66792664152, 16693.0, 16872.409465668643, 17096.0, 12781.10532262742, 13278.66803329915, 13809.24049177295, 14017.299135043208, 14039.719205615933, 3425.366307233145, 3457.0665920201404, 3459.446488561843, 3463.2727127303046, 3471.9826400867832, 105044.81894944084, 130175.0, 130336.0, 130785.0, 133311.33344333217, 12661.240325580495, 12977.675558111123, 13009.934950325378, 13156.736865262641, 13238.4042718076, 24082.63876041861, 25024.0, 25106.497870042862, 25162.87418562932, 25377.238682839543, 7562.470627056054, 7729.265719756614, 7736.032995875516, 7737.187595302525, 7755.844883102306, 3736.140687641803, 3763.8870833875026, 3780.4896338994436, 3819.0643292393543, 3821.1402434452025, 4283.935740963888, 4346.8043938022865, 4390.626796722315, 4396.1867054595, 4411.977940110279, 931.5528546297815, 965.5510187762724, 972.2902281334524, 973.0, 974.858645496399, 643.3823529411817, 656.8686262747469, 673.1047706550277, 680.3162821364497, 697.9232284448707, 10160.593576256866, 10405.58377664885, 10944.616938407118, 11975.401229938469, 12126.333051682243, 658.8287045368239, 666.8366250268715, 666.9366410191024, 674.9865002700017, 687.5393486364148, 5405.8107966221, 5464.153056276284, 5502.5597952163735, 5586.720663966786, 5632.915506267409, 85796.71304930431, 87153.0, 106215.4689226549, 107016.92983070225, 107569.0, 64580.0, 95043.0, 95113.5244323774, 95190.52404737932, 97518.0, 61630.69184654048, 81490.59254703688, 81969.0, 83130.0, 83926.74109888356, 8908.663700444986, 8921.598528066383, 10828.404437755999, 11260.211785174959, 11486.712832179262, 39479.407808883465, 41703.58296416997, 42263.78868105763, 42671.50649727244, 42984.570154299305, 50979.49020509747, 54123.0, 54557.90884182374, 55150.0, 55329.44670553243, 16093.275802588678, 16734.91632541878, 16745.0, 16818.57953551171, 16828.57928551796, 17897.28410863603, 18110.456686299432, 18176.0, 18667.719984199975, 18684.065796710383, 15854.365825366856, 16184.838151618804, 16353.0, 16381.180940953143, 16524.917375413046, 16622.916885415496, 17200.827991720424, 17385.82614173842, 17419.651606968044, 17519.299228031246, 13384.397702103623, 13906.513272035834, 14717.264136793332, 15254.542363729106, 16967.406140785013, 11678.6496405108, 11731.178817483036, 11785.116116291141, 12269.38653067361, 12314.938425307817, 12866.099373043797, 13792.655183620089, 13837.377318020915, 13860.0, 13884.166949983033], "value": 8303.286700184379, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1544.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 115.0, 113.0, 114.0, 114.0, 119.0, 162.0, 114.0, 118.0], "value": 119.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 109.0, 107.0, 151.0, 113.0, 110.0, 111.0, 112.0, 135.0, 112.0], "value": 119.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [232.0, 223.0, 200.0, 220.0, 202.0, 219.0, 194.0, 201.0, 228.0, 262.0], "value": 218.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 59.0, 104.0, 88.0, 88.0, 50.0, 77.0, 93.0, 84.0], "value": 78.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 69.0, 82.0, 71.0, 70.0, 73.0, 85.0, 69.0, 71.0, 90.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 89.0, 89.0, 89.0, 90.0, 91.0, 103.0, 90.0, 111.0], "value": 93.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 102.0, 96.0, 97.0, 97.0, 95.0, 104.0, 120.0], "value": 100.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 93.0, 94.0, 92.0, 91.0, 90.0, 91.0, 94.0, 92.0, 90.0], "value": 91.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 50.0, 49.0, 49.0, 49.0, 48.0, 51.0, 50.0, 51.0], "value": 49.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 63.0, 69.0, 60.0, 56.0, 53.0, 56.0, 53.0, 55.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 82.0, 83.0, 83.0, 84.0, 81.0, 85.0, 83.0, 84.0], "value": 83.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 151.0, 163.0, 152.0, 127.0, 154.0, 152.0, 154.0, 270.0, 161.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 189.0, 194.0, 245.0, 167.0, 237.0, 246.0, 198.0, 179.0, 234.0], "value": 207.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 90.0, 93.0, 96.0, 99.0, 95.0, 68.0, 70.0, 96.0], "value": 85.6, "unit": "score"}]}]} 03:20:08 INFO - Return code: 0 03:20:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:20:08 ERROR - # TBPL SUCCESS # 03:20:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:20:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:20:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:20:08 INFO - 2017-04-22 03:20:08.386 screenresolution[1669:11445] starting screenresolution argv=screenresolution get 03:20:08 INFO - 2017-04-22 03:20:08.389 screenresolution[1669:11445] Display 0: 1600x1200x32@60 03:20:08 INFO - 2017-04-22 03:20:08.396 screenresolution[1670:11448] starting screenresolution argv=screenresolution list 03:20:08 INFO - Available Modes on Display 0 03:20:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:20:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:20:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:20:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:20:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:20:08 INFO - Intel Iris: 03:20:08 INFO - Chipset Model: Intel Iris 03:20:08 INFO - Type: GPU 03:20:08 INFO - Bus: Built-In 03:20:08 INFO - VRAM (Dynamic, Max): 1536 MB 03:20:08 INFO - Vendor: Intel (0x8086) 03:20:08 INFO - Device ID: 0x0a2e 03:20:08 INFO - Revision ID: 0x0009 03:20:08 INFO - Displays: 03:20:08 INFO - Display: 03:20:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:20:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:20:08 INFO - Display Serial Number: 1600x1200 60 03:20:08 INFO - Main Display: Yes 03:20:08 INFO - Mirror: Off 03:20:08 INFO - Online: Yes 03:20:08 INFO - Rotation: Supported 03:20:08 INFO - Return code: 0 03:20:08 INFO - Running post-action listener: _resource_record_post_action 03:20:08 INFO - [mozharness: 2017-04-22 10:20:08.643524Z] Finished run-tests step (success) 03:20:08 INFO - Running post-run listener: _resource_record_post_run 03:20:08 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 35049984; Write bytes: 521965568; Read time: 324; Write time: 1891 03:20:08 INFO - TinderboxPrint: CPU usage
54.2% 03:20:08 INFO - TinderboxPrint: I/O read bytes / time
35,049,984 / 324 03:20:08 INFO - TinderboxPrint: I/O write bytes / time
521,965,568 / 1,891 03:20:08 INFO - TinderboxPrint: CPU idle
2,191.8 (45.8%) 03:20:08 INFO - TinderboxPrint: CPU system
966.2 (20.2%) 03:20:08 INFO - TinderboxPrint: CPU user
1,627.6 (34.0%) 03:20:08 INFO - TinderboxPrint: Swap in / out
239,534,080 / 0 03:20:08 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 194660864; Write bytes: 194683392; Read time: 14892; Write time: 567 03:20:08 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 34058752; Write bytes: 310455808; Read time: 307; Write time: 1275 03:20:09 INFO - Running post-run listener: _upload_blobber_files 03:20:09 INFO - Blob upload gear active. 03:20:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:20:09 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 03:20:09 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'] 03:20:09 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 03:20:09 INFO - (blobuploader) - INFO - Open directory for files ... 03:20:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:20:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:20:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:10 INFO - (blobuploader) - INFO - Done attempting. 03:20:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:20:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:20:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:11 INFO - (blobuploader) - INFO - Done attempting. 03:20:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:20:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:20:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:12 INFO - (blobuploader) - INFO - Done attempting. 03:20:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:20:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:20:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:14 INFO - (blobuploader) - INFO - Done attempting. 03:20:14 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:14 INFO - Return code: 0 03:20:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:20:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c17ba69e37d34e597a0170c064b5c734d80e1cb24798b182cdbcdb8f8038d286bb288716a6c88f9b6791d0721c3701650f063947e867056ad1d510a98dfe1abe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e0405f32c81f4b318fb6af14ad1fb783d65db3a5f8cd0d39945a3dc10640429cc7d017f18873b71106ee156f128d0ab8cacc47bc6356014ac8472ede88d4df6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca91a46b53cba06985a8c68d2c23d2c719ae8f3f06def192018bdc8ced1b95a9ff9e01c5de892f321a46155a150e7fc62671bccba2e4cd8bdd2c86df1e74d9b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/676ae6ff4a77f2c33dfd80aab6846dc0c772c70fcf2c4453785cbea010514e38bf93aad04aaa915f62f9962a94cb50c2d81c842fbcdba2b07c0638e14bafc58e"} 03:20:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:14 INFO - Contents: 03:20:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c17ba69e37d34e597a0170c064b5c734d80e1cb24798b182cdbcdb8f8038d286bb288716a6c88f9b6791d0721c3701650f063947e867056ad1d510a98dfe1abe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e0405f32c81f4b318fb6af14ad1fb783d65db3a5f8cd0d39945a3dc10640429cc7d017f18873b71106ee156f128d0ab8cacc47bc6356014ac8472ede88d4df6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca91a46b53cba06985a8c68d2c23d2c719ae8f3f06def192018bdc8ced1b95a9ff9e01c5de892f321a46155a150e7fc62671bccba2e4cd8bdd2c86df1e74d9b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/676ae6ff4a77f2c33dfd80aab6846dc0c772c70fcf2c4453785cbea010514e38bf93aad04aaa915f62f9962a94cb50c2d81c842fbcdba2b07c0638e14bafc58e"} 03:20:14 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:14 INFO - Copying logs to upload dir... 03:20:14 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.130867 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2017-04-22 03:20:14.993044) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-22 03:20:14.996421) ========= 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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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/c17ba69e37d34e597a0170c064b5c734d80e1cb24798b182cdbcdb8f8038d286bb288716a6c88f9b6791d0721c3701650f063947e867056ad1d510a98dfe1abe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e0405f32c81f4b318fb6af14ad1fb783d65db3a5f8cd0d39945a3dc10640429cc7d017f18873b71106ee156f128d0ab8cacc47bc6356014ac8472ede88d4df6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca91a46b53cba06985a8c68d2c23d2c719ae8f3f06def192018bdc8ced1b95a9ff9e01c5de892f321a46155a150e7fc62671bccba2e4cd8bdd2c86df1e74d9b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/676ae6ff4a77f2c33dfd80aab6846dc0c772c70fcf2c4453785cbea010514e38bf93aad04aaa915f62f9962a94cb50c2d81c842fbcdba2b07c0638e14bafc58e"} build_url:https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011474 build_url: 'https://queue.taskcluster.net/v1/task/dfXQn7i9SSik2A_8MD0QbA/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/c17ba69e37d34e597a0170c064b5c734d80e1cb24798b182cdbcdb8f8038d286bb288716a6c88f9b6791d0721c3701650f063947e867056ad1d510a98dfe1abe", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e0405f32c81f4b318fb6af14ad1fb783d65db3a5f8cd0d39945a3dc10640429cc7d017f18873b71106ee156f128d0ab8cacc47bc6356014ac8472ede88d4df6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca91a46b53cba06985a8c68d2c23d2c719ae8f3f06def192018bdc8ced1b95a9ff9e01c5de892f321a46155a150e7fc62671bccba2e4cd8bdd2c86df1e74d9b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/676ae6ff4a77f2c33dfd80aab6846dc0c772c70fcf2c4453785cbea010514e38bf93aad04aaa915f62f9962a94cb50c2d81c842fbcdba2b07c0638e14bafc58e"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-22 03:20:15.032989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:20:15.033320) ========= 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.ZICkjlKDXk/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.eTzhbOkmBA/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.004483 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-22 03:20:15.081663) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-22 03:20:15.081984) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-22 03:20:15.082317) ========= ========= Total master_lag: 0.39 =========