builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0361 starttime: 1485420410.36 results: success (0) buildid: 20170125234131 builduid: 83b8677afe8e40d6b95d0bd83bf03162 revision: f0e4b9855df1986fbc3e560b6373bd4f276440e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 00:46:50.357426) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 00:46:50.358049) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 00:46:50.358478) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 00:46:50.385632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 00:46:50.386018) ========= 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.dr0957Frvt/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.g5DVoVKYMf/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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-01-26 00:46:50-- 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% 204M=0s 2017-01-26 00:46:50 (204 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175774 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 00:46:50.717633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 00:46:50.717941) ========= 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.dr0957Frvt/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.g5DVoVKYMf/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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.026888 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 00:46:50.768868) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-26 00:46:50.769214) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f0e4b9855df1986fbc3e560b6373bd4f276440e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f0e4b9855df1986fbc3e560b6373bd4f276440e5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dr0957Frvt/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.g5DVoVKYMf/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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-01-26 00:46:50,877 truncating revision to first 12 chars 2017-01-26 00:46:50,877 Setting DEBUG logging. 2017-01-26 00:46:50,877 attempt 1/10 2017-01-26 00:46:50,877 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f0e4b9855df1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-26 00:46:52,006 unpacking tar archive at: mozilla-aurora-f0e4b9855df1/testing/mozharness/ program finished with exit code 0 elapsedTime=1.389231 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-26 00:46:52.183698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 00:46:52.184037) ========= script_repo_revision: f0e4b9855df1986fbc3e560b6373bd4f276440e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 00:46:52.184463) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 00:46:52.184733) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 00:46:52.205111) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-26 00:46:52.205530) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.dr0957Frvt/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.g5DVoVKYMf/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 00:46:52 INFO - MultiFileLogger online at 20170126 00:46:52 in /builds/slave/test 00:46:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 00:46:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:46:52 INFO - {'append_to_log': False, 00:46:52 INFO - 'base_work_dir': '/builds/slave/test', 00:46:52 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 00:46:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:46:52 INFO - 'branch': 'Mozilla-Aurora', 00:46:52 INFO - 'buildbot_json_path': 'buildprops.json', 00:46:52 INFO - 'config_files': ('talos/mac_config.py',), 00:46:52 INFO - 'default_actions': ('clobber', 00:46:52 INFO - 'read-buildbot-config', 00:46:52 INFO - 'download-and-extract', 00:46:52 INFO - 'populate-webroot', 00:46:52 INFO - 'create-virtualenv', 00:46:52 INFO - 'install', 00:46:52 INFO - 'run-tests'), 00:46:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:46:52 INFO - 'download_minidump_stackwalk': True, 00:46:52 INFO - 'download_symbols': 'ondemand', 00:46:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:46:52 INFO - 'tooltool.py': '/tools/tooltool.py', 00:46:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:46:52 INFO - '/tools/misc-python/virtualenv.py')}, 00:46:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:46:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:46:52 INFO - 'installer_path': 'installer.exe', 00:46:52 INFO - 'log_level': 'info', 00:46:52 INFO - 'log_name': 'talos', 00:46:52 INFO - 'log_to_console': True, 00:46:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:46:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:46:52 INFO - 'opt_config_files': (), 00:46:52 INFO - 'pip_index': False, 00:46:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:46:52 INFO - 'cmd': ('bash', 00:46:52 INFO - '-c', 00:46:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:46:52 INFO - 'enabled': True, 00:46:52 INFO - 'halt_on_failure': False, 00:46:52 INFO - 'name': 'check_screen_resolution'},), 00:46:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:46:52 INFO - 'cmd': ('bash', 00:46:52 INFO - '-c', 00:46:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:46:52 INFO - 'enabled': True, 00:46:52 INFO - 'halt_on_failure': False, 00:46:52 INFO - 'name': 'check_screen_resolution'},), 00:46:52 INFO - 'run_cmd_checks_enabled': True, 00:46:52 INFO - 'sps_profile': False, 00:46:52 INFO - 'sps_profile_interval': 0, 00:46:52 INFO - 'suite': 'dromaeojs-e10s', 00:46:52 INFO - 'system_bits': '32', 00:46:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:46:52 INFO - 'title': 't-yosemite-r7-0361', 00:46:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:46:52 INFO - 'use_talos_json': True, 00:46:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:46:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:46:52 INFO - 'work_dir': 'build'} 00:46:52 INFO - [mozharness: 2017-01-26 08:46:52.420900Z] Running clobber step. 00:46:52 INFO - Running pre-action listener: _resource_record_pre_action 00:46:52 INFO - Running main action method: clobber 00:46:52 INFO - rmtree: /builds/slave/test/build 00:46:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:46:54 INFO - Running post-action listener: _resource_record_post_action 00:46:54 INFO - [mozharness: 2017-01-26 08:46:54.778837Z] Finished clobber step (success) 00:46:54 INFO - [mozharness: 2017-01-26 08:46:54.778966Z] Running read-buildbot-config step. 00:46:54 INFO - Running pre-action listener: _resource_record_pre_action 00:46:54 INFO - Running main action method: read_buildbot_config 00:46:54 INFO - Using buildbot properties: 00:46:54 INFO - { 00:46:54 INFO - "project": "", 00:46:54 INFO - "product": "firefox", 00:46:54 INFO - "script_repo_revision": "production", 00:46:54 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 00:46:54 INFO - "repository": "", 00:46:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 00:46:54 INFO - "buildid": "20170125234131", 00:46:54 INFO - "pgo_build": "False", 00:46:54 INFO - "basedir": "/builds/slave/test", 00:46:54 INFO - "buildnumber": 43, 00:46:54 INFO - "slavename": "t-yosemite-r7-0361", 00:46:54 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 00:46:54 INFO - "platform": "yosemite_r7", 00:46:54 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 00:46:54 INFO - "branch": "mozilla-aurora", 00:46:54 INFO - "repo_path": "releases/mozilla-aurora", 00:46:54 INFO - "revision": "f0e4b9855df1986fbc3e560b6373bd4f276440e5", 00:46:54 INFO - "stage_platform": "macosx64", 00:46:54 INFO - "builduid": "83b8677afe8e40d6b95d0bd83bf03162", 00:46:54 INFO - "slavebuilddir": "test" 00:46:54 INFO - } 00:46:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 00:46:54 INFO - Running post-action listener: _resource_record_post_action 00:46:54 INFO - [mozharness: 2017-01-26 08:46:54.782437Z] Finished read-buildbot-config step (success) 00:46:54 INFO - [mozharness: 2017-01-26 08:46:54.782572Z] Running download-and-extract step. 00:46:54 INFO - Running pre-action listener: _resource_record_pre_action 00:46:54 INFO - Running main action method: download_and_extract 00:46:54 INFO - mkdir: /builds/slave/test/build/tests 00:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:46:54 INFO - trying https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 00:46:54 INFO - Downloading https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 00:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 00:46:55 INFO - Downloaded 1199 bytes. 00:46:55 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 00:46:55 INFO - Using the following test package requirements: 00:46:55 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 00:46:55 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 00:46:55 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 00:46:55 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 00:46:55 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 00:46:55 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 00:46:55 INFO - u'jsshell-mac.zip'], 00:46:55 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 00:46:55 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 00:46:55 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 00:46:55 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 00:46:55 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 00:46:55 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 00:46:55 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 00:46:55 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 00:46:55 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 00:46:55 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 00:46:55 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 00:46:55 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 00:46:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 00:46:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 00:46:55 INFO - Fetch https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 00:46:56 INFO - Expected file size: 16349693 00:46:56 INFO - Obtained file size: 16349693 00:47:03 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 00:47:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 00:47:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 00:47:03 INFO - Fetch https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 00:47:04 INFO - Expected file size: 16349693 00:47:04 INFO - Obtained file size: 16349693 00:47:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 00:47:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 00:47:10 INFO - Fetch https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 00:47:11 INFO - Expected file size: 14403485 00:47:11 INFO - Obtained file size: 14403485 00:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:12 INFO - trying https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 00:47:12 INFO - Downloading https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 00:47:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 00:47:14 INFO - Downloaded 73893132 bytes. 00:47:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 00:47:14 INFO - mkdir: /builds/slave/test/properties 00:47:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:47:14 INFO - Writing to file /builds/slave/test/properties/build_url 00:47:14 INFO - Contents: 00:47:14 INFO - build_url:https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 00:47:14 INFO - Running post-action listener: _resource_record_post_action 00:47:14 INFO - Running post-action listener: set_extra_try_arguments 00:47:14 INFO - [mozharness: 2017-01-26 08:47:14.853644Z] Finished download-and-extract step (success) 00:47:14 INFO - [mozharness: 2017-01-26 08:47:14.853793Z] Running populate-webroot step. 00:47:14 INFO - Running pre-action listener: _resource_record_pre_action 00:47:14 INFO - Running main action method: populate_webroot 00:47:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:47:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:47:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:47:14 INFO - '--tppagecycles', 00:47:14 INFO - '7'], 00:47:14 INFO - 'tests': ['tsvgm']}}, 00:47:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:47:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:47:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:47:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:47:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:47:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:47:14 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:47:14 INFO - 'talos_options': ['--disable-e10s'], 00:47:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:47:14 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:47:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:47:14 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:47:14 INFO - 'talos_options': ['--disable-e10s'], 00:47:14 INFO - 'tests': ['damp', 'tps']}, 00:47:14 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:47:14 INFO - 'tests': ['damp', 'tps']}, 00:47:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:47:14 INFO - 'tests': ['dromaeo_dom']}, 00:47:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:47:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:47:14 INFO - 'tests': ['basic_compositor_video']}, 00:47:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:47:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:47:14 INFO - 'tests': ['a11yr', 00:47:14 INFO - 'ts_paint', 00:47:14 INFO - 'tpaint', 00:47:14 INFO - 'sessionrestore', 00:47:14 INFO - 'sessionrestore_no_auto_restore', 00:47:14 INFO - 'tabpaint']}, 00:47:14 INFO - 'other-e10s': {'tests': ['a11yr', 00:47:14 INFO - 'ts_paint', 00:47:14 INFO - 'tpaint', 00:47:14 INFO - 'sessionrestore', 00:47:14 INFO - 'sessionrestore_no_auto_restore', 00:47:14 INFO - 'tabpaint']}, 00:47:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:47:14 INFO - 'ts_paint', 00:47:14 INFO - 'tpaint', 00:47:14 INFO - 'sessionrestore', 00:47:14 INFO - 'sessionrestore_no_auto_restore', 00:47:14 INFO - 'tabpaint']}, 00:47:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:47:14 INFO - 'ts_paint', 00:47:14 INFO - 'tpaint', 00:47:14 INFO - 'sessionrestore', 00:47:14 INFO - 'sessionrestore_no_auto_restore', 00:47:14 INFO - 'tabpaint']}, 00:47:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:47:14 INFO - 'tests': ['a11yr', 00:47:14 INFO - 'ts_paint', 00:47:14 INFO - 'tpaint', 00:47:14 INFO - 'sessionrestore', 00:47:14 INFO - 'sessionrestore_no_auto_restore', 00:47:14 INFO - 'tabpaint']}, 00:47:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:47:14 INFO - 'tests': ['a11yr', 00:47:14 INFO - 'ts_paint', 00:47:14 INFO - 'tpaint', 00:47:14 INFO - 'sessionrestore', 00:47:14 INFO - 'sessionrestore_no_auto_restore', 00:47:14 INFO - 'tabpaint']}, 00:47:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:47:14 INFO - 'tests': ['tsvgx', 00:47:14 INFO - 'tsvgr_opacity', 00:47:14 INFO - 'tart', 00:47:14 INFO - 'tscrollx', 00:47:14 INFO - 'cart', 00:47:14 INFO - 'tsvg_static']}, 00:47:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:47:14 INFO - 'tsvgr_opacity', 00:47:14 INFO - 'tart', 00:47:14 INFO - 'tscrollx', 00:47:14 INFO - 'cart', 00:47:14 INFO - 'tsvg_static']}, 00:47:14 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:47:14 INFO - 'talos_options': ['--disable-e10s'], 00:47:14 INFO - 'tests': ['tp5o']}, 00:47:14 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:47:14 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:47:14 INFO - 'talos_options': ['--disable-e10s', 00:47:14 INFO - '--xperf_path', 00:47:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:47:14 INFO - 'tests': ['tp5n']}, 00:47:14 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:47:14 INFO - 'talos_options': ['--xperf_path', 00:47:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:47:14 INFO - 'tests': ['tp5n']}}, 00:47:14 INFO - 'talos.zip': {'path': '', 00:47:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:47:14 INFO - Running post-action listener: _resource_record_post_action 00:47:14 INFO - [mozharness: 2017-01-26 08:47:14.872323Z] Finished populate-webroot step (success) 00:47:14 INFO - [mozharness: 2017-01-26 08:47:14.872460Z] Running create-virtualenv step. 00:47:14 INFO - Running pre-action listener: _resource_record_pre_action 00:47:14 INFO - Running main action method: create_virtualenv 00:47:14 INFO - Creating virtualenv /builds/slave/test/build/venv 00:47:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 00:47:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:47:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:47:14 INFO - Using real prefix '/tools/python27' 00:47:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:47:15 INFO - Installing distribute.............................................................................................................................................................................................done. 00:47:18 INFO - Installing pip.................done. 00:47:18 INFO - Return code: 0 00:47:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:47:18 INFO - Reading from file tmpfile_stdout 00:47:18 INFO - Output received: 00:47:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 00:47:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10111b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7bc718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ef6d30>, '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 0x100e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eebbe8>, '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.dr0957Frvt/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.g5DVoVKYMf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:47:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr0957Frvt/Render', 00:47:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:47:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:47:18 INFO - 'HOME': '/Users/cltbld', 00:47:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:47:18 INFO - 'LOGNAME': 'cltbld', 00:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:18 INFO - 'MOZ_NO_REMOTE': '1', 00:47:18 INFO - 'NO_EM_RESTART': '1', 00:47:18 INFO - 'PAGER': '/bin/cat', 00:47:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:18 INFO - 'PWD': '/builds/slave/test', 00:47:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:47:18 INFO - 'SHELL': '/bin/bash', 00:47:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5DVoVKYMf/Listeners', 00:47:18 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 00:47:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:47:18 INFO - 'USER': 'cltbld', 00:47:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:47:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:18 INFO - 'XPC_FLAGS': '0x0', 00:47:18 INFO - 'XPC_SERVICE_NAME': '0', 00:47:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 00:47:19 INFO - Cleaning up... 00:47:19 INFO - Return code: 0 00:47:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:19 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 0x101118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10111b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7bc718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ef6d30>, '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 0x100e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eebbe8>, '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.dr0957Frvt/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.g5DVoVKYMf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:47:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:47:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:47:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr0957Frvt/Render', 00:47:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:47:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:47:19 INFO - 'HOME': '/Users/cltbld', 00:47:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:47:19 INFO - 'LOGNAME': 'cltbld', 00:47:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:19 INFO - 'MOZ_NO_REMOTE': '1', 00:47:19 INFO - 'NO_EM_RESTART': '1', 00:47:19 INFO - 'PAGER': '/bin/cat', 00:47:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:47:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:19 INFO - 'PWD': '/builds/slave/test', 00:47:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:47:19 INFO - 'SHELL': '/bin/bash', 00:47:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5DVoVKYMf/Listeners', 00:47:19 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 00:47:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:47:19 INFO - 'USER': 'cltbld', 00:47:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:47:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:47:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:19 INFO - 'XPC_FLAGS': '0x0', 00:47:19 INFO - 'XPC_SERVICE_NAME': '0', 00:47:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:47:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:19 INFO - Downloading/unpacking psutil>=3.1.1 00:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:47:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:47:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:47:22 INFO - Installing collected packages: psutil 00:47:22 INFO - Running setup.py install for psutil 00:47:22 INFO - building 'psutil._psutil_osx' extension 00:47:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 00:47:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 00:47:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 00:47:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 00:47:23 INFO - building 'psutil._psutil_posix' extension 00:47:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 00:47:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:47:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:47:23 INFO - ^ 00:47:23 INFO - 1 warning generated. 00:47:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 00:47:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:47:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:47:23 INFO - Successfully installed psutil 00:47:23 INFO - Cleaning up... 00:47:24 INFO - Return code: 0 00:47:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:24 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 0x101118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10111b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7bc718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ef6d30>, '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 0x100e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eebbe8>, '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.dr0957Frvt/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.g5DVoVKYMf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:47:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:47:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr0957Frvt/Render', 00:47:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:47:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:47:24 INFO - 'HOME': '/Users/cltbld', 00:47:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:47:24 INFO - 'LOGNAME': 'cltbld', 00:47:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:24 INFO - 'MOZ_NO_REMOTE': '1', 00:47:24 INFO - 'NO_EM_RESTART': '1', 00:47:24 INFO - 'PAGER': '/bin/cat', 00:47:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:47:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:24 INFO - 'PWD': '/builds/slave/test', 00:47:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:47:24 INFO - 'SHELL': '/bin/bash', 00:47:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5DVoVKYMf/Listeners', 00:47:24 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 00:47:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:47:24 INFO - 'USER': 'cltbld', 00:47:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:47:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:47:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:24 INFO - 'XPC_FLAGS': '0x0', 00:47:24 INFO - 'XPC_SERVICE_NAME': '0', 00:47:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:47:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:47:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:47:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:47:26 INFO - Installing collected packages: mozsystemmonitor 00:47:26 INFO - Running setup.py install for mozsystemmonitor 00:47:27 INFO - Successfully installed mozsystemmonitor 00:47:27 INFO - Cleaning up... 00:47:27 INFO - Return code: 0 00:47:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:27 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 0x101118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10111b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7bc718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ef6d30>, '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 0x100e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eebbe8>, '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.dr0957Frvt/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.g5DVoVKYMf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:47:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 00:47:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 00:47:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr0957Frvt/Render', 00:47:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:47:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:47:27 INFO - 'HOME': '/Users/cltbld', 00:47:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:47:27 INFO - 'LOGNAME': 'cltbld', 00:47:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:27 INFO - 'MOZ_NO_REMOTE': '1', 00:47:27 INFO - 'NO_EM_RESTART': '1', 00:47:27 INFO - 'PAGER': '/bin/cat', 00:47:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:47:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:27 INFO - 'PWD': '/builds/slave/test', 00:47:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:47:27 INFO - 'SHELL': '/bin/bash', 00:47:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5DVoVKYMf/Listeners', 00:47:27 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 00:47:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:47:27 INFO - 'USER': 'cltbld', 00:47:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:47:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:47:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:27 INFO - 'XPC_FLAGS': '0x0', 00:47:27 INFO - 'XPC_SERVICE_NAME': '0', 00:47:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:47:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:27 INFO - Downloading/unpacking jsonschema==2.5.1 00:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:47:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:30 INFO - Downloading functools32-3.2.3-2.tar.gz 00:47:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:47:30 INFO - warning: no files found matching '*.txt' 00:47:30 INFO - no previously-included directories found matching 'build' 00:47:30 INFO - no previously-included directories found matching 'dist' 00:47:30 INFO - no previously-included directories found matching '.git*' 00:47:30 INFO - Installing collected packages: jsonschema, functools32 00:47:30 INFO - Running setup.py install for functools32 00:47:30 INFO - warning: no files found matching '*.txt' 00:47:30 INFO - no previously-included directories found matching 'build' 00:47:30 INFO - no previously-included directories found matching 'dist' 00:47:30 INFO - no previously-included directories found matching '.git*' 00:47:30 INFO - Successfully installed jsonschema functools32 00:47:30 INFO - Cleaning up... 00:47:30 INFO - Return code: 0 00:47:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:30 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 0x101118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10111b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7bc718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ef6d30>, '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 0x100e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eebbe8>, '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.dr0957Frvt/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.g5DVoVKYMf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 00:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 00:47:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr0957Frvt/Render', 00:47:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:47:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:47:30 INFO - 'HOME': '/Users/cltbld', 00:47:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:47:30 INFO - 'LOGNAME': 'cltbld', 00:47:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:30 INFO - 'MOZ_NO_REMOTE': '1', 00:47:30 INFO - 'NO_EM_RESTART': '1', 00:47:30 INFO - 'PAGER': '/bin/cat', 00:47:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:47:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:30 INFO - 'PWD': '/builds/slave/test', 00:47:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:47:30 INFO - 'SHELL': '/bin/bash', 00:47:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5DVoVKYMf/Listeners', 00:47:30 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 00:47:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:47:30 INFO - 'USER': 'cltbld', 00:47:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:47:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:47:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:30 INFO - 'XPC_FLAGS': '0x0', 00:47:30 INFO - 'XPC_SERVICE_NAME': '0', 00:47:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:47:31 INFO - Cleaning up... 00:47:31 INFO - Return code: 0 00:47:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:47: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')]} 00:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47: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')]} 00:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:31 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 0x101118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10111b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7bc718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ef6d30>, '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 0x100e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eebbe8>, '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.dr0957Frvt/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.g5DVoVKYMf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:47:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:47:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:47:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr0957Frvt/Render', 00:47:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:47:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:47:31 INFO - 'HOME': '/Users/cltbld', 00:47:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:47:31 INFO - 'LOGNAME': 'cltbld', 00:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:31 INFO - 'MOZ_NO_REMOTE': '1', 00:47:31 INFO - 'NO_EM_RESTART': '1', 00:47:31 INFO - 'PAGER': '/bin/cat', 00:47:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:31 INFO - 'PWD': '/builds/slave/test', 00:47:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:47:31 INFO - 'SHELL': '/bin/bash', 00:47:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5DVoVKYMf/Listeners', 00:47:31 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 00:47:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:47:31 INFO - 'USER': 'cltbld', 00:47:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:47:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:31 INFO - 'XPC_FLAGS': '0x0', 00:47:31 INFO - 'XPC_SERVICE_NAME': '0', 00:47:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:47:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:31 INFO - Downloading/unpacking blobuploader==1.2.4 00:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:34 INFO - Downloading blobuploader-1.2.4.tar.gz 00:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:47:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:47:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:35 INFO - Downloading docopt-0.6.1.tar.gz 00:47:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:47:35 INFO - Installing collected packages: blobuploader, requests, docopt 00:47:35 INFO - Running setup.py install for blobuploader 00:47:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:47:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:47:35 INFO - Running setup.py install for requests 00:47:36 INFO - Running setup.py install for docopt 00:47:36 INFO - Successfully installed blobuploader requests docopt 00:47:36 INFO - Cleaning up... 00:47:36 INFO - Return code: 0 00:47:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:36 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 0x101118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10111b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7bc718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ef6d30>, '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 0x100e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eebbe8>, '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.dr0957Frvt/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.g5DVoVKYMf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:47:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:47:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:47:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr0957Frvt/Render', 00:47:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:47:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:47:36 INFO - 'HOME': '/Users/cltbld', 00:47:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:47:36 INFO - 'LOGNAME': 'cltbld', 00:47:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:36 INFO - 'MOZ_NO_REMOTE': '1', 00:47:36 INFO - 'NO_EM_RESTART': '1', 00:47:36 INFO - 'PAGER': '/bin/cat', 00:47:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:47:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:36 INFO - 'PWD': '/builds/slave/test', 00:47:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:47:36 INFO - 'SHELL': '/bin/bash', 00:47:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5DVoVKYMf/Listeners', 00:47:36 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 00:47:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:47:36 INFO - 'USER': 'cltbld', 00:47:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:47:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:47:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:36 INFO - 'XPC_FLAGS': '0x0', 00:47:36 INFO - 'XPC_SERVICE_NAME': '0', 00:47:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:47:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:47:36 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-mShpI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:47:36 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-ICOcQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:47:36 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-euQ_qi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:47:36 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-2E0nEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:47:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:47:36 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-xWygHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:47:37 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-o3gXgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:47:37 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-6COq3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:47:37 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-4nXxSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:47:37 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-vB6qZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:47:37 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-vtXLU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:47:37 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-B4Qe56-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:47:37 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-movV7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:47:37 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-kCj6Gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:47:37 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-tdCZJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:47:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:47:38 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-TShZjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:47:38 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-6Ma7uW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:47:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:47:38 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-gIdCbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:47:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:47:38 INFO - Running setup.py install for manifestparser 00:47:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:47:38 INFO - Running setup.py install for mozcrash 00:47:38 INFO - Running setup.py install for mozdebug 00:47:38 INFO - Running setup.py install for mozdevice 00:47:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:47:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:47:38 INFO - Running setup.py install for mozfile 00:47:39 INFO - Running setup.py install for mozhttpd 00:47:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:47:39 INFO - Running setup.py install for mozinfo 00:47:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:47:39 INFO - Running setup.py install for mozInstall 00:47:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:47:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:47:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:47:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:47:39 INFO - Running setup.py install for mozleak 00:47:39 INFO - Running setup.py install for mozlog 00:47:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:47:39 INFO - Running setup.py install for moznetwork 00:47:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:47:39 INFO - Running setup.py install for mozprocess 00:47:40 INFO - Running setup.py install for mozprofile 00:47:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:47:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:47:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:47:40 INFO - Running setup.py install for mozrunner 00:47:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:47:40 INFO - Running setup.py install for mozscreenshot 00:47:40 INFO - Running setup.py install for moztest 00:47:40 INFO - Running setup.py install for mozversion 00:47:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:47:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:47:40 INFO - Cleaning up... 00:47:40 INFO - Return code: 0 00:47:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:40 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 0x101118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10111b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7bc718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ef6d30>, '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 0x100e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eebbe8>, '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.dr0957Frvt/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.g5DVoVKYMf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:47:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 00:47:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:47:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr0957Frvt/Render', 00:47:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:47:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:47:40 INFO - 'HOME': '/Users/cltbld', 00:47:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:47:40 INFO - 'LOGNAME': 'cltbld', 00:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:40 INFO - 'MOZ_NO_REMOTE': '1', 00:47:40 INFO - 'NO_EM_RESTART': '1', 00:47:40 INFO - 'PAGER': '/bin/cat', 00:47:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:40 INFO - 'PWD': '/builds/slave/test', 00:47:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:47:40 INFO - 'SHELL': '/bin/bash', 00:47:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5DVoVKYMf/Listeners', 00:47:40 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 00:47:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:47:40 INFO - 'USER': 'cltbld', 00:47:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:47:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:40 INFO - 'XPC_FLAGS': '0x0', 00:47:40 INFO - 'XPC_SERVICE_NAME': '0', 00:47:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:47:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:47:41 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-fHOera-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 00:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:47:41 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-O7LIuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:47:41 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-KBUAnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:47:41 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-0YlS8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:47:41 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-5KgWq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 00:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:47:41 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-7KLwXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 00:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:47:41 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-u1TEiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 00:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:47:41 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-fWfvob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 00:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:47:41 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-BmuqTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 00:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:47:42 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-RwqZBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:47:42 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-H1RQHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 00:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:47:42 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-KKy799-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 00:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:47:42 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-RHNsKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 00:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:47:42 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-U2LW82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:47:42 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-D35PXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 00:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:47:42 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-3R7DSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 00:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:47:42 INFO - Running setup.py (path:/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/pip-qZ917g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:47:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:47:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:47:45 INFO - Downloading blessings-1.6.tar.gz 00:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:47:45 INFO - Installing collected packages: blessings 00:47:45 INFO - Running setup.py install for blessings 00:47:45 INFO - Successfully installed blessings 00:47:45 INFO - Cleaning up... 00:47:45 INFO - Return code: 0 00:47:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:47:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:47:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:47:46 INFO - Reading from file tmpfile_stdout 00:47:46 INFO - Current package versions: 00:47:46 INFO - blessings == 1.6 00:47:46 INFO - blobuploader == 1.2.4 00:47:46 INFO - docopt == 0.6.1 00:47:46 INFO - functools32 == 3.2.3-2 00:47:46 INFO - jsonschema == 2.5.1 00:47:46 INFO - manifestparser == 1.1 00:47:46 INFO - mozInstall == 1.12 00:47:46 INFO - mozcrash == 1.0 00:47:46 INFO - mozdebug == 0.1 00:47:46 INFO - mozdevice == 0.49 00:47:46 INFO - mozfile == 1.2 00:47:46 INFO - mozhttpd == 0.7 00:47:46 INFO - mozinfo == 0.9 00:47:46 INFO - mozleak == 0.1 00:47:46 INFO - mozlog == 3.4 00:47:46 INFO - moznetwork == 0.27 00:47:46 INFO - mozprocess == 0.24 00:47:46 INFO - mozprofile == 0.28 00:47:46 INFO - mozrunner == 6.13 00:47:46 INFO - mozscreenshot == 0.1 00:47:46 INFO - mozsystemmonitor == 0.3 00:47:46 INFO - moztest == 0.8 00:47:46 INFO - mozversion == 1.4 00:47:46 INFO - psutil == 3.1.1 00:47:46 INFO - requests == 1.2.3 00:47:46 INFO - wsgiref == 0.1.2 00:47:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:47 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 0x101118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10111b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7bc718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ef6d30>, '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 0x100e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eebbe8>, '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.dr0957Frvt/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.g5DVoVKYMf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:47:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 00:47:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 00:47:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr0957Frvt/Render', 00:47:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:47:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:47:47 INFO - 'HOME': '/Users/cltbld', 00:47:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:47:47 INFO - 'LOGNAME': 'cltbld', 00:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:47 INFO - 'MOZ_NO_REMOTE': '1', 00:47:47 INFO - 'NO_EM_RESTART': '1', 00:47:47 INFO - 'PAGER': '/bin/cat', 00:47:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:47 INFO - 'PWD': '/builds/slave/test', 00:47:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:47:47 INFO - 'SHELL': '/bin/bash', 00:47:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5DVoVKYMf/Listeners', 00:47:47 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 00:47:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:47:47 INFO - 'USER': 'cltbld', 00:47:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:47:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:47 INFO - 'XPC_FLAGS': '0x0', 00:47:47 INFO - 'XPC_SERVICE_NAME': '0', 00:47:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 00:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 00:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 00:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 00:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 00:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 00:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 00:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 00:47:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 00:47:47 INFO - Cleaning up... 00:47:47 INFO - Return code: 0 00:47:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:47:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101118b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10111b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcd7bc718d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100ef6d30>, '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 0x100e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eebbe8>, '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.dr0957Frvt/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.g5DVoVKYMf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 00:47:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:47:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:47:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr0957Frvt/Render', 00:47:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:47:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:47:47 INFO - 'HOME': '/Users/cltbld', 00:47:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:47:47 INFO - 'LOGNAME': 'cltbld', 00:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:47:47 INFO - 'MOZ_NO_REMOTE': '1', 00:47:47 INFO - 'NO_EM_RESTART': '1', 00:47:47 INFO - 'PAGER': '/bin/cat', 00:47:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:47:47 INFO - 'PWD': '/builds/slave/test', 00:47:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:47:47 INFO - 'SHELL': '/bin/bash', 00:47:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5DVoVKYMf/Listeners', 00:47:47 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 00:47:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:47:47 INFO - 'USER': 'cltbld', 00:47:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:47:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:47:47 INFO - 'XPC_FLAGS': '0x0', 00:47:47 INFO - 'XPC_SERVICE_NAME': '0', 00:47:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:47:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:47:48 INFO - Cleaning up... 00:47:48 INFO - Return code: 0 00:47:48 INFO - Running post-action listener: _resource_record_post_action 00:47:48 INFO - Running post-action listener: _start_resource_monitoring 00:47:48 INFO - Starting resource monitoring. 00:47:48 INFO - [mozharness: 2017-01-26 08:47:48.285385Z] Finished create-virtualenv step (success) 00:47:48 INFO - [mozharness: 2017-01-26 08:47:48.286328Z] Running install step. 00:47:48 INFO - Running pre-action listener: _resource_record_pre_action 00:47:48 INFO - Running main action method: install 00:47:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:47:48 INFO - Reading from file tmpfile_stdout 00:47:48 INFO - Detecting whether we're running mozinstall >=1.0... 00:47:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:47:48 INFO - Reading from file tmpfile_stdout 00:47:48 INFO - Output received: 00:47:48 INFO - Usage: mozinstall [options] installer 00:47:48 INFO - Options: 00:47:48 INFO - -h, --help show this help message and exit 00:47:48 INFO - -d DEST, --destination=DEST 00:47:48 INFO - Directory to install application into. [default: 00:47:48 INFO - "/builds/slave/test"] 00:47:48 INFO - --app=APP Application being installed. [default: firefox] 00:47:48 INFO - mkdir: /builds/slave/test/build/application 00:47:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 00:47:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 00:48:08 INFO - Reading from file tmpfile_stdout 00:48:08 INFO - Output received: 00:48:08 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 00:48:08 INFO - Running post-action listener: _resource_record_post_action 00:48:08 INFO - [mozharness: 2017-01-26 08:48:08.569287Z] Finished install step (success) 00:48:08 INFO - [mozharness: 2017-01-26 08:48:08.569467Z] Running run-tests step. 00:48:08 INFO - Running pre-action listener: _resource_record_pre_action 00:48:08 INFO - Running main action method: run_tests 00:48:08 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:48:08 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:48:08 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:48:08 INFO - 2017-01-26 00:48:08.583 screenresolution[1622:7246] starting screenresolution argv=screenresolution get 00:48:08 INFO - 2017-01-26 00:48:08.586 screenresolution[1622:7246] Display 0: 1600x1200x32@60 00:48:08 INFO - 2017-01-26 00:48:08.592 screenresolution[1623:7248] starting screenresolution argv=screenresolution list 00:48:08 INFO - Available Modes on Display 0 00:48:08 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:48:08 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:48:08 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:48:08 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:48:08 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:48:08 INFO - Intel Iris: 00:48:08 INFO - Chipset Model: Intel Iris 00:48:08 INFO - Type: GPU 00:48:08 INFO - Bus: Built-In 00:48:08 INFO - VRAM (Dynamic, Max): 1536 MB 00:48:08 INFO - Vendor: Intel (0x8086) 00:48:08 INFO - Device ID: 0x0a2e 00:48:08 INFO - Revision ID: 0x0009 00:48:08 INFO - Displays: 00:48:08 INFO - Display: 00:48:08 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:48:08 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:48:08 INFO - Display Serial Number: 1600x1200 60 00:48:08 INFO - Main Display: Yes 00:48:08 INFO - Mirror: Off 00:48:08 INFO - Online: Yes 00:48:08 INFO - Rotation: Supported 00:48:08 INFO - Return code: 0 00:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:48:08 INFO - Python 2.7.3 00:48:08 INFO - Return code: 0 00:48:08 INFO - grabbing minidump binary from tooltool 00:48:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:48:08 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 0x100ef6d30>, '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 0x100e1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100eebbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:48:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 00:48:08 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 00:48:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 00:48:08 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:48:08 INFO - Return code: 0 00:48:08 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:48:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:48:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:48:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:48:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:48:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0361', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 00:48:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0361 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 00:48:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.dr0957Frvt/Render', 00:48:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:48:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:48:08 INFO - 'HOME': '/Users/cltbld', 00:48:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:48:08 INFO - 'LOGNAME': 'cltbld', 00:48:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:48:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:48:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:48:08 INFO - 'MOZ_NO_REMOTE': '1', 00:48:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:48:08 INFO - 'NO_EM_RESTART': '1', 00:48:08 INFO - 'PAGER': '/bin/cat', 00:48:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:48:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:48:08 INFO - 'PWD': '/builds/slave/test', 00:48:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:48:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:48:08 INFO - 'SHELL': '/bin/bash', 00:48:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g5DVoVKYMf/Listeners', 00:48:08 INFO - 'TMPDIR': '/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/', 00:48:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:48:08 INFO - 'USER': 'cltbld', 00:48:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:48:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:48:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:48:08 INFO - 'XPC_FLAGS': '0x0', 00:48:08 INFO - 'XPC_SERVICE_NAME': '0', 00:48:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:48:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0361', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 00:48:09 INFO - mozversion application_buildid: 20170125234131 00:48:09 INFO - mozversion application_changeset: f0e4b9855df1986fbc3e560b6373bd4f276440e5 00:48:09 INFO - mozversion application_display_name: FirefoxDeveloperEdition 00:48:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:48:09 INFO - mozversion application_name: Firefox 00:48:09 INFO - mozversion application_remotingname: firefox-dev 00:48:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:48:09 INFO - mozversion application_vendor: Mozilla 00:48:09 INFO - mozversion application_version: 53.0a2 00:48:09 INFO - mozversion platform_buildid: 20170125234131 00:48:09 INFO - mozversion platform_changeset: f0e4b9855df1986fbc3e560b6373bd4f276440e5 00:48:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 00:48:09 INFO - mozversion platform_version: 53.0a2 00:48:09 INFO - using testdate: 1485420489 00:48:09 INFO - actual date: 1485420489 00:48:09 INFO - starting webserver on 'localhost:49241' 00:48:09 INFO - SUITE-START | Running 2 tests 00:48:09 INFO - TEST-START | dromaeo_css 00:48:09 INFO - operating with platform_type : mac_ 00:48:09 INFO - Initialising browser for dromaeo_css test... 00:48:09 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpwpsbSW/profile http://localhost:49241/getInfo.html) 00:48:12 INFO - PROCESS | 1633 | 2017-01-26 00:48:12.019 plugin-container[1635:7422] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 00:48:12 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:48:12 INFO - PROCESS | 1633 | 2017-01-26 00:48:12.022 plugin-container[1635:7422] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d1b, name = 'com.apple.CFPasteboardClient' 00:48:12 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:48:12 INFO - PROCESS | 1633 | 2017-01-26 00:48:12.023 plugin-container[1635:7422] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:48:12 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 00:48:12 INFO - PROCESS | 1633 | colorDepth:24 00:48:12 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 00:48:12 INFO - PROCESS | 1633 | __metrics 00:48:12 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 00:48:12 INFO - TEST-INFO | 1633: exit 0 00:48:12 INFO - Browser initialized. 00:48:12 INFO - Running cycle 1/1 for dromaeo_css test... 00:48:12 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpwpsbSW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:48:15 INFO - PROCESS | 1636 | 2017-01-26 00:48:15.309 plugin-container[1637:7553] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x443b, name = 'com.apple.tsm.portname' 00:48:15 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:48:15 INFO - PROCESS | 1636 | 2017-01-26 00:48:15.309 plugin-container[1637:7553] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 00:48:15 INFO - PROCESS | 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 00:48:15 INFO - PROCESS | 1636 | 2017-01-26 00:48:15.309 plugin-container[1637:7553] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 00:48:24 INFO - PROCESS | 1636 | RSS: Main: 218705920 00:48:24 INFO - PROCESS | 1636 | 00:51:27 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 00:51:29 INFO - PROCESS | 1636 | RSS: Main: 238813184 00:51:29 INFO - PROCESS | 1636 | 00:53:13 INFO - PROCESS | 1636 | ************************* 00:53:13 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 00:53:13 INFO - PROCESS | 1636 | 00:53:13 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 00:53:13 INFO - PROCESS | 1636 | Full stack: 00:53:13 INFO - PROCESS | 1636 | ************************* 00:54:31 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 00:54:32 INFO - PROCESS | 1636 | RSS: Main: 248639488 00:54:32 INFO - PROCESS | 1636 | 00:57:34 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 00:57:34 INFO - PROCESS | 1636 | RSS: Main: 255016960 00:57:34 INFO - PROCESS | 1636 | 01:00:36 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 01:00:37 INFO - PROCESS | 1636 | RSS: Main: 254750720 01:00:37 INFO - PROCESS | 1636 | 01:03:40 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 01:03:40 INFO - PROCESS | 1636 | RSS: Main: 258781184 01:03:40 INFO - PROCESS | 1636 | 01:06:43 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 01:06:43 INFO - PROCESS | 1636 | RSS: Main: 260403200 01:06:43 INFO - PROCESS | 1636 | 01:06:43 INFO - PROCESS | 1636 | __start_tp_report 01:06:43 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 01:06:43 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 01:06:43 INFO - PROCESS | 1636 | |i|pagename|runs| 01:06:43 INFO - PROCESS | 1636 | |0;dojo.html;2862.2987368094814;3065.4635438798214;3349.4305967985442;3369.545111409962;3395.2021275000384;4781.856544303668;5017.824376146836;5800.651960882345;5806.158107074471;5857.853553661161;4858.5627293543575;5799.2750906136735;5850.941490585104;5893.764249430018;5926.3184733755525;4406.669499787513;5274.208868669711;5338.866528336804;5386.461353864622;5444.673319600836;5005.54950054495;5357.062514060043;5398.6220964532495;5406.621536492447;5406.729663516828;4452.821887124511;5099.923501147486;5249.580033597303;5372.167314066326;5394.109971854639;5270.657407268534;5311.495407936259;5323.041852466555;5370;5420;4030.8589199378175;4373.540778218305;5103.56619687327;5303.416624171338;5322.467753224685;5659.858503537444;5849.61977471463;5856.326522449887;5982.551308651825;6016.879662406771;6187.628742275433;6195.349488303754;6213.813585592439;6245.594036387621;6256.092866534327;6269.467095296905;6270.874582508324;6281.309056003836;6282.811515654537;6308.684565771693;5972.790952316692;5994;6008.008678568075;6026.487748541379;6040.214772079602;6186.907196392058;6237.438630523275;6239.251289845248;6290.276618188876;6301.905471417932;6139.84650383744;6234.657093859791;6242.531810114259;6244.625322480666;6263.029230469285;5391.406945236021;6174.919389106888;6205.689715514206;6264.624122552661;6282;6140.105498721277;6151.200343955346;6160.815175544741;6166.907496387557;6222.62664240147;6219.564630475823;6223.906641400383;6226.59527130735;6240.219972503437;6249.25008998923;4928.975355123273;4938.38270216223;4951.579115775199;4958.628102892226;4969.90060198794;4259.084296876124;4347.195768782785;4363.323684828857;4389.846355377546;4421.447319085114;5117.181250999822;5493.038718224295;5848.970755146197;5907.084401917709;5967.313758917693;5233.215017747292;6282.183316168869;6295.276043255084;6302.684865756693;6312.43188113072;4928.827491037797;5688.203651488795;5717.313922329347;5811.128330750336;5884.999550076497;5460.918086228709;5481.150421684645;5487.75305111271;5498.862528436821;5536.833894983157;6425.421712045938;6447.4197322241225;6452.709628066842;6458.580192287486;6483.870322593428;5231.633785634969;6079.392060793885;6153.600015998945;6164.506839452743;6167.876642467036;6402.839929001812;6450.258220304725;6479.7408103675325;6480.8703825922275;6502.642354670538;6125.877482450237;6238.157848690369;6247.250329960252;6256.562040657111;6281.685915704105;6186.969065154825;6248;6278.905816412849;6280.057991301342;6294.118823364641;6118.223266370805;6127.20346354971;6129.3564175762685;6176.81469555914;6196.969015154896;6118.174046503665;6165.599236049822;6170.074488826533;6197.845053873509;6209.316975132822;5716.314042314949;5730.799422020209;5839.978003849395;5944;6079.148919151411;6114.175715401414;6114.449699527064;6137.131844484855;6179.6910154493;6231.2522497300615;6054.122152287981;6077.6353418795015;6101.389861013863;6120.571559990758;6125.816225513242 01:06:43 INFO - PROCESS | 1636 | |1;ext.html;465.230044276722;504.1731560241205;515.5798024609945;515.8813472901232;524.5567495466335;40266.19467610646;43078;43155.56844431555;43164;43431.78284108579;43744.343834842424;44078.33882491765;44153.77923110388;44262.778686106605;44418.55581444185;9440.905590944089;9617.567209475556;9620.56707448163;9655.46894920779;11221.102311815075;11199.160062995266;11473.942630286836;11477.253978491413;11498.597549085784;11524.962753352196;9698.951505242463;11473.426328683532;11480.942595287011;11484.253523520945;11485.138614603897;11299.378534180616;11370.772584548304;11444.084473242121;11444.656660300205;11455.599054033111;11251.60619378326;11287.830682539769;11291.040261577777;11323.150763692756;11326.093912486982;38185.80907095475;38435.039124021845;38549.42175867364;38595.842124736024;38653.42019869676;3924.4505769192338;3953.4267531207815;4004.3392840181336;4063.918721625551;4113.732607380511;27153;27254.727452725416;28848.567271490945;28963;29489.557656635166;3192.6647701991187;3210.678932106794;3275.148461400029;3304.058343372127;3339.231976645385;386598;449514;464714;465413;466651;47812.5218747815;58445.70777146172;58938.705306473195;58948;59030;61329;61527.077093843625;61652.07521887175;62172.06741898875;62537.37462625316;15413.845861541242;15857.048577085412;16183.676326473405;16259.59351016234;16426.671466570842;11371.601993930339;11676;12477.75044499123;12789.680257993625;12852.357382130856;18446.35437759672;18544.536386590175;18654.067296635112;18709.625807484048;18825.623487530174;7337.926620733831;7415.295546923034;7917.643706033243;8064.395170362246;8154.714584989615;893.6246776353947;903.6385445821724;908.2416182487697;920.7053742802239;937.8874535055837;28309;30403.391932161234;30879.919202827794;31039.68960310368;31471.685283147333;1026.3226270661478;1084.143526613982;1110.9944450277696;1125.8142406502836;1227.8710735372658;14218.85781142196;15979.201039948188;16287.454806596952;16380.426685065966;16388.098654574114;600811;604577;609023;610371;613134;62195.37804621896;62837.37162628315;62880.68559657264;62883.37116628866;63361.36638633647;1438.9568312950628;1452.3101526774697;1474.5576327101826;1477.623206082442;1478.7412202864455;27201.72798272071;29209.415811684074;30715.2321191972;30946.381072378877;31549.211269718442;53887;54488.72755636196;54581.45418545764;54602.726986366404;54697.45302547083;460216;461996;462857;463216;463400;23982.640260396456;24695.62956555689;24703.87648061748;27319.72680273172;27680.307992300353;42505.57494425016;42610.7216783497;42831.571684284005;43621;43906.682799516064;28573.571396428655;34001.31997359989;34532.65467345295;35249.64750352463;35545.82227088848;35437;35577.46633800443;35766;36195.819020904724;36557.634423656484;33921.66078339185;35205;35418.822905886336;35498;35727.64272357243;30825.229369265948;31853;32235.67764322327;32724.181895452803;33425;25257.74742252554;25306.493870122125;25357.112501062373;25439.87280063588;25475.74524254734 01:06:43 INFO - PROCESS | 1636 | |2;jquery.html;393.525801409302;395.30821063139507;402.7663954906155;407.0799992018039;425.81902691356186;18685.532861678465;19819.504512387197;20712;21212.25757098504;21249.468763280925;20864.89567552164;20937.47656308593;21051;21114.788852111473;21656.35030949074;5746.25298711168;6037.184980027706;6040.214772079624;6050.878982420349;6070.484008859252;5795.681237531934;5959.821205363824;5959.970200148993;6021.488173505235;6055.364186760393;5956.778860333621;5962.970185149068;5964.552658550604;5964.7315870785915;5971.611845230068;5715.171300161495;5892.587518873659;5947.732352044147;5981.5214782817275;6037.788677396314;5013.774380152902;5893.7053147342895;5932.11018347247;5944.167816505693;5958.5828991970575;13327.600171994856;15717.13555754433;20263.696044559343;25772;25878.611820822516;2224.877631730254;2680.9865950670123;2698.6087017382565;2758.517259479603;2796.734310240524;8274.13121622227;10135.290529662927;10273.897261027443;10506.78986420275;10513.211509136845;1874.3533480949052;1896.5637903282184;1908.7041508566194;1919.4721451600783;1923.3749031564657;117823;130670;132595;136912.31543842316;137071;10304.175665946706;10784.676459706221;10793.892061079288;10803.405812680377;10864.239503234856;12906.483740650456;12943.935280323727;12960.027997900195;12973.740525189443;12978.091533592558;7000.2999700030605;8386.916130838614;8503.064662887078;8535.445196062361;8616.827663446697;7151.642417879085;7159.749408770668;8879.179768147515;8928.642854285756;8940.284777217938;4071.4731975509185;4138.151678905817;4150.543440221573;4196.538380778112;4199.622034016892;2055.290924631;2069.391332058629;2091.1217288738767;2098.0558748562903;2101.980539438371;761.7828918758128;793.8531371696139;796.1680044353665;808.878668199763;811.9106898241189;21322.253721119687;21399.25102621432;21407.18936936868;21780.673289900664;21993.120275188812;840.3907167303778;849.2738708404349;849.7153453592992;850;853.7652145659869;11249.10007199422;11441.942790285995;11457.885421145682;11474.942625286987;11562.248453850641;589337.3198803957;670631;691012;709741;714345;150763;151609;154851.67722484173;154918;155044.2247788754;1023.2888142740873;1026.7587117027492;1052.3685788526975;1054.056619325699;1065.808154532176;18601.348952786586;19137.617247655246;19469;19473.51316217106;19537.51156221049;57402.42597573971;57995.420045799;58267;58332.83334333375;58383.70808145932;82367;86837.56581217053;87448.5627571858;87640;89702.55148724215;5475.342958844964;6635.502337324817;7379.631018448948;8157.592120394075;8877.112288771072;12169.39153042362;13629.454821807414;13699.972502062186;13829.962752793379;14003.439862405798;11439.313641181556;11473.196876218584;11601.941990289995;11660.18378713482;11864.822027669765;11372.715682108013;11459.885401146215;11566.884331156582;11576.421178941187;11765.058795296527;6113.480354169946;6154.599951003171;7588.962055189689;8970.96833864114;9910.56296836969;6782.728690852508;7547.924520754722;7582.848343033219;7672.769816905502;7798.25916537928;8452.112528184698;9866.309358344846;10923.56305747793;11348.659540213806;11465.082793376676 01:06:43 INFO - PROCESS | 1636 | |3;mootools.html;1304.1588175626714;1436.9725646162992;1462.924750308523;1470.2942587557973;1476.6160798192473;7623.123340815808;7861.606919654008;8191.426600137986;8645.827083458327;8660.523671198082;6433.646149461778;8389.077201507844;8442.113578074306;8469.322454203664;8474.364422668294;2302.113686230805;2332.416895776056;2340.3564019894493;2342.0397636968846;2354.8469349492316;1991.0741505200078;2082.875027498347;2165.1988764157286;2346.249200255919;2353.8469999450067;2165.6101901657694;2166.1768527959352;2246.4047027537717;2251.5609456156058;2270.2735124760084;2321.0947730385165;2322.7677232276806;2339.298210536849;2345.7419683834764;2348.941276468102;2293.1629955066446;2309.480366917447;2310.7689231076924;2359.3393849722106;2362.338545207345;8510.829783404359;8529.402941794076;8562.357823163287;8565.571721413904;8584.356173286966;5133.358330208724;5266.973665131688;5267.26258323835;5282.366116066059;5283.022640811424;3471.8784842530645;3518.3315170117853;3539.681428671406;3569.625189355132;3570.1610121621397;1205.722683782735;1206.4209179593756;1248.887600115994;1259.2192840438986;1270.7458508298284;10826.566937322497;10948.95984881443;10950.34297942118;10973.122150227962;10976.615818446317;3691.8154092295276;4704.0356726870905;4747.216709243005;4765.189917713997;4790.784414701347;9484.95257523708;9530.571124299284;9561.187299079516;9562;9569.665061722806;5201.921971170435;5266.262723218752;5290.497402746733;5294.258803767476;5302.496262855023;4678.111158879802;4786.234202527578;4826.975865120652;4838.274258861199;4853.12643724126;3301.5873015873017;3930.390789427643;3948.407738839197;4008.5390180129075;4073.796310184538;1159.7738441003924;1197.1201167142144;1274.2736640115231;1279.4754150798128;1299.4867027524076;717.7129148340706;768.2279309294236;787.9527228366317;800.8238187598719;848.2662496940102;5490.5882058844945;5607.859803504945;5638.746256418471;5698.515626171822;5827.155062515912;943.3538026451765;956.6938579654444;978.7406337320616;1031.865857438528;1049.9580016799243;3564.7345192456823;3667.504886840296;3692.8522859085874;3721.423179407142;3732.2908647356917;8667.306615470747;9693.70918872435;10088.293819432569;10236.027577380137;10258.974102589682;10066.798664026679;10145.797084058426;10157.898421015843;10160.847587286196;10188.541515631814;6583.275839657634;7930.682772689028;7952;7955.801104972422;7989.960050199828;5330.653507521999;5339.813106541253;5349.331333583302;5466.1527463243265;5519.69641669712;8918.509481978554;9145.908540914772;9218.492982886006;9224.815503690023;9232.076792320715;8198.59007049657;8966.237869781142;9228;9231.676891308773;9485.952570237105;7070.151581810215;7124.465665075037;7135.143782746104;7147.3210045045635;7165.7850264492145;7823.84352312962;7890.842183156419;7892.171322011106;7893.250141236574;7896.565688886936;6971.75598854058;7017.157941047107;7134.143902731706;7279.890801638086;7280.890786638099;6982.755603553851;7019.964900175466;7034.859302813813;7041.471889608198;7062.3996960258955;6193.194884664965;6342.270638876588;6367.3314301997625;6394.840128996812;6404.679766011774;4937.407511098691;4955.603551715782;4970.155073637563;4989.650724449254;4993.101241776515;4945.530174633404;4981.078500477423;5037.823676171463;5045.621578381562;5091.923621145612 01:06:43 INFO - PROCESS | 1636 | |4;prototype.html;299.3952216522624;367.83263615055154;368.7124043246269;373.1026880352749;377.1626988086449;4152.148809494054;4756.690815097017;4871.951280487194;5016.523430274118;5411;4275.722078064923;5350.250964864912;5368.892622147565;5403.567714582834;5419.859155633532;3469.7918124912458;3772.3398405279104;3937.8621748238816;3943.8957092014284;4125.525564560069;3759.2105657811894;3964.801759912007;4146.253674338618;4191.350340697181;4248.702590818644;3759.3045286622064;3837.9808100959594;4098.918021639565;4144.834206631746;4271.636910862565;3378.864845406181;3501.5973163086314;4046.2514434829354;4229.809658565372;4266.1467706458525;3045.2641994063392;3277.6886195811358;3508.6842184203288;3518.894433167009;3538.663826936437;4730.266808644666;5237.062286953814;5282.445343238982;5286.762095705664;5312.92030619541;4371.693981421302;4634.72191668501;4651.790669419885;4668.019715859674;4685.906281874343;5183.896322073575;5373.140297552372;5649.604527683064;5674.801381951612;5767;3859.6333348331864;3866.149447121629;3867.2265546890735;3880.7477513961503;3888.8055597220027;5766.942330576682;5898.498627616701;5982.222311099573;6028.577999540034;6072.635641861502;3786.015635934677;3840.9231815364096;3866.903327416781;3875.8178755479285;3887.3002859485;3479.0691166402385;3697.759645623026;3868;3984.960150398517;3993.7004724645767;4618.699784513996;4636.142313671981;4638.350630911675;4640.396748422683;4662.9766851166205;5300.898974100118;5686.459786320375;5704.0588302929555;5795.768169273182;5798.855028624318;1144.4678224625588;1222.7283625030047;1291.1542939374724;1301.9519286973887;1307.267929959226;773.8237878424762;791.6160662078887;823.6368809620088;874.3529787956993;878.6353663229816;4449.666275029385;4792.5382758258365;5087.23691446286;5121.641485096007;5148.407933087743;4896.706197628154;4926.4088309403105;5656.632318899258;5689.601727879009;5800.477956983892;4252.957470425318;4721.95278047222;4984.6261530384645;5053.797848086109;5084.474657602778;2586.5602847515966;2905.57869108978;2921.7662586992988;2976.687447817991;3017.788754787188;5417.024935511646;5789.160571717078;5878.882422351529;5916.467517923407;5926.644401335933;5509.421510741395;5641.323041235078;5721.197822685841;5791.88416231673;5819.418058194146;5089.847304580869;5095.210242412432;5279.630425870229;5566.415526369754;5838.314375387285;4838.516148385133;4911.140550403737;4937.35814344133;5675.120356344773;5751.626144300607;4545;5393.9730301348245;5638.9436105638415;5773.480386765212;5888.939990801526;5065.7720402581235;5164.767585458589;5618.85952851182;5649.152627105803;5712.7714891403875;4006.699497537638;4237.618614324726;4271.5514870938105;4281.700280980302;4284.400183974309;5049.419316778617;5525.336959564717;5903.616264942765;5939.831961334168;5954.940450595612;4680.531946805292;4826.396700412449;4937.975310123426;5210.322658054429;5876.00215926587;5042.7897304645885;5456;5672.886542269214;5690.630109042899;5713;5439.918401223906;5586.413426590312;5599.552035837205;5605.635633683797;5614.6631202128;5410.107332290128;5670;5691.658500489983;5740.253767010262;5808.099744539603;4599.770011499345;5541.8639178967405;5558;5558.638688485235;5560.638558493685 01:06:43 INFO - PROCESS | 1636 | |5;yui.html;697.7767114523351;723.4935545118418;726.3208899678804;795.7214974758836;827.2967977219364;15004.849951500482;15951.680966380665;16058.518244452656;16085.678286434279;16103.516894493154;14550.19973901435;14666.266686665678;14667.633309167277;14679.633009174777;14737.48418805342;672.418358120225;692.9826754331157;837.9329653627696;866.5840396609616;872.7730789994583;849.762066621347;860.6772460327377;862.4049405909933;863.2489733931457;873.2053831013778;910.9225715814164;918.1415376622846;919.7194855569048;920.1948295241664;924.523870206844;914.1955079530004;914.40563633638;915.2815040193416;915.9816803663923;916.3768637326615;682.8429461223897;683.0471492268308;684.750066225829;685.372883811312;688.0951548713426;14824.629384265372;15094.54716358511;15126.470573529874;15813.525594232191;15998.920005400016;14467.27663616815;14506.202158881257;14567.417303307855;14610.853891461056;14831.70336593262;10274.845877311845;11602.883971160265;11623.302601843832;11776.293422394683;12023.879761202363;3335.7498187636024;3345.749068819848;3807.695384369244;3851.499305090348;3864.942025869614;77949.22050779476;83123;103438;108462.45768771185;109320;9589;11077.11383089351;11339.886601134049;11381.374024428736;11623.941880290544;23078.769212307998;23144.3056708299;23196.18813341525;23208.767912321;23214.53570928572;7886.526808391515;7964.840703185904;7984.161663025298;7991.320737737357;8054.637541310655;4309.245881970643;4341.848035318749;4436.556344365537;4444.400005999213;4456.175607512556;3523.1720545671747;3580.803055831902;3586.7309951753723;3628.3650361186687;3634.509341238952;652.4030512081392;660.0066899316594;662.2814246542459;667.072768851297;671.509797847574;669.3540733192492;691.6783695581579;694.6596167877805;709.1844378964232;734.2918262772976;10262.914440896582;10401.344296463196;10505.527251273557;10676.359418434919;10729.678109656723;688.8656711941223;695.8782213112685;710.5630037526987;712.1667648850857;725.2638571849577;4979.377577802775;5109.693418394908;5112.514311140436;5121.590272778169;5157.535821776059;81236;98775;101665;101845;108094;86142.56928715316;87682.56158719165;89188.10811891928;90844;91554;70174;83107;83674.58162709148;85153.57423212845;85333;9944.15474684631;10066.245031622804;10088.54601542947;10093.394396336244;10127.544260508443;46304.53695463002;46654.766726166155;55066.072687455744;55394.72302638461;55614.44385556092;68172.65913670599;68657.65671171612;70409.29590704027;70817.93773093304;71145;12983.480660773463;13158.868411315765;13202.669933251362;13528.188308701509;13532.932335338654;15089.170095644846;15355.001924874847;15587.376504939675;15620;16141.838581614034;13892.374843132286;14310.928445358122;14417.711645767236;14485.493007744679;15116;13974.441022358991;14278.2146981917;14852.554423367315;15022.323995420014;15037;13550.79673804874;14324.57026289213;14498.85501144975;14629.414823406945;14631.26843657834;10663.360198388122;11281.943590281997;11301.71745706364;11571.247868888495;12083.093767967262;11246.268992515461;11460.541578337106;11683.766324673288;11723.179377443497;11749.29504229749 01:06:43 INFO - PROCESS | 1636 | __end_tp_report 01:06:43 INFO - PROCESS | 1636 | __start_cc_report 01:06:43 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,381 01:06:43 INFO - PROCESS | 1636 | __end_cc_report 01:06:43 INFO - PROCESS | 1636 | __startTimestamp1485421603501__endTimestamp 01:06:43 INFO - PROCESS | 1636 | 01:06:43 INFO - PROCESS | 1636 | ------- Summary: start ------- 01:06:43 INFO - PROCESS | 1636 | Number of tests: 6 01:06:43 INFO - PROCESS | 1636 | 01:06:43 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5738.52 Median:6054.12 stddev:714.18 (11.8%) stddev-sans-first:679.79 01:06:43 INFO - PROCESS | 1636 | Values: 2862.3 3065.5 3349.4 3369.5 3395.2 4781.9 5017.8 5800.7 5806.2 5857.9 4858.6 5799.3 5850.9 5893.8 5926.3 4406.7 5274.2 5338.9 5386.5 5444.7 5005.5 5357.1 5398.6 5406.6 5406.7 4452.8 5099.9 5249.6 5372.2 5394.1 5270.7 5311.5 5323.0 5370.0 5420.0 4030.9 4373.5 5103.6 5303.4 5322.5 5659.9 5849.6 5856.3 5982.6 6016.9 6187.6 6195.3 6213.8 6245.6 6256.1 6269.5 6270.9 6281.3 6282.8 6308.7 5972.8 5994.0 6008.0 6026.5 6040.2 6186.9 6237.4 6239.3 6290.3 6301.9 6139.8 6234.7 6242.5 6244.6 6263.0 5391.4 6174.9 6205.7 6264.6 6282.0 6140.1 6151.2 6160.8 6166.9 6222.6 6219.6 6223.9 6226.6 6240.2 6249.3 4929.0 4938.4 4951.6 4958.6 4969.9 4259.1 4347.2 4363.3 4389.8 4421.4 5117.2 5493.0 5849.0 5907.1 5967.3 5233.2 6282.2 6295.3 6302.7 6312.4 4928.8 5688.2 5717.3 5811.1 5885.0 5460.9 5481.2 5487.8 5498.9 5536.8 6425.4 6447.4 6452.7 6458.6 6483.9 5231.6 6079.4 6153.6 6164.5 6167.9 6402.8 6450.3 6479.7 6480.9 6502.6 6125.9 6238.2 6247.3 6256.6 6281.7 6187.0 6248.0 6278.9 6280.1 6294.1 6118.2 6127.2 6129.4 6176.8 6197.0 6118.2 6165.6 6170.1 6197.8 6209.3 5716.3 5730.8 5840.0 5944.0 6079.1 6114.2 6114.4 6137.1 6179.7 6231.3 6054.1 6077.6 6101.4 6120.6 6125.8 01:06:43 INFO - PROCESS | 1636 | 01:06:43 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:64837.33 Median:35334.24 stddev:136125.00 (385.2%) stddev-sans-first:136421.07 01:06:43 INFO - PROCESS | 1636 | Values: 465.2 504.2 515.6 515.9 524.6 40266.2 43078.0 43155.6 43164.0 43431.8 43744.3 44078.3 44153.8 44262.8 44418.6 9440.9 9617.6 9620.6 9655.5 11221.1 11199.2 11473.9 11477.3 11498.6 11525.0 9699.0 11473.4 11480.9 11484.3 11485.1 11299.4 11370.8 11444.1 11444.7 11455.6 11251.6 11287.8 11291.0 11323.2 11326.1 38185.8 38435.0 38549.4 38595.8 38653.4 3924.5 3953.4 4004.3 4063.9 4113.7 27153.0 27254.7 28848.6 28963.0 29489.6 3192.7 3210.7 3275.1 3304.1 3339.2 386598.0 449514.0 464714.0 465413.0 466651.0 47812.5 58445.7 58938.7 58948.0 59030.0 61329.0 61527.1 61652.1 62172.1 62537.4 15413.8 15857.0 16183.7 16259.6 16426.7 11371.6 11676.0 12477.8 12789.7 12852.4 18446.4 18544.5 18654.1 18709.6 18825.6 7337.9 7415.3 7917.6 8064.4 8154.7 893.6 903.6 908.2 920.7 937.9 28309.0 30403.4 30879.9 31039.7 31471.7 1026.3 1084.1 1111.0 1125.8 1227.9 14218.9 15979.2 16287.5 16380.4 16388.1 600811.0 604577.0 609023.0 610371.0 613134.0 62195.4 62837.4 62880.7 62883.4 63361.4 1439.0 1452.3 1474.6 1477.6 1478.7 27201.7 29209.4 30715.2 30946.4 31549.2 53887.0 54488.7 54581.5 54602.7 54697.5 460216.0 461996.0 462857.0 463216.0 463400.0 23982.6 24695.6 24703.9 27319.7 27680.3 42505.6 42610.7 42831.6 43621.0 43906.7 28573.6 34001.3 34532.7 35249.6 35545.8 35437.0 35577.5 35766.0 36195.8 36557.6 33921.7 35205.0 35418.8 35498.0 35727.6 30825.2 31853.0 32235.7 32724.2 33425.0 25257.7 25306.5 25357.1 25439.9 25475.7 01:06:43 INFO - PROCESS | 1636 | 01:06:43 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:38368.87 Median:2777.63 stddev:113368.25 (4081.5%) stddev-sans-first:113650.42 01:06:43 INFO - PROCESS | 1636 | Values: 393.5 395.3 402.8 407.1 425.8 18685.5 19819.5 20712.0 21212.3 21249.5 20864.9 20937.5 21051.0 21114.8 21656.4 5746.3 6037.2 6040.2 6050.9 6070.5 5795.7 5959.8 5960.0 6021.5 6055.4 5956.8 5963.0 5964.6 5964.7 5971.6 5715.2 5892.6 5947.7 5981.5 6037.8 5013.8 5893.7 5932.1 5944.2 5958.6 13327.6 15717.1 20263.7 25772.0 25878.6 2224.9 2681.0 2698.6 2758.5 2796.7 8274.1 10135.3 10273.9 10506.8 10513.2 1874.4 1896.6 1908.7 1919.5 1923.4 117823.0 130670.0 132595.0 136912.3 137071.0 10304.2 10784.7 10793.9 10803.4 10864.2 12906.5 12943.9 12960.0 12973.7 12978.1 7000.3 8386.9 8503.1 8535.4 8616.8 7151.6 7159.7 8879.2 8928.6 8940.3 4071.5 4138.2 4150.5 4196.5 4199.6 2055.3 2069.4 2091.1 2098.1 2102.0 761.8 793.9 796.2 808.9 811.9 21322.3 21399.3 21407.2 21780.7 21993.1 840.4 849.3 849.7 850.0 853.8 11249.1 11441.9 11457.9 11474.9 11562.2 589337.3 670631.0 691012.0 709741.0 714345.0 150763.0 151609.0 154851.7 154918.0 155044.2 1023.3 1026.8 1052.4 1054.1 1065.8 18601.3 19137.6 19469.0 19473.5 19537.5 57402.4 57995.4 58267.0 58332.8 58383.7 82367.0 86837.6 87448.6 87640.0 89702.6 5475.3 6635.5 7379.6 8157.6 8877.1 12169.4 13629.5 13700.0 13830.0 14003.4 11439.3 11473.2 11601.9 11660.2 11864.8 11372.7 11459.9 11566.9 11576.4 11765.1 6113.5 6154.6 7589.0 8971.0 9910.6 6782.7 7547.9 7582.8 7672.8 7798.3 8452.1 9866.3 10923.6 11348.7 11465.1 01:06:43 INFO - PROCESS | 1636 | 01:06:43 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5433.77 Median:5167.64 stddev:2963.95 (57.4%) stddev-sans-first:2956.01 01:06:43 INFO - PROCESS | 1636 | Values: 1304.2 1437.0 1462.9 1470.3 1476.6 7623.1 7861.6 8191.4 8645.8 8660.5 6433.6 8389.1 8442.1 8469.3 8474.4 2302.1 2332.4 2340.4 2342.0 2354.8 1991.1 2082.9 2165.2 2346.2 2353.8 2165.6 2166.2 2246.4 2251.6 2270.3 2321.1 2322.8 2339.3 2345.7 2348.9 2293.2 2309.5 2310.8 2359.3 2362.3 8510.8 8529.4 8562.4 8565.6 8584.4 5133.4 5267.0 5267.3 5282.4 5283.0 3471.9 3518.3 3539.7 3569.6 3570.2 1205.7 1206.4 1248.9 1259.2 1270.7 10826.6 10949.0 10950.3 10973.1 10976.6 3691.8 4704.0 4747.2 4765.2 4790.8 9485.0 9530.6 9561.2 9562.0 9569.7 5201.9 5266.3 5290.5 5294.3 5302.5 4678.1 4786.2 4827.0 4838.3 4853.1 3301.6 3930.4 3948.4 4008.5 4073.8 1159.8 1197.1 1274.3 1279.5 1299.5 717.7 768.2 788.0 800.8 848.3 5490.6 5607.9 5638.7 5698.5 5827.2 943.4 956.7 978.7 1031.9 1050.0 3564.7 3667.5 3692.9 3721.4 3732.3 8667.3 9693.7 10088.3 10236.0 10259.0 10066.8 10145.8 10157.9 10160.8 10188.5 6583.3 7930.7 7952.0 7955.8 7990.0 5330.7 5339.8 5349.3 5466.2 5519.7 8918.5 9145.9 9218.5 9224.8 9232.1 8198.6 8966.2 9228.0 9231.7 9486.0 7070.2 7124.5 7135.1 7147.3 7165.8 7823.8 7890.8 7892.2 7893.3 7896.6 6971.8 7017.2 7134.1 7279.9 7280.9 6982.8 7020.0 7034.9 7041.5 7062.4 6193.2 6342.3 6367.3 6394.8 6404.7 4937.4 4955.6 4970.2 4989.7 4993.1 4945.5 4981.1 5037.8 5045.6 5091.9 01:06:43 INFO - PROCESS | 1636 | 01:06:43 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4522.55 Median:5029.66 stddev:1386.18 (27.6%) stddev-sans-first:1353.34 01:06:43 INFO - PROCESS | 1636 | Values: 299.4 367.8 368.7 373.1 377.2 4152.1 4756.7 4872.0 5016.5 5411.0 4275.7 5350.3 5368.9 5403.6 5419.9 3469.8 3772.3 3937.9 3943.9 4125.5 3759.2 3964.8 4146.3 4191.4 4248.7 3759.3 3838.0 4098.9 4144.8 4271.6 3378.9 3501.6 4046.3 4229.8 4266.1 3045.3 3277.7 3508.7 3518.9 3538.7 4730.3 5237.1 5282.4 5286.8 5312.9 4371.7 4634.7 4651.8 4668.0 4685.9 5183.9 5373.1 5649.6 5674.8 5767.0 3859.6 3866.1 3867.2 3880.7 3888.8 5766.9 5898.5 5982.2 6028.6 6072.6 3786.0 3840.9 3866.9 3875.8 3887.3 3479.1 3697.8 3868.0 3985.0 3993.7 4618.7 4636.1 4638.4 4640.4 4663.0 5300.9 5686.5 5704.1 5795.8 5798.9 1144.5 1222.7 1291.2 1302.0 1307.3 773.8 791.6 823.6 874.4 878.6 4449.7 4792.5 5087.2 5121.6 5148.4 4896.7 4926.4 5656.6 5689.6 5800.5 4253.0 4722.0 4984.6 5053.8 5084.5 2586.6 2905.6 2921.8 2976.7 3017.8 5417.0 5789.2 5878.9 5916.5 5926.6 5509.4 5641.3 5721.2 5791.9 5819.4 5089.8 5095.2 5279.6 5566.4 5838.3 4838.5 4911.1 4937.4 5675.1 5751.6 4545.0 5394.0 5638.9 5773.5 5888.9 5065.8 5164.8 5618.9 5649.2 5712.8 4006.7 4237.6 4271.6 4281.7 4284.4 5049.4 5525.3 5903.6 5939.8 5954.9 4680.5 4826.4 4938.0 5210.3 5876.0 5042.8 5456.0 5672.9 5690.6 5713.0 5439.9 5586.4 5599.6 5605.6 5614.7 5410.1 5670.0 5691.7 5740.3 5808.1 4599.8 5541.9 5558.0 5558.6 5560.6 01:06:43 INFO - PROCESS | 1636 | 01:06:43 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:20571.41 Median:3721.10 stddev:28734.43 (772.2%) stddev-sans-first:28776.29 01:06:43 INFO - PROCESS | 1636 | Values: 697.8 723.5 726.3 795.7 827.3 15004.8 15951.7 16058.5 16085.7 16103.5 14550.2 14666.3 14667.6 14679.6 14737.5 672.4 693.0 837.9 866.6 872.8 849.8 860.7 862.4 863.2 873.2 910.9 918.1 919.7 920.2 924.5 914.2 914.4 915.3 916.0 916.4 682.8 683.0 684.8 685.4 688.1 14824.6 15094.5 15126.5 15813.5 15998.9 14467.3 14506.2 14567.4 14610.9 14831.7 10274.8 11602.9 11623.3 11776.3 12023.9 3335.7 3345.7 3807.7 3851.5 3864.9 77949.2 83123.0 103438.0 108462.5 109320.0 9589.0 11077.1 11339.9 11381.4 11623.9 23078.8 23144.3 23196.2 23208.8 23214.5 7886.5 7964.8 7984.2 7991.3 8054.6 4309.2 4341.8 4436.6 4444.4 4456.2 3523.2 3580.8 3586.7 3628.4 3634.5 652.4 660.0 662.3 667.1 671.5 669.4 691.7 694.7 709.2 734.3 10262.9 10401.3 10505.5 10676.4 10729.7 688.9 695.9 710.6 712.2 725.3 4979.4 5109.7 5112.5 5121.6 5157.5 81236.0 98775.0 101665.0 101845.0 108094.0 86142.6 87682.6 89188.1 90844.0 91554.0 70174.0 83107.0 83674.6 85153.6 85333.0 9944.2 10066.2 10088.5 10093.4 10127.5 46304.5 46654.8 55066.1 55394.7 55614.4 68172.7 68657.7 70409.3 70817.9 71145.0 12983.5 13158.9 13202.7 13528.2 13532.9 15089.2 15355.0 15587.4 15620.0 16141.8 13892.4 14310.9 14417.7 14485.5 15116.0 13974.4 14278.2 14852.6 15022.3 15037.0 13550.8 14324.6 14498.9 14629.4 14631.3 10663.4 11281.9 11301.7 11571.2 12083.1 11246.3 11460.5 11683.8 11723.2 11749.3 01:06:43 INFO - PROCESS | 1636 | -------- Summary: end -------- 01:06:43 INFO - PROCESS | 1636 | 01:06:44 INFO - TEST-INFO | 1636: exit 0 01:06:44 INFO - TEST-OK | dromaeo_css | took 1114968ms 01:06:44 INFO - TEST-START | kraken 01:06:44 INFO - operating with platform_type : mac_ 01:06:44 INFO - Initialising browser for kraken test... 01:06:44 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpoBIaoV/profile http://localhost:49241/getInfo.html) 01:06:46 INFO - PROCESS | 1647 | 2017-01-26 01:06:46.732 plugin-container[1648:9811] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 01:06:46 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:06:46 INFO - PROCESS | 1647 | 2017-01-26 01:06:46.735 plugin-container[1648:9811] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x910b, name = 'com.apple.CFPasteboardClient' 01:06:46 INFO - PROCESS | 1647 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:06:46 INFO - PROCESS | 1647 | 2017-01-26 01:06:46.735 plugin-container[1648:9811] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:06:46 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 01:06:46 INFO - PROCESS | 1647 | colorDepth:24 01:06:46 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 01:06:46 INFO - PROCESS | 1647 | __metrics 01:06:46 ERROR - PROCESS | 1647 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 01:06:47 INFO - TEST-INFO | 1647: exit 0 01:06:47 INFO - Browser initialized. 01:06:47 INFO - Running cycle 1/1 for kraken test... 01:06:47 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/T/tmpoBIaoV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:06:50 INFO - PROCESS | 1649 | 2017-01-26 01:06:50.089 plugin-container[1650:9940] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 01:06:50 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:06:50 INFO - PROCESS | 1649 | 2017-01-26 01:06:50.089 plugin-container[1650:9940] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 01:06:50 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 01:06:50 INFO - PROCESS | 1649 | 2017-01-26 01:06:50.089 plugin-container[1650:9940] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 01:06:59 INFO - PROCESS | 1649 | RSS: Main: 218488832 01:06:59 INFO - PROCESS | 1649 | 01:07:02 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 01:07:03 INFO - PROCESS | 1649 | RSS: Main: 232665088 01:07:03 INFO - PROCESS | 1649 | 01:07:06 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 01:07:07 INFO - PROCESS | 1649 | RSS: Main: 240590848 01:07:07 INFO - PROCESS | 1649 | 01:07:10 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 01:07:11 INFO - PROCESS | 1649 | RSS: Main: 244449280 01:07:11 INFO - PROCESS | 1649 | 01:07:12 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 01:07:13 INFO - PROCESS | 1649 | RSS: Main: 244649984 01:07:13 INFO - PROCESS | 1649 | 01:07:15 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:07:16 INFO - PROCESS | 1649 | RSS: Main: 244789248 01:07:16 INFO - PROCESS | 1649 | 01:07:18 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 01:07:19 INFO - PROCESS | 1649 | RSS: Main: 250048512 01:07:19 INFO - PROCESS | 1649 | 01:07:22 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 01:07:23 INFO - PROCESS | 1649 | RSS: Main: 248438784 01:07:23 INFO - PROCESS | 1649 | 01:07:26 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 01:07:27 INFO - PROCESS | 1649 | RSS: Main: 249274368 01:07:27 INFO - PROCESS | 1649 | 01:07:28 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:07:29 INFO - PROCESS | 1649 | RSS: Main: 248983552 01:07:29 INFO - PROCESS | 1649 | 01:07:31 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:07:32 INFO - PROCESS | 1649 | RSS: Main: 248975360 01:07:32 INFO - PROCESS | 1649 | 01:07:34 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:07:34 INFO - PROCESS | 1649 | RSS: Main: 249081856 01:07:34 INFO - PROCESS | 1649 | 01:07:37 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:07:38 INFO - PROCESS | 1649 | RSS: Main: 249438208 01:07:38 INFO - PROCESS | 1649 | 01:07:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:07:42 INFO - PROCESS | 1649 | RSS: Main: 249528320 01:07:42 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 01:07:44 INFO - PROCESS | 1649 | RSS: Main: 251404288 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | __start_tp_report 01:07:44 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 01:07:44 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 01:07:44 INFO - PROCESS | 1649 | |i|pagename|runs| 01:07:44 INFO - PROCESS | 1649 | |0;ai-astar;105;117;119;118;116;124;171;133;118;118 01:07:44 INFO - PROCESS | 1649 | |1;audio-beat-detection;140;143;143;146;110;111;116;116;148;139 01:07:44 INFO - PROCESS | 1649 | |2;audio-dft;198;196;194;267;207;198;193;202;194;196 01:07:44 INFO - PROCESS | 1649 | |3;audio-fft;80;58;58;87;60;60;59;61;71;67 01:07:44 INFO - PROCESS | 1649 | |4;audio-oscillator;82;70;84;71;69;71;81;73;77;113 01:07:44 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;89;88;90;87;89;85;106;92;90;86 01:07:44 INFO - PROCESS | 1649 | |6;imaging-darkroom;97;151;151;111;153;92;132;125;151;152 01:07:44 INFO - PROCESS | 1649 | |7;imaging-desaturate;94;97;125;146;94;111;79;91;82;144 01:07:44 INFO - PROCESS | 1649 | |8;json-parse-financial;61;59;60;62;62;63;62;64;63;61 01:07:44 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;67;74;67;85;76;85;65;69;71;70 01:07:44 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;89;86;92;84;86;85;84;87;86;86 01:07:44 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;143;140;139;138;138;165;163;153;205;157 01:07:44 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;176;177;176;210;222;158;218;222;180;173 01:07:44 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;65;71;75;85;83;86;83;67;68;83 01:07:44 INFO - PROCESS | 1649 | __end_tp_report 01:07:44 INFO - PROCESS | 1649 | __start_cc_report 01:07:44 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,956 01:07:44 INFO - PROCESS | 1649 | __end_cc_report 01:07:44 INFO - PROCESS | 1649 | __startTimestamp1485421664344__endTimestamp 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | ------- Summary: start ------- 01:07:44 INFO - PROCESS | 1649 | Number of tests: 14 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:123.90 Median:118.50 stddev:17.94 (15.1%) stddev-sans-first:17.68 01:07:44 INFO - PROCESS | 1649 | Values: 105.0 117.0 119.0 118.0 116.0 124.0 171.0 133.0 118.0 118.0 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:131.20 Median:141.50 stddev:15.77 (11.1%) stddev-sans-first:16.40 01:07:44 INFO - PROCESS | 1649 | Values: 140.0 143.0 143.0 146.0 110.0 111.0 116.0 116.0 148.0 139.0 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:204.50 Median:198.00 stddev:22.36 (11.3%) stddev-sans-first:23.59 01:07:44 INFO - PROCESS | 1649 | Values: 198.0 196.0 194.0 267.0 207.0 198.0 193.0 202.0 194.0 196.0 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:66.10 Median:64.00 stddev:10.20 (15.9%) stddev-sans-first:9.50 01:07:44 INFO - PROCESS | 1649 | Values: 80.0 58.0 58.0 87.0 60.0 60.0 59.0 61.0 71.0 67.0 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:79.10 Median:75.00 stddev:13.09 (17.5%) stddev-sans-first:13.85 01:07:44 INFO - PROCESS | 1649 | Values: 82.0 70.0 84.0 71.0 69.0 71.0 81.0 73.0 77.0 113.0 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:89.00 stddev:5.92 (6.7%) stddev-sans-first:6.26 01:07:44 INFO - PROCESS | 1649 | Values: 89.0 88.0 90.0 87.0 89.0 85.0 106.0 92.0 90.0 86.0 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:131.50 Median:151.50 stddev:24.12 (15.9%) stddev-sans-first:22.12 01:07:44 INFO - PROCESS | 1649 | Values: 97.0 151.0 151.0 111.0 153.0 92.0 132.0 125.0 151.0 152.0 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:106.30 Median:86.50 stddev:24.33 (28.1%) stddev-sans-first:25.40 01:07:44 INFO - PROCESS | 1649 | Values: 94.0 97.0 125.0 146.0 94.0 111.0 79.0 91.0 82.0 144.0 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:61.70 Median:62.00 stddev:1.49 (2.4%) stddev-sans-first:1.56 01:07:44 INFO - PROCESS | 1649 | Values: 61.0 59.0 60.0 62.0 62.0 63.0 62.0 64.0 63.0 61.0 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:72.90 Median:72.50 stddev:7.17 (9.9%) stddev-sans-first:7.28 01:07:44 INFO - PROCESS | 1649 | Values: 67.0 74.0 67.0 85.0 76.0 85.0 65.0 69.0 71.0 70.0 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:2.42 (2.8%) stddev-sans-first:2.39 01:07:44 INFO - PROCESS | 1649 | Values: 89.0 86.0 92.0 84.0 86.0 85.0 84.0 87.0 86.0 86.0 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:154.10 Median:155.00 stddev:20.73 (13.4%) stddev-sans-first:21.59 01:07:44 INFO - PROCESS | 1649 | Values: 143.0 140.0 139.0 138.0 138.0 165.0 163.0 153.0 205.0 157.0 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.20 Median:195.00 stddev:24.02 (12.3%) stddev-sans-first:24.84 01:07:44 INFO - PROCESS | 1649 | Values: 176.0 177.0 176.0 210.0 222.0 158.0 218.0 222.0 180.0 173.0 01:07:44 INFO - PROCESS | 1649 | 01:07:44 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.60 Median:83.00 stddev:8.28 (10.0%) stddev-sans-first:7.64 01:07:44 INFO - PROCESS | 1649 | Values: 65.0 71.0 75.0 85.0 83.0 86.0 83.0 67.0 68.0 83.0 01:07:44 INFO - PROCESS | 1649 | -------- Summary: end -------- 01:07:44 INFO - PROCESS | 1649 | 01:07:45 INFO - TEST-INFO | 1649: exit 0 01:07:45 INFO - TEST-OK | kraken | took 61061ms 01:07:45 INFO - SUITE-END | took 1176s 01:07:45 INFO - Completed test suite (00:19:36) 01:07:45 INFO - javascript benchmark 01:07:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7297.767681412402, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2862.2987368094814, 3065.4635438798214, 3349.4305967985442, 3369.545111409962, 3395.2021275000384, 4781.856544303668, 5017.824376146836, 5800.651960882345, 5806.158107074471, 5857.853553661161, 4858.5627293543575, 5799.2750906136735, 5850.941490585104, 5893.764249430018, 5926.3184733755525, 4406.669499787513, 5274.208868669711, 5338.866528336804, 5386.461353864622, 5444.673319600836, 5005.54950054495, 5357.062514060043, 5398.6220964532495, 5406.621536492447, 5406.729663516828, 4452.821887124511, 5099.923501147486, 5249.580033597303, 5372.167314066326, 5394.109971854639, 5270.657407268534, 5311.495407936259, 5323.041852466555, 5370.0, 5420.0, 4030.8589199378175, 4373.540778218305, 5103.56619687327, 5303.416624171338, 5322.467753224685, 5659.858503537444, 5849.61977471463, 5856.326522449887, 5982.551308651825, 6016.879662406771, 6187.628742275433, 6195.349488303754, 6213.813585592439, 6245.594036387621, 6256.092866534327, 6269.467095296905, 6270.874582508324, 6281.309056003836, 6282.811515654537, 6308.684565771693, 5972.790952316692, 5994.0, 6008.008678568075, 6026.487748541379, 6040.214772079602, 6186.907196392058, 6237.438630523275, 6239.251289845248, 6290.276618188876, 6301.905471417932, 6139.84650383744, 6234.657093859791, 6242.531810114259, 6244.625322480666, 6263.029230469285, 5391.406945236021, 6174.919389106888, 6205.689715514206, 6264.624122552661, 6282.0, 6140.105498721277, 6151.200343955346, 6160.815175544741, 6166.907496387557, 6222.62664240147, 6219.564630475823, 6223.906641400383, 6226.59527130735, 6240.219972503437, 6249.25008998923, 4928.975355123273, 4938.38270216223, 4951.579115775199, 4958.628102892226, 4969.90060198794, 4259.084296876124, 4347.195768782785, 4363.323684828857, 4389.846355377546, 4421.447319085114, 5117.181250999822, 5493.038718224295, 5848.970755146197, 5907.084401917709, 5967.313758917693, 5233.215017747292, 6282.183316168869, 6295.276043255084, 6302.684865756693, 6312.43188113072, 4928.827491037797, 5688.203651488795, 5717.313922329347, 5811.128330750336, 5884.999550076497, 5460.918086228709, 5481.150421684645, 5487.75305111271, 5498.862528436821, 5536.833894983157, 6425.421712045938, 6447.4197322241225, 6452.709628066842, 6458.580192287486, 6483.870322593428, 5231.633785634969, 6079.392060793885, 6153.600015998945, 6164.506839452743, 6167.876642467036, 6402.839929001812, 6450.258220304725, 6479.7408103675325, 6480.8703825922275, 6502.642354670538, 6125.877482450237, 6238.157848690369, 6247.250329960252, 6256.562040657111, 6281.685915704105, 6186.969065154825, 6248.0, 6278.905816412849, 6280.057991301342, 6294.118823364641, 6118.223266370805, 6127.20346354971, 6129.3564175762685, 6176.81469555914, 6196.969015154896, 6118.174046503665, 6165.599236049822, 6170.074488826533, 6197.845053873509, 6209.316975132822, 5716.314042314949, 5730.799422020209, 5839.978003849395, 5944.0, 6079.148919151411, 6114.175715401414, 6114.449699527064, 6137.131844484855, 6179.6910154493, 6231.2522497300615, 6054.122152287981, 6077.6353418795015, 6101.389861013863, 6120.571559990758, 6125.816225513242], "value": 5690.488676462132, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [465.230044276722, 504.1731560241205, 515.5798024609945, 515.8813472901232, 524.5567495466335, 40266.19467610646, 43078.0, 43155.56844431555, 43164.0, 43431.78284108579, 43744.343834842424, 44078.33882491765, 44153.77923110388, 44262.778686106605, 44418.55581444185, 9440.905590944089, 9617.567209475556, 9620.56707448163, 9655.46894920779, 11221.102311815075, 11199.160062995266, 11473.942630286836, 11477.253978491413, 11498.597549085784, 11524.962753352196, 9698.951505242463, 11473.426328683532, 11480.942595287011, 11484.253523520945, 11485.138614603897, 11299.378534180616, 11370.772584548304, 11444.084473242121, 11444.656660300205, 11455.599054033111, 11251.60619378326, 11287.830682539769, 11291.040261577777, 11323.150763692756, 11326.093912486982, 38185.80907095475, 38435.039124021845, 38549.42175867364, 38595.842124736024, 38653.42019869676, 3924.4505769192338, 3953.4267531207815, 4004.3392840181336, 4063.918721625551, 4113.732607380511, 27153.0, 27254.727452725416, 28848.567271490945, 28963.0, 29489.557656635166, 3192.6647701991187, 3210.678932106794, 3275.148461400029, 3304.058343372127, 3339.231976645385, 386598.0, 449514.0, 464714.0, 465413.0, 466651.0, 47812.5218747815, 58445.70777146172, 58938.705306473195, 58948.0, 59030.0, 61329.0, 61527.077093843625, 61652.07521887175, 62172.06741898875, 62537.37462625316, 15413.845861541242, 15857.048577085412, 16183.676326473405, 16259.59351016234, 16426.671466570842, 11371.601993930339, 11676.0, 12477.75044499123, 12789.680257993625, 12852.357382130856, 18446.35437759672, 18544.536386590175, 18654.067296635112, 18709.625807484048, 18825.623487530174, 7337.926620733831, 7415.295546923034, 7917.643706033243, 8064.395170362246, 8154.714584989615, 893.6246776353947, 903.6385445821724, 908.2416182487697, 920.7053742802239, 937.8874535055837, 28309.0, 30403.391932161234, 30879.919202827794, 31039.68960310368, 31471.685283147333, 1026.3226270661478, 1084.143526613982, 1110.9944450277696, 1125.8142406502836, 1227.8710735372658, 14218.85781142196, 15979.201039948188, 16287.454806596952, 16380.426685065966, 16388.098654574114, 600811.0, 604577.0, 609023.0, 610371.0, 613134.0, 62195.37804621896, 62837.37162628315, 62880.68559657264, 62883.37116628866, 63361.36638633647, 1438.9568312950628, 1452.3101526774697, 1474.5576327101826, 1477.623206082442, 1478.7412202864455, 27201.72798272071, 29209.415811684074, 30715.2321191972, 30946.381072378877, 31549.211269718442, 53887.0, 54488.72755636196, 54581.45418545764, 54602.726986366404, 54697.45302547083, 460216.0, 461996.0, 462857.0, 463216.0, 463400.0, 23982.640260396456, 24695.62956555689, 24703.87648061748, 27319.72680273172, 27680.307992300353, 42505.57494425016, 42610.7216783497, 42831.571684284005, 43621.0, 43906.682799516064, 28573.571396428655, 34001.31997359989, 34532.65467345295, 35249.64750352463, 35545.82227088848, 35437.0, 35577.46633800443, 35766.0, 36195.819020904724, 36557.634423656484, 33921.66078339185, 35205.0, 35418.822905886336, 35498.0, 35727.64272357243, 30825.229369265948, 31853.0, 32235.67764322327, 32724.181895452803, 33425.0, 25257.74742252554, 25306.493870122125, 25357.112501062373, 25439.87280063588, 25475.74524254734], "value": 20070.354045516222, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.525801409302, 395.30821063139507, 402.7663954906155, 407.0799992018039, 425.81902691356186, 18685.532861678465, 19819.504512387197, 20712.0, 21212.25757098504, 21249.468763280925, 20864.89567552164, 20937.47656308593, 21051.0, 21114.788852111473, 21656.35030949074, 5746.25298711168, 6037.184980027706, 6040.214772079624, 6050.878982420349, 6070.484008859252, 5795.681237531934, 5959.821205363824, 5959.970200148993, 6021.488173505235, 6055.364186760393, 5956.778860333621, 5962.970185149068, 5964.552658550604, 5964.7315870785915, 5971.611845230068, 5715.171300161495, 5892.587518873659, 5947.732352044147, 5981.5214782817275, 6037.788677396314, 5013.774380152902, 5893.7053147342895, 5932.11018347247, 5944.167816505693, 5958.5828991970575, 13327.600171994856, 15717.13555754433, 20263.696044559343, 25772.0, 25878.611820822516, 2224.877631730254, 2680.9865950670123, 2698.6087017382565, 2758.517259479603, 2796.734310240524, 8274.13121622227, 10135.290529662927, 10273.897261027443, 10506.78986420275, 10513.211509136845, 1874.3533480949052, 1896.5637903282184, 1908.7041508566194, 1919.4721451600783, 1923.3749031564657, 117823.0, 130670.0, 132595.0, 136912.31543842316, 137071.0, 10304.175665946706, 10784.676459706221, 10793.892061079288, 10803.405812680377, 10864.239503234856, 12906.483740650456, 12943.935280323727, 12960.027997900195, 12973.740525189443, 12978.091533592558, 7000.2999700030605, 8386.916130838614, 8503.064662887078, 8535.445196062361, 8616.827663446697, 7151.642417879085, 7159.749408770668, 8879.179768147515, 8928.642854285756, 8940.284777217938, 4071.4731975509185, 4138.151678905817, 4150.543440221573, 4196.538380778112, 4199.622034016892, 2055.290924631, 2069.391332058629, 2091.1217288738767, 2098.0558748562903, 2101.980539438371, 761.7828918758128, 793.8531371696139, 796.1680044353665, 808.878668199763, 811.9106898241189, 21322.253721119687, 21399.25102621432, 21407.18936936868, 21780.673289900664, 21993.120275188812, 840.3907167303778, 849.2738708404349, 849.7153453592992, 850.0, 853.7652145659869, 11249.10007199422, 11441.942790285995, 11457.885421145682, 11474.942625286987, 11562.248453850641, 589337.3198803957, 670631.0, 691012.0, 709741.0, 714345.0, 150763.0, 151609.0, 154851.67722484173, 154918.0, 155044.2247788754, 1023.2888142740873, 1026.7587117027492, 1052.3685788526975, 1054.056619325699, 1065.808154532176, 18601.348952786586, 19137.617247655246, 19469.0, 19473.51316217106, 19537.51156221049, 57402.42597573971, 57995.420045799, 58267.0, 58332.83334333375, 58383.70808145932, 82367.0, 86837.56581217053, 87448.5627571858, 87640.0, 89702.55148724215, 5475.342958844964, 6635.502337324817, 7379.631018448948, 8157.592120394075, 8877.112288771072, 12169.39153042362, 13629.454821807414, 13699.972502062186, 13829.962752793379, 14003.439862405798, 11439.313641181556, 11473.196876218584, 11601.941990289995, 11660.18378713482, 11864.822027669765, 11372.715682108013, 11459.885401146215, 11566.884331156582, 11576.421178941187, 11765.058795296527, 6113.480354169946, 6154.599951003171, 7588.962055189689, 8970.96833864114, 9910.56296836969, 6782.728690852508, 7547.924520754722, 7582.848343033219, 7672.769816905502, 7798.25916537928, 8452.112528184698, 9866.309358344846, 10923.56305747793, 11348.659540213806, 11465.082793376676], "value": 9545.671862805524, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1304.1588175626714, 1436.9725646162992, 1462.924750308523, 1470.2942587557973, 1476.6160798192473, 7623.123340815808, 7861.606919654008, 8191.426600137986, 8645.827083458327, 8660.523671198082, 6433.646149461778, 8389.077201507844, 8442.113578074306, 8469.322454203664, 8474.364422668294, 2302.113686230805, 2332.416895776056, 2340.3564019894493, 2342.0397636968846, 2354.8469349492316, 1991.0741505200078, 2082.875027498347, 2165.1988764157286, 2346.249200255919, 2353.8469999450067, 2165.6101901657694, 2166.1768527959352, 2246.4047027537717, 2251.5609456156058, 2270.2735124760084, 2321.0947730385165, 2322.7677232276806, 2339.298210536849, 2345.7419683834764, 2348.941276468102, 2293.1629955066446, 2309.480366917447, 2310.7689231076924, 2359.3393849722106, 2362.338545207345, 8510.829783404359, 8529.402941794076, 8562.357823163287, 8565.571721413904, 8584.356173286966, 5133.358330208724, 5266.973665131688, 5267.26258323835, 5282.366116066059, 5283.022640811424, 3471.8784842530645, 3518.3315170117853, 3539.681428671406, 3569.625189355132, 3570.1610121621397, 1205.722683782735, 1206.4209179593756, 1248.887600115994, 1259.2192840438986, 1270.7458508298284, 10826.566937322497, 10948.95984881443, 10950.34297942118, 10973.122150227962, 10976.615818446317, 3691.8154092295276, 4704.0356726870905, 4747.216709243005, 4765.189917713997, 4790.784414701347, 9484.95257523708, 9530.571124299284, 9561.187299079516, 9562.0, 9569.665061722806, 5201.921971170435, 5266.262723218752, 5290.497402746733, 5294.258803767476, 5302.496262855023, 4678.111158879802, 4786.234202527578, 4826.975865120652, 4838.274258861199, 4853.12643724126, 3301.5873015873017, 3930.390789427643, 3948.407738839197, 4008.5390180129075, 4073.796310184538, 1159.7738441003924, 1197.1201167142144, 1274.2736640115231, 1279.4754150798128, 1299.4867027524076, 717.7129148340706, 768.2279309294236, 787.9527228366317, 800.8238187598719, 848.2662496940102, 5490.5882058844945, 5607.859803504945, 5638.746256418471, 5698.515626171822, 5827.155062515912, 943.3538026451765, 956.6938579654444, 978.7406337320616, 1031.865857438528, 1049.9580016799243, 3564.7345192456823, 3667.504886840296, 3692.8522859085874, 3721.423179407142, 3732.2908647356917, 8667.306615470747, 9693.70918872435, 10088.293819432569, 10236.027577380137, 10258.974102589682, 10066.798664026679, 10145.797084058426, 10157.898421015843, 10160.847587286196, 10188.541515631814, 6583.275839657634, 7930.682772689028, 7952.0, 7955.801104972422, 7989.960050199828, 5330.653507521999, 5339.813106541253, 5349.331333583302, 5466.1527463243265, 5519.69641669712, 8918.509481978554, 9145.908540914772, 9218.492982886006, 9224.815503690023, 9232.076792320715, 8198.59007049657, 8966.237869781142, 9228.0, 9231.676891308773, 9485.952570237105, 7070.151581810215, 7124.465665075037, 7135.143782746104, 7147.3210045045635, 7165.7850264492145, 7823.84352312962, 7890.842183156419, 7892.171322011106, 7893.250141236574, 7896.565688886936, 6971.75598854058, 7017.157941047107, 7134.143902731706, 7279.890801638086, 7280.890786638099, 6982.755603553851, 7019.964900175466, 7034.859302813813, 7041.471889608198, 7062.3996960258955, 6193.194884664965, 6342.270638876588, 6367.3314301997625, 6394.840128996812, 6404.679766011774, 4937.407511098691, 4955.603551715782, 4970.155073637563, 4989.650724449254, 4993.101241776515, 4945.530174633404, 4981.078500477423, 5037.823676171463, 5045.621578381562, 5091.923621145612], "value": 4411.691611960244, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.3952216522624, 367.83263615055154, 368.7124043246269, 373.1026880352749, 377.1626988086449, 4152.148809494054, 4756.690815097017, 4871.951280487194, 5016.523430274118, 5411.0, 4275.722078064923, 5350.250964864912, 5368.892622147565, 5403.567714582834, 5419.859155633532, 3469.7918124912458, 3772.3398405279104, 3937.8621748238816, 3943.8957092014284, 4125.525564560069, 3759.2105657811894, 3964.801759912007, 4146.253674338618, 4191.350340697181, 4248.702590818644, 3759.3045286622064, 3837.9808100959594, 4098.918021639565, 4144.834206631746, 4271.636910862565, 3378.864845406181, 3501.5973163086314, 4046.2514434829354, 4229.809658565372, 4266.1467706458525, 3045.2641994063392, 3277.6886195811358, 3508.6842184203288, 3518.894433167009, 3538.663826936437, 4730.266808644666, 5237.062286953814, 5282.445343238982, 5286.762095705664, 5312.92030619541, 4371.693981421302, 4634.72191668501, 4651.790669419885, 4668.019715859674, 4685.906281874343, 5183.896322073575, 5373.140297552372, 5649.604527683064, 5674.801381951612, 5767.0, 3859.6333348331864, 3866.149447121629, 3867.2265546890735, 3880.7477513961503, 3888.8055597220027, 5766.942330576682, 5898.498627616701, 5982.222311099573, 6028.577999540034, 6072.635641861502, 3786.015635934677, 3840.9231815364096, 3866.903327416781, 3875.8178755479285, 3887.3002859485, 3479.0691166402385, 3697.759645623026, 3868.0, 3984.960150398517, 3993.7004724645767, 4618.699784513996, 4636.142313671981, 4638.350630911675, 4640.396748422683, 4662.9766851166205, 5300.898974100118, 5686.459786320375, 5704.0588302929555, 5795.768169273182, 5798.855028624318, 1144.4678224625588, 1222.7283625030047, 1291.1542939374724, 1301.9519286973887, 1307.267929959226, 773.8237878424762, 791.6160662078887, 823.6368809620088, 874.3529787956993, 878.6353663229816, 4449.666275029385, 4792.5382758258365, 5087.23691446286, 5121.641485096007, 5148.407933087743, 4896.706197628154, 4926.4088309403105, 5656.632318899258, 5689.601727879009, 5800.477956983892, 4252.957470425318, 4721.95278047222, 4984.6261530384645, 5053.797848086109, 5084.474657602778, 2586.5602847515966, 2905.57869108978, 2921.7662586992988, 2976.687447817991, 3017.788754787188, 5417.024935511646, 5789.160571717078, 5878.882422351529, 5916.467517923407, 5926.644401335933, 5509.421510741395, 5641.323041235078, 5721.197822685841, 5791.88416231673, 5819.418058194146, 5089.847304580869, 5095.210242412432, 5279.630425870229, 5566.415526369754, 5838.314375387285, 4838.516148385133, 4911.140550403737, 4937.35814344133, 5675.120356344773, 5751.626144300607, 4545.0, 5393.9730301348245, 5638.9436105638415, 5773.480386765212, 5888.939990801526, 5065.7720402581235, 5164.767585458589, 5618.85952851182, 5649.152627105803, 5712.7714891403875, 4006.699497537638, 4237.618614324726, 4271.5514870938105, 4281.700280980302, 4284.400183974309, 5049.419316778617, 5525.336959564717, 5903.616264942765, 5939.831961334168, 5954.940450595612, 4680.531946805292, 4826.396700412449, 4937.975310123426, 5210.322658054429, 5876.00215926587, 5042.7897304645885, 5456.0, 5672.886542269214, 5690.630109042899, 5713.0, 5439.918401223906, 5586.413426590312, 5599.552035837205, 5605.635633683797, 5614.6631202128, 5410.107332290128, 5670.0, 5691.658500489983, 5740.253767010262, 5808.099744539603, 4599.770011499345, 5541.8639178967405, 5558.0, 5558.638688485235, 5560.638558493685], "value": 4087.777749661969, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [697.7767114523351, 723.4935545118418, 726.3208899678804, 795.7214974758836, 827.2967977219364, 15004.849951500482, 15951.680966380665, 16058.518244452656, 16085.678286434279, 16103.516894493154, 14550.19973901435, 14666.266686665678, 14667.633309167277, 14679.633009174777, 14737.48418805342, 672.418358120225, 692.9826754331157, 837.9329653627696, 866.5840396609616, 872.7730789994583, 849.762066621347, 860.6772460327377, 862.4049405909933, 863.2489733931457, 873.2053831013778, 910.9225715814164, 918.1415376622846, 919.7194855569048, 920.1948295241664, 924.523870206844, 914.1955079530004, 914.40563633638, 915.2815040193416, 915.9816803663923, 916.3768637326615, 682.8429461223897, 683.0471492268308, 684.750066225829, 685.372883811312, 688.0951548713426, 14824.629384265372, 15094.54716358511, 15126.470573529874, 15813.525594232191, 15998.920005400016, 14467.27663616815, 14506.202158881257, 14567.417303307855, 14610.853891461056, 14831.70336593262, 10274.845877311845, 11602.883971160265, 11623.302601843832, 11776.293422394683, 12023.879761202363, 3335.7498187636024, 3345.749068819848, 3807.695384369244, 3851.499305090348, 3864.942025869614, 77949.22050779476, 83123.0, 103438.0, 108462.45768771185, 109320.0, 9589.0, 11077.11383089351, 11339.886601134049, 11381.374024428736, 11623.941880290544, 23078.769212307998, 23144.3056708299, 23196.18813341525, 23208.767912321, 23214.53570928572, 7886.526808391515, 7964.840703185904, 7984.161663025298, 7991.320737737357, 8054.637541310655, 4309.245881970643, 4341.848035318749, 4436.556344365537, 4444.400005999213, 4456.175607512556, 3523.1720545671747, 3580.803055831902, 3586.7309951753723, 3628.3650361186687, 3634.509341238952, 652.4030512081392, 660.0066899316594, 662.2814246542459, 667.072768851297, 671.509797847574, 669.3540733192492, 691.6783695581579, 694.6596167877805, 709.1844378964232, 734.2918262772976, 10262.914440896582, 10401.344296463196, 10505.527251273557, 10676.359418434919, 10729.678109656723, 688.8656711941223, 695.8782213112685, 710.5630037526987, 712.1667648850857, 725.2638571849577, 4979.377577802775, 5109.693418394908, 5112.514311140436, 5121.590272778169, 5157.535821776059, 81236.0, 98775.0, 101665.0, 101845.0, 108094.0, 86142.56928715316, 87682.56158719165, 89188.10811891928, 90844.0, 91554.0, 70174.0, 83107.0, 83674.58162709148, 85153.57423212845, 85333.0, 9944.15474684631, 10066.245031622804, 10088.54601542947, 10093.394396336244, 10127.544260508443, 46304.53695463002, 46654.766726166155, 55066.072687455744, 55394.72302638461, 55614.44385556092, 68172.65913670599, 68657.65671171612, 70409.29590704027, 70817.93773093304, 71145.0, 12983.480660773463, 13158.868411315765, 13202.669933251362, 13528.188308701509, 13532.932335338654, 15089.170095644846, 15355.001924874847, 15587.376504939675, 15620.0, 16141.838581614034, 13892.374843132286, 14310.928445358122, 14417.711645767236, 14485.493007744679, 15116.0, 13974.441022358991, 14278.2146981917, 14852.554423367315, 15022.323995420014, 15037.0, 13550.79673804874, 14324.57026289213, 14498.85501144975, 14629.414823406945, 14631.26843657834, 10663.360198388122, 11281.943590281997, 11301.71745706364, 11571.247868888495, 12083.093767967262, 11246.268992515461, 11460.541578337106, 11683.766324673288, 11723.179377443497, 11749.29504229749], "value": 7682.261545493559, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 117.0, 119.0, 118.0, 116.0, 124.0, 171.0, 133.0, 118.0, 118.0], "value": 123.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 143.0, 143.0, 146.0, 110.0, 111.0, 116.0, 116.0, 148.0, 139.0], "value": 131.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 196.0, 194.0, 267.0, 207.0, 198.0, 193.0, 202.0, 194.0, 196.0], "value": 204.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 87.0, 60.0, 60.0, 59.0, 61.0, 71.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 70.0, 84.0, 71.0, 69.0, 71.0, 81.0, 73.0, 77.0, 113.0], "value": 79.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 90.0, 87.0, 89.0, 85.0, 106.0, 92.0, 90.0, 86.0], "value": 90.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 151.0, 151.0, 111.0, 153.0, 92.0, 132.0, 125.0, 151.0, 152.0], "value": 131.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 97.0, 125.0, 146.0, 94.0, 111.0, 79.0, 91.0, 82.0, 144.0], "value": 106.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 60.0, 62.0, 62.0, 63.0, 62.0, 64.0, 63.0, 61.0], "value": 61.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 74.0, 67.0, 85.0, 76.0, 85.0, 65.0, 69.0, 71.0, 70.0], "value": 72.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 92.0, 84.0, 86.0, 85.0, 84.0, 87.0, 86.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 140.0, 139.0, 138.0, 138.0, 165.0, 163.0, 153.0, 205.0, 157.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 177.0, 176.0, 210.0, 222.0, 158.0, 218.0, 222.0, 180.0, 173.0], "value": 191.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 75.0, 85.0, 83.0, 86.0, 83.0, 67.0, 68.0, 83.0], "value": 76.6, "unit": "score"}]}]} 01:07:45 INFO - Return code: 0 01:07:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:07:45 ERROR - # TBPL SUCCESS # 01:07:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:07:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:07:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:07:45 INFO - 2017-01-26 01:07:45.647 screenresolution[1654:10337] starting screenresolution argv=screenresolution get 01:07:45 INFO - 2017-01-26 01:07:45.649 screenresolution[1654:10337] Display 0: 1600x1200x32@60 01:07:45 INFO - 2017-01-26 01:07:45.655 screenresolution[1655:10340] starting screenresolution argv=screenresolution list 01:07:45 INFO - Available Modes on Display 0 01:07:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:07:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:07:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:07:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:07:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:07:45 INFO - Intel Iris: 01:07:45 INFO - Chipset Model: Intel Iris 01:07:45 INFO - Type: GPU 01:07:45 INFO - Bus: Built-In 01:07:45 INFO - VRAM (Dynamic, Max): 1536 MB 01:07:45 INFO - Vendor: Intel (0x8086) 01:07:45 INFO - Device ID: 0x0a2e 01:07:45 INFO - Revision ID: 0x0009 01:07:45 INFO - Displays: 01:07:45 INFO - Display: 01:07:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:07:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:07:45 INFO - Display Serial Number: 1600x1200 60 01:07:45 INFO - Main Display: Yes 01:07:45 INFO - Mirror: Off 01:07:45 INFO - Online: Yes 01:07:45 INFO - Rotation: Supported 01:07:45 INFO - Return code: 0 01:07:45 INFO - Running post-action listener: _resource_record_post_action 01:07:45 INFO - [mozharness: 2017-01-26 09:07:45.892543Z] Finished run-tests step (success) 01:07:45 INFO - Running post-run listener: _resource_record_post_run 01:07:45 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 38676992; Write bytes: 508984320; Read time: 241; Write time: 1625 01:07:45 INFO - TinderboxPrint: CPU usage
54.3% 01:07:45 INFO - TinderboxPrint: I/O read bytes / time
38,676,992 / 241 01:07:45 INFO - TinderboxPrint: I/O write bytes / time
508,984,320 / 1,625 01:07:45 INFO - TinderboxPrint: CPU idle
2,190.5 (45.7%) 01:07:45 INFO - TinderboxPrint: CPU system
962.1 (20.1%) 01:07:45 INFO - TinderboxPrint: CPU user
1,637.0 (34.2%) 01:07:45 INFO - TinderboxPrint: Swap in / out
246,050,816 / 0 01:07:45 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207354368; Write bytes: 200820224; Read time: 15965; Write time: 446 01:07:45 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 36014592; Write bytes: 298128896; Read time: 220; Write time: 1144 01:07:46 INFO - Running post-run listener: _upload_blobber_files 01:07:46 INFO - Blob upload gear active. 01:07:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:07:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:07:46 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:07:46 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:07:46 INFO - (blobuploader) - INFO - Open directory for files ... 01:07:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:07:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:07:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:07:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:07:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:07:48 INFO - (blobuploader) - INFO - Done attempting. 01:07:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:07:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:07:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:07:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:07:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:07:49 INFO - (blobuploader) - INFO - Done attempting. 01:07:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:07:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:07:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:07:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:07:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:07:50 INFO - (blobuploader) - INFO - Done attempting. 01:07:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:07:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:07:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:07:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:07:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:07:52 INFO - (blobuploader) - INFO - Done attempting. 01:07:52 INFO - (blobuploader) - INFO - Iteration through files over. 01:07:52 INFO - Return code: 0 01:07:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:07:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:07:52 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d6ed6728091d2a72d434a73ea8cb1823af48109b90f6ca4ba400821db60332549ddc0b18993e66d38de356fff8f7ae3d6a8ee32e2b1285071b8f078b3cf2b83", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e75d8f9f84f4f23d7eb2db4f2c59ee21e84dd7022b524c735e3c348a8896c858eb6b17d6bbc26caf0c640db3a6eb3898063a8ae695ee2512139cc29ccadc9607", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7907335993a7618b16c10a9cfbba5a6e89fda05c3664edf0bc0368d721b97349c9e9f2d9392b457ccb5f1a2418f257afbaef79aaa0242deab6e5302d148871ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/028884cc9001e75739f24820571e1c156d7786b92f7e63bf58d97082153a104e1dd46189b3a5682c8d4c392979dff62d2166c9e506e77ad994564963374600b0"} 01:07:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:07:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:07:52 INFO - Contents: 01:07:52 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d6ed6728091d2a72d434a73ea8cb1823af48109b90f6ca4ba400821db60332549ddc0b18993e66d38de356fff8f7ae3d6a8ee32e2b1285071b8f078b3cf2b83", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e75d8f9f84f4f23d7eb2db4f2c59ee21e84dd7022b524c735e3c348a8896c858eb6b17d6bbc26caf0c640db3a6eb3898063a8ae695ee2512139cc29ccadc9607", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7907335993a7618b16c10a9cfbba5a6e89fda05c3664edf0bc0368d721b97349c9e9f2d9392b457ccb5f1a2418f257afbaef79aaa0242deab6e5302d148871ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/028884cc9001e75739f24820571e1c156d7786b92f7e63bf58d97082153a104e1dd46189b3a5682c8d4c392979dff62d2166c9e506e77ad994564963374600b0"} 01:07:52 INFO - Running post-run listener: copy_logs_to_upload_dir 01:07:52 INFO - Copying logs to upload dir... 01:07:52 INFO - mkdir: /builds/slave/test/build/upload/logs 01:07:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.760272 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-26 01:07:53.021037) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 01:07:53.025063) ========= 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.dr0957Frvt/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.g5DVoVKYMf/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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/Mozilla-Aurora/sha512/7d6ed6728091d2a72d434a73ea8cb1823af48109b90f6ca4ba400821db60332549ddc0b18993e66d38de356fff8f7ae3d6a8ee32e2b1285071b8f078b3cf2b83", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e75d8f9f84f4f23d7eb2db4f2c59ee21e84dd7022b524c735e3c348a8896c858eb6b17d6bbc26caf0c640db3a6eb3898063a8ae695ee2512139cc29ccadc9607", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7907335993a7618b16c10a9cfbba5a6e89fda05c3664edf0bc0368d721b97349c9e9f2d9392b457ccb5f1a2418f257afbaef79aaa0242deab6e5302d148871ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/028884cc9001e75739f24820571e1c156d7786b92f7e63bf58d97082153a104e1dd46189b3a5682c8d4c392979dff62d2166c9e506e77ad994564963374600b0"} build_url:https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010953 build_url: 'https://queue.taskcluster.net/v1/task/aLMrPJKmQ_KHuFaYbdIvSQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7d6ed6728091d2a72d434a73ea8cb1823af48109b90f6ca4ba400821db60332549ddc0b18993e66d38de356fff8f7ae3d6a8ee32e2b1285071b8f078b3cf2b83", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e75d8f9f84f4f23d7eb2db4f2c59ee21e84dd7022b524c735e3c348a8896c858eb6b17d6bbc26caf0c640db3a6eb3898063a8ae695ee2512139cc29ccadc9607", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7907335993a7618b16c10a9cfbba5a6e89fda05c3664edf0bc0368d721b97349c9e9f2d9392b457ccb5f1a2418f257afbaef79aaa0242deab6e5302d148871ba", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/028884cc9001e75739f24820571e1c156d7786b92f7e63bf58d97082153a104e1dd46189b3a5682c8d4c392979dff62d2166c9e506e77ad994564963374600b0"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 01:07:53.064781) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 01:07:53.065207) ========= 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.dr0957Frvt/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.g5DVoVKYMf/Listeners TMPDIR=/var/folders/mg/9gn67p3x3h52jpkl3qqzw4tw00000w/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.004980 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 01:07:53.115952) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 01:07:53.116475) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 01:07:53.117008) ========= ========= Total master_lag: 0.33 =========