builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0244 starttime: 1487072313.79 results: success (0) buildid: 20170214014944 builduid: 9d072265c08f46a9a93291ed74fed2d3 revision: 2476b831a480c8ab160281f8fb11e9cdc298ad26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 03:38:33.795176) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 03:38:33.795613) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 03:38:33.795886) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 03:38:33.822255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 03:38:33.822660) ========= 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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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-02-14 03:38:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 72.1M=0s 2017-02-14 03:38:33 (72.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.100897 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 03:38:33.947308) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 03:38:33.947656) ========= 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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.024257 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 03:38:33.996143) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 03:38:33.996542) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2476b831a480c8ab160281f8fb11e9cdc298ad26 --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 2476b831a480c8ab160281f8fb11e9cdc298ad26 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Hq0TV3dxCe/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.9d32Ij99s7/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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-02-14 03:38:34,077 truncating revision to first 12 chars 2017-02-14 03:38:34,077 Setting DEBUG logging. 2017-02-14 03:38:34,077 attempt 1/10 2017-02-14 03:38:34,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2476b831a480?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-14 03:38:35,180 unpacking tar archive at: mozilla-aurora-2476b831a480/testing/mozharness/ program finished with exit code 0 elapsedTime=1.377007 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 03:38:35.396761) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 03:38:35.397081) ========= script_repo_revision: 2476b831a480c8ab160281f8fb11e9cdc298ad26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 03:38:35.397469) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 03:38:35.397753) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 03:38:35.417045) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-14 03:38:35.417414) ========= /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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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 03:38:35 INFO - MultiFileLogger online at 20170214 03:38:35 in /builds/slave/test 03:38:35 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 03:38:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:38:35 INFO - {'append_to_log': False, 03:38:35 INFO - 'base_work_dir': '/builds/slave/test', 03:38:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:38:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:38:35 INFO - 'branch': 'Mozilla-Aurora', 03:38:35 INFO - 'buildbot_json_path': 'buildprops.json', 03:38:35 INFO - 'config_files': ('talos/mac_config.py',), 03:38:35 INFO - 'default_actions': ('clobber', 03:38:35 INFO - 'read-buildbot-config', 03:38:35 INFO - 'download-and-extract', 03:38:35 INFO - 'populate-webroot', 03:38:35 INFO - 'create-virtualenv', 03:38:35 INFO - 'install', 03:38:35 INFO - 'run-tests'), 03:38:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:38:35 INFO - 'download_minidump_stackwalk': True, 03:38:35 INFO - 'download_symbols': 'ondemand', 03:38:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:38:35 INFO - 'tooltool.py': '/tools/tooltool.py', 03:38:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:38:35 INFO - '/tools/misc-python/virtualenv.py')}, 03:38:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:38:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:38:35 INFO - 'installer_path': 'installer.exe', 03:38:35 INFO - 'log_level': 'info', 03:38:35 INFO - 'log_name': 'talos', 03:38:35 INFO - 'log_to_console': True, 03:38:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:38:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:38:35 INFO - 'opt_config_files': (), 03:38:35 INFO - 'pip_index': False, 03:38:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:38:35 INFO - 'cmd': ('bash', 03:38:35 INFO - '-c', 03:38:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:38:35 INFO - 'enabled': True, 03:38:35 INFO - 'halt_on_failure': False, 03:38:35 INFO - 'name': 'check_screen_resolution'},), 03:38:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:38:35 INFO - 'cmd': ('bash', 03:38:35 INFO - '-c', 03:38:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:38:35 INFO - 'enabled': True, 03:38:35 INFO - 'halt_on_failure': False, 03:38:35 INFO - 'name': 'check_screen_resolution'},), 03:38:35 INFO - 'run_cmd_checks_enabled': True, 03:38:35 INFO - 'sps_profile': False, 03:38:35 INFO - 'sps_profile_interval': 0, 03:38:35 INFO - 'suite': 'dromaeojs-e10s', 03:38:35 INFO - 'system_bits': '32', 03:38:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:38:35 INFO - 'title': 't-yosemite-r7-0244', 03:38:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:38:35 INFO - 'use_talos_json': True, 03:38:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:38:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:38:35 INFO - 'work_dir': 'build'} 03:38:35 INFO - [mozharness: 2017-02-14 11:38:35.605581Z] Running clobber step. 03:38:35 INFO - Running pre-action listener: _resource_record_pre_action 03:38:35 INFO - Running main action method: clobber 03:38:35 INFO - rmtree: /builds/slave/test/build 03:38:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:38:37 INFO - Running post-action listener: _resource_record_post_action 03:38:37 INFO - [mozharness: 2017-02-14 11:38:37.976175Z] Finished clobber step (success) 03:38:37 INFO - [mozharness: 2017-02-14 11:38:37.976303Z] Running read-buildbot-config step. 03:38:37 INFO - Running pre-action listener: _resource_record_pre_action 03:38:37 INFO - Running main action method: read_buildbot_config 03:38:37 INFO - Using buildbot properties: 03:38:37 INFO - { 03:38:37 INFO - "project": "", 03:38:37 INFO - "product": "firefox", 03:38:37 INFO - "script_repo_revision": "production", 03:38:37 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 03:38:37 INFO - "repository": "", 03:38:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 03:38:37 INFO - "buildid": "20170214014944", 03:38:37 INFO - "pgo_build": "False", 03:38:37 INFO - "basedir": "/builds/slave/test", 03:38:37 INFO - "buildnumber": 58, 03:38:37 INFO - "slavename": "t-yosemite-r7-0244", 03:38:37 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:38:37 INFO - "platform": "yosemite_r7", 03:38:37 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 03:38:37 INFO - "branch": "mozilla-aurora", 03:38:37 INFO - "repo_path": "releases/mozilla-aurora", 03:38:37 INFO - "revision": "2476b831a480c8ab160281f8fb11e9cdc298ad26", 03:38:37 INFO - "stage_platform": "macosx64", 03:38:37 INFO - "builduid": "9d072265c08f46a9a93291ed74fed2d3", 03:38:37 INFO - "slavebuilddir": "test" 03:38:37 INFO - } 03:38:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 03:38:37 INFO - Running post-action listener: _resource_record_post_action 03:38:37 INFO - [mozharness: 2017-02-14 11:38:37.979500Z] Finished read-buildbot-config step (success) 03:38:37 INFO - [mozharness: 2017-02-14 11:38:37.979581Z] Running download-and-extract step. 03:38:37 INFO - Running pre-action listener: _resource_record_pre_action 03:38:37 INFO - Running main action method: download_and_extract 03:38:37 INFO - mkdir: /builds/slave/test/build/tests 03:38:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:38:37 INFO - trying https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 03:38:37 INFO - Downloading https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 03:38:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 03:38:39 INFO - Downloaded 1199 bytes. 03:38:39 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 03:38:39 INFO - Using the following test package requirements: 03:38:39 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 03:38:39 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:38:39 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 03:38:39 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:38:39 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 03:38:39 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:38:39 INFO - u'jsshell-mac.zip'], 03:38:39 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:38:39 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 03:38:39 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 03:38:39 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:38:39 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 03:38:39 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:38:39 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 03:38:39 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:38:39 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 03:38:39 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 03:38:39 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 03:38:39 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 03:38:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 03:38:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:38:39 INFO - Fetch https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 03:38:40 INFO - Expected file size: 16358348 03:38:40 INFO - Obtained file size: 16358348 03:38:47 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 03:38:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 03:38:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 03:38:47 INFO - Fetch https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 03:38:47 INFO - Expected file size: 16358348 03:38:47 INFO - Obtained file size: 16358348 03:38:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 03:38:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 03:38:54 INFO - Fetch https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 03:38:55 INFO - Expected file size: 14403485 03:38:55 INFO - Obtained file size: 14403485 03:38: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')]} 03:38:56 INFO - trying https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 03:38:56 INFO - Downloading https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 03:38:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 03:38:58 INFO - Downloaded 73959750 bytes. 03:38:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 03:38:58 INFO - mkdir: /builds/slave/test/properties 03:38:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:38:58 INFO - Writing to file /builds/slave/test/properties/build_url 03:38:58 INFO - Contents: 03:38:58 INFO - build_url:https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 03:38:59 INFO - Running post-action listener: _resource_record_post_action 03:38:59 INFO - Running post-action listener: set_extra_try_arguments 03:38:59 INFO - [mozharness: 2017-02-14 11:38:59.109325Z] Finished download-and-extract step (success) 03:38:59 INFO - [mozharness: 2017-02-14 11:38:59.109453Z] Running populate-webroot step. 03:38:59 INFO - Running pre-action listener: _resource_record_pre_action 03:38:59 INFO - Running main action method: populate_webroot 03:38:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:38:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:38:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:38:59 INFO - '--tppagecycles', 03:38:59 INFO - '7'], 03:38:59 INFO - 'tests': ['tsvgm']}}, 03:38:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:38:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:38:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:38:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:38:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:38:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:38:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:38:59 INFO - 'talos_options': ['--disable-e10s'], 03:38:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:38:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:38:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:38:59 INFO - 'talos_options': ['--disable-e10s'], 03:38:59 INFO - 'tests': ['damp', 'tps']}, 03:38:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:38:59 INFO - 'tests': ['damp', 'tps']}, 03:38:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:38:59 INFO - 'tests': ['dromaeo_dom']}, 03:38:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:38:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:38:59 INFO - 'tests': ['basic_compositor_video']}, 03:38:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:38:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:38:59 INFO - 'tests': ['a11yr', 03:38:59 INFO - 'ts_paint', 03:38:59 INFO - 'tpaint', 03:38:59 INFO - 'sessionrestore', 03:38:59 INFO - 'sessionrestore_no_auto_restore', 03:38:59 INFO - 'tabpaint']}, 03:38:59 INFO - 'other-e10s': {'tests': ['a11yr', 03:38:59 INFO - 'ts_paint', 03:38:59 INFO - 'tpaint', 03:38:59 INFO - 'sessionrestore', 03:38:59 INFO - 'sessionrestore_no_auto_restore', 03:38:59 INFO - 'tabpaint']}, 03:38:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:38:59 INFO - 'ts_paint', 03:38:59 INFO - 'tpaint', 03:38:59 INFO - 'sessionrestore', 03:38:59 INFO - 'sessionrestore_no_auto_restore', 03:38:59 INFO - 'tabpaint']}, 03:38:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:38:59 INFO - 'ts_paint', 03:38:59 INFO - 'tpaint', 03:38:59 INFO - 'sessionrestore', 03:38:59 INFO - 'sessionrestore_no_auto_restore', 03:38:59 INFO - 'tabpaint']}, 03:38:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:38:59 INFO - 'tests': ['a11yr', 03:38:59 INFO - 'ts_paint', 03:38:59 INFO - 'tpaint', 03:38:59 INFO - 'sessionrestore', 03:38:59 INFO - 'sessionrestore_no_auto_restore', 03:38:59 INFO - 'tabpaint']}, 03:38:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:38:59 INFO - 'tests': ['a11yr', 03:38:59 INFO - 'ts_paint', 03:38:59 INFO - 'tpaint', 03:38:59 INFO - 'sessionrestore', 03:38:59 INFO - 'sessionrestore_no_auto_restore', 03:38:59 INFO - 'tabpaint']}, 03:38:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:38:59 INFO - 'tests': ['tsvgx', 03:38:59 INFO - 'tsvgr_opacity', 03:38:59 INFO - 'tart', 03:38:59 INFO - 'tscrollx', 03:38:59 INFO - 'cart', 03:38:59 INFO - 'tsvg_static']}, 03:38:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:38:59 INFO - 'tsvgr_opacity', 03:38:59 INFO - 'tart', 03:38:59 INFO - 'tscrollx', 03:38:59 INFO - 'cart', 03:38:59 INFO - 'tsvg_static']}, 03:38:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:38:59 INFO - 'talos_options': ['--disable-e10s'], 03:38:59 INFO - 'tests': ['tp5o']}, 03:38:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:38:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:38:59 INFO - 'talos_options': ['--disable-e10s', 03:38:59 INFO - '--xperf_path', 03:38:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:59 INFO - 'tests': ['tp5n']}, 03:38:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:38:59 INFO - 'talos_options': ['--xperf_path', 03:38:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:38:59 INFO - 'tests': ['tp5n']}}, 03:38:59 INFO - 'talos.zip': {'path': '', 03:38:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:38:59 INFO - Running post-action listener: _resource_record_post_action 03:38:59 INFO - [mozharness: 2017-02-14 11:38:59.128214Z] Finished populate-webroot step (success) 03:38:59 INFO - [mozharness: 2017-02-14 11:38:59.128305Z] Running create-virtualenv step. 03:38:59 INFO - Running pre-action listener: _resource_record_pre_action 03:38:59 INFO - Running main action method: create_virtualenv 03:38:59 INFO - Creating virtualenv /builds/slave/test/build/venv 03:38:59 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 03:38:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:38:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:38:59 INFO - Using real prefix '/tools/python27' 03:38:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:38:59 INFO - Installing distribute.............................................................................................................................................................................................done. 03:39:02 INFO - Installing pip.................done. 03:39:02 INFO - Return code: 0 03:39:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:39:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:39:03 INFO - Reading from file tmpfile_stdout 03:39:03 INFO - Output received: 03:39:03 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) 03:39:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109cf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc6ad86810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109aced30>, '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 0x1099f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ac3be8>, '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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39: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', 'pip>=1.5'] in /builds/slave/test/build 03:39: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 pip>=1.5 03:39:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq0TV3dxCe/Render', 03:39:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:03 INFO - 'HOME': '/Users/cltbld', 03:39:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:03 INFO - 'LOGNAME': 'cltbld', 03:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:03 INFO - 'MOZ_NO_REMOTE': '1', 03:39:03 INFO - 'NO_EM_RESTART': '1', 03:39:03 INFO - 'PAGER': '/bin/cat', 03:39:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:03 INFO - 'PWD': '/builds/slave/test', 03:39:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:03 INFO - 'SHELL': '/bin/bash', 03:39:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9d32Ij99s7/Listeners', 03:39:03 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 03:39:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:03 INFO - 'USER': 'cltbld', 03:39:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:03 INFO - 'XPC_FLAGS': '0x0', 03:39:03 INFO - 'XPC_SERVICE_NAME': '0', 03:39:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:03 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 03:39:03 INFO - Cleaning up... 03:39:03 INFO - Return code: 0 03:39:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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', '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 0x109cf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc6ad86810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109aced30>, '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 0x1099f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ac3be8>, '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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39: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', 'psutil>=3.1.1'] in /builds/slave/test/build 03:39: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 psutil>=3.1.1 03:39:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq0TV3dxCe/Render', 03:39:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:03 INFO - 'HOME': '/Users/cltbld', 03:39:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:03 INFO - 'LOGNAME': 'cltbld', 03:39:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:03 INFO - 'MOZ_NO_REMOTE': '1', 03:39:03 INFO - 'NO_EM_RESTART': '1', 03:39:03 INFO - 'PAGER': '/bin/cat', 03:39:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:03 INFO - 'PWD': '/builds/slave/test', 03:39:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:03 INFO - 'SHELL': '/bin/bash', 03:39:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9d32Ij99s7/Listeners', 03:39:03 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 03:39:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:03 INFO - 'USER': 'cltbld', 03:39:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:03 INFO - 'XPC_FLAGS': '0x0', 03:39:03 INFO - 'XPC_SERVICE_NAME': '0', 03:39:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:03 INFO - Downloading/unpacking psutil>=3.1.1 03:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:39:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:07 INFO - Installing collected packages: psutil 03:39:07 INFO - Running setup.py install for psutil 03:39:07 INFO - building 'psutil._psutil_osx' extension 03:39:07 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 03:39:07 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 03:39:07 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 03:39:07 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 03:39:07 INFO - building 'psutil._psutil_posix' extension 03:39:07 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 03:39:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:39:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:39:08 INFO - ^ 03:39:08 INFO - 1 warning generated. 03:39:08 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 03:39:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:39:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:39:08 INFO - Successfully installed psutil 03:39:08 INFO - Cleaning up... 03:39:08 INFO - Return code: 0 03:39:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109cf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc6ad86810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109aced30>, '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 0x1099f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ac3be8>, '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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:39: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 mozsystemmonitor==0.3 03:39:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq0TV3dxCe/Render', 03:39:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:08 INFO - 'HOME': '/Users/cltbld', 03:39:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:08 INFO - 'LOGNAME': 'cltbld', 03:39:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:08 INFO - 'MOZ_NO_REMOTE': '1', 03:39:08 INFO - 'NO_EM_RESTART': '1', 03:39:08 INFO - 'PAGER': '/bin/cat', 03:39:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:08 INFO - 'PWD': '/builds/slave/test', 03:39:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:08 INFO - 'SHELL': '/bin/bash', 03:39:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9d32Ij99s7/Listeners', 03:39:08 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 03:39:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:08 INFO - 'USER': 'cltbld', 03:39:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:08 INFO - 'XPC_FLAGS': '0x0', 03:39:08 INFO - 'XPC_SERVICE_NAME': '0', 03:39:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:39:11 INFO - Installing collected packages: mozsystemmonitor 03:39:11 INFO - Running setup.py install for mozsystemmonitor 03:39:11 INFO - Successfully installed mozsystemmonitor 03:39:11 INFO - Cleaning up... 03:39:11 INFO - Return code: 0 03:39:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109cf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc6ad86810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109aced30>, '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 0x1099f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ac3be8>, '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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:39:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:39:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq0TV3dxCe/Render', 03:39:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:11 INFO - 'HOME': '/Users/cltbld', 03:39:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:11 INFO - 'LOGNAME': 'cltbld', 03:39:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:11 INFO - 'MOZ_NO_REMOTE': '1', 03:39:11 INFO - 'NO_EM_RESTART': '1', 03:39:11 INFO - 'PAGER': '/bin/cat', 03:39:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:11 INFO - 'PWD': '/builds/slave/test', 03:39:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:11 INFO - 'SHELL': '/bin/bash', 03:39:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9d32Ij99s7/Listeners', 03:39:11 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 03:39:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:11 INFO - 'USER': 'cltbld', 03:39:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:11 INFO - 'XPC_FLAGS': '0x0', 03:39:11 INFO - 'XPC_SERVICE_NAME': '0', 03:39:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:11 INFO - Downloading/unpacking jsonschema==2.5.1 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:39:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:14 INFO - Downloading functools32-3.2.3-2.tar.gz 03:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:39:14 INFO - warning: no files found matching '*.txt' 03:39:14 INFO - no previously-included directories found matching 'build' 03:39:14 INFO - no previously-included directories found matching 'dist' 03:39:14 INFO - no previously-included directories found matching '.git*' 03:39:14 INFO - Installing collected packages: jsonschema, functools32 03:39:15 INFO - Running setup.py install for functools32 03:39:15 INFO - warning: no files found matching '*.txt' 03:39:15 INFO - no previously-included directories found matching 'build' 03:39:15 INFO - no previously-included directories found matching 'dist' 03:39:15 INFO - no previously-included directories found matching '.git*' 03:39:15 INFO - Successfully installed jsonschema functools32 03:39:15 INFO - Cleaning up... 03:39:15 INFO - Return code: 0 03:39:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:15 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 0x109cf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc6ad86810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109aced30>, '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 0x1099f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ac3be8>, '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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:15 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 03:39:15 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 03:39:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq0TV3dxCe/Render', 03:39:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:15 INFO - 'HOME': '/Users/cltbld', 03:39:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:15 INFO - 'LOGNAME': 'cltbld', 03:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:15 INFO - 'MOZ_NO_REMOTE': '1', 03:39:15 INFO - 'NO_EM_RESTART': '1', 03:39:15 INFO - 'PAGER': '/bin/cat', 03:39:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:15 INFO - 'PWD': '/builds/slave/test', 03:39:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:15 INFO - 'SHELL': '/bin/bash', 03:39:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9d32Ij99s7/Listeners', 03:39:15 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 03:39:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:15 INFO - 'USER': 'cltbld', 03:39:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:15 INFO - 'XPC_FLAGS': '0x0', 03:39:15 INFO - 'XPC_SERVICE_NAME': '0', 03:39:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:39:15 INFO - Cleaning up... 03:39:15 INFO - Return code: 0 03:39:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:15 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 0x109cf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc6ad86810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109aced30>, '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 0x1099f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ac3be8>, '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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:15 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 03:39:15 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 03:39:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq0TV3dxCe/Render', 03:39:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:15 INFO - 'HOME': '/Users/cltbld', 03:39:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:15 INFO - 'LOGNAME': 'cltbld', 03:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:15 INFO - 'MOZ_NO_REMOTE': '1', 03:39:15 INFO - 'NO_EM_RESTART': '1', 03:39:15 INFO - 'PAGER': '/bin/cat', 03:39:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:15 INFO - 'PWD': '/builds/slave/test', 03:39:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:15 INFO - 'SHELL': '/bin/bash', 03:39:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9d32Ij99s7/Listeners', 03:39:15 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 03:39:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:15 INFO - 'USER': 'cltbld', 03:39:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:15 INFO - 'XPC_FLAGS': '0x0', 03:39:15 INFO - 'XPC_SERVICE_NAME': '0', 03:39:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:15 INFO - Downloading/unpacking blobuploader==1.2.4 03:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:18 INFO - Downloading blobuploader-1.2.4.tar.gz 03:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:39:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39: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 03:39:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:39:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:19 INFO - Downloading docopt-0.6.1.tar.gz 03:39:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:39:19 INFO - Installing collected packages: blobuploader, requests, docopt 03:39:19 INFO - Running setup.py install for blobuploader 03:39:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:39:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:39:19 INFO - Running setup.py install for requests 03:39:20 INFO - Running setup.py install for docopt 03:39:20 INFO - Successfully installed blobuploader requests docopt 03:39:20 INFO - Cleaning up... 03:39:20 INFO - Return code: 0 03:39:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:20 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 0x109cf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc6ad86810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109aced30>, '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 0x1099f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ac3be8>, '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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:39:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:39:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq0TV3dxCe/Render', 03:39:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:20 INFO - 'HOME': '/Users/cltbld', 03:39:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:20 INFO - 'LOGNAME': 'cltbld', 03:39:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:20 INFO - 'MOZ_NO_REMOTE': '1', 03:39:20 INFO - 'NO_EM_RESTART': '1', 03:39:20 INFO - 'PAGER': '/bin/cat', 03:39:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:20 INFO - 'PWD': '/builds/slave/test', 03:39:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:20 INFO - 'SHELL': '/bin/bash', 03:39:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9d32Ij99s7/Listeners', 03:39:20 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 03:39:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:20 INFO - 'USER': 'cltbld', 03:39:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:20 INFO - 'XPC_FLAGS': '0x0', 03:39:20 INFO - 'XPC_SERVICE_NAME': '0', 03:39:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:39:20 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-TlqU4W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:39:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:39:20 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-HuRaSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:39:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-MVBGdP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:39:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-LuH6P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:39:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-L3UF4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:39:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-UlwGjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:39:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-yqWbim-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:39:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-lLqGP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:39:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-YrLKUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:39:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ATkY5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:39:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ZFVsQr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:39:21 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-GBTXgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:39:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-EJkzqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:39:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ZMZgOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-J27xAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:39:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-K1orwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:39:22 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-q02dFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:39:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:39:22 INFO - Running setup.py install for manifestparser 03:39:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:39:22 INFO - Running setup.py install for mozcrash 03:39:22 INFO - Running setup.py install for mozdebug 03:39:22 INFO - Running setup.py install for mozdevice 03:39:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:39:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:39:23 INFO - Running setup.py install for mozfile 03:39:23 INFO - Running setup.py install for mozhttpd 03:39:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:39:23 INFO - Running setup.py install for mozinfo 03:39:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:39:23 INFO - Running setup.py install for mozInstall 03:39:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:39:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:39:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:39:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:39:23 INFO - Running setup.py install for mozleak 03:39:23 INFO - Running setup.py install for mozlog 03:39:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:39:24 INFO - Running setup.py install for moznetwork 03:39:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:39:24 INFO - Running setup.py install for mozprocess 03:39:24 INFO - Running setup.py install for mozprofile 03:39:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:39:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:39:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:39:24 INFO - Running setup.py install for mozrunner 03:39:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:39:24 INFO - Running setup.py install for mozscreenshot 03:39:24 INFO - Running setup.py install for moztest 03:39:24 INFO - Running setup.py install for mozversion 03:39:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:39:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:39:25 INFO - Cleaning up... 03:39:25 INFO - Return code: 0 03:39:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:25 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 0x109cf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc6ad86810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109aced30>, '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 0x1099f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ac3be8>, '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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:39:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:39:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq0TV3dxCe/Render', 03:39:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:25 INFO - 'HOME': '/Users/cltbld', 03:39:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:25 INFO - 'LOGNAME': 'cltbld', 03:39:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:25 INFO - 'MOZ_NO_REMOTE': '1', 03:39:25 INFO - 'NO_EM_RESTART': '1', 03:39:25 INFO - 'PAGER': '/bin/cat', 03:39:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:25 INFO - 'PWD': '/builds/slave/test', 03:39:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:25 INFO - 'SHELL': '/bin/bash', 03:39:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9d32Ij99s7/Listeners', 03:39:25 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 03:39:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:25 INFO - 'USER': 'cltbld', 03:39:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:25 INFO - 'XPC_FLAGS': '0x0', 03:39:25 INFO - 'XPC_SERVICE_NAME': '0', 03:39:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:39:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-C4EKof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:39:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:39:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-PC3TLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:39: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)) 03:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:39:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-fHNpd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:39: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)) 03:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:39:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-T0MlE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:39: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)) 03:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:39:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-7Mu1zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:39: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)) 03:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:39:25 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-Ai2SkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:39:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-hghyfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:39:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-cKBR2v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:39:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-NiGgY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:39:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-imZb6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:39:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-4oyFTn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:39:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-nYngjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:39:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:39:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-e_iBpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:39: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)) 03:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:39:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-0WWU4_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:39: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)) 03:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:26 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-bwK9KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:39:27 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-p68iI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:39:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:39:27 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-ZCte52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:39:27 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)) 03:39:27 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)) 03:39:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:39:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:39:29 INFO - Downloading blessings-1.6.tar.gz 03:39:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:39:29 INFO - Installing collected packages: blessings 03:39:29 INFO - Running setup.py install for blessings 03:39:30 INFO - Successfully installed blessings 03:39:30 INFO - Cleaning up... 03:39:30 INFO - Return code: 0 03:39:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:39:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:30 INFO - Reading from file tmpfile_stdout 03:39:30 INFO - Current package versions: 03:39:30 INFO - blessings == 1.6 03:39:30 INFO - blobuploader == 1.2.4 03:39:30 INFO - docopt == 0.6.1 03:39:30 INFO - functools32 == 3.2.3-2 03:39:30 INFO - jsonschema == 2.5.1 03:39:30 INFO - manifestparser == 1.1 03:39:30 INFO - mozInstall == 1.12 03:39:30 INFO - mozcrash == 1.0 03:39:30 INFO - mozdebug == 0.1 03:39:30 INFO - mozdevice == 0.49 03:39:30 INFO - mozfile == 1.2 03:39:30 INFO - mozhttpd == 0.7 03:39:30 INFO - mozinfo == 0.9 03:39:30 INFO - mozleak == 0.1 03:39:30 INFO - mozlog == 3.4 03:39:30 INFO - moznetwork == 0.27 03:39:30 INFO - mozprocess == 0.24 03:39:30 INFO - mozprofile == 0.28 03:39:30 INFO - mozrunner == 6.13 03:39:30 INFO - mozscreenshot == 0.1 03:39:30 INFO - mozsystemmonitor == 0.3 03:39:30 INFO - moztest == 0.8 03:39:30 INFO - mozversion == 1.4 03:39:30 INFO - psutil == 3.1.1 03:39:30 INFO - requests == 1.2.3 03:39:30 INFO - wsgiref == 0.1.2 03:39:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:39: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')]} 03:39:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39: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')]} 03:39:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:31 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 0x109cf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc6ad86810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109aced30>, '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 0x1099f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ac3be8>, '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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:39:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq0TV3dxCe/Render', 03:39:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:31 INFO - 'HOME': '/Users/cltbld', 03:39:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:31 INFO - 'LOGNAME': 'cltbld', 03:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:31 INFO - 'MOZ_NO_REMOTE': '1', 03:39:31 INFO - 'NO_EM_RESTART': '1', 03:39:31 INFO - 'PAGER': '/bin/cat', 03:39:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:31 INFO - 'PWD': '/builds/slave/test', 03:39:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:31 INFO - 'SHELL': '/bin/bash', 03:39:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9d32Ij99s7/Listeners', 03:39:31 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 03:39:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:31 INFO - 'USER': 'cltbld', 03:39:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:31 INFO - 'XPC_FLAGS': '0x0', 03:39:31 INFO - 'XPC_SERVICE_NAME': '0', 03:39:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 03:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:39:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:39:31 INFO - Cleaning up... 03:39:31 INFO - Return code: 0 03:39:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:39:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109cf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109cf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc6ad86810>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109aced30>, '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 0x1099f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ac3be8>, '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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 03:39:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:39:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:39:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq0TV3dxCe/Render', 03:39:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:31 INFO - 'HOME': '/Users/cltbld', 03:39:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:31 INFO - 'LOGNAME': 'cltbld', 03:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:31 INFO - 'MOZ_NO_REMOTE': '1', 03:39:31 INFO - 'NO_EM_RESTART': '1', 03:39:31 INFO - 'PAGER': '/bin/cat', 03:39:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:31 INFO - 'PWD': '/builds/slave/test', 03:39:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:31 INFO - 'SHELL': '/bin/bash', 03:39:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9d32Ij99s7/Listeners', 03:39:31 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 03:39:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:31 INFO - 'USER': 'cltbld', 03:39:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:31 INFO - 'XPC_FLAGS': '0x0', 03:39:31 INFO - 'XPC_SERVICE_NAME': '0', 03:39:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:39:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:39:32 INFO - Cleaning up... 03:39:32 INFO - Return code: 0 03:39:32 INFO - Running post-action listener: _resource_record_post_action 03:39:32 INFO - Running post-action listener: _start_resource_monitoring 03:39:32 INFO - Starting resource monitoring. 03:39:32 INFO - [mozharness: 2017-02-14 11:39:32.164356Z] Finished create-virtualenv step (success) 03:39:32 INFO - [mozharness: 2017-02-14 11:39:32.165369Z] Running install step. 03:39:32 INFO - Running pre-action listener: _resource_record_pre_action 03:39:32 INFO - Running main action method: install 03:39:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:39:32 INFO - Reading from file tmpfile_stdout 03:39:32 INFO - Detecting whether we're running mozinstall >=1.0... 03:39:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:39:32 INFO - Reading from file tmpfile_stdout 03:39:32 INFO - Output received: 03:39:32 INFO - Usage: mozinstall [options] installer 03:39:32 INFO - Options: 03:39:32 INFO - -h, --help show this help message and exit 03:39:32 INFO - -d DEST, --destination=DEST 03:39:32 INFO - Directory to install application into. [default: 03:39:32 INFO - "/builds/slave/test"] 03:39:32 INFO - --app=APP Application being installed. [default: firefox] 03:39:32 INFO - mkdir: /builds/slave/test/build/application 03:39:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:39:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 03:39:52 INFO - Reading from file tmpfile_stdout 03:39:52 INFO - Output received: 03:39:52 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 03:39:52 INFO - Running post-action listener: _resource_record_post_action 03:39:52 INFO - [mozharness: 2017-02-14 11:39:52.323530Z] Finished install step (success) 03:39:52 INFO - [mozharness: 2017-02-14 11:39:52.323690Z] Running run-tests step. 03:39:52 INFO - Running pre-action listener: _resource_record_pre_action 03:39:52 INFO - Running main action method: run_tests 03:39:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:39:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:39:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:39:52 INFO - 2017-02-14 03:39:52.337 screenresolution[1624:7365] starting screenresolution argv=screenresolution get 03:39:52 INFO - 2017-02-14 03:39:52.340 screenresolution[1624:7365] Display 0: 1600x1200x32@60 03:39:52 INFO - 2017-02-14 03:39:52.346 screenresolution[1625:7368] starting screenresolution argv=screenresolution list 03:39:52 INFO - Available Modes on Display 0 03:39:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:39:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:39:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:39:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:39:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:39:52 INFO - Intel Iris: 03:39:52 INFO - Chipset Model: Intel Iris 03:39:52 INFO - Type: GPU 03:39:52 INFO - Bus: Built-In 03:39:52 INFO - VRAM (Dynamic, Max): 1536 MB 03:39:52 INFO - Vendor: Intel (0x8086) 03:39:52 INFO - Device ID: 0x0a2e 03:39:52 INFO - Revision ID: 0x0009 03:39:52 INFO - Displays: 03:39:52 INFO - Display: 03:39:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:39:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:39:52 INFO - Display Serial Number: 1600x1200 60 03:39:52 INFO - Main Display: Yes 03:39:52 INFO - Mirror: Off 03:39:52 INFO - Online: Yes 03:39:52 INFO - Rotation: Supported 03:39:52 INFO - Return code: 0 03:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:39:52 INFO - Python 2.7.3 03:39:52 INFO - Return code: 0 03:39:52 INFO - grabbing minidump binary from tooltool 03:39: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')]} 03:39: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 0x109aced30>, '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 0x1099f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109ac3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:39: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 03:39: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 03:39: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 03:39:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:39:52 INFO - Return code: 0 03:39:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:39:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:39:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:39:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:39:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:39: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/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 03:39: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/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0244 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 03:39:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Hq0TV3dxCe/Render', 03:39:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:39:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:39:52 INFO - 'HOME': '/Users/cltbld', 03:39:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:39:52 INFO - 'LOGNAME': 'cltbld', 03:39:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:39:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:39:52 INFO - 'MOZ_NO_REMOTE': '1', 03:39:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:39:52 INFO - 'NO_EM_RESTART': '1', 03:39:52 INFO - 'PAGER': '/bin/cat', 03:39:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:39:52 INFO - 'PWD': '/builds/slave/test', 03:39:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:39:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:39:52 INFO - 'SHELL': '/bin/bash', 03:39:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9d32Ij99s7/Listeners', 03:39:52 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 03:39:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:39:52 INFO - 'USER': 'cltbld', 03:39:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:39:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:39:52 INFO - 'XPC_FLAGS': '0x0', 03:39:52 INFO - 'XPC_SERVICE_NAME': '0', 03:39:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:39: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/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 03:39:52 INFO - mozversion application_buildid: 20170214014944 03:39:52 INFO - mozversion application_changeset: 2476b831a480c8ab160281f8fb11e9cdc298ad26 03:39:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:39:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:39:52 INFO - mozversion application_name: Firefox 03:39:52 INFO - mozversion application_remotingname: firefox-dev 03:39:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:39:52 INFO - mozversion application_vendor: Mozilla 03:39:52 INFO - mozversion application_version: 53.0a2 03:39:52 INFO - mozversion platform_buildid: 20170214014944 03:39:52 INFO - mozversion platform_changeset: 2476b831a480c8ab160281f8fb11e9cdc298ad26 03:39:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:39:52 INFO - mozversion platform_version: 53.0a2 03:39:52 INFO - using testdate: 1487072392 03:39:52 INFO - actual date: 1487072392 03:39:52 INFO - starting webserver on 'localhost:49244' 03:39:52 INFO - SUITE-START | Running 2 tests 03:39:52 INFO - TEST-START | dromaeo_css 03:39:52 INFO - operating with platform_type : mac_ 03:39:52 INFO - Initialising browser for dromaeo_css test... 03:39:52 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmp14PMPg/profile http://localhost:49244/getInfo.html) 03:39:55 INFO - PROCESS | 1635 | 2017-02-14 03:39:55.827 plugin-container[1637:7544] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9047, name = 'com.apple.tsm.portname' 03:39:55 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:39:55 INFO - PROCESS | 1635 | 2017-02-14 03:39:55.829 plugin-container[1637:7544] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x950b, name = 'com.apple.CFPasteboardClient' 03:39:55 INFO - PROCESS | 1635 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:39:55 INFO - PROCESS | 1635 | 2017-02-14 03:39:55.829 plugin-container[1637:7544] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:39:55 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 03:39:55 INFO - PROCESS | 1635 | colorDepth:24 03:39:55 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 03:39:55 INFO - PROCESS | 1635 | __metrics 03:39:55 ERROR - PROCESS | 1635 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 03:39:56 INFO - TEST-INFO | 1635: exit 0 03:39:56 INFO - Browser initialized. 03:39:56 INFO - Running cycle 1/1 for dromaeo_css test... 03:39:56 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmp14PMPg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:39:59 INFO - PROCESS | 1638 | 2017-02-14 03:39:59.231 plugin-container[1639:7673] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 03:39:59 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:39:59 INFO - PROCESS | 1638 | 2017-02-14 03:39:59.232 plugin-container[1639:7673] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 03:39:59 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:39:59 INFO - PROCESS | 1638 | 2017-02-14 03:39:59.232 plugin-container[1639:7673] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:40:08 INFO - PROCESS | 1638 | RSS: Main: 218808320 03:40:08 INFO - PROCESS | 1638 | 03:43:11 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 03:43:13 INFO - PROCESS | 1638 | RSS: Main: 239202304 03:43:13 INFO - PROCESS | 1638 | 03:44:57 INFO - PROCESS | 1638 | ************************* 03:44:57 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 03:44:57 INFO - PROCESS | 1638 | 03:44:57 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:44:57 INFO - PROCESS | 1638 | Full stack: 03:44:57 INFO - PROCESS | 1638 | ************************* 03:46:15 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 03:46:16 INFO - PROCESS | 1638 | RSS: Main: 251047936 03:46:16 INFO - PROCESS | 1638 | 03:49:17 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 03:49:18 INFO - PROCESS | 1638 | RSS: Main: 257359872 03:49:18 INFO - PROCESS | 1638 | 03:52:20 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 03:52:21 INFO - PROCESS | 1638 | RSS: Main: 253792256 03:52:21 INFO - PROCESS | 1638 | 03:55:24 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 03:55:24 INFO - PROCESS | 1638 | RSS: Main: 257806336 03:55:24 INFO - PROCESS | 1638 | 03:58:27 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 03:58:27 INFO - PROCESS | 1638 | RSS: Main: 259207168 03:58:27 INFO - PROCESS | 1638 | 03:58:27 INFO - PROCESS | 1638 | __start_tp_report 03:58:27 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 03:58:27 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 03:58:27 INFO - PROCESS | 1638 | |i|pagename|runs| 03:58:27 INFO - PROCESS | 1638 | |0;dojo.html;3332.8166950817704;3364.8485818138183;3366.2257680733433;3375.915602109947;3402.4045791986396;5677.233573467581;5765.884682306351;5773.5092517136045;5786.1610066540325;5787.797427090053;5708.20085188074;5760.251167348239;5770.451807078321;5776.306843178824;5779.82660520184;4357.4771027476745;5016.49835016499;5245;5266.4733526647315;5294.655847369928;4360.56394360563;5324.520793128618;5334;5352.652077614962;5383.757730902099;5153.69077855328;5172;5340.759665815028;5348.224507446418;5348.625596208267;5199.272101905736;5243.606729495303;5256.81601143962;5327.706976116312;5378.139497680352;5176.844694659167;5271.103912334912;5286.07493688603;5287.074761916688;5292.073887069748;5559.221708960748;5750.712464376765;5763.221965034709;5889.469947704727;5911.93585154672;6121.265448146251;6169.3522180170885;6175.907361389583;6200.534959877982;6319.74721011159;6249.968750156266;6255.218097737783;6259.061140828867;6268.341824108494;6308.684565771739;5885.028970219909;5887.35239123696;5912.467877890925;5914.5268378530045;5920.644761314292;6165.815025549241;6211.440970312603;6217.378262173836;6223.813285601439;6230.314665386803;6134.589663226396;6135.722664536883;6174.9073763893575;6206.534509911775;6213.03697926822;6181.196444462281;6272;6298.307186209513;6298.622082675054;6313.084602732578;5999.310079340845;6037.245344331958;6135.263289243823;6177.949748542758;6276.184096067482;6277.843053923597;6282.465990390777;6304.338044505353;6308.0537919311555;6348.904766428507;4326.697131200849;5018.422881368616;5023.899522009539;5033.6224783141415;5036.445990940993;4311.137772445523;4329.848455304049;4331.675124365685;4449.221386257392;4484.170428470743;5698.601097923189;5766.538676905838;5796.304443466726;5852.824415267549;5860.443257890493;6259;6277.435030847246;6295.213098362705;6297.559170858088;6304.117423560705;5641.802536911188;5665.575081868877;5777.797777077866;5784.768609255667;5792.218050563204;5445.809396671098;5514.91727624086;5516.972415137899;5525.198846167364;5527.695976721238;6352;6363.936360636334;6368.713407896563;6368.942907404379;6380.425761681471;6034.668093254913;6039.5470339723815;6163.84590385244;6178.938210617836;6211.09939058843;6308.053791931247;6313.652749098844;6315.242170939517;6318.936810632019;6319.96840015797;6218.968905155445;6234.844128896814;6237.594556353823;6258.7809426671665;6273.404026617464;6024.849378765566;6161.291451483136;6176.722047507963;6237.625742455467;6288.465480434214;5010.549050585465;5907.4683278505145;6147.463134216446;6157.876842463036;6162.168107305456;4864.683795553277;6106.419890110433;6155.107509411021;6163.506919446344;6169.907451388143;5762.366139724711;5810.360860305278;5847.502962248256;6002.609830361012;6024.277086749618;4644.651651126247;4722.433308002925;5051.0150520649595;5857.297124345106;6095.085737139465;5998.130271110752;6025.969870150621;6040.728167232573;6049.818505444844;6086.3000754913755 03:58:27 INFO - PROCESS | 1638 | |1;ext.html;439.86803958812357;476.75208891376496;496.42414798833363;515.8787684894049;519.8934218485208;37925.620743792555;41074.794626026865;41115;41116.38325425114;41233.793831030875;42035;42540.36189457161;42709.57290427102;42717.572824271745;42725;8324.916750832504;8515.48907065578;9153.67962121326;9370.25037996962;9401.623935042624;9609.375390599589;11356.091512678966;11378.772424551504;11505.252158609705;11521.884781152165;11359.943200283988;11407.087433005381;11430.542778288858;11433.542658293658;11470.827937580943;11390.829137562943;11412.54349826006;11451.713707157305;11464.025557827554;11482.425878706032;11388.373639449826;11460.885391146148;11489.597864074718;11491.310521368745;11527.769444611145;40784.38823417651;40937.795311023554;41007.179856403;41047.58952410497;41143.588564114274;3436.244026314207;3920.2943470175355;4004.4794176757127;4007.318755811519;4038.2932986727205;28940.98706545282;29246.56130158028;29563.96526121597;31336.21659458509;31531.369372612648;3148.338848841746;3152.5428812822242;3236.2394837213237;3256.886008989674;3306.818125003124;497690;504066;505849;507322;511567.4421627905;62050.75898482005;62177.37822621716;62207;62224;62338;65091.02363464552;65757;65766;65835;65879.68240635256;16143;16602.25289861959;16754.58113547171;16780.83219167817;16846.241919113425;10365.844512332322;11817.054635629129;12898.871011289766;13005.414756335987;13277.535286264934;20693.58612827735;21588.244411445525;21807.90960451971;21809.56380872374;21815.781842181375;7610.847783044419;8798.780030499289;8986.775330616656;9005.234555062892;9077.232948326502;868.2316150207113;883.9911600884037;885.0706757904303;897.1387468030633;914.5975770660888;30258.394832103233;30365.24086897801;30401;30506.54240186399;30537.847310763747;1007.2294694558668;1059.750958524746;1089.743910181107;1106.1758989552834;1209.1415095282273;15393;15782.68434631301;15798.36806527726;15832.28754706041;15922.646575041252;665319;665844;668858;669802;671235;62070;62501;62561.68719156375;62950.37049629536;63014.36985630085;1445.3712635003808;1448.2903377345026;1463.231803303253;1465.4504560789703;1467.9045862018934;28370.71629283681;28875.71124288814;29683.109506714834;29998.70001299959;30624.387512250076;51685;51856.740716296175;52482.687932801986;52521.737391312796;52608.21087683764;575791;584408;586013;586023;587279;39354;40050.39924401078;40752.59247407488;40818.387724183565;40911.1817763649;35029.824850875586;43774;43922;44389.33415998827;44650.10699786051;29150.56274155932;36097.63902361048;36480.45279320866;36605.63394366129;36816.81591592025;34221;36246.456303156;36904.63095369012;37049.629503704615;37806.054848629006;34939.82530087333;34939.951801446;35272.647273526934;35881;35987.64012359843;30168.24579385533;31900.521492177173;31932.201694957814;31972.20069498281;32017.839910800296;24215;24557.35219056738;24588.016479340626;24606.942598126432;24749.505009900062 03:58:27 INFO - PROCESS | 1638 | |2;jquery.html;384.6807150065446;387.1888393814958;394.8479835263423;398.7348413305152;419.36466253625764;19744;20905.477363065893;21336.35990920271;21345.35963921083;21593.568128637457;20839.166433342685;21364.786352136474;21394.57210855786;21511.354659360204;21798.801065941407;5203.4796520348045;5711.571632127597;5900.409959004087;5928.081147422156;5939.762409503614;5187.6628019178825;5828.708564571775;5854.590178687494;5927.318358388798;5932.2584676915385;5839.708014599274;5845.8830823383505;5863.560232982522;5864.472197502224;5864.501517371029;5581;5686.943130568724;5721.313442386899;5842.211301474289;5863.003289440784;5094.974525127388;5098.490150984909;5104.05574968632;5114.744262786846;5122.436531981479;25390.11134610298;25709.871450642815;25896.352591185183;25898.482030359286;26147.60778588323;3055.9236019099476;3055.938881222385;3087.4133914556164;3091.6290045194496;3100.4574199514996;15039.849601504064;15596.766048509282;15792.92103539475;15999;16010.679786404324;1792.3995461520406;1801.2974939773499;1822.8086050964723;1826.5890174710717;1827.8263564961308;124983;127134;129102.3544882279;129734.40531189418;131646;11474.770504589862;11794.941025294818;11798.764024719458;11823.52705891772;11996.520139194508;14740.926295368668;14755.040922340228;14768.704625907636;14769.409223630935;14780.48268310604;8711.47731136134;8822.2060014599;8859.601317940707;8904.154105359981;8937.374383793072;8814.735557933273;8832.8675069874;8834.690785822466;8958.328125390623;8992.55037248135;7189.712411503586;7334.266573342729;7335.156457007406;7335.94593513817;7354.154272258652;1628.9348426062825;1744.9825501745074;1928.6721257386278;1943.7243626034153;1986.3445063129134;851.4337965253161;969.8836139663285;1038.2622558788453;1059.2479339668766;1092.907102896247;21463.570728585342;21883.343499695035;21950.560988780137;21951.890240548695;22034.779652203273;1073.9946300268605;1074.2641290715728;1093.7156339351666;1113.3987646670869;1114.1087130295732;9639.421634701941;11441.141914356456;11575.594854180232;11615.6515304541;11629.185382546751;729080;747070;749336;759052;765691;118114.40942795231;127429;132182;133762;137720;856.486108334994;1017.862588550551;1021.3259248895694;1025.7845852370936;1029.2126523209752;18452.077396130408;19283.325083622007;19555.902220488806;19661.410157695293;19687.21251149995;47193.528064718914;53909;56206.18969051449;57252.713736431055;57384;58837.5290617738;77991.61004194943;78168;78371.21628783867;79584.60207698925;7200.675969581277;7493.288137626917;7541.43439242048;7551.584662843597;7723.6138193089;12616.432260548114;12931.353432328535;12960.611181664564;12966.35168241603;13107.737845242851;10361.911999239972;10407;10745.94627026891;11022.834657479983;11437.942810285895;10470.581176752845;10840.349579025284;10964.232503724663;11018.944905275423;11277.154213433862;11174.050205732603;11424.885751142714;11453.370064646524;11541.422928853355;11622.6513204604;6619.205695316593;6716.227633822173;7640.770776876702;7652.349550288065;8666.783330416538;9514.571844267162;10997.285176463503;11169.664910052712;11189.776204476027;11371.545138194711 03:58:27 INFO - PROCESS | 1638 | |3;mootools.html;1421.9715605687886;1426.9429222831088;1440.5246268731319;1441.2937660546331;1449.1087980891755;7265.673044712988;7456.925430745691;8053.798655033627;8512.148785121484;8517.914820851789;8009.639566219519;8256.298214651762;8280.62737176827;8347.624356903938;8350.791230219247;2297.4141593893532;2326.5114325991563;2338.228384633067;2340.707411573553;2350.635651474024;2074.066669998499;2141.7215761950924;2319.4317392238927;2358.1864256831363;2360.3862995621175;2230.7769223077726;2346.8005219556358;2348.7416384197722;2349.4361353275176;2350.1421980976907;1958.9510262243416;2262.468319944812;2311.7457079721216;2314.849534780234;2323.2913961241816;2325.058351367699;2327.301809457173;2331.1491305673476;2334.2763743239652;2377.916772912957;8282.254597086292;8355.248027677539;8367;8391.454555453936;8400.159984001551;4500.572445617661;5060.367454068241;5204.4014938281825;5209.270702101709;5224.52979231871;3317.043981250633;3458.602260740022;3517.6658217469553;3523.6476352364816;3533.2580158166816;1166.352674265782;1172.2029020266216;1223.6145614131608;1237.4926280225066;1242.490578862671;9551.14039736427;9761.414315141114;10451.529681164366;10677.41274229917;10686.038256556947;4275.722078064916;4408.140412619508;4587.17430862448;4740.976295118571;4760.404949381327;8662.003869555081;8668.78328041804;8706.12938706137;8752.081031491602;8768.78078048054;5129.794808207705;5142.357205349332;5155.510226528474;5156.458571849977;5165.793368265227;4610.608098311681;4711.952880471152;4744.264638980963;4823.855284341475;4833.709977401367;3464.6015708193377;3723.385641369198;3791.981040094837;3845.1732877431486;3852.287326844543;975.5902520941222;1082.1991726122612;1120;1156.450685924196;1176.5293882446917;756.3183891710296;803.5883002317237;851.3359579527978;910.349100393222;915.6245939165044;5252.1596544552685;5265.210218467184;5546.306711661043;5562.415946325577;5588.804391846266;939.196986576481;955.7085089047769;957.760559860035;967.8451447768323;992.3797626483448;3605.7656252343513;3696.2607478504406;3714.1457464783252;3721.832517536717;3744.9063773405337;9605.423674579548;9924;9953.054459826304;9957.502124893872;9969.900300997042;9779;9888.802223955481;9900.108990190918;9900.356476828983;9922.305438619227;7633.931249625057;7666.693332266647;7792.2986931176465;7844.097928738154;7861.213878612093;5443.374011988513;5467.125259958388;5489.121740521658;5514.283143191359;5515.641483303572;9007.324450666096;9178.67874624385;9297.72106836796;9301.534923253676;9311.348205625542;9023.052579479061;9255.398399104037;9323;9351;9370.39092458988;7538.09542854861;7671.117821450604;7690.769276921477;7757.3794096473275;7770.961145194238;7627.618619068913;7663.348615367756;7672.693092276247;7739.110002349802;7879.566623835744;6063.999440092335;7100.254473280231;7150.499465037397;7166.784996450115;7175.210726819942;6401.87967105764;6503.837404064936;6946.895796562954;7020.508564400648;7154.642267886689;5419.918701219563;6327.651979141191;6367.108604795239;6424.9036264455135;6456.644884531396;4965.155923492943;4984;4985.850424487271;4989.575886049726;5052.671576347526;4897.632677549127;4955.207166853286;5072.112380333353;5075.390953085654;5150.793968241228 03:58:27 INFO - PROCESS | 1638 | |4;prototype.html;299.4445303961152;352.85197713752484;358.48915295703614;367.76279299851615;376.6572419098621;4455.710378825383;4644.256918892977;5121.20621303698;5523.4476552344795;5606.775728970846;4612.630989520839;4754.9524504754945;5279.208118782185;5351.304330437038;5402.9464254470395;3517.7537572369943;3864.8840534784003;4136.855210067648;4166.916661666764;4188.518320393163;3541.8937431876957;4026.4161696553983;4093.6900191938594;4173.332266837291;4327.883923575021;4072.775997320161;4254.723442976197;4263.275243208662;4277.914441711179;4319.784010799463;4048.392741088831;4301.354796780477;4305.289627211507;4320.870373888788;4338.240807858644;3520.612732599412;3701.370766969622;3763.5483741950866;3785.3375659259796;3814.809259537012;5287.312649355559;5315.096433606258;5357.6605848537865;5385;5399.948019752508;4600.585947264729;4979.278004689336;5009.173486374781;5010.549050585429;5010.949890501085;4409.316555933835;4554.43069616298;5218.373795144607;5740.732410697793;5923.534732181636;3324;3690.6678398943955;4214.515330736974;4225.9788701056295;4245.8513952011535;6073.4533891949495;6081.1790408294755;6111.572189946661;6148.415900489491;6158.7228574714245;3532.4524698671235;3735.6451137141926;3955.20895820837;3999.7400168988925;4133.759872038437;3402.4385976314124;3779.9433008504893;4320.071184695305;4365.934510982338;4381.21138195128;4853.102176097434;4966;4966.354373931365;4978.829974955883;5019.920717045779;4786.904261914812;5045.9747701261995;5397.622166448311;5491.28613280271;5890.823275301748;1251.8497780266425;1415.9079659822078;1432.2337549411016;1441.0921119694526;1446.6455718349073;911.4531281231208;933.0436302789694;1003.6035765872585;1004.6132239087858;1011.6155860773007;4319.43847299849;4624.699394539344;4698.812047518061;5159.484051594811;5250.343707036621;5750;5921.171036054956;5942.10868369748;5985.246786478268;6006.939930600638;4415.205263052617;5026.798928042837;5083.848014231126;5180.119379705459;5414.431484694129;2847.3024109093403;2889.1509433962283;2999.4900866852686;3015.517517197238;3025.364673418607;5120.385553733501;5176.81881134166;5195.558377537876;5535.889282214333;5874.73563689635;5274.367075950834;5356.651817631841;5850.619709718854;5954.583179177503;5996.880062398727;4949.579285760678;5256.688286379556;5665.688387138582;5764.097847710245;5918.461200088008;5419.972900135474;5610.607257491936;5697.743601537858;5719.656820590778;5728.856778580569;4813.4945830687275;5005.849824505271;5329.467053294795;5830.921279563295;5831.425515110981;5197.168453047646;5563.415841336763;5849.853753656193;5869.383714710065;5889.322727886348;3526.911827204238;3724.42271447926;3760.7179461539945;4013.8795836124964;4076.0258747720736;3896.2012787379085;4630.58324750774;5279.703329051875;5415.4313797050745;5535.501804837584;5461.890762184814;5480.177973304037;5481.5066644000635;5504.779808807763;5536.501714845522;5011.621804003928;5155.742212889416;5510.366307874646;5546.556275498031;5573.6098473106495;5106.412762532208;5397.757100930389;5401.405845356929;5665.291838520185;5719.342275638189;5476.507114359727;5783.248177736868;5828.6502809831545;5859.384764599656;5861.508858735106;4436.5563443656665;5549.72251387421;5670.631408958405;5684.346300175367;5752.9712351437975 03:58:27 INFO - PROCESS | 1638 | |5;yui.html;669.6517810738416;699.6152116336017;706.0115837827038;796.26345630292;816.0574536410444;13778.517751878686;15146.924265378657;15423.614409639764;15438.84561154388;15486.457973970913;13968.022238443313;14990.925045374757;15454.768178477332;15604.375824966988;16052.277647505862;854.6624083487019;860.4450129666361;879.0594064351147;880.4321212817761;882.9514376709278;691.429570604251;706.3289874619106;848.3764433141636;872.2193636695154;875.0636818604096;901.4230892228978;916.463868636845;926.7868390270208;926.9675561355353;929.8372784762673;916.6699988004314;923.9307051971095;924.570074915161;925.9768505787342;926.0878035135386;684.8596037812237;691.761342336898;695.4575431163701;695.655650453029;695.9478039147034;14490.275486225752;14915.552533424014;15496.922515387463;15508.5347439577;15673.686526269525;13813.792793108112;14489.710205795931;14655.34050967709;14658.70682586353;14704.485343012942;10992.560297588087;11097.83353249702;11246.49390777417;11279.323240605509;11388.71528211793;3594.532710747586;3760.1545078050212;3775.2826962876966;3863.8068096595057;3865.40086286626;89417;92948.53525732395;94594.10811783794;110217.44891275492;111214;11493.367864767351;11534.884651153548;11575.42122893852;11577.189596728316;11613.6515904523;19941;23552.64671029936;23854.522909541713;23979.52040959171;23991;8037.437379383504;8045.356371490384;8072.233137851895;8108.797280067927;8114.63484143215;4183.8063133301;4185.121124563876;4295.033617436052;4312.676549258818;4370.737755734603;3483.8780642677384;3581.409067503833;3582.1402863313137;3590.5870824854956;3599.802010889426;612.3692596625483;645.854682696399;668.8495088605122;672.0758956434902;681.8568100698909;687.2543290529832;699.6781480519019;707.6709330161397;719.1478098453349;722.6531264992833;9448.57481413338;10140.949295253624;10202.642907498202;10222.182225421948;10444.73888152787;676.1277951442584;692.504859025799;703.1772825793834;706.9893951590731;707.2220557386936;4695.248760198352;4915.3855768029;4947.431045429749;4947.505249475023;4948.802047918043;97634.51182744041;101250;107464;110335.89664103417;111191.44404277927;96970.03029969751;97769;97786;99417;100215;60536.78926421535;77443;79837;80383;82265.17734822695;8442.746717598482;8890.110988901059;9423.717288481357;9510.1440870322;9564.378315409476;52958.470415295356;53645.73177134089;54357.72821135869;54613;54750.726246370104;70194.29805701878;71394;71970.28029719845;72787.63606181936;72942;11623.941880290544;11663.675217913074;11729.35488548138;11972.341521216416;12286.81569776472;12438.315892625993;12558.309292988974;12605.43275552584;13001.544945926848;13143.342832858127;11688;11840;11861.169718119649;12093.81859272094;12529.749405012031;11710.824337634773;11774.470148843151;12077.39613019363;12403.875961240634;12575.685607859878;11663.475143618727;11883.287002779862;11891.345975971404;12393.566225182436;12508.749825003631;9927.950360248153;9946.403215807075;10028.348157369748;10437;10449.895501044892;9783.36408133469;9820.373610924076;9909.405435673883;9915.107640312119;9938.801223975624 03:58:27 INFO - PROCESS | 1638 | __end_tp_report 03:58:27 INFO - PROCESS | 1638 | __start_cc_report 03:58:27 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,374 03:58:27 INFO - PROCESS | 1638 | __end_cc_report 03:58:27 INFO - PROCESS | 1638 | __startTimestamp1487073507678__endTimestamp 03:58:27 INFO - PROCESS | 1638 | 03:58:27 INFO - PROCESS | 1638 | ------- Summary: start ------- 03:58:27 INFO - PROCESS | 1638 | Number of tests: 6 03:58:27 INFO - PROCESS | 1638 | 03:58:27 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5724.56 Median:5912.47 stddev:668.93 (11.3%) stddev-sans-first:644.13 03:58:27 INFO - PROCESS | 1638 | Values: 3332.8 3364.8 3366.2 3375.9 3402.4 5677.2 5765.9 5773.5 5786.2 5787.8 5708.2 5760.3 5770.5 5776.3 5779.8 4357.5 5016.5 5245.0 5266.5 5294.7 4360.6 5324.5 5334.0 5352.7 5383.8 5153.7 5172.0 5340.8 5348.2 5348.6 5199.3 5243.6 5256.8 5327.7 5378.1 5176.8 5271.1 5286.1 5287.1 5292.1 5559.2 5750.7 5763.2 5889.5 5911.9 6121.3 6169.4 6175.9 6200.5 6319.7 6250.0 6255.2 6259.1 6268.3 6308.7 5885.0 5887.4 5912.5 5914.5 5920.6 6165.8 6211.4 6217.4 6223.8 6230.3 6134.6 6135.7 6174.9 6206.5 6213.0 6181.2 6272.0 6298.3 6298.6 6313.1 5999.3 6037.2 6135.3 6177.9 6276.2 6277.8 6282.5 6304.3 6308.1 6348.9 4326.7 5018.4 5023.9 5033.6 5036.4 4311.1 4329.8 4331.7 4449.2 4484.2 5698.6 5766.5 5796.3 5852.8 5860.4 6259.0 6277.4 6295.2 6297.6 6304.1 5641.8 5665.6 5777.8 5784.8 5792.2 5445.8 5514.9 5517.0 5525.2 5527.7 6352.0 6363.9 6368.7 6368.9 6380.4 6034.7 6039.5 6163.8 6178.9 6211.1 6308.1 6313.7 6315.2 6318.9 6320.0 6219.0 6234.8 6237.6 6258.8 6273.4 6024.8 6161.3 6176.7 6237.6 6288.5 5010.5 5907.5 6147.5 6157.9 6162.2 4864.7 6106.4 6155.1 6163.5 6169.9 5762.4 5810.4 5847.5 6002.6 6024.3 4644.7 4722.4 5051.0 5857.3 6095.1 5998.1 6026.0 6040.7 6049.8 6086.3 03:58:27 INFO - PROCESS | 1638 | 03:58:27 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:72228.55 Median:36543.04 stddev:157527.75 (431.1%) stddev-sans-first:157877.44 03:58:27 INFO - PROCESS | 1638 | Values: 439.9 476.8 496.4 515.9 519.9 37925.6 41074.8 41115.0 41116.4 41233.8 42035.0 42540.4 42709.6 42717.6 42725.0 8324.9 8515.5 9153.7 9370.3 9401.6 9609.4 11356.1 11378.8 11505.3 11521.9 11359.9 11407.1 11430.5 11433.5 11470.8 11390.8 11412.5 11451.7 11464.0 11482.4 11388.4 11460.9 11489.6 11491.3 11527.8 40784.4 40937.8 41007.2 41047.6 41143.6 3436.2 3920.3 4004.5 4007.3 4038.3 28941.0 29246.6 29564.0 31336.2 31531.4 3148.3 3152.5 3236.2 3256.9 3306.8 497690.0 504066.0 505849.0 507322.0 511567.4 62050.8 62177.4 62207.0 62224.0 62338.0 65091.0 65757.0 65766.0 65835.0 65879.7 16143.0 16602.3 16754.6 16780.8 16846.2 10365.8 11817.1 12898.9 13005.4 13277.5 20693.6 21588.2 21807.9 21809.6 21815.8 7610.8 8798.8 8986.8 9005.2 9077.2 868.2 884.0 885.1 897.1 914.6 30258.4 30365.2 30401.0 30506.5 30537.8 1007.2 1059.8 1089.7 1106.2 1209.1 15393.0 15782.7 15798.4 15832.3 15922.6 665319.0 665844.0 668858.0 669802.0 671235.0 62070.0 62501.0 62561.7 62950.4 63014.4 1445.4 1448.3 1463.2 1465.5 1467.9 28370.7 28875.7 29683.1 29998.7 30624.4 51685.0 51856.7 52482.7 52521.7 52608.2 575791.0 584408.0 586013.0 586023.0 587279.0 39354.0 40050.4 40752.6 40818.4 40911.2 35029.8 43774.0 43922.0 44389.3 44650.1 29150.6 36097.6 36480.5 36605.6 36816.8 34221.0 36246.5 36904.6 37049.6 37806.1 34939.8 34940.0 35272.6 35881.0 35987.6 30168.2 31900.5 31932.2 31972.2 32017.8 24215.0 24557.4 24588.0 24606.9 24749.5 03:58:27 INFO - PROCESS | 1638 | 03:58:27 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:39874.57 Median:21841.07 stddev:124151.65 (568.4%) stddev-sans-first:124464.52 03:58:27 INFO - PROCESS | 1638 | Values: 384.7 387.2 394.8 398.7 419.4 19744.0 20905.5 21336.4 21345.4 21593.6 20839.2 21364.8 21394.6 21511.4 21798.8 5203.5 5711.6 5900.4 5928.1 5939.8 5187.7 5828.7 5854.6 5927.3 5932.3 5839.7 5845.9 5863.6 5864.5 5864.5 5581.0 5686.9 5721.3 5842.2 5863.0 5095.0 5098.5 5104.1 5114.7 5122.4 25390.1 25709.9 25896.4 25898.5 26147.6 3055.9 3055.9 3087.4 3091.6 3100.5 15039.8 15596.8 15792.9 15999.0 16010.7 1792.4 1801.3 1822.8 1826.6 1827.8 124983.0 127134.0 129102.4 129734.4 131646.0 11474.8 11794.9 11798.8 11823.5 11996.5 14740.9 14755.0 14768.7 14769.4 14780.5 8711.5 8822.2 8859.6 8904.2 8937.4 8814.7 8832.9 8834.7 8958.3 8992.6 7189.7 7334.3 7335.2 7335.9 7354.2 1628.9 1745.0 1928.7 1943.7 1986.3 851.4 969.9 1038.3 1059.2 1092.9 21463.6 21883.3 21950.6 21951.9 22034.8 1074.0 1074.3 1093.7 1113.4 1114.1 9639.4 11441.1 11575.6 11615.7 11629.2 729080.0 747070.0 749336.0 759052.0 765691.0 118114.4 127429.0 132182.0 133762.0 137720.0 856.5 1017.9 1021.3 1025.8 1029.2 18452.1 19283.3 19555.9 19661.4 19687.2 47193.5 53909.0 56206.2 57252.7 57384.0 58837.5 77991.6 78168.0 78371.2 79584.6 7200.7 7493.3 7541.4 7551.6 7723.6 12616.4 12931.4 12960.6 12966.4 13107.7 10361.9 10407.0 10745.9 11022.8 11437.9 10470.6 10840.3 10964.2 11018.9 11277.2 11174.1 11424.9 11453.4 11541.4 11622.7 6619.2 6716.2 7640.8 7652.3 8666.8 9514.6 10997.3 11169.7 11189.8 11371.5 03:58:27 INFO - PROCESS | 1638 | 03:58:27 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5367.53 Median:5455.25 stddev:2900.00 (53.2%) stddev-sans-first:2892.98 03:58:27 INFO - PROCESS | 1638 | Values: 1422.0 1426.9 1440.5 1441.3 1449.1 7265.7 7456.9 8053.8 8512.1 8517.9 8009.6 8256.3 8280.6 8347.6 8350.8 2297.4 2326.5 2338.2 2340.7 2350.6 2074.1 2141.7 2319.4 2358.2 2360.4 2230.8 2346.8 2348.7 2349.4 2350.1 1959.0 2262.5 2311.7 2314.8 2323.3 2325.1 2327.3 2331.1 2334.3 2377.9 8282.3 8355.2 8367.0 8391.5 8400.2 4500.6 5060.4 5204.4 5209.3 5224.5 3317.0 3458.6 3517.7 3523.6 3533.3 1166.4 1172.2 1223.6 1237.5 1242.5 9551.1 9761.4 10451.5 10677.4 10686.0 4275.7 4408.1 4587.2 4741.0 4760.4 8662.0 8668.8 8706.1 8752.1 8768.8 5129.8 5142.4 5155.5 5156.5 5165.8 4610.6 4712.0 4744.3 4823.9 4833.7 3464.6 3723.4 3792.0 3845.2 3852.3 975.6 1082.2 1120.0 1156.5 1176.5 756.3 803.6 851.3 910.3 915.6 5252.2 5265.2 5546.3 5562.4 5588.8 939.2 955.7 957.8 967.8 992.4 3605.8 3696.3 3714.1 3721.8 3744.9 9605.4 9924.0 9953.1 9957.5 9969.9 9779.0 9888.8 9900.1 9900.4 9922.3 7633.9 7666.7 7792.3 7844.1 7861.2 5443.4 5467.1 5489.1 5514.3 5515.6 9007.3 9178.7 9297.7 9301.5 9311.3 9023.1 9255.4 9323.0 9351.0 9370.4 7538.1 7671.1 7690.8 7757.4 7771.0 7627.6 7663.3 7672.7 7739.1 7879.6 6064.0 7100.3 7150.5 7166.8 7175.2 6401.9 6503.8 6946.9 7020.5 7154.6 5419.9 6327.7 6367.1 6424.9 6456.6 4965.2 4984.0 4985.9 4989.6 5052.7 4897.6 4955.2 5072.1 5075.4 5150.8 03:58:27 INFO - PROCESS | 1638 | 03:58:27 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4583.81 Median:5023.36 stddev:1365.78 (27.2%) stddev-sans-first:1331.21 03:58:27 INFO - PROCESS | 1638 | Values: 299.4 352.9 358.5 367.8 376.7 4455.7 4644.3 5121.2 5523.4 5606.8 4612.6 4755.0 5279.2 5351.3 5402.9 3517.8 3864.9 4136.9 4166.9 4188.5 3541.9 4026.4 4093.7 4173.3 4327.9 4072.8 4254.7 4263.3 4277.9 4319.8 4048.4 4301.4 4305.3 4320.9 4338.2 3520.6 3701.4 3763.5 3785.3 3814.8 5287.3 5315.1 5357.7 5385.0 5399.9 4600.6 4979.3 5009.2 5010.5 5010.9 4409.3 4554.4 5218.4 5740.7 5923.5 3324.0 3690.7 4214.5 4226.0 4245.9 6073.5 6081.2 6111.6 6148.4 6158.7 3532.5 3735.6 3955.2 3999.7 4133.8 3402.4 3779.9 4320.1 4365.9 4381.2 4853.1 4966.0 4966.4 4978.8 5019.9 4786.9 5046.0 5397.6 5491.3 5890.8 1251.8 1415.9 1432.2 1441.1 1446.6 911.5 933.0 1003.6 1004.6 1011.6 4319.4 4624.7 4698.8 5159.5 5250.3 5750.0 5921.2 5942.1 5985.2 6006.9 4415.2 5026.8 5083.8 5180.1 5414.4 2847.3 2889.2 2999.5 3015.5 3025.4 5120.4 5176.8 5195.6 5535.9 5874.7 5274.4 5356.7 5850.6 5954.6 5996.9 4949.6 5256.7 5665.7 5764.1 5918.5 5420.0 5610.6 5697.7 5719.7 5728.9 4813.5 5005.8 5329.5 5830.9 5831.4 5197.2 5563.4 5849.9 5869.4 5889.3 3526.9 3724.4 3760.7 4013.9 4076.0 3896.2 4630.6 5279.7 5415.4 5535.5 5461.9 5480.2 5481.5 5504.8 5536.5 5011.6 5155.7 5510.4 5546.6 5573.6 5106.4 5397.8 5401.4 5665.3 5719.3 5476.5 5783.2 5828.7 5859.4 5861.5 4436.6 5549.7 5670.6 5684.3 5753.0 03:58:27 INFO - PROCESS | 1638 | 03:58:27 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20642.44 Median:4931.41 stddev:30104.74 (610.5%) stddev-sans-first:30151.84 03:58:27 INFO - PROCESS | 1638 | Values: 669.7 699.6 706.0 796.3 816.1 13778.5 15146.9 15423.6 15438.8 15486.5 13968.0 14990.9 15454.8 15604.4 16052.3 854.7 860.4 879.1 880.4 883.0 691.4 706.3 848.4 872.2 875.1 901.4 916.5 926.8 927.0 929.8 916.7 923.9 924.6 926.0 926.1 684.9 691.8 695.5 695.7 695.9 14490.3 14915.6 15496.9 15508.5 15673.7 13813.8 14489.7 14655.3 14658.7 14704.5 10992.6 11097.8 11246.5 11279.3 11388.7 3594.5 3760.2 3775.3 3863.8 3865.4 89417.0 92948.5 94594.1 110217.4 111214.0 11493.4 11534.9 11575.4 11577.2 11613.7 19941.0 23552.6 23854.5 23979.5 23991.0 8037.4 8045.4 8072.2 8108.8 8114.6 4183.8 4185.1 4295.0 4312.7 4370.7 3483.9 3581.4 3582.1 3590.6 3599.8 612.4 645.9 668.8 672.1 681.9 687.3 699.7 707.7 719.1 722.7 9448.6 10140.9 10202.6 10222.2 10444.7 676.1 692.5 703.2 707.0 707.2 4695.2 4915.4 4947.4 4947.5 4948.8 97634.5 101250.0 107464.0 110335.9 111191.4 96970.0 97769.0 97786.0 99417.0 100215.0 60536.8 77443.0 79837.0 80383.0 82265.2 8442.7 8890.1 9423.7 9510.1 9564.4 52958.5 53645.7 54357.7 54613.0 54750.7 70194.3 71394.0 71970.3 72787.6 72942.0 11623.9 11663.7 11729.4 11972.3 12286.8 12438.3 12558.3 12605.4 13001.5 13143.3 11688.0 11840.0 11861.2 12093.8 12529.7 11710.8 11774.5 12077.4 12403.9 12575.7 11663.5 11883.3 11891.3 12393.6 12508.7 9928.0 9946.4 10028.3 10437.0 10449.9 9783.4 9820.4 9909.4 9915.1 9938.8 03:58:27 INFO - PROCESS | 1638 | -------- Summary: end -------- 03:58:27 INFO - PROCESS | 1638 | 03:58:28 INFO - TEST-INFO | 1638: exit 0 03:58:28 INFO - TEST-OK | dromaeo_css | took 1115374ms 03:58:28 INFO - TEST-START | kraken 03:58:28 INFO - operating with platform_type : mac_ 03:58:28 INFO - Initialising browser for kraken test... 03:58:28 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpY5zCmF/profile http://localhost:49244/getInfo.html) 03:58:31 INFO - PROCESS | 1653 | 2017-02-14 03:58:30.999 plugin-container[1654:9882] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4343, name = 'com.apple.tsm.portname' 03:58:31 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:58:31 INFO - PROCESS | 1653 | 2017-02-14 03:58:31.001 plugin-container[1654:9882] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9003, name = 'com.apple.CFPasteboardClient' 03:58:31 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:58:31 INFO - PROCESS | 1653 | 2017-02-14 03:58:31.002 plugin-container[1654:9882] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:58:31 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 03:58:31 INFO - PROCESS | 1653 | colorDepth:24 03:58:31 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 03:58:31 INFO - PROCESS | 1653 | __metrics 03:58:31 ERROR - PROCESS | 1653 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 03:58:31 INFO - TEST-INFO | 1653: exit 0 03:58:31 INFO - Browser initialized. 03:58:31 INFO - Running cycle 1/1 for kraken test... 03:58:31 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpY5zCmF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:58:34 INFO - PROCESS | 1655 | 2017-02-14 03:58:34.384 plugin-container[1656:10005] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883b, name = 'com.apple.tsm.portname' 03:58:34 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:58:34 INFO - PROCESS | 1655 | 2017-02-14 03:58:34.385 plugin-container[1656:10005] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 03:58:34 INFO - PROCESS | 1655 | See /usr/include/servers/bootstrap_defs.h for the error codes. 03:58:34 INFO - PROCESS | 1655 | 2017-02-14 03:58:34.385 plugin-container[1656:10005] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 03:58:44 INFO - PROCESS | 1655 | RSS: Main: 218566656 03:58:44 INFO - PROCESS | 1655 | 03:58:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 03:58:48 INFO - PROCESS | 1655 | RSS: Main: 233172992 03:58:48 INFO - PROCESS | 1655 | 03:58:50 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 03:58:51 INFO - PROCESS | 1655 | RSS: Main: 242216960 03:58:51 INFO - PROCESS | 1655 | 03:58:54 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 03:58:55 INFO - PROCESS | 1655 | RSS: Main: 245190656 03:58:55 INFO - PROCESS | 1655 | 03:58:57 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 03:58:57 INFO - PROCESS | 1655 | RSS: Main: 245145600 03:58:57 INFO - PROCESS | 1655 | 03:58:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:59:00 INFO - PROCESS | 1655 | RSS: Main: 245182464 03:59:00 INFO - PROCESS | 1655 | 03:59:03 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 03:59:04 INFO - PROCESS | 1655 | RSS: Main: 250568704 03:59:04 INFO - PROCESS | 1655 | 03:59:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 03:59:07 INFO - PROCESS | 1655 | RSS: Main: 250003456 03:59:07 INFO - PROCESS | 1655 | 03:59:10 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 03:59:11 INFO - PROCESS | 1655 | RSS: Main: 250077184 03:59:11 INFO - PROCESS | 1655 | 03:59:12 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:59:13 INFO - PROCESS | 1655 | RSS: Main: 249393152 03:59:13 INFO - PROCESS | 1655 | 03:59:15 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:59:15 INFO - PROCESS | 1655 | RSS: Main: 249458688 03:59:15 INFO - PROCESS | 1655 | 03:59:18 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:59:18 INFO - PROCESS | 1655 | RSS: Main: 249442304 03:59:18 INFO - PROCESS | 1655 | 03:59:21 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:59:22 INFO - PROCESS | 1655 | RSS: Main: 249962496 03:59:22 INFO - PROCESS | 1655 | 03:59:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:59:25 INFO - PROCESS | 1655 | RSS: Main: 250003456 03:59:25 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 03:59:27 INFO - PROCESS | 1655 | RSS: Main: 251871232 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | __start_tp_report 03:59:27 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 03:59:27 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 03:59:27 INFO - PROCESS | 1655 | |i|pagename|runs| 03:59:27 INFO - PROCESS | 1655 | |0;ai-astar;104;118;117;154;172;132;119;119;117;98 03:59:27 INFO - PROCESS | 1655 | |1;audio-beat-detection;163;143;112;146;110;111;136;104;163;96 03:59:27 INFO - PROCESS | 1655 | |2;audio-dft;198;194;195;197;189;195;196;198;200;238 03:59:27 INFO - PROCESS | 1655 | |3;audio-fft;74;80;81;109;83;50;70;57;72;70 03:59:27 INFO - PROCESS | 1655 | |4;audio-oscillator;94;71;83;73;70;71;82;70;70;94 03:59:27 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;135;132;88;87;89;85;95;87;89;89 03:59:27 INFO - PROCESS | 1655 | |6;imaging-darkroom;118;153;96;97;96;96;96;98;97;98 03:59:27 INFO - PROCESS | 1655 | |7;imaging-desaturate;95;95;92;93;94;93;95;96;96;93 03:59:27 INFO - PROCESS | 1655 | |8;json-parse-financial;56;55;57;57;65;92;89;89;50;56 03:59:27 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;66;69;81;74;77;69;70;68;72;73 03:59:27 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;84;89;83;90;85;88;86;85;92;84 03:59:27 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;174;153;153;165;161;155;155;144;184;143 03:59:27 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;175;215;170;171;169;170;167;174;176;165 03:59:27 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;65;68;67;68;63;81;88;89;88;87 03:59:27 INFO - PROCESS | 1655 | __end_tp_report 03:59:27 INFO - PROCESS | 1655 | __start_cc_report 03:59:27 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,918 03:59:27 INFO - PROCESS | 1655 | __end_cc_report 03:59:27 INFO - PROCESS | 1655 | __startTimestamp1487073567981__endTimestamp 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | ------- Summary: start ------- 03:59:27 INFO - PROCESS | 1655 | Number of tests: 14 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:125.00 Median:125.50 stddev:22.41 (17.9%) stddev-sans-first:22.44 03:59:27 INFO - PROCESS | 1655 | Values: 104.0 118.0 117.0 154.0 172.0 132.0 119.0 119.0 117.0 98.0 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:144.50 stddev:24.79 (17.2%) stddev-sans-first:22.91 03:59:27 INFO - PROCESS | 1655 | Values: 163.0 143.0 112.0 146.0 110.0 111.0 136.0 104.0 163.0 96.0 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:200.00 Median:197.50 stddev:13.68 (6.9%) stddev-sans-first:14.49 03:59:27 INFO - PROCESS | 1655 | Values: 198.0 194.0 195.0 197.0 189.0 195.0 196.0 198.0 200.0 238.0 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:74.60 Median:73.00 stddev:15.95 (21.8%) stddev-sans-first:16.91 03:59:27 INFO - PROCESS | 1655 | Values: 74.0 80.0 81.0 109.0 83.0 50.0 70.0 57.0 72.0 70.0 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:77.80 Median:77.50 stddev:9.82 (12.7%) stddev-sans-first:8.49 03:59:27 INFO - PROCESS | 1655 | Values: 94.0 71.0 83.0 73.0 70.0 71.0 82.0 70.0 70.0 94.0 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:97.60 Median:88.50 stddev:19.11 (21.6%) stddev-sans-first:14.71 03:59:27 INFO - PROCESS | 1655 | Values: 135.0 132.0 88.0 87.0 89.0 85.0 95.0 87.0 89.0 89.0 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:104.50 Median:96.50 stddev:18.32 (19.0%) stddev-sans-first:18.77 03:59:27 INFO - PROCESS | 1655 | Values: 118.0 153.0 96.0 97.0 96.0 96.0 96.0 98.0 97.0 98.0 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:95.00 stddev:1.40 (1.5%) stddev-sans-first:1.45 03:59:27 INFO - PROCESS | 1655 | Values: 95.0 95.0 92.0 93.0 94.0 93.0 95.0 96.0 96.0 93.0 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:61.00 stddev:16.57 (27.2%) stddev-sans-first:17.12 03:59:27 INFO - PROCESS | 1655 | Values: 56.0 55.0 57.0 57.0 65.0 92.0 89.0 89.0 50.0 56.0 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:71.90 Median:72.50 stddev:4.53 (6.3%) stddev-sans-first:4.28 03:59:27 INFO - PROCESS | 1655 | Values: 66.0 69.0 81.0 74.0 77.0 69.0 70.0 68.0 72.0 73.0 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:2.99 (3.4%) stddev-sans-first:3.02 03:59:27 INFO - PROCESS | 1655 | Values: 84.0 89.0 83.0 90.0 85.0 88.0 86.0 85.0 92.0 84.0 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:158.70 Median:158.00 stddev:12.80 (8.1%) stddev-sans-first:12.32 03:59:27 INFO - PROCESS | 1655 | Values: 174.0 153.0 153.0 165.0 161.0 155.0 155.0 144.0 184.0 143.0 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.20 Median:172.50 stddev:14.41 (8.4%) stddev-sans-first:15.28 03:59:27 INFO - PROCESS | 1655 | Values: 175.0 215.0 170.0 171.0 169.0 170.0 167.0 174.0 176.0 165.0 03:59:27 INFO - PROCESS | 1655 | 03:59:27 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.40 Median:84.00 stddev:11.06 (13.2%) stddev-sans-first:10.93 03:59:27 INFO - PROCESS | 1655 | Values: 65.0 68.0 67.0 68.0 63.0 81.0 88.0 89.0 88.0 87.0 03:59:27 INFO - PROCESS | 1655 | -------- Summary: end -------- 03:59:27 INFO - PROCESS | 1655 | 03:59:28 INFO - TEST-INFO | 1655: exit 0 03:59:28 INFO - TEST-OK | kraken | took 60554ms 03:59:28 INFO - SUITE-END | took 1175s 03:59:29 INFO - Completed test suite (00:19:36) 03:59:29 INFO - javascript benchmark 03:59:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7369.790590835561, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3332.8166950817704, 3364.8485818138183, 3366.2257680733433, 3375.915602109947, 3402.4045791986396, 5677.233573467581, 5765.884682306351, 5773.5092517136045, 5786.1610066540325, 5787.797427090053, 5708.20085188074, 5760.251167348239, 5770.451807078321, 5776.306843178824, 5779.82660520184, 4357.4771027476745, 5016.49835016499, 5245.0, 5266.4733526647315, 5294.655847369928, 4360.56394360563, 5324.520793128618, 5334.0, 5352.652077614962, 5383.757730902099, 5153.69077855328, 5172.0, 5340.759665815028, 5348.224507446418, 5348.625596208267, 5199.272101905736, 5243.606729495303, 5256.81601143962, 5327.706976116312, 5378.139497680352, 5176.844694659167, 5271.103912334912, 5286.07493688603, 5287.074761916688, 5292.073887069748, 5559.221708960748, 5750.712464376765, 5763.221965034709, 5889.469947704727, 5911.93585154672, 6121.265448146251, 6169.3522180170885, 6175.907361389583, 6200.534959877982, 6319.74721011159, 6249.968750156266, 6255.218097737783, 6259.061140828867, 6268.341824108494, 6308.684565771739, 5885.028970219909, 5887.35239123696, 5912.467877890925, 5914.5268378530045, 5920.644761314292, 6165.815025549241, 6211.440970312603, 6217.378262173836, 6223.813285601439, 6230.314665386803, 6134.589663226396, 6135.722664536883, 6174.9073763893575, 6206.534509911775, 6213.03697926822, 6181.196444462281, 6272.0, 6298.307186209513, 6298.622082675054, 6313.084602732578, 5999.310079340845, 6037.245344331958, 6135.263289243823, 6177.949748542758, 6276.184096067482, 6277.843053923597, 6282.465990390777, 6304.338044505353, 6308.0537919311555, 6348.904766428507, 4326.697131200849, 5018.422881368616, 5023.899522009539, 5033.6224783141415, 5036.445990940993, 4311.137772445523, 4329.848455304049, 4331.675124365685, 4449.221386257392, 4484.170428470743, 5698.601097923189, 5766.538676905838, 5796.304443466726, 5852.824415267549, 5860.443257890493, 6259.0, 6277.435030847246, 6295.213098362705, 6297.559170858088, 6304.117423560705, 5641.802536911188, 5665.575081868877, 5777.797777077866, 5784.768609255667, 5792.218050563204, 5445.809396671098, 5514.91727624086, 5516.972415137899, 5525.198846167364, 5527.695976721238, 6352.0, 6363.936360636334, 6368.713407896563, 6368.942907404379, 6380.425761681471, 6034.668093254913, 6039.5470339723815, 6163.84590385244, 6178.938210617836, 6211.09939058843, 6308.053791931247, 6313.652749098844, 6315.242170939517, 6318.936810632019, 6319.96840015797, 6218.968905155445, 6234.844128896814, 6237.594556353823, 6258.7809426671665, 6273.404026617464, 6024.849378765566, 6161.291451483136, 6176.722047507963, 6237.625742455467, 6288.465480434214, 5010.549050585465, 5907.4683278505145, 6147.463134216446, 6157.876842463036, 6162.168107305456, 4864.683795553277, 6106.419890110433, 6155.107509411021, 6163.506919446344, 6169.907451388143, 5762.366139724711, 5810.360860305278, 5847.502962248256, 6002.609830361012, 6024.277086749618, 4644.651651126247, 4722.433308002925, 5051.0150520649595, 5857.297124345106, 6095.085737139465, 5998.130271110752, 6025.969870150621, 6040.728167232573, 6049.818505444844, 6086.3000754913755], "value": 5682.461616586599, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.86803958812357, 476.75208891376496, 496.42414798833363, 515.8787684894049, 519.8934218485208, 37925.620743792555, 41074.794626026865, 41115.0, 41116.38325425114, 41233.793831030875, 42035.0, 42540.36189457161, 42709.57290427102, 42717.572824271745, 42725.0, 8324.916750832504, 8515.48907065578, 9153.67962121326, 9370.25037996962, 9401.623935042624, 9609.375390599589, 11356.091512678966, 11378.772424551504, 11505.252158609705, 11521.884781152165, 11359.943200283988, 11407.087433005381, 11430.542778288858, 11433.542658293658, 11470.827937580943, 11390.829137562943, 11412.54349826006, 11451.713707157305, 11464.025557827554, 11482.425878706032, 11388.373639449826, 11460.885391146148, 11489.597864074718, 11491.310521368745, 11527.769444611145, 40784.38823417651, 40937.795311023554, 41007.179856403, 41047.58952410497, 41143.588564114274, 3436.244026314207, 3920.2943470175355, 4004.4794176757127, 4007.318755811519, 4038.2932986727205, 28940.98706545282, 29246.56130158028, 29563.96526121597, 31336.21659458509, 31531.369372612648, 3148.338848841746, 3152.5428812822242, 3236.2394837213237, 3256.886008989674, 3306.818125003124, 497690.0, 504066.0, 505849.0, 507322.0, 511567.4421627905, 62050.75898482005, 62177.37822621716, 62207.0, 62224.0, 62338.0, 65091.02363464552, 65757.0, 65766.0, 65835.0, 65879.68240635256, 16143.0, 16602.25289861959, 16754.58113547171, 16780.83219167817, 16846.241919113425, 10365.844512332322, 11817.054635629129, 12898.871011289766, 13005.414756335987, 13277.535286264934, 20693.58612827735, 21588.244411445525, 21807.90960451971, 21809.56380872374, 21815.781842181375, 7610.847783044419, 8798.780030499289, 8986.775330616656, 9005.234555062892, 9077.232948326502, 868.2316150207113, 883.9911600884037, 885.0706757904303, 897.1387468030633, 914.5975770660888, 30258.394832103233, 30365.24086897801, 30401.0, 30506.54240186399, 30537.847310763747, 1007.2294694558668, 1059.750958524746, 1089.743910181107, 1106.1758989552834, 1209.1415095282273, 15393.0, 15782.68434631301, 15798.36806527726, 15832.28754706041, 15922.646575041252, 665319.0, 665844.0, 668858.0, 669802.0, 671235.0, 62070.0, 62501.0, 62561.68719156375, 62950.37049629536, 63014.36985630085, 1445.3712635003808, 1448.2903377345026, 1463.231803303253, 1465.4504560789703, 1467.9045862018934, 28370.71629283681, 28875.71124288814, 29683.109506714834, 29998.70001299959, 30624.387512250076, 51685.0, 51856.740716296175, 52482.687932801986, 52521.737391312796, 52608.21087683764, 575791.0, 584408.0, 586013.0, 586023.0, 587279.0, 39354.0, 40050.39924401078, 40752.59247407488, 40818.387724183565, 40911.1817763649, 35029.824850875586, 43774.0, 43922.0, 44389.33415998827, 44650.10699786051, 29150.56274155932, 36097.63902361048, 36480.45279320866, 36605.63394366129, 36816.81591592025, 34221.0, 36246.456303156, 36904.63095369012, 37049.629503704615, 37806.054848629006, 34939.82530087333, 34939.951801446, 35272.647273526934, 35881.0, 35987.64012359843, 30168.24579385533, 31900.521492177173, 31932.201694957814, 31972.20069498281, 32017.839910800296, 24215.0, 24557.35219056738, 24588.016479340626, 24606.942598126432, 24749.505009900062], "value": 20695.95346920831, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.6807150065446, 387.1888393814958, 394.8479835263423, 398.7348413305152, 419.36466253625764, 19744.0, 20905.477363065893, 21336.35990920271, 21345.35963921083, 21593.568128637457, 20839.166433342685, 21364.786352136474, 21394.57210855786, 21511.354659360204, 21798.801065941407, 5203.4796520348045, 5711.571632127597, 5900.409959004087, 5928.081147422156, 5939.762409503614, 5187.6628019178825, 5828.708564571775, 5854.590178687494, 5927.318358388798, 5932.2584676915385, 5839.708014599274, 5845.8830823383505, 5863.560232982522, 5864.472197502224, 5864.501517371029, 5581.0, 5686.943130568724, 5721.313442386899, 5842.211301474289, 5863.003289440784, 5094.974525127388, 5098.490150984909, 5104.05574968632, 5114.744262786846, 5122.436531981479, 25390.11134610298, 25709.871450642815, 25896.352591185183, 25898.482030359286, 26147.60778588323, 3055.9236019099476, 3055.938881222385, 3087.4133914556164, 3091.6290045194496, 3100.4574199514996, 15039.849601504064, 15596.766048509282, 15792.92103539475, 15999.0, 16010.679786404324, 1792.3995461520406, 1801.2974939773499, 1822.8086050964723, 1826.5890174710717, 1827.8263564961308, 124983.0, 127134.0, 129102.3544882279, 129734.40531189418, 131646.0, 11474.770504589862, 11794.941025294818, 11798.764024719458, 11823.52705891772, 11996.520139194508, 14740.926295368668, 14755.040922340228, 14768.704625907636, 14769.409223630935, 14780.48268310604, 8711.47731136134, 8822.2060014599, 8859.601317940707, 8904.154105359981, 8937.374383793072, 8814.735557933273, 8832.8675069874, 8834.690785822466, 8958.328125390623, 8992.55037248135, 7189.712411503586, 7334.266573342729, 7335.156457007406, 7335.94593513817, 7354.154272258652, 1628.9348426062825, 1744.9825501745074, 1928.6721257386278, 1943.7243626034153, 1986.3445063129134, 851.4337965253161, 969.8836139663285, 1038.2622558788453, 1059.2479339668766, 1092.907102896247, 21463.570728585342, 21883.343499695035, 21950.560988780137, 21951.890240548695, 22034.779652203273, 1073.9946300268605, 1074.2641290715728, 1093.7156339351666, 1113.3987646670869, 1114.1087130295732, 9639.421634701941, 11441.141914356456, 11575.594854180232, 11615.6515304541, 11629.185382546751, 729080.0, 747070.0, 749336.0, 759052.0, 765691.0, 118114.40942795231, 127429.0, 132182.0, 133762.0, 137720.0, 856.486108334994, 1017.862588550551, 1021.3259248895694, 1025.7845852370936, 1029.2126523209752, 18452.077396130408, 19283.325083622007, 19555.902220488806, 19661.410157695293, 19687.21251149995, 47193.528064718914, 53909.0, 56206.18969051449, 57252.713736431055, 57384.0, 58837.5290617738, 77991.61004194943, 78168.0, 78371.21628783867, 79584.60207698925, 7200.675969581277, 7493.288137626917, 7541.43439242048, 7551.584662843597, 7723.6138193089, 12616.432260548114, 12931.353432328535, 12960.611181664564, 12966.35168241603, 13107.737845242851, 10361.911999239972, 10407.0, 10745.94627026891, 11022.834657479983, 11437.942810285895, 10470.581176752845, 10840.349579025284, 10964.232503724663, 11018.944905275423, 11277.154213433862, 11174.050205732603, 11424.885751142714, 11453.370064646524, 11541.422928853355, 11622.6513204604, 6619.205695316593, 6716.227633822173, 7640.770776876702, 7652.349550288065, 8666.783330416538, 9514.571844267162, 10997.285176463503, 11169.664910052712, 11189.776204476027, 11371.545138194711], "value": 10042.240482012132, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.9715605687886, 1426.9429222831088, 1440.5246268731319, 1441.2937660546331, 1449.1087980891755, 7265.673044712988, 7456.925430745691, 8053.798655033627, 8512.148785121484, 8517.914820851789, 8009.639566219519, 8256.298214651762, 8280.62737176827, 8347.624356903938, 8350.791230219247, 2297.4141593893532, 2326.5114325991563, 2338.228384633067, 2340.707411573553, 2350.635651474024, 2074.066669998499, 2141.7215761950924, 2319.4317392238927, 2358.1864256831363, 2360.3862995621175, 2230.7769223077726, 2346.8005219556358, 2348.7416384197722, 2349.4361353275176, 2350.1421980976907, 1958.9510262243416, 2262.468319944812, 2311.7457079721216, 2314.849534780234, 2323.2913961241816, 2325.058351367699, 2327.301809457173, 2331.1491305673476, 2334.2763743239652, 2377.916772912957, 8282.254597086292, 8355.248027677539, 8367.0, 8391.454555453936, 8400.159984001551, 4500.572445617661, 5060.367454068241, 5204.4014938281825, 5209.270702101709, 5224.52979231871, 3317.043981250633, 3458.602260740022, 3517.6658217469553, 3523.6476352364816, 3533.2580158166816, 1166.352674265782, 1172.2029020266216, 1223.6145614131608, 1237.4926280225066, 1242.490578862671, 9551.14039736427, 9761.414315141114, 10451.529681164366, 10677.41274229917, 10686.038256556947, 4275.722078064916, 4408.140412619508, 4587.17430862448, 4740.976295118571, 4760.404949381327, 8662.003869555081, 8668.78328041804, 8706.12938706137, 8752.081031491602, 8768.78078048054, 5129.794808207705, 5142.357205349332, 5155.510226528474, 5156.458571849977, 5165.793368265227, 4610.608098311681, 4711.952880471152, 4744.264638980963, 4823.855284341475, 4833.709977401367, 3464.6015708193377, 3723.385641369198, 3791.981040094837, 3845.1732877431486, 3852.287326844543, 975.5902520941222, 1082.1991726122612, 1120.0, 1156.450685924196, 1176.5293882446917, 756.3183891710296, 803.5883002317237, 851.3359579527978, 910.349100393222, 915.6245939165044, 5252.1596544552685, 5265.210218467184, 5546.306711661043, 5562.415946325577, 5588.804391846266, 939.196986576481, 955.7085089047769, 957.760559860035, 967.8451447768323, 992.3797626483448, 3605.7656252343513, 3696.2607478504406, 3714.1457464783252, 3721.832517536717, 3744.9063773405337, 9605.423674579548, 9924.0, 9953.054459826304, 9957.502124893872, 9969.900300997042, 9779.0, 9888.802223955481, 9900.108990190918, 9900.356476828983, 9922.305438619227, 7633.931249625057, 7666.693332266647, 7792.2986931176465, 7844.097928738154, 7861.213878612093, 5443.374011988513, 5467.125259958388, 5489.121740521658, 5514.283143191359, 5515.641483303572, 9007.324450666096, 9178.67874624385, 9297.72106836796, 9301.534923253676, 9311.348205625542, 9023.052579479061, 9255.398399104037, 9323.0, 9351.0, 9370.39092458988, 7538.09542854861, 7671.117821450604, 7690.769276921477, 7757.3794096473275, 7770.961145194238, 7627.618619068913, 7663.348615367756, 7672.693092276247, 7739.110002349802, 7879.566623835744, 6063.999440092335, 7100.254473280231, 7150.499465037397, 7166.784996450115, 7175.210726819942, 6401.87967105764, 6503.837404064936, 6946.895796562954, 7020.508564400648, 7154.642267886689, 5419.918701219563, 6327.651979141191, 6367.108604795239, 6424.9036264455135, 6456.644884531396, 4965.155923492943, 4984.0, 4985.850424487271, 4989.575886049726, 5052.671576347526, 4897.632677549127, 4955.207166853286, 5072.112380333353, 5075.390953085654, 5150.793968241228], "value": 4365.93990350284, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.4445303961152, 352.85197713752484, 358.48915295703614, 367.76279299851615, 376.6572419098621, 4455.710378825383, 4644.256918892977, 5121.20621303698, 5523.4476552344795, 5606.775728970846, 4612.630989520839, 4754.9524504754945, 5279.208118782185, 5351.304330437038, 5402.9464254470395, 3517.7537572369943, 3864.8840534784003, 4136.855210067648, 4166.916661666764, 4188.518320393163, 3541.8937431876957, 4026.4161696553983, 4093.6900191938594, 4173.332266837291, 4327.883923575021, 4072.775997320161, 4254.723442976197, 4263.275243208662, 4277.914441711179, 4319.784010799463, 4048.392741088831, 4301.354796780477, 4305.289627211507, 4320.870373888788, 4338.240807858644, 3520.612732599412, 3701.370766969622, 3763.5483741950866, 3785.3375659259796, 3814.809259537012, 5287.312649355559, 5315.096433606258, 5357.6605848537865, 5385.0, 5399.948019752508, 4600.585947264729, 4979.278004689336, 5009.173486374781, 5010.549050585429, 5010.949890501085, 4409.316555933835, 4554.43069616298, 5218.373795144607, 5740.732410697793, 5923.534732181636, 3324.0, 3690.6678398943955, 4214.515330736974, 4225.9788701056295, 4245.8513952011535, 6073.4533891949495, 6081.1790408294755, 6111.572189946661, 6148.415900489491, 6158.7228574714245, 3532.4524698671235, 3735.6451137141926, 3955.20895820837, 3999.7400168988925, 4133.759872038437, 3402.4385976314124, 3779.9433008504893, 4320.071184695305, 4365.934510982338, 4381.21138195128, 4853.102176097434, 4966.0, 4966.354373931365, 4978.829974955883, 5019.920717045779, 4786.904261914812, 5045.9747701261995, 5397.622166448311, 5491.28613280271, 5890.823275301748, 1251.8497780266425, 1415.9079659822078, 1432.2337549411016, 1441.0921119694526, 1446.6455718349073, 911.4531281231208, 933.0436302789694, 1003.6035765872585, 1004.6132239087858, 1011.6155860773007, 4319.43847299849, 4624.699394539344, 4698.812047518061, 5159.484051594811, 5250.343707036621, 5750.0, 5921.171036054956, 5942.10868369748, 5985.246786478268, 6006.939930600638, 4415.205263052617, 5026.798928042837, 5083.848014231126, 5180.119379705459, 5414.431484694129, 2847.3024109093403, 2889.1509433962283, 2999.4900866852686, 3015.517517197238, 3025.364673418607, 5120.385553733501, 5176.81881134166, 5195.558377537876, 5535.889282214333, 5874.73563689635, 5274.367075950834, 5356.651817631841, 5850.619709718854, 5954.583179177503, 5996.880062398727, 4949.579285760678, 5256.688286379556, 5665.688387138582, 5764.097847710245, 5918.461200088008, 5419.972900135474, 5610.607257491936, 5697.743601537858, 5719.656820590778, 5728.856778580569, 4813.4945830687275, 5005.849824505271, 5329.467053294795, 5830.921279563295, 5831.425515110981, 5197.168453047646, 5563.415841336763, 5849.853753656193, 5869.383714710065, 5889.322727886348, 3526.911827204238, 3724.42271447926, 3760.7179461539945, 4013.8795836124964, 4076.0258747720736, 3896.2012787379085, 4630.58324750774, 5279.703329051875, 5415.4313797050745, 5535.501804837584, 5461.890762184814, 5480.177973304037, 5481.5066644000635, 5504.779808807763, 5536.501714845522, 5011.621804003928, 5155.742212889416, 5510.366307874646, 5546.556275498031, 5573.6098473106495, 5106.412762532208, 5397.757100930389, 5401.405845356929, 5665.291838520185, 5719.342275638189, 5476.507114359727, 5783.248177736868, 5828.6502809831545, 5859.384764599656, 5861.508858735106, 4436.5563443656665, 5549.72251387421, 5670.631408958405, 5684.346300175367, 5752.9712351437975], "value": 4168.661541469303, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.6517810738416, 699.6152116336017, 706.0115837827038, 796.26345630292, 816.0574536410444, 13778.517751878686, 15146.924265378657, 15423.614409639764, 15438.84561154388, 15486.457973970913, 13968.022238443313, 14990.925045374757, 15454.768178477332, 15604.375824966988, 16052.277647505862, 854.6624083487019, 860.4450129666361, 879.0594064351147, 880.4321212817761, 882.9514376709278, 691.429570604251, 706.3289874619106, 848.3764433141636, 872.2193636695154, 875.0636818604096, 901.4230892228978, 916.463868636845, 926.7868390270208, 926.9675561355353, 929.8372784762673, 916.6699988004314, 923.9307051971095, 924.570074915161, 925.9768505787342, 926.0878035135386, 684.8596037812237, 691.761342336898, 695.4575431163701, 695.655650453029, 695.9478039147034, 14490.275486225752, 14915.552533424014, 15496.922515387463, 15508.5347439577, 15673.686526269525, 13813.792793108112, 14489.710205795931, 14655.34050967709, 14658.70682586353, 14704.485343012942, 10992.560297588087, 11097.83353249702, 11246.49390777417, 11279.323240605509, 11388.71528211793, 3594.532710747586, 3760.1545078050212, 3775.2826962876966, 3863.8068096595057, 3865.40086286626, 89417.0, 92948.53525732395, 94594.10811783794, 110217.44891275492, 111214.0, 11493.367864767351, 11534.884651153548, 11575.42122893852, 11577.189596728316, 11613.6515904523, 19941.0, 23552.64671029936, 23854.522909541713, 23979.52040959171, 23991.0, 8037.437379383504, 8045.356371490384, 8072.233137851895, 8108.797280067927, 8114.63484143215, 4183.8063133301, 4185.121124563876, 4295.033617436052, 4312.676549258818, 4370.737755734603, 3483.8780642677384, 3581.409067503833, 3582.1402863313137, 3590.5870824854956, 3599.802010889426, 612.3692596625483, 645.854682696399, 668.8495088605122, 672.0758956434902, 681.8568100698909, 687.2543290529832, 699.6781480519019, 707.6709330161397, 719.1478098453349, 722.6531264992833, 9448.57481413338, 10140.949295253624, 10202.642907498202, 10222.182225421948, 10444.73888152787, 676.1277951442584, 692.504859025799, 703.1772825793834, 706.9893951590731, 707.2220557386936, 4695.248760198352, 4915.3855768029, 4947.431045429749, 4947.505249475023, 4948.802047918043, 97634.51182744041, 101250.0, 107464.0, 110335.89664103417, 111191.44404277927, 96970.03029969751, 97769.0, 97786.0, 99417.0, 100215.0, 60536.78926421535, 77443.0, 79837.0, 80383.0, 82265.17734822695, 8442.746717598482, 8890.110988901059, 9423.717288481357, 9510.1440870322, 9564.378315409476, 52958.470415295356, 53645.73177134089, 54357.72821135869, 54613.0, 54750.726246370104, 70194.29805701878, 71394.0, 71970.28029719845, 72787.63606181936, 72942.0, 11623.941880290544, 11663.675217913074, 11729.35488548138, 11972.341521216416, 12286.81569776472, 12438.315892625993, 12558.309292988974, 12605.43275552584, 13001.544945926848, 13143.342832858127, 11688.0, 11840.0, 11861.169718119649, 12093.81859272094, 12529.749405012031, 11710.824337634773, 11774.470148843151, 12077.39613019363, 12403.875961240634, 12575.685607859878, 11663.475143618727, 11883.287002779862, 11891.345975971404, 12393.566225182436, 12508.749825003631, 9927.950360248153, 9946.403215807075, 10028.348157369748, 10437.0, 10449.895501044892, 9783.36408133469, 9820.373610924076, 9909.405435673883, 9915.107640312119, 9938.801223975624], "value": 7453.408715436885, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1537.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 118.0, 117.0, 154.0, 172.0, 132.0, 119.0, 119.0, 117.0, 98.0], "value": 125.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 143.0, 112.0, 146.0, 110.0, 111.0, 136.0, 104.0, 163.0, 96.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 194.0, 195.0, 197.0, 189.0, 195.0, 196.0, 198.0, 200.0, 238.0], "value": 200.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 81.0, 109.0, 83.0, 50.0, 70.0, 57.0, 72.0, 70.0], "value": 74.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 71.0, 83.0, 73.0, 70.0, 71.0, 82.0, 70.0, 70.0, 94.0], "value": 77.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 88.0, 87.0, 89.0, 85.0, 95.0, 87.0, 89.0, 89.0], "value": 97.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 153.0, 96.0, 97.0, 96.0, 96.0, 96.0, 98.0, 97.0, 98.0], "value": 104.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 92.0, 93.0, 94.0, 93.0, 95.0, 96.0, 96.0, 93.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 57.0, 57.0, 65.0, 92.0, 89.0, 89.0, 50.0, 56.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 81.0, 74.0, 77.0, 69.0, 70.0, 68.0, 72.0, 73.0], "value": 71.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 83.0, 90.0, 85.0, 88.0, 86.0, 85.0, 92.0, 84.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 153.0, 153.0, 165.0, 161.0, 155.0, 155.0, 144.0, 184.0, 143.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 215.0, 170.0, 171.0, 169.0, 170.0, 167.0, 174.0, 176.0, 165.0], "value": 175.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 67.0, 68.0, 63.0, 81.0, 88.0, 89.0, 88.0, 87.0], "value": 76.4, "unit": "score"}]}]} 03:59:29 INFO - Return code: 0 03:59:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:59:29 ERROR - # TBPL SUCCESS # 03:59:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:59:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:59:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:59:29 INFO - 2017-02-14 03:59:29.284 screenresolution[1660:10398] starting screenresolution argv=screenresolution get 03:59:29 INFO - 2017-02-14 03:59:29.287 screenresolution[1660:10398] Display 0: 1600x1200x32@60 03:59:29 INFO - 2017-02-14 03:59:29.293 screenresolution[1661:10401] starting screenresolution argv=screenresolution list 03:59:29 INFO - Available Modes on Display 0 03:59:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:59:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:59:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:59:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:59:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:59:29 INFO - Intel Iris: 03:59:29 INFO - Chipset Model: Intel Iris 03:59:29 INFO - Type: GPU 03:59:29 INFO - Bus: Built-In 03:59:29 INFO - VRAM (Dynamic, Max): 1536 MB 03:59:29 INFO - Vendor: Intel (0x8086) 03:59:29 INFO - Device ID: 0x0a2e 03:59:29 INFO - Revision ID: 0x0009 03:59:29 INFO - Displays: 03:59:29 INFO - Display: 03:59:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:59:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:59:29 INFO - Display Serial Number: 1600x1200 60 03:59:29 INFO - Main Display: Yes 03:59:29 INFO - Mirror: Off 03:59:29 INFO - Online: Yes 03:59:29 INFO - Rotation: Supported 03:59:29 INFO - Return code: 0 03:59:29 INFO - Running post-action listener: _resource_record_post_action 03:59:29 INFO - [mozharness: 2017-02-14 11:59:29.529259Z] Finished run-tests step (success) 03:59:29 INFO - Running post-run listener: _resource_record_post_run 03:59:29 INFO - Total resource usage - Wall time: 1196s; CPU: 55.0%; Read bytes: 38992384; Write bytes: 510334976; Read time: 248; Write time: 1642 03:59:29 INFO - TinderboxPrint: CPU usage
54.5% 03:59:29 INFO - TinderboxPrint: I/O read bytes / time
38,992,384 / 248 03:59:29 INFO - TinderboxPrint: I/O write bytes / time
510,334,976 / 1,642 03:59:29 INFO - TinderboxPrint: CPU idle
2,175.5 (45.5%) 03:59:29 INFO - TinderboxPrint: CPU system
964.2 (20.1%) 03:59:29 INFO - TinderboxPrint: CPU user
1,645.9 (34.4%) 03:59:29 INFO - TinderboxPrint: Swap in / out
246,710,272 / 0 03:59:29 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207739392; Write bytes: 201836032; Read time: 16046; Write time: 453 03:59:29 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 35445248; Write bytes: 298418688; Read time: 225; Write time: 1158 03:59:29 INFO - Running post-run listener: _upload_blobber_files 03:59:29 INFO - Blob upload gear active. 03:59:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:59:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:59:29 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'] 03:59:29 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 03:59:30 INFO - (blobuploader) - INFO - Open directory for files ... 03:59:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:59:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:59:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:31 INFO - (blobuploader) - INFO - Done attempting. 03:59:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:59:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:59:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:32 INFO - (blobuploader) - INFO - Done attempting. 03:59:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:59:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:59:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:33 INFO - (blobuploader) - INFO - Done attempting. 03:59:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:59:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:59:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:59:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:59:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:59:36 INFO - (blobuploader) - INFO - Done attempting. 03:59:36 INFO - (blobuploader) - INFO - Iteration through files over. 03:59:36 INFO - Return code: 0 03:59:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:59:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:59:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6d71c519656cfb4a1ac5badf8f2f6347a33289716519375a3bd3d3190d83563d6e9d14646911d45706935c5bebe7a28198e4b72a54eee3aaeabd78ba58a754a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c14cc477ee4310643694f50596c56b1c11c5d7910735a25d1971f55ef2cf1380968f44f1fc4b1fbf92cd753ca646cd5973581a409b951a71e3ce116f5d1d5b71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b40adeab822ee798872a53b2bf92f4231a8da637754e5b4440ec1f1ae0ce84a122af06886c0608c477dae2c45188bb4cd1fb4301942f82f5ce7cbfa4d0760d62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84c00b9b738cfa4012a9b92f83a44b0e9559a8fecf13c14a504c3f8bdc60bb67d117ff6266d213f44f4ba63d24ea8d5ba09309c176ffcaef5fd5df151da58c6a"} 03:59:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:59:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:59:36 INFO - Contents: 03:59:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6d71c519656cfb4a1ac5badf8f2f6347a33289716519375a3bd3d3190d83563d6e9d14646911d45706935c5bebe7a28198e4b72a54eee3aaeabd78ba58a754a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c14cc477ee4310643694f50596c56b1c11c5d7910735a25d1971f55ef2cf1380968f44f1fc4b1fbf92cd753ca646cd5973581a409b951a71e3ce116f5d1d5b71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b40adeab822ee798872a53b2bf92f4231a8da637754e5b4440ec1f1ae0ce84a122af06886c0608c477dae2c45188bb4cd1fb4301942f82f5ce7cbfa4d0760d62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84c00b9b738cfa4012a9b92f83a44b0e9559a8fecf13c14a504c3f8bdc60bb67d117ff6266d213f44f4ba63d24ea8d5ba09309c176ffcaef5fd5df151da58c6a"} 03:59:36 INFO - Running post-run listener: copy_logs_to_upload_dir 03:59:36 INFO - Copying logs to upload dir... 03:59:36 INFO - mkdir: /builds/slave/test/build/upload/logs 03:59:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.925538 ========= master_lag: 1.07 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-14 03:59:37.408497) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 03:59:37.411811) ========= 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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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/e6d71c519656cfb4a1ac5badf8f2f6347a33289716519375a3bd3d3190d83563d6e9d14646911d45706935c5bebe7a28198e4b72a54eee3aaeabd78ba58a754a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c14cc477ee4310643694f50596c56b1c11c5d7910735a25d1971f55ef2cf1380968f44f1fc4b1fbf92cd753ca646cd5973581a409b951a71e3ce116f5d1d5b71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b40adeab822ee798872a53b2bf92f4231a8da637754e5b4440ec1f1ae0ce84a122af06886c0608c477dae2c45188bb4cd1fb4301942f82f5ce7cbfa4d0760d62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84c00b9b738cfa4012a9b92f83a44b0e9559a8fecf13c14a504c3f8bdc60bb67d117ff6266d213f44f4ba63d24ea8d5ba09309c176ffcaef5fd5df151da58c6a"} build_url:https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011069 build_url: 'https://queue.taskcluster.net/v1/task/fBoTpzfrRrWK5ucJO5ilLw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e6d71c519656cfb4a1ac5badf8f2f6347a33289716519375a3bd3d3190d83563d6e9d14646911d45706935c5bebe7a28198e4b72a54eee3aaeabd78ba58a754a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c14cc477ee4310643694f50596c56b1c11c5d7910735a25d1971f55ef2cf1380968f44f1fc4b1fbf92cd753ca646cd5973581a409b951a71e3ce116f5d1d5b71", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b40adeab822ee798872a53b2bf92f4231a8da637754e5b4440ec1f1ae0ce84a122af06886c0608c477dae2c45188bb4cd1fb4301942f82f5ce7cbfa4d0760d62", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/84c00b9b738cfa4012a9b92f83a44b0e9559a8fecf13c14a504c3f8bdc60bb67d117ff6266d213f44f4ba63d24ea8d5ba09309c176ffcaef5fd5df151da58c6a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 03:59:37.446517) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 03:59:37.446884) ========= 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.Hq0TV3dxCe/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.9d32Ij99s7/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.005157 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 03:59:37.495287) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 03:59:37.495622) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 03:59:37.496100) ========= ========= Total master_lag: 1.20 =========