builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0234 starttime: 1490347502.59 results: success (0) buildid: 20170324012224 builduid: 737fe8891d964d8788f9235577b56d95 revision: 1bff0c493536f68a1850c435409495c45c91daf5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 02:25:02.590511) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-24 02:25:02.590948) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 02:25:02.591236) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-24 02:25:02.618230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:25:02.618602) ========= 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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-24 02:25:02-- 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% 18.6M=0.001s 2017-03-24 02:25:03 (18.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.295870 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:25:02.939064) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:25:02.939471) ========= 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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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.026037 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:25:02.988147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-24 02:25:02.988519) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1bff0c493536f68a1850c435409495c45c91daf5 --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 1bff0c493536f68a1850c435409495c45c91daf5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ca9DDR71XC/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.Atg9B1BQgz/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-24 02:25:03,191 truncating revision to first 12 chars 2017-03-24 02:25:03,191 Setting DEBUG logging. 2017-03-24 02:25:03,191 attempt 1/10 2017-03-24 02:25:03,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1bff0c493536?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-24 02:25:05,128 unpacking tar archive at: mozilla-aurora-1bff0c493536/testing/mozharness/ program finished with exit code 0 elapsedTime=2.215487 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-24 02:25:05.227858) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 02:25:05.228192) ========= script_repo_revision: 1bff0c493536f68a1850c435409495c45c91daf5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-24 02:25:05.228619) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 02:25:05.228894) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-24 02:25:05.248625) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2017-03-24 02:25:05.249050) ========= /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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 02:25:05 INFO - MultiFileLogger online at 20170324 02:25:05 in /builds/slave/test 02:25:05 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 02:25:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:25:05 INFO - {'append_to_log': False, 02:25:05 INFO - 'base_work_dir': '/builds/slave/test', 02:25:05 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:25:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:25:05 INFO - 'branch': 'Mozilla-Aurora', 02:25:05 INFO - 'buildbot_json_path': 'buildprops.json', 02:25:05 INFO - 'config_files': ('talos/mac_config.py',), 02:25:05 INFO - 'default_actions': ('clobber', 02:25:05 INFO - 'read-buildbot-config', 02:25:05 INFO - 'download-and-extract', 02:25:05 INFO - 'populate-webroot', 02:25:05 INFO - 'create-virtualenv', 02:25:05 INFO - 'install', 02:25:05 INFO - 'run-tests'), 02:25:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:25:05 INFO - 'download_minidump_stackwalk': True, 02:25:05 INFO - 'download_symbols': 'ondemand', 02:25:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:25:05 INFO - 'tooltool.py': '/tools/tooltool.py', 02:25:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:25:05 INFO - '/tools/misc-python/virtualenv.py')}, 02:25:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:25:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:25:05 INFO - 'gecko_profile': False, 02:25:05 INFO - 'gecko_profile_interval': 0, 02:25:05 INFO - 'installer_path': 'installer.exe', 02:25:05 INFO - 'log_level': 'info', 02:25:05 INFO - 'log_name': 'talos', 02:25:05 INFO - 'log_to_console': True, 02:25:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:25:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:25:05 INFO - 'opt_config_files': (), 02:25:05 INFO - 'pip_index': False, 02:25:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:25:05 INFO - 'cmd': ('bash', 02:25:05 INFO - '-c', 02:25:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:25:05 INFO - 'enabled': True, 02:25:05 INFO - 'halt_on_failure': False, 02:25:05 INFO - 'name': 'check_screen_resolution'},), 02:25:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:25:05 INFO - 'cmd': ('bash', 02:25:05 INFO - '-c', 02:25:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:25:05 INFO - 'enabled': True, 02:25:05 INFO - 'halt_on_failure': False, 02:25:05 INFO - 'name': 'check_screen_resolution'},), 02:25:05 INFO - 'run_cmd_checks_enabled': True, 02:25:05 INFO - 'suite': 'dromaeojs-e10s', 02:25:05 INFO - 'system_bits': '32', 02:25:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:25:05 INFO - 'title': 't-yosemite-r7-0234', 02:25:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:25:05 INFO - 'use_talos_json': True, 02:25:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:25:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:25:05 INFO - 'work_dir': 'build'} 02:25:05 INFO - [mozharness: 2017-03-24 09:25:05.557524Z] Running clobber step. 02:25:05 INFO - Running pre-action listener: _resource_record_pre_action 02:25:05 INFO - Running main action method: clobber 02:25:05 INFO - rmtree: /builds/slave/test/build 02:25:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:25:07 INFO - Running post-action listener: _resource_record_post_action 02:25:07 INFO - [mozharness: 2017-03-24 09:25:07.916229Z] Finished clobber step (success) 02:25:07 INFO - [mozharness: 2017-03-24 09:25:07.916433Z] Running read-buildbot-config step. 02:25:07 INFO - Running pre-action listener: _resource_record_pre_action 02:25:07 INFO - Running main action method: read_buildbot_config 02:25:07 INFO - Using buildbot properties: 02:25:07 INFO - { 02:25:07 INFO - "project": "", 02:25:07 INFO - "product": "firefox", 02:25:07 INFO - "script_repo_revision": "production", 02:25:07 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 02:25:07 INFO - "repository": "", 02:25:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 02:25:07 INFO - "buildid": "20170324012224", 02:25:07 INFO - "pgo_build": "False", 02:25:07 INFO - "basedir": "/builds/slave/test", 02:25:07 INFO - "buildnumber": 4, 02:25:07 INFO - "slavename": "t-yosemite-r7-0234", 02:25:07 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 02:25:07 INFO - "platform": "yosemite_r7", 02:25:07 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:25:07 INFO - "branch": "mozilla-aurora", 02:25:07 INFO - "repo_path": "releases/mozilla-aurora", 02:25:07 INFO - "revision": "1bff0c493536f68a1850c435409495c45c91daf5", 02:25:07 INFO - "stage_platform": "macosx64", 02:25:07 INFO - "builduid": "737fe8891d964d8788f9235577b56d95", 02:25:07 INFO - "slavebuilddir": "test" 02:25:07 INFO - } 02:25:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 02:25:07 INFO - Running post-action listener: _resource_record_post_action 02:25:07 INFO - [mozharness: 2017-03-24 09:25:07.919934Z] Finished read-buildbot-config step (success) 02:25:07 INFO - [mozharness: 2017-03-24 09:25:07.920047Z] Running download-and-extract step. 02:25:07 INFO - Running pre-action listener: _resource_record_pre_action 02:25:07 INFO - Running main action method: download_and_extract 02:25:07 INFO - mkdir: /builds/slave/test/build/tests 02:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:07 INFO - trying https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 02:25:07 INFO - Downloading https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:25:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 02:25:10 INFO - Downloaded 1199 bytes. 02:25:10 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 02:25:10 INFO - Using the following test package requirements: 02:25:10 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:25:10 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:10 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 02:25:10 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:10 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 02:25:10 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:10 INFO - u'jsshell-mac.zip'], 02:25:10 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:10 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 02:25:10 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 02:25:10 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:10 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 02:25:10 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:10 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 02:25:10 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:10 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 02:25:10 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 02:25:10 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 02:25:10 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:25:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:25:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:25:10 INFO - Fetch https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:25:13 INFO - Expected file size: 51787042 02:25:13 INFO - Obtained file size: 51787042 02:25:29 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:25:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 02:25:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:25:29 INFO - Fetch https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 02:25:31 INFO - Expected file size: 51787042 02:25:31 INFO - Obtained file size: 51787042 02:25:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 02:25:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:25:46 INFO - Fetch https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 02:25:48 INFO - Expected file size: 14404438 02:25:48 INFO - Obtained file size: 14404438 02:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:48 INFO - trying https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:25:48 INFO - Downloading https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 02:25:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 02:25:51 INFO - Downloaded 74765260 bytes. 02:25:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:25:51 INFO - mkdir: /builds/slave/test/properties 02:25:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:25:51 INFO - Writing to file /builds/slave/test/properties/build_url 02:25:51 INFO - Contents: 02:25:51 INFO - build_url:https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 02:25:52 INFO - Running post-action listener: _resource_record_post_action 02:25:52 INFO - Running post-action listener: set_extra_try_arguments 02:25:52 INFO - [mozharness: 2017-03-24 09:25:52.225453Z] Finished download-and-extract step (success) 02:25:52 INFO - [mozharness: 2017-03-24 09:25:52.225622Z] Running populate-webroot step. 02:25:52 INFO - Running pre-action listener: _resource_record_pre_action 02:25:52 INFO - Running main action method: populate_webroot 02:25:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:25:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:25:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:25:52 INFO - '--tppagecycles', 02:25:52 INFO - '7'], 02:25:52 INFO - 'tests': ['tsvgm']}}, 02:25:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:25:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:25:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:25:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:25:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:25:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:25:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 02:25:52 INFO - 'talos_options': ['--disable-e10s'], 02:25:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:25:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 02:25:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:25:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 02:25:52 INFO - 'talos_options': ['--disable-e10s'], 02:25:52 INFO - 'tests': ['damp', 'tps']}, 02:25:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 02:25:52 INFO - 'tests': ['damp', 'tps']}, 02:25:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:25:52 INFO - 'tests': ['dromaeo_dom']}, 02:25:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:25:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:25:52 INFO - 'tests': ['basic_compositor_video']}, 02:25:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:25:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:25:52 INFO - 'tests': ['a11yr', 02:25:52 INFO - 'ts_paint', 02:25:52 INFO - 'tpaint', 02:25:52 INFO - 'sessionrestore', 02:25:52 INFO - 'sessionrestore_no_auto_restore', 02:25:52 INFO - 'tabpaint']}, 02:25:52 INFO - 'other-e10s': {'tests': ['a11yr', 02:25:52 INFO - 'ts_paint', 02:25:52 INFO - 'tpaint', 02:25:52 INFO - 'sessionrestore', 02:25:52 INFO - 'sessionrestore_no_auto_restore', 02:25:52 INFO - 'tabpaint']}, 02:25:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:25:52 INFO - 'ts_paint', 02:25:52 INFO - 'tpaint', 02:25:52 INFO - 'sessionrestore', 02:25:52 INFO - 'sessionrestore_no_auto_restore', 02:25:52 INFO - 'tabpaint']}, 02:25:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:25:52 INFO - 'ts_paint', 02:25:52 INFO - 'tpaint', 02:25:52 INFO - 'sessionrestore', 02:25:52 INFO - 'sessionrestore_no_auto_restore', 02:25:52 INFO - 'tabpaint']}, 02:25:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:25:52 INFO - 'tests': ['a11yr', 02:25:52 INFO - 'ts_paint', 02:25:52 INFO - 'tpaint', 02:25:52 INFO - 'sessionrestore', 02:25:52 INFO - 'sessionrestore_no_auto_restore', 02:25:52 INFO - 'tabpaint']}, 02:25:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:25:52 INFO - 'tests': ['a11yr', 02:25:52 INFO - 'ts_paint', 02:25:52 INFO - 'tpaint', 02:25:52 INFO - 'sessionrestore', 02:25:52 INFO - 'sessionrestore_no_auto_restore', 02:25:52 INFO - 'tabpaint']}, 02:25:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:25:52 INFO - 'tests': ['tsvgx', 02:25:52 INFO - 'tsvgr_opacity', 02:25:52 INFO - 'tart', 02:25:52 INFO - 'tscrollx', 02:25:52 INFO - 'cart', 02:25:52 INFO - 'tsvg_static']}, 02:25:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:25:52 INFO - 'tsvgr_opacity', 02:25:52 INFO - 'tart', 02:25:52 INFO - 'tscrollx', 02:25:52 INFO - 'cart', 02:25:52 INFO - 'tsvg_static']}, 02:25:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 02:25:52 INFO - 'talos_options': ['--disable-e10s'], 02:25:52 INFO - 'tests': ['tp5o']}, 02:25:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 02:25:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 02:25:52 INFO - 'talos_options': ['--disable-e10s', 02:25:52 INFO - '--xperf_path', 02:25:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:25:52 INFO - 'tests': ['tp5n']}, 02:25:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 02:25:52 INFO - 'talos_options': ['--xperf_path', 02:25:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:25:52 INFO - 'tests': ['tp5n']}}, 02:25:52 INFO - 'talos.zip': {'path': '', 02:25:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:25:52 INFO - Running post-action listener: _resource_record_post_action 02:25:52 INFO - [mozharness: 2017-03-24 09:25:52.243923Z] Finished populate-webroot step (success) 02:25:52 INFO - [mozharness: 2017-03-24 09:25:52.244059Z] Running create-virtualenv step. 02:25:52 INFO - Running pre-action listener: _resource_record_pre_action 02:25:52 INFO - Running main action method: create_virtualenv 02:25:52 INFO - Creating virtualenv /builds/slave/test/build/venv 02:25:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:25:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:25:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:25:52 INFO - Using real prefix '/tools/python27' 02:25:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:25:53 INFO - Installing distribute.............................................................................................................................................................................................done. 02:25:55 INFO - Installing pip.................done. 02:25:55 INFO - Return code: 0 02:25:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:25:56 INFO - Reading from file tmpfile_stdout 02:25:56 INFO - Output received: 02:25:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:25:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe87ac84be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e4d30>, '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 0x10a30bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d9be8>, '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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:25:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ca9DDR71XC/Render', 02:25:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:25:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:25:56 INFO - 'HOME': '/Users/cltbld', 02:25:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:25:56 INFO - 'LOGNAME': 'cltbld', 02:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:56 INFO - 'MOZ_NO_REMOTE': '1', 02:25:56 INFO - 'NO_EM_RESTART': '1', 02:25:56 INFO - 'PAGER': '/bin/cat', 02:25:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:56 INFO - 'PWD': '/builds/slave/test', 02:25:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:25:56 INFO - 'SHELL': '/bin/bash', 02:25:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Atg9B1BQgz/Listeners', 02:25:56 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 02:25:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:25:56 INFO - 'USER': 'cltbld', 02:25:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:25:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:56 INFO - 'XPC_FLAGS': '0x0', 02:25:56 INFO - 'XPC_SERVICE_NAME': '0', 02:25:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:57 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:25:57 INFO - Cleaning up... 02:25:57 INFO - Return code: 0 02:25:57 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:25:57 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 0x10a606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe87ac84be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e4d30>, '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 0x10a30bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d9be8>, '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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:25:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:25:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ca9DDR71XC/Render', 02:25:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:25:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:25:57 INFO - 'HOME': '/Users/cltbld', 02:25:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:25:57 INFO - 'LOGNAME': 'cltbld', 02:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:25:57 INFO - 'MOZ_NO_REMOTE': '1', 02:25:57 INFO - 'NO_EM_RESTART': '1', 02:25:57 INFO - 'PAGER': '/bin/cat', 02:25:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:25:57 INFO - 'PWD': '/builds/slave/test', 02:25:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:25:57 INFO - 'SHELL': '/bin/bash', 02:25:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Atg9B1BQgz/Listeners', 02:25:57 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 02:25:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:25:57 INFO - 'USER': 'cltbld', 02:25:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:25:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:25:57 INFO - 'XPC_FLAGS': '0x0', 02:25:57 INFO - 'XPC_SERVICE_NAME': '0', 02:25:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:25:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:25:57 INFO - Downloading/unpacking psutil>=3.1.1 02:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:25:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:25:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:26:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:01 INFO - Installing collected packages: psutil 02:26:01 INFO - Running setup.py install for psutil 02:26:01 INFO - building 'psutil._psutil_osx' extension 02:26:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 02:26:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 02:26:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 02:26:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 02:26:02 INFO - building 'psutil._psutil_posix' extension 02:26:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 02:26:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:26:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:26:02 INFO - ^ 02:26:02 INFO - 1 warning generated. 02:26:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 02:26:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:02 INFO - Successfully installed psutil 02:26:02 INFO - Cleaning up... 02:26:02 INFO - Return code: 0 02:26:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:26:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:03 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 0x10a606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe87ac84be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e4d30>, '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 0x10a30bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d9be8>, '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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:26:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:26:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:26:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ca9DDR71XC/Render', 02:26:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:03 INFO - 'HOME': '/Users/cltbld', 02:26:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:03 INFO - 'LOGNAME': 'cltbld', 02:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:03 INFO - 'MOZ_NO_REMOTE': '1', 02:26:03 INFO - 'NO_EM_RESTART': '1', 02:26:03 INFO - 'PAGER': '/bin/cat', 02:26:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:03 INFO - 'PWD': '/builds/slave/test', 02:26:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:03 INFO - 'SHELL': '/bin/bash', 02:26:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Atg9B1BQgz/Listeners', 02:26:03 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 02:26:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:03 INFO - 'USER': 'cltbld', 02:26:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:03 INFO - 'XPC_FLAGS': '0x0', 02:26:03 INFO - 'XPC_SERVICE_NAME': '0', 02:26:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:26:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:26:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:26:07 INFO - Installing collected packages: mozsystemmonitor 02:26:07 INFO - Running setup.py install for mozsystemmonitor 02:26:07 INFO - Successfully installed mozsystemmonitor 02:26:07 INFO - Cleaning up... 02:26:08 INFO - Return code: 0 02:26:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:08 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 0x10a606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe87ac84be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e4d30>, '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 0x10a30bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d9be8>, '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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:26:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:26:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ca9DDR71XC/Render', 02:26:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:08 INFO - 'HOME': '/Users/cltbld', 02:26:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:08 INFO - 'LOGNAME': 'cltbld', 02:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:08 INFO - 'MOZ_NO_REMOTE': '1', 02:26:08 INFO - 'NO_EM_RESTART': '1', 02:26:08 INFO - 'PAGER': '/bin/cat', 02:26:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:08 INFO - 'PWD': '/builds/slave/test', 02:26:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:08 INFO - 'SHELL': '/bin/bash', 02:26:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Atg9B1BQgz/Listeners', 02:26:08 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 02:26:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:08 INFO - 'USER': 'cltbld', 02:26:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:08 INFO - 'XPC_FLAGS': '0x0', 02:26:08 INFO - 'XPC_SERVICE_NAME': '0', 02:26:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:08 INFO - Downloading/unpacking jsonschema==2.5.1 02:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:26:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:11 INFO - Downloading functools32-3.2.3-2.tar.gz 02:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:26:11 INFO - warning: no files found matching '*.txt' 02:26:11 INFO - no previously-included directories found matching 'build' 02:26:11 INFO - no previously-included directories found matching 'dist' 02:26:11 INFO - no previously-included directories found matching '.git*' 02:26:11 INFO - Installing collected packages: jsonschema, functools32 02:26:12 INFO - Running setup.py install for functools32 02:26:12 INFO - warning: no files found matching '*.txt' 02:26:12 INFO - no previously-included directories found matching 'build' 02:26:12 INFO - no previously-included directories found matching 'dist' 02:26:12 INFO - no previously-included directories found matching '.git*' 02:26:12 INFO - Successfully installed jsonschema functools32 02:26:12 INFO - Cleaning up... 02:26:12 INFO - Return code: 0 02:26:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe87ac84be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e4d30>, '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 0x10a30bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d9be8>, '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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 02:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 02:26:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ca9DDR71XC/Render', 02:26:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:12 INFO - 'HOME': '/Users/cltbld', 02:26:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:12 INFO - 'LOGNAME': 'cltbld', 02:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:12 INFO - 'MOZ_NO_REMOTE': '1', 02:26:12 INFO - 'NO_EM_RESTART': '1', 02:26:12 INFO - 'PAGER': '/bin/cat', 02:26:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:12 INFO - 'PWD': '/builds/slave/test', 02:26:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:12 INFO - 'SHELL': '/bin/bash', 02:26:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Atg9B1BQgz/Listeners', 02:26:12 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 02:26:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:12 INFO - 'USER': 'cltbld', 02:26:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:12 INFO - 'XPC_FLAGS': '0x0', 02:26:12 INFO - 'XPC_SERVICE_NAME': '0', 02:26:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:26:12 INFO - Cleaning up... 02:26:12 INFO - Return code: 0 02:26:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe87ac84be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e4d30>, '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 0x10a30bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d9be8>, '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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:26:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ca9DDR71XC/Render', 02:26:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:12 INFO - 'HOME': '/Users/cltbld', 02:26:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:12 INFO - 'LOGNAME': 'cltbld', 02:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:12 INFO - 'MOZ_NO_REMOTE': '1', 02:26:12 INFO - 'NO_EM_RESTART': '1', 02:26:12 INFO - 'PAGER': '/bin/cat', 02:26:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:12 INFO - 'PWD': '/builds/slave/test', 02:26:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:12 INFO - 'SHELL': '/bin/bash', 02:26:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Atg9B1BQgz/Listeners', 02:26:12 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 02:26:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:12 INFO - 'USER': 'cltbld', 02:26:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:12 INFO - 'XPC_FLAGS': '0x0', 02:26:12 INFO - 'XPC_SERVICE_NAME': '0', 02:26:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:12 INFO - Downloading/unpacking blobuploader==1.2.4 02:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:17 INFO - Downloading blobuploader-1.2.4.tar.gz 02:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:26:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:26:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:18 INFO - Downloading docopt-0.6.1.tar.gz 02:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:26:19 INFO - Installing collected packages: blobuploader, requests, docopt 02:26:19 INFO - Running setup.py install for blobuploader 02:26:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:26:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:26:19 INFO - Running setup.py install for requests 02:26:19 INFO - Running setup.py install for docopt 02:26:19 INFO - Successfully installed blobuploader requests docopt 02:26:19 INFO - Cleaning up... 02:26:19 INFO - Return code: 0 02:26:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:19 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 0x10a606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe87ac84be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e4d30>, '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 0x10a30bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d9be8>, '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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:26:19 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 02:26:19 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 02:26:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ca9DDR71XC/Render', 02:26:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:19 INFO - 'HOME': '/Users/cltbld', 02:26:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:19 INFO - 'LOGNAME': 'cltbld', 02:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:19 INFO - 'MOZ_NO_REMOTE': '1', 02:26:19 INFO - 'NO_EM_RESTART': '1', 02:26:19 INFO - 'PAGER': '/bin/cat', 02:26:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:19 INFO - 'PWD': '/builds/slave/test', 02:26:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:19 INFO - 'SHELL': '/bin/bash', 02:26:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Atg9B1BQgz/Listeners', 02:26:19 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 02:26:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:19 INFO - 'USER': 'cltbld', 02:26:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:19 INFO - 'XPC_FLAGS': '0x0', 02:26:19 INFO - 'XPC_SERVICE_NAME': '0', 02:26:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:20 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Ss3lyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:20 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-7STeUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:20 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-uskekY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:20 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-6zSm96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:20 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-S8kO6A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:20 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-gA2fja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:20 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-oixntO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:20 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-oWFVHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:21 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Ul6Q_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:21 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-3gAH2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:21 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-IA_HX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:21 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-o6aolS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:21 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-D31a9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:21 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-o4C64t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:21 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-J8KdAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:21 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-ZUvHMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:21 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-_NOMvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:26:21 INFO - Running setup.py install for manifestparser 02:26:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:26:22 INFO - Running setup.py install for mozcrash 02:26:22 INFO - Running setup.py install for mozdebug 02:26:22 INFO - Running setup.py install for mozdevice 02:26:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:26:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:26:22 INFO - Running setup.py install for mozfile 02:26:22 INFO - Running setup.py install for mozhttpd 02:26:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:26:22 INFO - Running setup.py install for mozinfo 02:26:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:26:22 INFO - Running setup.py install for mozInstall 02:26:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:26:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:26:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:26:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:26:23 INFO - Running setup.py install for mozleak 02:26:23 INFO - Running setup.py install for mozlog 02:26:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:26:23 INFO - Running setup.py install for moznetwork 02:26:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:26:23 INFO - Running setup.py install for mozprocess 02:26:23 INFO - Running setup.py install for mozprofile 02:26:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:26:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:26:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:26:23 INFO - Running setup.py install for mozrunner 02:26:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:26:24 INFO - Running setup.py install for mozscreenshot 02:26:24 INFO - Running setup.py install for moztest 02:26:24 INFO - Running setup.py install for mozversion 02:26:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:26:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:26:24 INFO - Cleaning up... 02:26:24 INFO - Return code: 0 02:26:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:24 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 0x10a606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe87ac84be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e4d30>, '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 0x10a30bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d9be8>, '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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:26:24 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 02:26:24 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 02:26:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ca9DDR71XC/Render', 02:26:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:24 INFO - 'HOME': '/Users/cltbld', 02:26:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:24 INFO - 'LOGNAME': 'cltbld', 02:26:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:24 INFO - 'MOZ_NO_REMOTE': '1', 02:26:24 INFO - 'NO_EM_RESTART': '1', 02:26:24 INFO - 'PAGER': '/bin/cat', 02:26:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:24 INFO - 'PWD': '/builds/slave/test', 02:26:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:24 INFO - 'SHELL': '/bin/bash', 02:26:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Atg9B1BQgz/Listeners', 02:26:24 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 02:26:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:24 INFO - 'USER': 'cltbld', 02:26:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:24 INFO - 'XPC_FLAGS': '0x0', 02:26:24 INFO - 'XPC_SERVICE_NAME': '0', 02:26:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:24 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-32KjRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:24 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)) 02:26:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:24 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-ALbQ8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:25 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)) 02:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Gp7PEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:25 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)) 02:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-GoVRTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:25 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)) 02:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-1F4I10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:25 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)) 02:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-lJBQ4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:25 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)) 02:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-6x6Mv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:25 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)) 02:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-Yv7Isd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:25 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)) 02:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-0XNYrq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:25 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)) 02:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-9Sk6rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:25 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)) 02:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-zfRPrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:25 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)) 02:26:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:25 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-mAUvlv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:26 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-EErU0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:26 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)) 02:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:26 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-y2iJXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:26 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)) 02:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:26 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-49yeOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:26 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)) 02:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:26 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-ZopQB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:26 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)) 02:26:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:26 INFO - Running setup.py (path:/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/pip-TWerP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:26 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)) 02:26:26 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)) 02:26:26 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)) 02:26:26 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)) 02:26:26 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)) 02:26:26 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)) 02:26:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:29 INFO - Downloading blessings-1.6.tar.gz 02:26:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:26:29 INFO - Installing collected packages: blessings 02:26:29 INFO - Running setup.py install for blessings 02:26:30 INFO - Successfully installed blessings 02:26:30 INFO - Cleaning up... 02:26:30 INFO - Return code: 0 02:26:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:26:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:30 INFO - Reading from file tmpfile_stdout 02:26:30 INFO - Current package versions: 02:26:30 INFO - blessings == 1.6 02:26:30 INFO - blobuploader == 1.2.4 02:26:30 INFO - docopt == 0.6.1 02:26:30 INFO - functools32 == 3.2.3-2 02:26:30 INFO - jsonschema == 2.5.1 02:26:30 INFO - manifestparser == 1.1 02:26:30 INFO - mozInstall == 1.12 02:26:30 INFO - mozcrash == 1.0 02:26:30 INFO - mozdebug == 0.1 02:26:30 INFO - mozdevice == 0.49 02:26:30 INFO - mozfile == 1.2 02:26:30 INFO - mozhttpd == 0.7 02:26:30 INFO - mozinfo == 0.9 02:26:30 INFO - mozleak == 0.1 02:26:30 INFO - mozlog == 3.4 02:26:30 INFO - moznetwork == 0.27 02:26:30 INFO - mozprocess == 0.25 02:26:30 INFO - mozprofile == 0.28 02:26:30 INFO - mozrunner == 6.13 02:26:30 INFO - mozscreenshot == 0.1 02:26:30 INFO - mozsystemmonitor == 0.3 02:26:30 INFO - moztest == 0.8 02:26:30 INFO - mozversion == 1.4 02:26:30 INFO - psutil == 3.1.1 02:26:30 INFO - requests == 1.2.3 02:26:30 INFO - wsgiref == 0.1.2 02:26:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:30 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 0x10a606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe87ac84be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e4d30>, '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 0x10a30bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d9be8>, '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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:26:30 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 02:26:30 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 02:26:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ca9DDR71XC/Render', 02:26:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:30 INFO - 'HOME': '/Users/cltbld', 02:26:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:30 INFO - 'LOGNAME': 'cltbld', 02:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:30 INFO - 'MOZ_NO_REMOTE': '1', 02:26:30 INFO - 'NO_EM_RESTART': '1', 02:26:30 INFO - 'PAGER': '/bin/cat', 02:26:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:30 INFO - 'PWD': '/builds/slave/test', 02:26:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:30 INFO - 'SHELL': '/bin/bash', 02:26:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Atg9B1BQgz/Listeners', 02:26:30 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 02:26:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:30 INFO - 'USER': 'cltbld', 02:26:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:30 INFO - 'XPC_FLAGS': '0x0', 02:26:30 INFO - 'XPC_SERVICE_NAME': '0', 02:26:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:30 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)) 02:26:30 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)) 02:26:30 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)) 02:26:30 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)) 02:26:30 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)) 02:26:30 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)) 02:26:30 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)) 02:26:30 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)) 02:26:30 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)) 02:26:30 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)) 02:26:30 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)) 02:26:30 INFO - Cleaning up... 02:26:30 INFO - Return code: 0 02:26:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a606b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a609768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe87ac84be0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a3e4d30>, '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 0x10a30bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d9be8>, '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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 02:26: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', 'jsonschema'] in /builds/slave/test/build 02:26: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 jsonschema 02:26:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ca9DDR71XC/Render', 02:26:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:30 INFO - 'HOME': '/Users/cltbld', 02:26:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:30 INFO - 'LOGNAME': 'cltbld', 02:26:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:30 INFO - 'MOZ_NO_REMOTE': '1', 02:26:30 INFO - 'NO_EM_RESTART': '1', 02:26:30 INFO - 'PAGER': '/bin/cat', 02:26:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:30 INFO - 'PWD': '/builds/slave/test', 02:26:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:30 INFO - 'SHELL': '/bin/bash', 02:26:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Atg9B1BQgz/Listeners', 02:26:30 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 02:26:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:30 INFO - 'USER': 'cltbld', 02:26:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:30 INFO - 'XPC_FLAGS': '0x0', 02:26:30 INFO - 'XPC_SERVICE_NAME': '0', 02:26:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:26:31 INFO - Cleaning up... 02:26:31 INFO - Return code: 0 02:26:31 INFO - Running post-action listener: _resource_record_post_action 02:26:31 INFO - Running post-action listener: _start_resource_monitoring 02:26:31 INFO - Starting resource monitoring. 02:26:31 INFO - [mozharness: 2017-03-24 09:26:31.050321Z] Finished create-virtualenv step (success) 02:26:31 INFO - [mozharness: 2017-03-24 09:26:31.051340Z] Running install step. 02:26:31 INFO - Running pre-action listener: _resource_record_pre_action 02:26:31 INFO - Running main action method: install 02:26:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:31 INFO - Reading from file tmpfile_stdout 02:26:31 INFO - Detecting whether we're running mozinstall >=1.0... 02:26:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:26:31 INFO - Reading from file tmpfile_stdout 02:26:31 INFO - Output received: 02:26:31 INFO - Usage: mozinstall [options] installer 02:26:31 INFO - Options: 02:26:31 INFO - -h, --help show this help message and exit 02:26:31 INFO - -d DEST, --destination=DEST 02:26:31 INFO - Directory to install application into. [default: 02:26:31 INFO - "/builds/slave/test"] 02:26:31 INFO - --app=APP Application being installed. [default: firefox] 02:26:31 INFO - mkdir: /builds/slave/test/build/application 02:26:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:26:52 INFO - Reading from file tmpfile_stdout 02:26:52 INFO - Output received: 02:26:52 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:26:52 INFO - Running post-action listener: _resource_record_post_action 02:26:52 INFO - [mozharness: 2017-03-24 09:26:52.099728Z] Finished install step (success) 02:26:52 INFO - [mozharness: 2017-03-24 09:26:52.099865Z] Running run-tests step. 02:26:52 INFO - Running pre-action listener: _resource_record_pre_action 02:26:52 INFO - Running main action method: run_tests 02:26:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:26:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:26:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:26:52 INFO - 2017-03-24 02:26:52.114 screenresolution[1632:7721] starting screenresolution argv=screenresolution get 02:26:52 INFO - 2017-03-24 02:26:52.117 screenresolution[1632:7721] Display 0: 1600x1200x32@60 02:26:52 INFO - 2017-03-24 02:26:52.123 screenresolution[1633:7723] starting screenresolution argv=screenresolution list 02:26:52 INFO - Available Modes on Display 0 02:26:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:26:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:26:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:26:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:26:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:26:52 INFO - Intel Iris: 02:26:52 INFO - Chipset Model: Intel Iris 02:26:52 INFO - Type: GPU 02:26:52 INFO - Bus: Built-In 02:26:52 INFO - VRAM (Dynamic, Max): 1536 MB 02:26:52 INFO - Vendor: Intel (0x8086) 02:26:52 INFO - Device ID: 0x0a2e 02:26:52 INFO - Revision ID: 0x0009 02:26:52 INFO - Displays: 02:26:52 INFO - Display: 02:26:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:26:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:26:52 INFO - Display Serial Number: 1600x1200 60 02:26:52 INFO - Main Display: Yes 02:26:52 INFO - Mirror: Off 02:26:52 INFO - Online: Yes 02:26:52 INFO - Rotation: Supported 02:26:52 INFO - Return code: 0 02:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:26:52 INFO - Python 2.7.3 02:26:52 INFO - Return code: 0 02:26:52 INFO - grabbing minidump binary from tooltool 02:26:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:26:52 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 0x10a3e4d30>, '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 0x10a30bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a3d9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:26:52 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 02:26:52 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 02:26:52 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 02:26:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:26:52 INFO - Return code: 0 02:26:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:26:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:26:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:26:52 INFO - ENV: RUST_BACKTRACE is now 1 02:26:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:26:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:26:52 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/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0234', '--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 02:26:52 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/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0234 --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 02:26:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ca9DDR71XC/Render', 02:26:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:26:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:26:52 INFO - 'HOME': '/Users/cltbld', 02:26:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:26:52 INFO - 'LOGNAME': 'cltbld', 02:26:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:26:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:52 INFO - 'MOZ_NO_REMOTE': '1', 02:26:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:26:52 INFO - 'NO_EM_RESTART': '1', 02:26:52 INFO - 'PAGER': '/bin/cat', 02:26:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:52 INFO - 'PWD': '/builds/slave/test', 02:26:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:26:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:26:52 INFO - 'RUST_BACKTRACE': '1', 02:26:52 INFO - 'SHELL': '/bin/bash', 02:26:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Atg9B1BQgz/Listeners', 02:26:52 INFO - 'TMPDIR': '/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/', 02:26:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:26:52 INFO - 'USER': 'cltbld', 02:26:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:26:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:52 INFO - 'XPC_FLAGS': '0x0', 02:26:52 INFO - 'XPC_SERVICE_NAME': '0', 02:26:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:26:52 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/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0234', '--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 02:26:52 INFO - mozversion application_buildid: 20170324012224 02:26:52 INFO - mozversion application_changeset: 1bff0c493536f68a1850c435409495c45c91daf5 02:26:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:26:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:26:52 INFO - mozversion application_name: Firefox 02:26:52 INFO - mozversion application_remotingname: firefox-dev 02:26:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:26:52 INFO - mozversion application_vendor: Mozilla 02:26:52 INFO - mozversion application_version: 54.0a2 02:26:52 INFO - mozversion platform_buildid: 20170324012224 02:26:52 INFO - mozversion platform_changeset: 1bff0c493536f68a1850c435409495c45c91daf5 02:26:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:26:52 INFO - mozversion platform_version: 54.0a2 02:26:52 INFO - using testdate: 1490347612 02:26:52 INFO - actual date: 1490347612 02:26:52 INFO - starting webserver on 'localhost:49247' 02:26:52 INFO - SUITE-START | Running 2 tests 02:26:52 INFO - TEST-START | dromaeo_css 02:26:52 INFO - operating with platform_type : mac_ 02:26:52 INFO - Initialising browser for dromaeo_css test... 02:26:52 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpGlmGMu/profile http://localhost:49247/getInfo.html) 02:26:55 INFO - PROCESS | 1643 | 2017-03-24 02:26:55.548 plugin-container[1645:7878] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x913f, name = 'com.apple.tsm.portname' 02:26:55 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:26:55 INFO - PROCESS | 1643 | 2017-03-24 02:26:55.553 plugin-container[1645:7878] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b0b, name = 'com.apple.CFPasteboardClient' 02:26:55 INFO - PROCESS | 1643 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:26:55 INFO - PROCESS | 1643 | 2017-03-24 02:26:55.553 plugin-container[1645:7878] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:26:55 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 02:26:55 INFO - PROCESS | 1643 | colorDepth:24 02:26:55 INFO - PROCESS | 1643 | Browser inner width/height: 1024/663 02:26:55 INFO - PROCESS | 1643 | __metrics 02:26:55 ERROR - PROCESS | 1643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 02:26:56 INFO - TEST-INFO | 1643: exit 0 02:26:56 INFO - Browser initialized. 02:26:56 INFO - Running cycle 1/1 for dromaeo_css test... 02:26:56 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpGlmGMu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:26:58 INFO - PROCESS | 1646 | 2017-03-24 02:26:58.714 plugin-container[1647:8010] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 02:26:58 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:26:58 INFO - PROCESS | 1646 | 2017-03-24 02:26:58.715 plugin-container[1647:8010] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 02:26:58 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:26:58 INFO - PROCESS | 1646 | 2017-03-24 02:26:58.715 plugin-container[1647:8010] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:27:08 INFO - PROCESS | 1646 | RSS: Main: 230854656 02:27:08 INFO - PROCESS | 1646 | 02:30:11 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 02:30:13 INFO - PROCESS | 1646 | RSS: Main: 245383168 02:30:13 INFO - PROCESS | 1646 | 02:31:56 INFO - PROCESS | 1646 | ************************* 02:31:56 INFO - PROCESS | 1646 | A coding exception was thrown and uncaught in a Task. 02:31:56 INFO - PROCESS | 1646 | 02:31:56 ERROR - PROCESS | 1646 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:31:56 INFO - PROCESS | 1646 | Full stack: 02:31:56 INFO - PROCESS | 1646 | ************************* 02:33:16 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 02:33:17 INFO - PROCESS | 1646 | RSS: Main: 255619072 02:33:17 INFO - PROCESS | 1646 | 02:36:18 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 02:36:19 INFO - PROCESS | 1646 | RSS: Main: 262299648 02:36:19 INFO - PROCESS | 1646 | 02:39:21 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 02:39:22 INFO - PROCESS | 1646 | RSS: Main: 258523136 02:39:22 INFO - PROCESS | 1646 | 02:42:25 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 02:42:26 INFO - PROCESS | 1646 | RSS: Main: 263696384 02:42:26 INFO - PROCESS | 1646 | 02:45:28 INFO - PROCESS | 1646 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 02:45:28 INFO - PROCESS | 1646 | RSS: Main: 259739648 02:45:28 INFO - PROCESS | 1646 | 02:45:28 INFO - PROCESS | 1646 | __start_tp_report 02:45:28 INFO - PROCESS | 1646 | _x_x_mozilla_page_load 02:45:28 INFO - PROCESS | 1646 | _x_x_mozilla_page_load_details 02:45:28 INFO - PROCESS | 1646 | |i|pagename|runs| 02:45:28 INFO - PROCESS | 1646 | |0;dojo.html;3465.60145583258;3496.5279687242223;3529.047157267538;3531.4526248431503;3539.8407071681772;6073.514118870491;6091.817245482637;6112.510999120071;6136.631802091878;6167.229096362955;6116.6941652917285;6200.875982480347;6240.063990401442;6244.344343843899;6256.874862502747;4566.474855391622;5458.0721277382845;5537.833864984037;5541.113421852504;5567.220589117527;5591.496765291123;5594.944050559483;5606.691631960241;5610;5645.0121228785;5395.568354531628;5409.161579955114;5507.228987941691;5594.720263986805;5604.383517813058;5500.532454741352;5534.169874518814;5544.500994910437;5578.888422231573;5610.102383618601;5418.133098704227;5530.834074977757;5541.224228607998;5552.333719953632;5580.246666699984;6184.56708030438;6201.16284301618;6230.408111229426;6239.06414037898;6244.438000579969;6265.87468250637;6349.301576826545;6382.585131966407;6409.327020662857;6471.061696054046;6581.670916454158;6599.70301336441;6607.008948657692;6608.1409416776;6630.734770609218;6195.721192546346;6222.066689996446;6248.187735594389;6272.9999999999545;6288.937110628926;6444.903326450107;6489.1888513935755;6642.867142657216;6660.467162626978;6755.932440675629;6311.368863113652;6343.175387199727;6369.394907483782;6414.967925160345;6429.6142231466265;4896.95103048972;5363.141897296414;5729.312482502127;6328.968355158195;6508.609483430914;6243.37566243372;6295.559310848288;6335.334789847092;6433.646149461731;6493.805185844338;6360.014197799349;6420.26166990802;6524.575902566413;6530.477561795045;6538.444232240217;5245.554127899095;5257.868553286198;5258.053550360895;5259.263703081571;5269;4539.500654927955;4638.2115040443205;4661.300804879227;4682.297655351656;4690.6951048182445;6161.4146656067605;6169.074638804125;6192.81421557354;6243.7814676486105;6309.08518264849;6561.835954101186;6599.868002640016;6609.6364699941005;6639;6642.501812364092;6078.848028799315;6133.96933015341;6224.346443623445;6229.688515574294;6257.43683068526;5825.854353641193;5856.326522449973;5857.970710146507;5888.9705551472825;5899.705014749331;6798.626075565693;6841.110655614738;6846.178458584902;6854.143232095988;6862;6310.873782524415;6376.9043464349;6470.352964703492;6608.768693095719;6620.404163625297;6783.728650853911;6798.048273241651;6820.658967051727;6832.077669514552;6836.213835408793;6448.613083215022;6462.579932304385;6463.870722585616;6471.417572418505;6479.838004049748;6269.059641053696;6333.20834895638;6468.870622587616;6483.124778154889;6529.020646903003;6341.841453963688;6390.584612000205;6395.776147834804;6401.551891367746;6403.51973601991;6364.172657554488;6369.840753981188;6375.872482550416;6384.201974753156;6391.424771770563;4756.524347565354;6136.815895523141;6173.660448675366;6210.596311239755;6293.716782744879;6279.654618995999;6314.147590075281;6434.613923164625;6446.67766611677;6452.838489071824;6266.310705822265;6269.937300627118;6273.905891411541;6284.654344010941;6293.622382657055 02:45:28 INFO - PROCESS | 1646 | |1;ext.html;666.6566718140158;716.4018044932482;793.7142628653681;856.152409114976;857.7726902370869;36358.909232723025;36763.08092297694;37013.81493092534;38281;38345.42481862774;36717.89846304608;37046.629533704654;37084.258314833685;37101.25797484049;37134.257314853756;7378.631068446583;7632.771016869503;7777.611119444034;7779.76660700177;7789.454738168331;7461;10955.890441095567;11164.776704465905;11303.982641562257;11363.431828408588;10020.899791002106;10705.357678539274;11103.333799972028;11187.32876027437;11213.159013074011;9475.28935329853;11114.444277786079;11134.49894754734;11139.721506962309;11163.441827908571;9702.320837541374;10553.261271710984;10878.836817447745;10887.673369798918;10897;38317;38618.03454913622;38636;38707.80646096751;38739.806300968594;3790.4882840816413;3803.40923230061;3864.381698928158;3921.0197450637343;3922.5685174630767;21909.452263693376;21916.671249931263;25293.49413011748;25403.983840646535;26268;2995.7409588557707;3088.6911308869157;3203.5675183850117;3285.4578994465883;3287.3260981498734;287217;344365;345054;345157;349023.76464352803;42047.159056818695;42397.36403953943;50313;50338.24492632614;50487.74756126196;52113;52679.73660131675;52727.20909186365;52930.47069529333;53262.46737532652;14064.578062658136;14194.574162775134;14284.785728214085;14310.356033978496;14333.498327558485;12363.876361236273;12387.938060309642;12402.25586464797;12417.875821241852;12434.875651243552;11719.882801172049;11721.648350549498;11734.178607497564;11780.352080635646;11839.467223974769;5475.589330800206;5485.451454854483;5488.341399032061;5495.560355171577;5541.196526503634;1116.3078891087578;1125.2685754259796;1131.7793030359167;1159.6197085495853;1184.5498710489958;26272.73727262741;26362.86818565895;26490.337741556614;26663.066792662165;26716;875.8861348024843;1047.910927571165;1201.1711918776016;1234.6419538333782;1244.5208594690928;8432.283255923316;10614.203934704929;11662.067034637208;11993.940030299793;14040.438382464587;386924;489282;489462;489759;490337;46265.30602040972;46317;46361;46381.76809115933;46481.53518464772;1352.371147416456;1367.5623800383783;1383.156274672449;1389.062382891544;1390.1450607876286;25544.489110218063;25773.484530309663;26368.3407914796;26415.471690566465;26693.866530667223;38820.80589597034;38870.028249293995;38893.611063889;38976.805115975374;39144.608553915234;450355;454281;454344;454590;455887;27243.72756272491;28478.715212847605;29096.854515727286;30136.794528219503;30235.09294721162;37447.81276093602;37897;38513;38706.80646596749;38718.225635487695;32402;32588.348233035682;32670;33595.32809343751;33682.10663069025;32411.51382729308;32750.508742368405;32846.17884552905;32945.67054329426;33107.351411886506;29968.85015574908;31722.841385792923;31931.201719957186;32332.676673232967;32738.690452381637;28693.99571015088;29308;29394;29429.85285073561;29495.410091798472;22642.77357226407;22868.97089631004;23114.653280201146;23188.072477100726;23276.534469310856 02:45:28 INFO - PROCESS | 1646 | |2;jquery.html;398.2254514968388;398.4401915308992;410.3864722240251;421.791213349392;439.2379222049745;19694;20080.397588072345;20528.384148475532;20724.48188795277;21183.04676289567;21561.921903904782;21731.565368692656;22183.55806872556;22375;22478.32565023048;6568.901466478007;6884.1050663413935;6924.376806087451;6939.132608423947;6942.062821519081;6087.178230938811;6569.408753212234;6665.13353264075;6860.862782744342;6865.901455767078;6545.476361891037;6851.794446166623;6855.4172895303955;6862.656867156647;6870.141232345957;6781.22015968165;6926.411255043277;6929.930700693004;6930.099087118668;6930.3762661360215;6335.493160547191;6584.9012264816065;6677.098591690108;6686.498512611525;6737.157855268091;25507;25679.871600641876;25725.742742572707;25882.87058564714;25911.870440647675;2476.8761561921833;2932.677405485395;2987.790854640176;3002.7597792176575;3182.6976437238427;15886.76169857453;16418.917905410515;16552.503424897273;16901;17217;2003.7996200379846;2021.6361055010093;2035.8473114516323;2035.918563257468;2069.1102825784906;121406;123595.52808943861;128315;129424.35287823595;131138;17530.386436474662;21945.451363715714;21951.780482195292;22134.225302114348;22251.332460026224;36726.08184795348;36735.816320918224;37294.25411491755;37396;37441.75349478985;10636.893631063745;10681.570285427562;10953.616623418142;11136.665900023012;11312.321260724382;7427.62861856905;9035.63857445708;9091.499967501719;9199.218066464426;9240.475321572;8618.827623447496;10192.949035254776;10543.894561054445;10544.736381590521;10629.681109566725;3559.501669766235;3995.34076877312;4378.723064006763;4400.427944367212;4424.977875110604;882.9249513791272;905.8686490458847;1000.2348203624233;1003.9598416063276;1019.2101121630648;11453.026492748044;13151.408186631625;13659.863401366058;13708.588742337746;14042.087264327785;901.4681338010605;1024.7643042100358;1040.8386700061503;1043.6660268713938;1061.2200032975757;6092.7562897484495;7013;7232.385247254042;7244.565326080452;7441.851162976818;705115;714396;714961;723280;729193;98865.01134988702;114840;115786.26320605198;123451;125234;1238.9690257743448;1253.3482589053824;1267.9429425675867;1268.3830855685312;1269.9936500317624;19338.806611934262;19881.60236795227;20718.067686954426;21027.579448411252;21029.789702102782;55837.162442562585;55837.883242334115;56261.15608265797;56669.43330566806;56741.43258567362;77732.61133694295;78585.60707196427;79492;79539.60230198812;79803.2019679819;11543.134264930331;11770.882291176978;11772.70568235801;11996.280223186637;12124.696882578006;12560.183588066746;12816.423260953467;12916.741665166832;13043.152195107288;13213.405396757362;8994.730158095268;11024.889751102386;11094.944525277322;11106.444677766242;11269.380184089954;9450.858237126311;10593.576256949636;10839.945800270949;10907.29102608328;10923.071538919281;11032.669019929415;11076.280041797258;11111.722096970263;11196.328220306481;11294.152938529478;11707.765844683228;11734.589289374831;11743.647690569296;12036.879631203576;12086.879131208576;10835.75388830263;10963.451827408438;10964.122870170208;11020.559177633126;11045 02:45:28 INFO - PROCESS | 1646 | |3;mootools.html;1530.4031427743175;1553.0914415067184;1570.2855200883598;1572.2767526937607;1585.1440222279969;10783.946080269598;11297.378644174567;11491.195616306852;11492.023178029867;11607;11320.547178112865;11541.769164616724;11553.960143587075;11563.364014979174;11570;2066.5143691232547;2364.9054037838464;2405.8075353971726;2410.867402292873;2412.8431651942656;2301.344116926676;2320.1879342230254;2339;2341.7892389684926;2346.2257455039794;2330.382448651109;2342.16853017179;2348.0255693887016;2348.729896061949;2357.6463530470396;2299.9195028174017;2304.124432715574;2304.4008557774932;2305.273838740808;2309.90760369585;2314.479242170515;2369.680093187415;2386.9403264918515;2388.3312672451743;2393.916212932539;11209.383483908381;11281.435928203638;11365.147613928988;11369.976702096768;11382.2032457728;5547.5007249347755;5566.137248726453;5632.831015069554;5872.060470324727;5892.116182572606;3417.6753208445157;3582.5342705448124;3589.066842620937;3658.2866341063504;3661.5056967309606;1114.3202646385698;1163.9359835209061;1185.4250688416112;1192.9522819087226;1220.206865537399;14286.928565357211;14439.205843678594;15230.162341071236;15755.68488630221;15783.842161578352;4484.529124441952;4607.00949295903;4747.264174053027;4754.120487709784;4763.285507173951;11696.94151529254;11824.822627660593;11852.644420667393;11881.287122772661;11887.10846686502;5720.48515633595;5741.540676745851;5743;5752.798652047159;5806.593538452352;5148.536631703165;5238.397584277857;5254.710990895461;5276.683398996072;5288.101022826128;3793.6206379361843;3865.40086286626;3883.4369016493015;3917.7061720370516;3961.16815468749;1005.6681295172575;1012.1902478017556;1015.3501758874327;1023.3297190340339;1024.7233247023412;947.8436058050345;955.953231211822;956.9712908612753;968.0948313327061;1008.1632245236583;6415.422611964852;6707.3628005339415;6865.759698410631;6891.448684105259;6928.930710692929;967.690339091498;986.935849169816;1004.5479534209635;1017.9236557258087;1030.9793304628363;4017.8995525112105;4059.411385349108;4083.89790255246;4546.272596384562;4565.748883811422;13796.172229666252;14261.215633140277;14264.286785660675;14295.784858287163;14299.213543255013;13795.379207935666;13897.374618142007;14220.217888016052;14280.357383917748;14466.20435876037;8623.956880215685;10207.948960255151;10323.48382580868;10439.321444106108;10499.527521261562;6487.610743355413;6907.827304317432;6968.3728464438445;7107.289271072851;7140.321669441395;12012.75974480523;12017.879821201675;12071.275723456622;12138.757224855277;12302.753944920873;12460.750784984431;12488;12658.556950506689;12781.16922400041;12886.613401597968;7808;8030.799230019296;8512.616932237941;8521.275691566287;8574.657013719381;10279.383237005804;10319.122874555447;10384.065434110664;10415.323004004715;10438.37369757817;9103.726888193365;9171.495567743572;9186.954065229631;9197.586108624993;9221.446713197229;8981.730548083568;9119.498427586546;9144.1770240676;9200.21798147165;9210.723678289662;7998.200179982188;8074.475159114639;8145.755627331189;8152.470089444168;8155.184481551797;5190.325257716624;5844.444777746107;5934.3175534814045;6119.388061193845;6184.474319682878;6000.669963152069;6013.338532761481;6118.112873633388;6126.877462450815;6285.874282514415 02:45:28 INFO - PROCESS | 1646 | |4;prototype.html;333.44314993960086;335.7213512784388;347.80890272219744;361.85344935301214;374.3374227617116;5001.399832020158;5054.595632349412;5141.383034035921;5318.255444237805;5426.728663566821;5090.236464530322;5206.088934436478;5255.710935898524;5256.316678831747;5271.209318602202;3552.43161094225;4172.70791044627;4541.863744087683;4542.069620411328;4548.431446069241;3679.705623550123;4269.359596060584;4286.42133312002;4535.863924082267;4562.749048802315;4039.454673619053;4502.2571275739465;4507.819687212507;4523.773811309437;4546.477155127153;3785.034816121899;4111.273265228611;4538.614217791492;4544.727316361029;4586.334981427708;3546;3832.1450519362975;3836.3861782114727;4288.69979101463;4324.524302326741;4711.924185579449;4764.904701905943;4822.276658501218;5095.668781529189;5150.819721309774;4495.820167193308;4578.122969582489;5056.823011194628;5058.671186372874;5071;4947.233178857283;5616.466435688603;5621.381648018714;5660.858478538028;5691.971540142315;4059.5128584569748;4312.63342615878;4451.532589078132;4452.977735111336;4465.955340446587;5363.758630861582;5447.45525447456;5599.860003499904;5869.482686274845;5926.303531892979;3686.115332320224;4172.937405938914;4210.642095421924;4385.7149285296355;4584.541545845455;3864.845406183721;3883.4757307763657;4652.743079844123;4717.575418212309;4802.327674125625;3917.6278253565865;3978.8209530571194;4703.929441058387;5035.748212589356;5094.694318340911;5400.594955378362;5564.523786914784;5590.97204513983;5683.232763576947;5698.6580805151825;1370.8971827113007;1393.5053056165118;1501.5510032818383;1584.5167223996561;1586.1672621873608;1073.4096247064083;1126.5212284778936;1161.1059484197121;1184.6209213051914;1186.4542310537076;5110.821121260738;5168.638195326291;5348.1175606025345;5382.865428364322;5404.405515393303;5180.585553155738;5268.629116897411;5808.709564521757;5860.560457965585;5886.293644762571;4544.159330523864;4886.511348865085;4986.850394488099;5046.47012063728;5195.896082078338;2573.7554932281405;3063;3080.9845950770105;3082.212316856263;3100.705432983863;5424.457554244623;5749.770009199585;5860.765569377178;6118.938810611926;6127.295361033538;5311.814086506954;5832.629332106952;5973.66908990978;6006.399360063959;6033.526254235742;4992.012779552687;5692.857678558069;5778.971105144447;6036.788712395045;6092.421219984094;5078.263651770547;5790.971045144747;5892.469677729025;5914.239037574794;5922.851928701817;5044.823431180038;5107.135895398079;5447.27636181909;5655.575831812713;5817.563682723728;5268.868278293074;5517.2344849647725;5734.7061175530125;5799.8550036249435;6151.6924153793025;4328.653707703439;4454.443194600675;4574.6569007323915;4577.702449340783;4584.701994370355;5334.413214546319;5410.702411367412;5545.528630066489;5837.387074357302;5903.815588232382;5069;5114.693118412907;5334;5655.321361436654;5673.347565030074;4871.585915197106;4908.803647854046;5227.137522308929;5557.888842223214;5683.516901063456;4620.676552641283;4850.733209673502;5029.723365214802;5057.747112644427;5569.777208911598;4393.946207385836;5012.924806127984;5152.819651312186;5261.447548007404;5640.492355688008;5241.528262456245;5307.311418564061;5511.830697349121;5537.944620553743;5552.888942221214 02:45:29 INFO - PROCESS | 1646 | |5;yui.html;713.9071920650315;723.4393345157499;773.8916551682765;786.7561056072618;819.3445243804958;14807.185604791732;17888.82111178888;18706.345277915276;18713.064346782674;18715.43853684388;17755.91122044388;17760.64478710425;17858.732119018227;17961.461156165336;17995.100244987763;771.7761849063764;893.4014210478962;925.676013395313;929.7350255177275;931.8602209668536;910.4719262827545;916.1342531307884;917.7338571814166;927.4852456886425;929.4098247612781;976.0288512929645;976.199516396555;977.1742877268732;977.7066879936026;977.8386566216566;962.672691284963;967.4340510801189;973.8539219117118;974.1865542272211;974.770928831724;627.093849387635;660.4056349285681;662.8011596521025;718.4683334332608;719.5251134251421;16479.670406591922;16504.092274924875;16711.415100471546;16794.66410671792;16809.571186449168;14212.289385530683;14292.785608215885;14326;14421.423143074264;14433.422663093465;11725.589604363806;11740.706482337924;11767;11771.176017678767;11855.39181380095;3635.745497815154;3658.22803649299;3688.409854423306;3699.167687270343;3860.227954409101;98840;104247;107108.99999999921;108661;109330;10302.484875756332;10477.790444191074;10592.205584581186;10666.893331066745;10716.362859088615;20399.796002040086;21101.78898210998;21584.352469425943;21978.560428791334;22246.888765556392;7932.405069619802;7950.562719050392;8058.556779377073;8075.959620201979;8084.595770211584;4281.550437204049;4347.500037495728;4407.603315701603;4414.867553973386;4510.887227819265;3416.829158542063;3487.9302413951577;3538.5222994895876;3573.6426357364057;3589.8743543975834;548.7393488093204;631.4853394483481;651.5341530805497;653.1313353240179;665.3845193196274;585.4613755345093;695.3847679984149;700.852820907605;714.9499535032602;755.0637209859734;8938.731838044869;10157.593696252216;10352.430616316024;10559.894401055892;10593.364398136137;539.36624466252;581.7992792486585;602.135934933372;605.8545948972215;721.4769292263068;4560.521145279764;4972.378452693413;4995.9500404996215;5017.523335283142;5031.949680503221;96866;98212;99049;100112;101185;83816.58091709502;85440.57279713561;86417.56791216004;87300;87541;77128;77408.61295693486;77772;77775.61112194516;78215.2178478208;9518.904810951803;9880.35777674449;9921.355111917703;9931.900680993098;9942.353747006422;40688.59311406848;40744.98137546585;50112;50222.2466662993;50359.24461133159;45535.861603458856;64541;65607;73156.63421682858;74689.87965180635;12966.286854223108;13201.933990329986;13305.600831975056;13330.933345333211;13505.527306544223;14962.775558366415;15374;15382.384704612137;15580.220988950734;16076.115813630362;13171.538996135088;13704.931475342559;13970.441182352592;14418.711625767635;14506.492272770402;13638.522651707142;14283.928580357031;14322.856771432153;14328.856711432752;14376.281185940452;13578.753773264014;13691.863081369058;13848.861511384757;13861.306934653428;14372.850171986007;10507.579696812041;11009.724756880822;11140.832887506856;11322.716932076764;11851.940740296588;11151.498182581965;11277.154213434189;11398.658040258806;11545.538178473103;11564.826527602261 02:45:29 INFO - PROCESS | 1646 | __end_tp_report 02:45:29 INFO - PROCESS | 1646 | __start_cc_report 02:45:29 INFO - PROCESS | 1646 | _x_x_mozilla_cycle_collect,423 02:45:29 INFO - PROCESS | 1646 | __end_cc_report 02:45:29 INFO - PROCESS | 1646 | __startTimestamp1490348728987__endTimestamp 02:45:29 INFO - PROCESS | 1646 | 02:45:29 INFO - PROCESS | 1646 | ------- Summary: start ------- 02:45:29 INFO - PROCESS | 1646 | Number of tests: 6 02:45:29 INFO - PROCESS | 1646 | 02:45:29 INFO - PROCESS | 1646 | [#0] dojo.html Cycles:165 Average:6045.95 Median:6269.06 stddev:682.70 (10.9%) stddev-sans-first:654.09 02:45:29 INFO - PROCESS | 1646 | Values: 3465.6 3496.5 3529.0 3531.5 3539.8 6073.5 6091.8 6112.5 6136.6 6167.2 6116.7 6200.9 6240.1 6244.3 6256.9 4566.5 5458.1 5537.8 5541.1 5567.2 5591.5 5594.9 5606.7 5610.0 5645.0 5395.6 5409.2 5507.2 5594.7 5604.4 5500.5 5534.2 5544.5 5578.9 5610.1 5418.1 5530.8 5541.2 5552.3 5580.2 6184.6 6201.2 6230.4 6239.1 6244.4 6265.9 6349.3 6382.6 6409.3 6471.1 6581.7 6599.7 6607.0 6608.1 6630.7 6195.7 6222.1 6248.2 6273.0 6288.9 6444.9 6489.2 6642.9 6660.5 6755.9 6311.4 6343.2 6369.4 6415.0 6429.6 4897.0 5363.1 5729.3 6329.0 6508.6 6243.4 6295.6 6335.3 6433.6 6493.8 6360.0 6420.3 6524.6 6530.5 6538.4 5245.6 5257.9 5258.1 5259.3 5269.0 4539.5 4638.2 4661.3 4682.3 4690.7 6161.4 6169.1 6192.8 6243.8 6309.1 6561.8 6599.9 6609.6 6639.0 6642.5 6078.8 6134.0 6224.3 6229.7 6257.4 5825.9 5856.3 5858.0 5889.0 5899.7 6798.6 6841.1 6846.2 6854.1 6862.0 6310.9 6376.9 6470.4 6608.8 6620.4 6783.7 6798.0 6820.7 6832.1 6836.2 6448.6 6462.6 6463.9 6471.4 6479.8 6269.1 6333.2 6468.9 6483.1 6529.0 6341.8 6390.6 6395.8 6401.6 6403.5 6364.2 6369.8 6375.9 6384.2 6391.4 4756.5 6136.8 6173.7 6210.6 6293.7 6279.7 6314.1 6434.6 6446.7 6452.8 6266.3 6269.9 6273.9 6284.7 6293.6 02:45:29 INFO - PROCESS | 1646 | 02:45:29 INFO - PROCESS | 1646 | [#1] ext.html Cycles:180 Average:54620.24 Median:32629.17 stddev:112813.20 (345.7%) stddev-sans-first:113056.94 02:45:29 INFO - PROCESS | 1646 | Values: 666.7 716.4 793.7 856.2 857.8 36358.9 36763.1 37013.8 38281.0 38345.4 36717.9 37046.6 37084.3 37101.3 37134.3 7378.6 7632.8 7777.6 7779.8 7789.5 7461.0 10955.9 11164.8 11304.0 11363.4 10020.9 10705.4 11103.3 11187.3 11213.2 9475.3 11114.4 11134.5 11139.7 11163.4 9702.3 10553.3 10878.8 10887.7 10897.0 38317.0 38618.0 38636.0 38707.8 38739.8 3790.5 3803.4 3864.4 3921.0 3922.6 21909.5 21916.7 25293.5 25404.0 26268.0 2995.7 3088.7 3203.6 3285.5 3287.3 287217.0 344365.0 345054.0 345157.0 349023.8 42047.2 42397.4 50313.0 50338.2 50487.7 52113.0 52679.7 52727.2 52930.5 53262.5 14064.6 14194.6 14284.8 14310.4 14333.5 12363.9 12387.9 12402.3 12417.9 12434.9 11719.9 11721.6 11734.2 11780.4 11839.5 5475.6 5485.5 5488.3 5495.6 5541.2 1116.3 1125.3 1131.8 1159.6 1184.5 26272.7 26362.9 26490.3 26663.1 26716.0 875.9 1047.9 1201.2 1234.6 1244.5 8432.3 10614.2 11662.1 11993.9 14040.4 386924.0 489282.0 489462.0 489759.0 490337.0 46265.3 46317.0 46361.0 46381.8 46481.5 1352.4 1367.6 1383.2 1389.1 1390.1 25544.5 25773.5 26368.3 26415.5 26693.9 38820.8 38870.0 38893.6 38976.8 39144.6 450355.0 454281.0 454344.0 454590.0 455887.0 27243.7 28478.7 29096.9 30136.8 30235.1 37447.8 37897.0 38513.0 38706.8 38718.2 32402.0 32588.3 32670.0 33595.3 33682.1 32411.5 32750.5 32846.2 32945.7 33107.4 29968.9 31722.8 31931.2 32332.7 32738.7 28694.0 29308.0 29394.0 29429.9 29495.4 22642.8 22869.0 23114.7 23188.1 23276.5 02:45:29 INFO - PROCESS | 1646 | 02:45:29 INFO - PROCESS | 1646 | [#2] jquery.html Cycles:180 Average:39865.53 Median:21838.51 stddev:118445.84 (542.4%) stddev-sans-first:118741.04 02:45:29 INFO - PROCESS | 1646 | Values: 398.2 398.4 410.4 421.8 439.2 19694.0 20080.4 20528.4 20724.5 21183.0 21561.9 21731.6 22183.6 22375.0 22478.3 6568.9 6884.1 6924.4 6939.1 6942.1 6087.2 6569.4 6665.1 6860.9 6865.9 6545.5 6851.8 6855.4 6862.7 6870.1 6781.2 6926.4 6929.9 6930.1 6930.4 6335.5 6584.9 6677.1 6686.5 6737.2 25507.0 25679.9 25725.7 25882.9 25911.9 2476.9 2932.7 2987.8 3002.8 3182.7 15886.8 16418.9 16552.5 16901.0 17217.0 2003.8 2021.6 2035.8 2035.9 2069.1 121406.0 123595.5 128315.0 129424.4 131138.0 17530.4 21945.5 21951.8 22134.2 22251.3 36726.1 36735.8 37294.3 37396.0 37441.8 10636.9 10681.6 10953.6 11136.7 11312.3 7427.6 9035.6 9091.5 9199.2 9240.5 8618.8 10192.9 10543.9 10544.7 10629.7 3559.5 3995.3 4378.7 4400.4 4425.0 882.9 905.9 1000.2 1004.0 1019.2 11453.0 13151.4 13659.9 13708.6 14042.1 901.5 1024.8 1040.8 1043.7 1061.2 6092.8 7013.0 7232.4 7244.6 7441.9 705115.0 714396.0 714961.0 723280.0 729193.0 98865.0 114840.0 115786.3 123451.0 125234.0 1239.0 1253.3 1267.9 1268.4 1270.0 19338.8 19881.6 20718.1 21027.6 21029.8 55837.2 55837.9 56261.2 56669.4 56741.4 77732.6 78585.6 79492.0 79539.6 79803.2 11543.1 11770.9 11772.7 11996.3 12124.7 12560.2 12816.4 12916.7 13043.2 13213.4 8994.7 11024.9 11094.9 11106.4 11269.4 9450.9 10593.6 10839.9 10907.3 10923.1 11032.7 11076.3 11111.7 11196.3 11294.2 11707.8 11734.6 11743.6 12036.9 12086.9 10835.8 10963.5 10964.1 11020.6 11045.0 02:45:29 INFO - PROCESS | 1646 | 02:45:29 INFO - PROCESS | 1646 | [#3] mootools.html Cycles:180 Average:6816.73 Median:2367.29 stddev:4305.19 (181.9%) stddev-sans-first:4298.94 02:45:29 INFO - PROCESS | 1646 | Values: 1530.4 1553.1 1570.3 1572.3 1585.1 10783.9 11297.4 11491.2 11492.0 11607.0 11320.5 11541.8 11554.0 11563.4 11570.0 2066.5 2364.9 2405.8 2410.9 2412.8 2301.3 2320.2 2339.0 2341.8 2346.2 2330.4 2342.2 2348.0 2348.7 2357.6 2299.9 2304.1 2304.4 2305.3 2309.9 2314.5 2369.7 2386.9 2388.3 2393.9 11209.4 11281.4 11365.1 11370.0 11382.2 5547.5 5566.1 5632.8 5872.1 5892.1 3417.7 3582.5 3589.1 3658.3 3661.5 1114.3 1163.9 1185.4 1193.0 1220.2 14286.9 14439.2 15230.2 15755.7 15783.8 4484.5 4607.0 4747.3 4754.1 4763.3 11696.9 11824.8 11852.6 11881.3 11887.1 5720.5 5741.5 5743.0 5752.8 5806.6 5148.5 5238.4 5254.7 5276.7 5288.1 3793.6 3865.4 3883.4 3917.7 3961.2 1005.7 1012.2 1015.4 1023.3 1024.7 947.8 956.0 957.0 968.1 1008.2 6415.4 6707.4 6865.8 6891.4 6928.9 967.7 986.9 1004.5 1017.9 1031.0 4017.9 4059.4 4083.9 4546.3 4565.7 13796.2 14261.2 14264.3 14295.8 14299.2 13795.4 13897.4 14220.2 14280.4 14466.2 8624.0 10207.9 10323.5 10439.3 10499.5 6487.6 6907.8 6968.4 7107.3 7140.3 12012.8 12017.9 12071.3 12138.8 12302.8 12460.8 12488.0 12658.6 12781.2 12886.6 7808.0 8030.8 8512.6 8521.3 8574.7 10279.4 10319.1 10384.1 10415.3 10438.4 9103.7 9171.5 9187.0 9197.6 9221.4 8981.7 9119.5 9144.2 9200.2 9210.7 7998.2 8074.5 8145.8 8152.5 8155.2 5190.3 5844.4 5934.3 6119.4 6184.5 6000.7 6013.3 6118.1 6126.9 6285.9 02:45:29 INFO - PROCESS | 1646 | 02:45:29 INFO - PROCESS | 1646 | [#4] prototype.html Cycles:180 Average:4664.54 Median:5057.29 stddev:1312.82 (26.0%) stddev-sans-first:1275.62 02:45:29 INFO - PROCESS | 1646 | Values: 333.4 335.7 347.8 361.9 374.3 5001.4 5054.6 5141.4 5318.3 5426.7 5090.2 5206.1 5255.7 5256.3 5271.2 3552.4 4172.7 4541.9 4542.1 4548.4 3679.7 4269.4 4286.4 4535.9 4562.7 4039.5 4502.3 4507.8 4523.8 4546.5 3785.0 4111.3 4538.6 4544.7 4586.3 3546.0 3832.1 3836.4 4288.7 4324.5 4711.9 4764.9 4822.3 5095.7 5150.8 4495.8 4578.1 5056.8 5058.7 5071.0 4947.2 5616.5 5621.4 5660.9 5692.0 4059.5 4312.6 4451.5 4453.0 4466.0 5363.8 5447.5 5599.9 5869.5 5926.3 3686.1 4172.9 4210.6 4385.7 4584.5 3864.8 3883.5 4652.7 4717.6 4802.3 3917.6 3978.8 4703.9 5035.7 5094.7 5400.6 5564.5 5591.0 5683.2 5698.7 1370.9 1393.5 1501.6 1584.5 1586.2 1073.4 1126.5 1161.1 1184.6 1186.5 5110.8 5168.6 5348.1 5382.9 5404.4 5180.6 5268.6 5808.7 5860.6 5886.3 4544.2 4886.5 4986.9 5046.5 5195.9 2573.8 3063.0 3081.0 3082.2 3100.7 5424.5 5749.8 5860.8 6118.9 6127.3 5311.8 5832.6 5973.7 6006.4 6033.5 4992.0 5692.9 5779.0 6036.8 6092.4 5078.3 5791.0 5892.5 5914.2 5922.9 5044.8 5107.1 5447.3 5655.6 5817.6 5268.9 5517.2 5734.7 5799.9 6151.7 4328.7 4454.4 4574.7 4577.7 4584.7 5334.4 5410.7 5545.5 5837.4 5903.8 5069.0 5114.7 5334.0 5655.3 5673.3 4871.6 4908.8 5227.1 5557.9 5683.5 4620.7 4850.7 5029.7 5057.7 5569.8 4393.9 5012.9 5152.8 5261.4 5640.5 5241.5 5307.3 5511.8 5537.9 5552.9 02:45:29 INFO - PROCESS | 1646 | 02:45:29 INFO - PROCESS | 1646 | [#5] yui.html Cycles:180 Average:20416.27 Median:40716.79 stddev:28626.15 (70.3%) stddev-sans-first:28668.23 02:45:29 INFO - PROCESS | 1646 | Values: 713.9 723.4 773.9 786.8 819.3 14807.2 17888.8 18706.3 18713.1 18715.4 17755.9 17760.6 17858.7 17961.5 17995.1 771.8 893.4 925.7 929.7 931.9 910.5 916.1 917.7 927.5 929.4 976.0 976.2 977.2 977.7 977.8 962.7 967.4 973.9 974.2 974.8 627.1 660.4 662.8 718.5 719.5 16479.7 16504.1 16711.4 16794.7 16809.6 14212.3 14292.8 14326.0 14421.4 14433.4 11725.6 11740.7 11767.0 11771.2 11855.4 3635.7 3658.2 3688.4 3699.2 3860.2 98840.0 104247.0 107109.0 108661.0 109330.0 10302.5 10477.8 10592.2 10666.9 10716.4 20399.8 21101.8 21584.4 21978.6 22246.9 7932.4 7950.6 8058.6 8076.0 8084.6 4281.6 4347.5 4407.6 4414.9 4510.9 3416.8 3487.9 3538.5 3573.6 3589.9 548.7 631.5 651.5 653.1 665.4 585.5 695.4 700.9 714.9 755.1 8938.7 10157.6 10352.4 10559.9 10593.4 539.4 581.8 602.1 605.9 721.5 4560.5 4972.4 4996.0 5017.5 5031.9 96866.0 98212.0 99049.0 100112.0 101185.0 83816.6 85440.6 86417.6 87300.0 87541.0 77128.0 77408.6 77772.0 77775.6 78215.2 9518.9 9880.4 9921.4 9931.9 9942.4 40688.6 40745.0 50112.0 50222.2 50359.2 45535.9 64541.0 65607.0 73156.6 74689.9 12966.3 13201.9 13305.6 13330.9 13505.5 14962.8 15374.0 15382.4 15580.2 16076.1 13171.5 13704.9 13970.4 14418.7 14506.5 13638.5 14283.9 14322.9 14328.9 14376.3 13578.8 13691.9 13848.9 13861.3 14372.9 10507.6 11009.7 11140.8 11322.7 11851.9 11151.5 11277.2 11398.7 11545.5 11564.8 02:45:29 INFO - PROCESS | 1646 | -------- Summary: end -------- 02:45:29 INFO - PROCESS | 1646 | 02:45:29 INFO - TEST-INFO | 1646: exit 0 02:45:29 INFO - TEST-OK | dromaeo_css | took 1116920ms 02:45:29 INFO - TEST-START | kraken 02:45:29 INFO - operating with platform_type : mac_ 02:45:29 INFO - Initialising browser for kraken test... 02:45:29 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpvkTuPp/profile http://localhost:49247/getInfo.html) 02:45:32 INFO - PROCESS | 1655 | 2017-03-24 02:45:32.334 plugin-container[1656:10339] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 02:45:32 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:45:32 INFO - PROCESS | 1655 | 2017-03-24 02:45:32.338 plugin-container[1656:10339] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x441f, name = 'com.apple.CFPasteboardClient' 02:45:32 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:45:32 INFO - PROCESS | 1655 | 2017-03-24 02:45:32.338 plugin-container[1656:10339] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:45:32 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 02:45:32 INFO - PROCESS | 1655 | colorDepth:24 02:45:32 INFO - PROCESS | 1655 | Browser inner width/height: 1024/663 02:45:32 INFO - PROCESS | 1655 | __metrics 02:45:32 ERROR - PROCESS | 1655 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 02:45:33 INFO - TEST-INFO | 1655: exit 0 02:45:33 INFO - Browser initialized. 02:45:33 INFO - Running cycle 1/1 for kraken test... 02:45:33 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/T/tmpvkTuPp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:35 INFO - PROCESS | 1657 | 2017-03-24 02:45:35.803 plugin-container[1658:10462] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8a47, name = 'com.apple.tsm.portname' 02:45:35 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:45:35 INFO - PROCESS | 1657 | 2017-03-24 02:45:35.804 plugin-container[1658:10462] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 02:45:35 INFO - PROCESS | 1657 | See /usr/include/servers/bootstrap_defs.h for the error codes. 02:45:35 INFO - PROCESS | 1657 | 2017-03-24 02:45:35.804 plugin-container[1658:10462] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 02:45:45 INFO - PROCESS | 1657 | RSS: Main: 228737024 02:45:45 INFO - PROCESS | 1657 | 02:45:48 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 02:45:49 INFO - PROCESS | 1657 | RSS: Main: 240902144 02:45:49 INFO - PROCESS | 1657 | 02:45:52 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 02:45:53 INFO - PROCESS | 1657 | RSS: Main: 249044992 02:45:53 INFO - PROCESS | 1657 | 02:45:56 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 02:45:57 INFO - PROCESS | 1657 | RSS: Main: 247873536 02:45:57 INFO - PROCESS | 1657 | 02:45:59 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 02:45:59 INFO - PROCESS | 1657 | RSS: Main: 249110528 02:45:59 INFO - PROCESS | 1657 | 02:46:01 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:46:02 INFO - PROCESS | 1657 | RSS: Main: 249462784 02:46:02 INFO - PROCESS | 1657 | 02:46:05 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 02:46:06 INFO - PROCESS | 1657 | RSS: Main: 253923328 02:46:06 INFO - PROCESS | 1657 | 02:46:09 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 02:46:10 INFO - PROCESS | 1657 | RSS: Main: 252911616 02:46:10 INFO - PROCESS | 1657 | 02:46:13 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 02:46:13 INFO - PROCESS | 1657 | RSS: Main: 252940288 02:46:13 INFO - PROCESS | 1657 | 02:46:15 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:46:16 INFO - PROCESS | 1657 | RSS: Main: 252780544 02:46:16 INFO - PROCESS | 1657 | 02:46:17 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:46:18 INFO - PROCESS | 1657 | RSS: Main: 252792832 02:46:18 INFO - PROCESS | 1657 | 02:46:20 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:46:21 INFO - PROCESS | 1657 | RSS: Main: 252764160 02:46:21 INFO - PROCESS | 1657 | 02:46:24 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:46:25 INFO - PROCESS | 1657 | RSS: Main: 253251584 02:46:25 INFO - PROCESS | 1657 | 02:46:28 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:46:28 INFO - PROCESS | 1657 | RSS: Main: 252948480 02:46:28 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 02:46:30 INFO - PROCESS | 1657 | RSS: Main: 254930944 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | __start_tp_report 02:46:30 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 02:46:30 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 02:46:30 INFO - PROCESS | 1657 | |i|pagename|runs| 02:46:30 INFO - PROCESS | 1657 | |0;ai-astar;110;127;180;176;120;121;120;122;120;118 02:46:30 INFO - PROCESS | 1657 | |1;audio-beat-detection;179;99;97;162;140;139;143;118;147;142 02:46:30 INFO - PROCESS | 1657 | |2;audio-dft;192;199;197;251;272;241;196;200;267;244 02:46:30 INFO - PROCESS | 1657 | |3;audio-fft;84;63;60;87;60;61;63;82;67;76 02:46:30 INFO - PROCESS | 1657 | |4;audio-oscillator;89;71;85;71;81;86;80;70;70;84 02:46:30 INFO - PROCESS | 1657 | |5;imaging-gaussian-blur;91;92;95;91;93;98;111;91;92;82 02:46:30 INFO - PROCESS | 1657 | |6;imaging-darkroom;133;99;99;99;153;99;155;104;151;109 02:46:30 INFO - PROCESS | 1657 | |7;imaging-desaturate;85;145;110;94;91;89;93;92;90;90 02:46:30 INFO - PROCESS | 1657 | |8;json-parse-financial;58;72;99;103;82;68;69;69;68;66 02:46:30 INFO - PROCESS | 1657 | |9;json-stringify-tinderbox;58;63;60;68;68;64;62;60;60;63 02:46:30 INFO - PROCESS | 1657 | |10;stanford-crypto-aes;85;87;89;83;85;89;88;87;91;87 02:46:30 INFO - PROCESS | 1657 | |11;stanford-crypto-ccm;124;139;150;146;159;164;153;172;188;141 02:46:30 INFO - PROCESS | 1657 | |12;stanford-crypto-pbkdf2;169;170;170;166;173;171;165;167;174;173 02:46:30 INFO - PROCESS | 1657 | |13;stanford-crypto-sha256-iterative;66;67;82;83;87;72;66;65;78;86 02:46:30 INFO - PROCESS | 1657 | __end_tp_report 02:46:30 INFO - PROCESS | 1657 | __start_cc_report 02:46:30 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1028 02:46:30 INFO - PROCESS | 1657 | __end_cc_report 02:46:30 INFO - PROCESS | 1657 | __startTimestamp1490348790738__endTimestamp 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | ------- Summary: start ------- 02:46:30 INFO - PROCESS | 1657 | Number of tests: 14 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#0] ai-astar Cycles:10 Average:131.40 Median:121.50 stddev:24.93 (20.5%) stddev-sans-first:25.21 02:46:30 INFO - PROCESS | 1657 | Values: 110.0 127.0 180.0 176.0 120.0 121.0 120.0 122.0 120.0 118.0 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:154.50 stddev:25.75 (16.7%) stddev-sans-first:22.27 02:46:30 INFO - PROCESS | 1657 | Values: 179.0 99.0 97.0 162.0 140.0 139.0 143.0 118.0 147.0 142.0 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#2] audio-dft Cycles:10 Average:225.90 Median:242.50 stddev:32.10 (13.2%) stddev-sans-first:31.61 02:46:30 INFO - PROCESS | 1657 | Values: 192.0 199.0 197.0 251.0 272.0 241.0 196.0 200.0 267.0 244.0 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#3] audio-fft Cycles:10 Average:70.30 Median:71.50 stddev:10.81 (15.1%) stddev-sans-first:10.27 02:46:30 INFO - PROCESS | 1657 | Values: 84.0 63.0 60.0 87.0 60.0 61.0 63.0 82.0 67.0 76.0 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#4] audio-oscillator Cycles:10 Average:78.70 Median:82.50 stddev:7.48 (9.1%) stddev-sans-first:6.95 02:46:30 INFO - PROCESS | 1657 | Values: 89.0 71.0 85.0 71.0 81.0 86.0 80.0 70.0 70.0 84.0 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#5] imaging-gaussian-blur Cycles:10 Average:93.60 Median:92.00 stddev:7.34 (8.0%) stddev-sans-first:7.72 02:46:30 INFO - PROCESS | 1657 | Values: 91.0 92.0 95.0 91.0 93.0 98.0 111.0 91.0 92.0 82.0 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#6] imaging-darkroom Cycles:10 Average:120.10 Median:127.00 stddev:24.91 (19.6%) stddev-sans-first:25.98 02:46:30 INFO - PROCESS | 1657 | Values: 133.0 99.0 99.0 99.0 153.0 99.0 155.0 104.0 151.0 109.0 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#7] imaging-desaturate Cycles:10 Average:97.90 Median:90.50 stddev:17.82 (19.7%) stddev-sans-first:18.28 02:46:30 INFO - PROCESS | 1657 | Values: 85.0 145.0 110.0 94.0 91.0 89.0 93.0 92.0 90.0 90.0 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#8] json-parse-financial Cycles:10 Average:75.40 Median:69.00 stddev:14.74 (21.4%) stddev-sans-first:14.23 02:46:30 INFO - PROCESS | 1657 | Values: 58.0 72.0 99.0 103.0 82.0 68.0 69.0 69.0 68.0 66.0 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:63.00 stddev:3.37 (5.4%) stddev-sans-first:3.14 02:46:30 INFO - PROCESS | 1657 | Values: 58.0 63.0 60.0 68.0 68.0 64.0 62.0 60.0 60.0 63.0 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.50 stddev:2.33 (2.7%) stddev-sans-first:2.35 02:46:30 INFO - PROCESS | 1657 | Values: 85.0 87.0 89.0 83.0 85.0 89.0 88.0 87.0 91.0 87.0 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#11] stanford-crypto-ccm Cycles:10 Average:153.60 Median:156.00 stddev:18.19 (11.7%) stddev-sans-first:15.83 02:46:30 INFO - PROCESS | 1657 | Values: 124.0 139.0 150.0 146.0 159.0 164.0 153.0 172.0 188.0 141.0 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:170.50 stddev:3.08 (1.8%) stddev-sans-first:3.26 02:46:30 INFO - PROCESS | 1657 | Values: 169.0 170.0 170.0 166.0 173.0 171.0 165.0 167.0 174.0 173.0 02:46:30 INFO - PROCESS | 1657 | 02:46:30 INFO - PROCESS | 1657 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:80.00 stddev:8.95 (11.2%) stddev-sans-first:8.86 02:46:30 INFO - PROCESS | 1657 | Values: 66.0 67.0 82.0 83.0 87.0 72.0 66.0 65.0 78.0 86.0 02:46:30 INFO - PROCESS | 1657 | -------- Summary: end -------- 02:46:30 INFO - PROCESS | 1657 | 02:46:31 INFO - TEST-INFO | 1657: exit 0 02:46:31 INFO - TEST-OK | kraken | took 62019ms 02:46:31 INFO - SUITE-END | took 1178s 02:46:31 INFO - Completed test suite (00:19:39) 02:46:31 INFO - javascript benchmark 02:46:31 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7679.2117529351235, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3465.60145583258, 3496.5279687242223, 3529.047157267538, 3531.4526248431503, 3539.8407071681772, 6073.514118870491, 6091.817245482637, 6112.510999120071, 6136.631802091878, 6167.229096362955, 6116.6941652917285, 6200.875982480347, 6240.063990401442, 6244.344343843899, 6256.874862502747, 4566.474855391622, 5458.0721277382845, 5537.833864984037, 5541.113421852504, 5567.220589117527, 5591.496765291123, 5594.944050559483, 5606.691631960241, 5610.0, 5645.0121228785, 5395.568354531628, 5409.161579955114, 5507.228987941691, 5594.720263986805, 5604.383517813058, 5500.532454741352, 5534.169874518814, 5544.500994910437, 5578.888422231573, 5610.102383618601, 5418.133098704227, 5530.834074977757, 5541.224228607998, 5552.333719953632, 5580.246666699984, 6184.56708030438, 6201.16284301618, 6230.408111229426, 6239.06414037898, 6244.438000579969, 6265.87468250637, 6349.301576826545, 6382.585131966407, 6409.327020662857, 6471.061696054046, 6581.670916454158, 6599.70301336441, 6607.008948657692, 6608.1409416776, 6630.734770609218, 6195.721192546346, 6222.066689996446, 6248.187735594389, 6272.9999999999545, 6288.937110628926, 6444.903326450107, 6489.1888513935755, 6642.867142657216, 6660.467162626978, 6755.932440675629, 6311.368863113652, 6343.175387199727, 6369.394907483782, 6414.967925160345, 6429.6142231466265, 4896.95103048972, 5363.141897296414, 5729.312482502127, 6328.968355158195, 6508.609483430914, 6243.37566243372, 6295.559310848288, 6335.334789847092, 6433.646149461731, 6493.805185844338, 6360.014197799349, 6420.26166990802, 6524.575902566413, 6530.477561795045, 6538.444232240217, 5245.554127899095, 5257.868553286198, 5258.053550360895, 5259.263703081571, 5269.0, 4539.500654927955, 4638.2115040443205, 4661.300804879227, 4682.297655351656, 4690.6951048182445, 6161.4146656067605, 6169.074638804125, 6192.81421557354, 6243.7814676486105, 6309.08518264849, 6561.835954101186, 6599.868002640016, 6609.6364699941005, 6639.0, 6642.501812364092, 6078.848028799315, 6133.96933015341, 6224.346443623445, 6229.688515574294, 6257.43683068526, 5825.854353641193, 5856.326522449973, 5857.970710146507, 5888.9705551472825, 5899.705014749331, 6798.626075565693, 6841.110655614738, 6846.178458584902, 6854.143232095988, 6862.0, 6310.873782524415, 6376.9043464349, 6470.352964703492, 6608.768693095719, 6620.404163625297, 6783.728650853911, 6798.048273241651, 6820.658967051727, 6832.077669514552, 6836.213835408793, 6448.613083215022, 6462.579932304385, 6463.870722585616, 6471.417572418505, 6479.838004049748, 6269.059641053696, 6333.20834895638, 6468.870622587616, 6483.124778154889, 6529.020646903003, 6341.841453963688, 6390.584612000205, 6395.776147834804, 6401.551891367746, 6403.51973601991, 6364.172657554488, 6369.840753981188, 6375.872482550416, 6384.201974753156, 6391.424771770563, 4756.524347565354, 6136.815895523141, 6173.660448675366, 6210.596311239755, 6293.716782744879, 6279.654618995999, 6314.147590075281, 6434.613923164625, 6446.67766611677, 6452.838489071824, 6266.310705822265, 6269.937300627118, 6273.905891411541, 6284.654344010941, 6293.622382657055], "value": 6002.692630248702, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [666.6566718140158, 716.4018044932482, 793.7142628653681, 856.152409114976, 857.7726902370869, 36358.909232723025, 36763.08092297694, 37013.81493092534, 38281.0, 38345.42481862774, 36717.89846304608, 37046.629533704654, 37084.258314833685, 37101.25797484049, 37134.257314853756, 7378.631068446583, 7632.771016869503, 7777.611119444034, 7779.76660700177, 7789.454738168331, 7461.0, 10955.890441095567, 11164.776704465905, 11303.982641562257, 11363.431828408588, 10020.899791002106, 10705.357678539274, 11103.333799972028, 11187.32876027437, 11213.159013074011, 9475.28935329853, 11114.444277786079, 11134.49894754734, 11139.721506962309, 11163.441827908571, 9702.320837541374, 10553.261271710984, 10878.836817447745, 10887.673369798918, 10897.0, 38317.0, 38618.03454913622, 38636.0, 38707.80646096751, 38739.806300968594, 3790.4882840816413, 3803.40923230061, 3864.381698928158, 3921.0197450637343, 3922.5685174630767, 21909.452263693376, 21916.671249931263, 25293.49413011748, 25403.983840646535, 26268.0, 2995.7409588557707, 3088.6911308869157, 3203.5675183850117, 3285.4578994465883, 3287.3260981498734, 287217.0, 344365.0, 345054.0, 345157.0, 349023.76464352803, 42047.159056818695, 42397.36403953943, 50313.0, 50338.24492632614, 50487.74756126196, 52113.0, 52679.73660131675, 52727.20909186365, 52930.47069529333, 53262.46737532652, 14064.578062658136, 14194.574162775134, 14284.785728214085, 14310.356033978496, 14333.498327558485, 12363.876361236273, 12387.938060309642, 12402.25586464797, 12417.875821241852, 12434.875651243552, 11719.882801172049, 11721.648350549498, 11734.178607497564, 11780.352080635646, 11839.467223974769, 5475.589330800206, 5485.451454854483, 5488.341399032061, 5495.560355171577, 5541.196526503634, 1116.3078891087578, 1125.2685754259796, 1131.7793030359167, 1159.6197085495853, 1184.5498710489958, 26272.73727262741, 26362.86818565895, 26490.337741556614, 26663.066792662165, 26716.0, 875.8861348024843, 1047.910927571165, 1201.1711918776016, 1234.6419538333782, 1244.5208594690928, 8432.283255923316, 10614.203934704929, 11662.067034637208, 11993.940030299793, 14040.438382464587, 386924.0, 489282.0, 489462.0, 489759.0, 490337.0, 46265.30602040972, 46317.0, 46361.0, 46381.76809115933, 46481.53518464772, 1352.371147416456, 1367.5623800383783, 1383.156274672449, 1389.062382891544, 1390.1450607876286, 25544.489110218063, 25773.484530309663, 26368.3407914796, 26415.471690566465, 26693.866530667223, 38820.80589597034, 38870.028249293995, 38893.611063889, 38976.805115975374, 39144.608553915234, 450355.0, 454281.0, 454344.0, 454590.0, 455887.0, 27243.72756272491, 28478.715212847605, 29096.854515727286, 30136.794528219503, 30235.09294721162, 37447.81276093602, 37897.0, 38513.0, 38706.80646596749, 38718.225635487695, 32402.0, 32588.348233035682, 32670.0, 33595.32809343751, 33682.10663069025, 32411.51382729308, 32750.508742368405, 32846.17884552905, 32945.67054329426, 33107.351411886506, 29968.85015574908, 31722.841385792923, 31931.201719957186, 32332.676673232967, 32738.690452381637, 28693.99571015088, 29308.0, 29394.0, 29429.85285073561, 29495.410091798472, 22642.77357226407, 22868.97089631004, 23114.653280201146, 23188.072477100726, 23276.534469310856], "value": 18014.818742979158, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.2254514968388, 398.4401915308992, 410.3864722240251, 421.791213349392, 439.2379222049745, 19694.0, 20080.397588072345, 20528.384148475532, 20724.48188795277, 21183.04676289567, 21561.921903904782, 21731.565368692656, 22183.55806872556, 22375.0, 22478.32565023048, 6568.901466478007, 6884.1050663413935, 6924.376806087451, 6939.132608423947, 6942.062821519081, 6087.178230938811, 6569.408753212234, 6665.13353264075, 6860.862782744342, 6865.901455767078, 6545.476361891037, 6851.794446166623, 6855.4172895303955, 6862.656867156647, 6870.141232345957, 6781.22015968165, 6926.411255043277, 6929.930700693004, 6930.099087118668, 6930.3762661360215, 6335.493160547191, 6584.9012264816065, 6677.098591690108, 6686.498512611525, 6737.157855268091, 25507.0, 25679.871600641876, 25725.742742572707, 25882.87058564714, 25911.870440647675, 2476.8761561921833, 2932.677405485395, 2987.790854640176, 3002.7597792176575, 3182.6976437238427, 15886.76169857453, 16418.917905410515, 16552.503424897273, 16901.0, 17217.0, 2003.7996200379846, 2021.6361055010093, 2035.8473114516323, 2035.918563257468, 2069.1102825784906, 121406.0, 123595.52808943861, 128315.0, 129424.35287823595, 131138.0, 17530.386436474662, 21945.451363715714, 21951.780482195292, 22134.225302114348, 22251.332460026224, 36726.08184795348, 36735.816320918224, 37294.25411491755, 37396.0, 37441.75349478985, 10636.893631063745, 10681.570285427562, 10953.616623418142, 11136.665900023012, 11312.321260724382, 7427.62861856905, 9035.63857445708, 9091.499967501719, 9199.218066464426, 9240.475321572, 8618.827623447496, 10192.949035254776, 10543.894561054445, 10544.736381590521, 10629.681109566725, 3559.501669766235, 3995.34076877312, 4378.723064006763, 4400.427944367212, 4424.977875110604, 882.9249513791272, 905.8686490458847, 1000.2348203624233, 1003.9598416063276, 1019.2101121630648, 11453.026492748044, 13151.408186631625, 13659.863401366058, 13708.588742337746, 14042.087264327785, 901.4681338010605, 1024.7643042100358, 1040.8386700061503, 1043.6660268713938, 1061.2200032975757, 6092.7562897484495, 7013.0, 7232.385247254042, 7244.565326080452, 7441.851162976818, 705115.0, 714396.0, 714961.0, 723280.0, 729193.0, 98865.01134988702, 114840.0, 115786.26320605198, 123451.0, 125234.0, 1238.9690257743448, 1253.3482589053824, 1267.9429425675867, 1268.3830855685312, 1269.9936500317624, 19338.806611934262, 19881.60236795227, 20718.067686954426, 21027.579448411252, 21029.789702102782, 55837.162442562585, 55837.883242334115, 56261.15608265797, 56669.43330566806, 56741.43258567362, 77732.61133694295, 78585.60707196427, 79492.0, 79539.60230198812, 79803.2019679819, 11543.134264930331, 11770.882291176978, 11772.70568235801, 11996.280223186637, 12124.696882578006, 12560.183588066746, 12816.423260953467, 12916.741665166832, 13043.152195107288, 13213.405396757362, 8994.730158095268, 11024.889751102386, 11094.944525277322, 11106.444677766242, 11269.380184089954, 9450.858237126311, 10593.576256949636, 10839.945800270949, 10907.29102608328, 10923.071538919281, 11032.669019929415, 11076.280041797258, 11111.722096970263, 11196.328220306481, 11294.152938529478, 11707.765844683228, 11734.589289374831, 11743.647690569296, 12036.879631203576, 12086.879131208576, 10835.75388830263, 10963.451827408438, 10964.122870170208, 11020.559177633126, 11045.0], "value": 11190.548544671274, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1530.4031427743175, 1553.0914415067184, 1570.2855200883598, 1572.2767526937607, 1585.1440222279969, 10783.946080269598, 11297.378644174567, 11491.195616306852, 11492.023178029867, 11607.0, 11320.547178112865, 11541.769164616724, 11553.960143587075, 11563.364014979174, 11570.0, 2066.5143691232547, 2364.9054037838464, 2405.8075353971726, 2410.867402292873, 2412.8431651942656, 2301.344116926676, 2320.1879342230254, 2339.0, 2341.7892389684926, 2346.2257455039794, 2330.382448651109, 2342.16853017179, 2348.0255693887016, 2348.729896061949, 2357.6463530470396, 2299.9195028174017, 2304.124432715574, 2304.4008557774932, 2305.273838740808, 2309.90760369585, 2314.479242170515, 2369.680093187415, 2386.9403264918515, 2388.3312672451743, 2393.916212932539, 11209.383483908381, 11281.435928203638, 11365.147613928988, 11369.976702096768, 11382.2032457728, 5547.5007249347755, 5566.137248726453, 5632.831015069554, 5872.060470324727, 5892.116182572606, 3417.6753208445157, 3582.5342705448124, 3589.066842620937, 3658.2866341063504, 3661.5056967309606, 1114.3202646385698, 1163.9359835209061, 1185.4250688416112, 1192.9522819087226, 1220.206865537399, 14286.928565357211, 14439.205843678594, 15230.162341071236, 15755.68488630221, 15783.842161578352, 4484.529124441952, 4607.00949295903, 4747.264174053027, 4754.120487709784, 4763.285507173951, 11696.94151529254, 11824.822627660593, 11852.644420667393, 11881.287122772661, 11887.10846686502, 5720.48515633595, 5741.540676745851, 5743.0, 5752.798652047159, 5806.593538452352, 5148.536631703165, 5238.397584277857, 5254.710990895461, 5276.683398996072, 5288.101022826128, 3793.6206379361843, 3865.40086286626, 3883.4369016493015, 3917.7061720370516, 3961.16815468749, 1005.6681295172575, 1012.1902478017556, 1015.3501758874327, 1023.3297190340339, 1024.7233247023412, 947.8436058050345, 955.953231211822, 956.9712908612753, 968.0948313327061, 1008.1632245236583, 6415.422611964852, 6707.3628005339415, 6865.759698410631, 6891.448684105259, 6928.930710692929, 967.690339091498, 986.935849169816, 1004.5479534209635, 1017.9236557258087, 1030.9793304628363, 4017.8995525112105, 4059.411385349108, 4083.89790255246, 4546.272596384562, 4565.748883811422, 13796.172229666252, 14261.215633140277, 14264.286785660675, 14295.784858287163, 14299.213543255013, 13795.379207935666, 13897.374618142007, 14220.217888016052, 14280.357383917748, 14466.20435876037, 8623.956880215685, 10207.948960255151, 10323.48382580868, 10439.321444106108, 10499.527521261562, 6487.610743355413, 6907.827304317432, 6968.3728464438445, 7107.289271072851, 7140.321669441395, 12012.75974480523, 12017.879821201675, 12071.275723456622, 12138.757224855277, 12302.753944920873, 12460.750784984431, 12488.0, 12658.556950506689, 12781.16922400041, 12886.613401597968, 7808.0, 8030.799230019296, 8512.616932237941, 8521.275691566287, 8574.657013719381, 10279.383237005804, 10319.122874555447, 10384.065434110664, 10415.323004004715, 10438.37369757817, 9103.726888193365, 9171.495567743572, 9186.954065229631, 9197.586108624993, 9221.446713197229, 8981.730548083568, 9119.498427586546, 9144.1770240676, 9200.21798147165, 9210.723678289662, 7998.200179982188, 8074.475159114639, 8145.755627331189, 8152.470089444168, 8155.184481551797, 5190.325257716624, 5844.444777746107, 5934.3175534814045, 6119.388061193845, 6184.474319682878, 6000.669963152069, 6013.338532761481, 6118.112873633388, 6126.877462450815, 6285.874282514415], "value": 5167.404645643373, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.44314993960086, 335.7213512784388, 347.80890272219744, 361.85344935301214, 374.3374227617116, 5001.399832020158, 5054.595632349412, 5141.383034035921, 5318.255444237805, 5426.728663566821, 5090.236464530322, 5206.088934436478, 5255.710935898524, 5256.316678831747, 5271.209318602202, 3552.43161094225, 4172.70791044627, 4541.863744087683, 4542.069620411328, 4548.431446069241, 3679.705623550123, 4269.359596060584, 4286.42133312002, 4535.863924082267, 4562.749048802315, 4039.454673619053, 4502.2571275739465, 4507.819687212507, 4523.773811309437, 4546.477155127153, 3785.034816121899, 4111.273265228611, 4538.614217791492, 4544.727316361029, 4586.334981427708, 3546.0, 3832.1450519362975, 3836.3861782114727, 4288.69979101463, 4324.524302326741, 4711.924185579449, 4764.904701905943, 4822.276658501218, 5095.668781529189, 5150.819721309774, 4495.820167193308, 4578.122969582489, 5056.823011194628, 5058.671186372874, 5071.0, 4947.233178857283, 5616.466435688603, 5621.381648018714, 5660.858478538028, 5691.971540142315, 4059.5128584569748, 4312.63342615878, 4451.532589078132, 4452.977735111336, 4465.955340446587, 5363.758630861582, 5447.45525447456, 5599.860003499904, 5869.482686274845, 5926.303531892979, 3686.115332320224, 4172.937405938914, 4210.642095421924, 4385.7149285296355, 4584.541545845455, 3864.845406183721, 3883.4757307763657, 4652.743079844123, 4717.575418212309, 4802.327674125625, 3917.6278253565865, 3978.8209530571194, 4703.929441058387, 5035.748212589356, 5094.694318340911, 5400.594955378362, 5564.523786914784, 5590.97204513983, 5683.232763576947, 5698.6580805151825, 1370.8971827113007, 1393.5053056165118, 1501.5510032818383, 1584.5167223996561, 1586.1672621873608, 1073.4096247064083, 1126.5212284778936, 1161.1059484197121, 1184.6209213051914, 1186.4542310537076, 5110.821121260738, 5168.638195326291, 5348.1175606025345, 5382.865428364322, 5404.405515393303, 5180.585553155738, 5268.629116897411, 5808.709564521757, 5860.560457965585, 5886.293644762571, 4544.159330523864, 4886.511348865085, 4986.850394488099, 5046.47012063728, 5195.896082078338, 2573.7554932281405, 3063.0, 3080.9845950770105, 3082.212316856263, 3100.705432983863, 5424.457554244623, 5749.770009199585, 5860.765569377178, 6118.938810611926, 6127.295361033538, 5311.814086506954, 5832.629332106952, 5973.66908990978, 6006.399360063959, 6033.526254235742, 4992.012779552687, 5692.857678558069, 5778.971105144447, 6036.788712395045, 6092.421219984094, 5078.263651770547, 5790.971045144747, 5892.469677729025, 5914.239037574794, 5922.851928701817, 5044.823431180038, 5107.135895398079, 5447.27636181909, 5655.575831812713, 5817.563682723728, 5268.868278293074, 5517.2344849647725, 5734.7061175530125, 5799.8550036249435, 6151.6924153793025, 4328.653707703439, 4454.443194600675, 4574.6569007323915, 4577.702449340783, 4584.701994370355, 5334.413214546319, 5410.702411367412, 5545.528630066489, 5837.387074357302, 5903.815588232382, 5069.0, 5114.693118412907, 5334.0, 5655.321361436654, 5673.347565030074, 4871.585915197106, 4908.803647854046, 5227.137522308929, 5557.888842223214, 5683.516901063456, 4620.676552641283, 4850.733209673502, 5029.723365214802, 5057.747112644427, 5569.777208911598, 4393.946207385836, 5012.924806127984, 5152.819651312186, 5261.447548007404, 5640.492355688008, 5241.528262456245, 5307.311418564061, 5511.830697349121, 5537.944620553743, 5552.888942221214], "value": 4270.972209106768, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.9071920650315, 723.4393345157499, 773.8916551682765, 786.7561056072618, 819.3445243804958, 14807.185604791732, 17888.82111178888, 18706.345277915276, 18713.064346782674, 18715.43853684388, 17755.91122044388, 17760.64478710425, 17858.732119018227, 17961.461156165336, 17995.100244987763, 771.7761849063764, 893.4014210478962, 925.676013395313, 929.7350255177275, 931.8602209668536, 910.4719262827545, 916.1342531307884, 917.7338571814166, 927.4852456886425, 929.4098247612781, 976.0288512929645, 976.199516396555, 977.1742877268732, 977.7066879936026, 977.8386566216566, 962.672691284963, 967.4340510801189, 973.8539219117118, 974.1865542272211, 974.770928831724, 627.093849387635, 660.4056349285681, 662.8011596521025, 718.4683334332608, 719.5251134251421, 16479.670406591922, 16504.092274924875, 16711.415100471546, 16794.66410671792, 16809.571186449168, 14212.289385530683, 14292.785608215885, 14326.0, 14421.423143074264, 14433.422663093465, 11725.589604363806, 11740.706482337924, 11767.0, 11771.176017678767, 11855.39181380095, 3635.745497815154, 3658.22803649299, 3688.409854423306, 3699.167687270343, 3860.227954409101, 98840.0, 104247.0, 107108.99999999921, 108661.0, 109330.0, 10302.484875756332, 10477.790444191074, 10592.205584581186, 10666.893331066745, 10716.362859088615, 20399.796002040086, 21101.78898210998, 21584.352469425943, 21978.560428791334, 22246.888765556392, 7932.405069619802, 7950.562719050392, 8058.556779377073, 8075.959620201979, 8084.595770211584, 4281.550437204049, 4347.500037495728, 4407.603315701603, 4414.867553973386, 4510.887227819265, 3416.829158542063, 3487.9302413951577, 3538.5222994895876, 3573.6426357364057, 3589.8743543975834, 548.7393488093204, 631.4853394483481, 651.5341530805497, 653.1313353240179, 665.3845193196274, 585.4613755345093, 695.3847679984149, 700.852820907605, 714.9499535032602, 755.0637209859734, 8938.731838044869, 10157.593696252216, 10352.430616316024, 10559.894401055892, 10593.364398136137, 539.36624466252, 581.7992792486585, 602.135934933372, 605.8545948972215, 721.4769292263068, 4560.521145279764, 4972.378452693413, 4995.9500404996215, 5017.523335283142, 5031.949680503221, 96866.0, 98212.0, 99049.0, 100112.0, 101185.0, 83816.58091709502, 85440.57279713561, 86417.56791216004, 87300.0, 87541.0, 77128.0, 77408.61295693486, 77772.0, 77775.61112194516, 78215.2178478208, 9518.904810951803, 9880.35777674449, 9921.355111917703, 9931.900680993098, 9942.353747006422, 40688.59311406848, 40744.98137546585, 50112.0, 50222.2466662993, 50359.24461133159, 45535.861603458856, 64541.0, 65607.0, 73156.63421682858, 74689.87965180635, 12966.286854223108, 13201.933990329986, 13305.600831975056, 13330.933345333211, 13505.527306544223, 14962.775558366415, 15374.0, 15382.384704612137, 15580.220988950734, 16076.115813630362, 13171.538996135088, 13704.931475342559, 13970.441182352592, 14418.711625767635, 14506.492272770402, 13638.522651707142, 14283.928580357031, 14322.856771432153, 14328.856711432752, 14376.281185940452, 13578.753773264014, 13691.863081369058, 13848.861511384757, 13861.306934653428, 14372.850171986007, 10507.579696812041, 11009.724756880822, 11140.832887506856, 11322.716932076764, 11851.940740296588, 11151.498182581965, 11277.154213434189, 11398.658040258806, 11545.538178473103, 11564.826527602261], "value": 7677.768986682081, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 127.0, 180.0, 176.0, 120.0, 121.0, 120.0, 122.0, 120.0, 118.0], "value": 131.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 99.0, 97.0, 162.0, 140.0, 139.0, 143.0, 118.0, 147.0, 142.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 199.0, 197.0, 251.0, 272.0, 241.0, 196.0, 200.0, 267.0, 244.0], "value": 225.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 63.0, 60.0, 87.0, 60.0, 61.0, 63.0, 82.0, 67.0, 76.0], "value": 70.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 85.0, 71.0, 81.0, 86.0, 80.0, 70.0, 70.0, 84.0], "value": 78.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 95.0, 91.0, 93.0, 98.0, 111.0, 91.0, 92.0, 82.0], "value": 93.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 99.0, 99.0, 99.0, 153.0, 99.0, 155.0, 104.0, 151.0, 109.0], "value": 120.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 145.0, 110.0, 94.0, 91.0, 89.0, 93.0, 92.0, 90.0, 90.0], "value": 97.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 72.0, 99.0, 103.0, 82.0, 68.0, 69.0, 69.0, 68.0, 66.0], "value": 75.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 63.0, 60.0, 68.0, 68.0, 64.0, 62.0, 60.0, 60.0, 63.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 89.0, 83.0, 85.0, 89.0, 88.0, 87.0, 91.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 139.0, 150.0, 146.0, 159.0, 164.0, 153.0, 172.0, 188.0, 141.0], "value": 153.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 170.0, 170.0, 166.0, 173.0, 171.0, 165.0, 167.0, 174.0, 173.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 82.0, 83.0, 87.0, 72.0, 66.0, 65.0, 78.0, 86.0], "value": 75.2, "unit": "score"}]}]} 02:46:31 INFO - Return code: 0 02:46:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:46:32 ERROR - # TBPL SUCCESS # 02:46:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:46:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:46:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:46:32 INFO - 2017-03-24 02:46:32.081 screenresolution[1662:10846] starting screenresolution argv=screenresolution get 02:46:32 INFO - 2017-03-24 02:46:32.084 screenresolution[1662:10846] Display 0: 1600x1200x32@60 02:46:32 INFO - 2017-03-24 02:46:32.090 screenresolution[1663:10849] starting screenresolution argv=screenresolution list 02:46:32 INFO - Available Modes on Display 0 02:46:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:46:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:46:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:46:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:46:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:46:32 INFO - Intel Iris: 02:46:32 INFO - Chipset Model: Intel Iris 02:46:32 INFO - Type: GPU 02:46:32 INFO - Bus: Built-In 02:46:32 INFO - VRAM (Dynamic, Max): 1536 MB 02:46:32 INFO - Vendor: Intel (0x8086) 02:46:32 INFO - Device ID: 0x0a2e 02:46:32 INFO - Revision ID: 0x0009 02:46:32 INFO - Displays: 02:46:32 INFO - Display: 02:46:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:46:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:46:32 INFO - Display Serial Number: 1600x1200 60 02:46:32 INFO - Main Display: Yes 02:46:32 INFO - Mirror: Off 02:46:32 INFO - Online: Yes 02:46:32 INFO - Rotation: Supported 02:46:32 INFO - Return code: 0 02:46:32 INFO - Running post-action listener: _resource_record_post_action 02:46:32 INFO - [mozharness: 2017-03-24 09:46:32.325304Z] Finished run-tests step (success) 02:46:32 INFO - Running post-run listener: _resource_record_post_run 02:46:32 INFO - Total resource usage - Wall time: 1200s; CPU: 55.0%; Read bytes: 39660032; Write bytes: 512267264; Read time: 260; Write time: 1597 02:46:32 INFO - TinderboxPrint: CPU usage
54.7% 02:46:32 INFO - TinderboxPrint: I/O read bytes / time
39,660,032 / 260 02:46:32 INFO - TinderboxPrint: I/O write bytes / time
512,267,264 / 1,597 02:46:32 INFO - TinderboxPrint: CPU idle
2,175.1 (45.3%) 02:46:32 INFO - TinderboxPrint: CPU system
969.3 (20.2%) 02:46:32 INFO - TinderboxPrint: CPU user
1,657.3 (34.5%) 02:46:32 INFO - TinderboxPrint: Swap in / out
247,365,632 / 0 02:46:32 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 215560704; Write bytes: 209887232; Read time: 16777; Write time: 452 02:46:32 INFO - run-tests - Wall time: 1180s; CPU: 55.0%; Read bytes: 30433792; Write bytes: 300790784; Read time: 186; Write time: 1139 02:46:32 INFO - Running post-run listener: _upload_blobber_files 02:46:32 INFO - Blob upload gear active. 02:46:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:46:32 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 02:46:32 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'] 02:46:32 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 02:46:33 INFO - (blobuploader) - INFO - Open directory for files ... 02:46:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:46:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:46:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:34 INFO - (blobuploader) - INFO - Done attempting. 02:46:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:46:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:46:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:35 INFO - (blobuploader) - INFO - Done attempting. 02:46:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:46:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:46:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:36 INFO - (blobuploader) - INFO - Done attempting. 02:46:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:46:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:46:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:38 INFO - (blobuploader) - INFO - Done attempting. 02:46:38 INFO - (blobuploader) - INFO - Iteration through files over. 02:46:38 INFO - Return code: 0 02:46:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:46:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:46:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/55be340d0409244b995e0bee66ba66190d6d07d87487e79724f7ae0fced27851919aa050da6c6b873c4afda844f0d40cc53cfe717f18728d76cedeef18afee64", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f3ccc4aa7a2a9f12f0aeeb58161e632d427c1c46b5caf27c6e3e9ac366898deda116b21bc4ba7e028dcd63c04f1f130566d2d0050f1c82af196e9f320a376bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e0c5026aa86f77a7c9bbc654746456ee010dd9c7c3421465ac2f59fb07193ff26cf35721a8a106da30e92f93ede35808a1172b1eaa2bc502a3df45636ece197", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80a839ff8275be38888b4ff93e8115f5a0cc48a5de4535e49e7ef8cfc3bbb010e1c33e7a2331cb37be774c6197cfbfe2cde6c7ceedcf03e22f89bf11856b4394"} 02:46:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:46:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:46:38 INFO - Contents: 02:46:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/55be340d0409244b995e0bee66ba66190d6d07d87487e79724f7ae0fced27851919aa050da6c6b873c4afda844f0d40cc53cfe717f18728d76cedeef18afee64", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f3ccc4aa7a2a9f12f0aeeb58161e632d427c1c46b5caf27c6e3e9ac366898deda116b21bc4ba7e028dcd63c04f1f130566d2d0050f1c82af196e9f320a376bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e0c5026aa86f77a7c9bbc654746456ee010dd9c7c3421465ac2f59fb07193ff26cf35721a8a106da30e92f93ede35808a1172b1eaa2bc502a3df45636ece197", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80a839ff8275be38888b4ff93e8115f5a0cc48a5de4535e49e7ef8cfc3bbb010e1c33e7a2331cb37be774c6197cfbfe2cde6c7ceedcf03e22f89bf11856b4394"} 02:46:38 INFO - Running post-run listener: copy_logs_to_upload_dir 02:46:38 INFO - Copying logs to upload dir... 02:46:38 INFO - mkdir: /builds/slave/test/build/upload/logs 02:46:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1292.831272 ========= master_lag: 0.11 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 32 secs) (at 2017-03-24 02:46:38.186893) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 02:46:38.190519) ========= 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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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/55be340d0409244b995e0bee66ba66190d6d07d87487e79724f7ae0fced27851919aa050da6c6b873c4afda844f0d40cc53cfe717f18728d76cedeef18afee64", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f3ccc4aa7a2a9f12f0aeeb58161e632d427c1c46b5caf27c6e3e9ac366898deda116b21bc4ba7e028dcd63c04f1f130566d2d0050f1c82af196e9f320a376bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e0c5026aa86f77a7c9bbc654746456ee010dd9c7c3421465ac2f59fb07193ff26cf35721a8a106da30e92f93ede35808a1172b1eaa2bc502a3df45636ece197", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80a839ff8275be38888b4ff93e8115f5a0cc48a5de4535e49e7ef8cfc3bbb010e1c33e7a2331cb37be774c6197cfbfe2cde6c7ceedcf03e22f89bf11856b4394"} build_url:https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/ZF35oCoGQAOGSFB7dU30Sg/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/55be340d0409244b995e0bee66ba66190d6d07d87487e79724f7ae0fced27851919aa050da6c6b873c4afda844f0d40cc53cfe717f18728d76cedeef18afee64", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4f3ccc4aa7a2a9f12f0aeeb58161e632d427c1c46b5caf27c6e3e9ac366898deda116b21bc4ba7e028dcd63c04f1f130566d2d0050f1c82af196e9f320a376bd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9e0c5026aa86f77a7c9bbc654746456ee010dd9c7c3421465ac2f59fb07193ff26cf35721a8a106da30e92f93ede35808a1172b1eaa2bc502a3df45636ece197", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/80a839ff8275be38888b4ff93e8115f5a0cc48a5de4535e49e7ef8cfc3bbb010e1c33e7a2331cb37be774c6197cfbfe2cde6c7ceedcf03e22f89bf11856b4394"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-24 02:46:38.226976) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:46:38.227329) ========= 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.Ca9DDR71XC/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.Atg9B1BQgz/Listeners TMPDIR=/var/folders/dz/z373y_vn69q3ypv0dpprfcs400000w/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.005070 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-24 02:46:38.276314) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 02:46:38.276712) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-24 02:46:38.277148) ========= ========= Total master_lag: 0.25 =========