builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0356 starttime: 1476359808.55 results: success (0) buildid: 20161013023624 builduid: 5f5eb7ca508e4712987082af272b41e6 revision: 00fdaac3efafd2621ed9849c52527051f9edda53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 04:56:48.549746) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 04:56:48.550184) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 04:56:48.550469) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 04:56:48.574699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:56:48.575070) ========= 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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 --2016-10-13 04:56:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.1M=0.001s 2016-10-13 04:56:48 (19.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.182298 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:56:48.779778) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:56:48.780084) ========= 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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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.026122 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 04:56:48.829296) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 04:56:48.829743) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 00fdaac3efafd2621ed9849c52527051f9edda53 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 00fdaac3efafd2621ed9849c52527051f9edda53 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 2016-10-13 04:56:48,914 truncating revision to first 12 chars 2016-10-13 04:56:48,914 Setting DEBUG logging. 2016-10-13 04:56:48,914 attempt 1/10 2016-10-13 04:56:48,914 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/00fdaac3efaf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 04:56:49,966 unpacking tar archive at: mozilla-central-00fdaac3efaf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.331746 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 04:56:50.185820) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 04:56:50.186329) ========= script_repo_revision: 00fdaac3efafd2621ed9849c52527051f9edda53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 04:56:50.186878) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 04:56:50.187287) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 04:56:50.206418) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-13 04:56:50.206799) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 04:56:50 INFO - MultiFileLogger online at 20161013 04:56:50 in /builds/slave/test 04:56:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:56:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:56:50 INFO - {'append_to_log': False, 04:56:50 INFO - 'base_work_dir': '/builds/slave/test', 04:56:50 INFO - 'blob_upload_branch': 'Firefox', 04:56:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:56:50 INFO - 'branch': 'Firefox', 04:56:50 INFO - 'buildbot_json_path': 'buildprops.json', 04:56:50 INFO - 'config_files': ('talos/mac_config.py',), 04:56:50 INFO - 'default_actions': ('clobber', 04:56:50 INFO - 'read-buildbot-config', 04:56:50 INFO - 'download-and-extract', 04:56:50 INFO - 'populate-webroot', 04:56:50 INFO - 'create-virtualenv', 04:56:50 INFO - 'install', 04:56:50 INFO - 'run-tests'), 04:56:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:56:50 INFO - 'download_minidump_stackwalk': True, 04:56:50 INFO - 'download_symbols': 'ondemand', 04:56:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:56:50 INFO - 'tooltool.py': '/tools/tooltool.py', 04:56:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:56:50 INFO - '/tools/misc-python/virtualenv.py')}, 04:56:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:56:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:56:50 INFO - 'installer_path': 'installer.exe', 04:56:50 INFO - 'log_level': 'info', 04:56:50 INFO - 'log_name': 'talos', 04:56:50 INFO - 'log_to_console': True, 04:56:50 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:56:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:56:50 INFO - 'opt_config_files': (), 04:56:50 INFO - 'pip_index': False, 04:56:50 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:56:50 INFO - 'cmd': ('bash', 04:56:50 INFO - '-c', 04:56:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:56:50 INFO - 'enabled': True, 04:56:50 INFO - 'halt_on_failure': False, 04:56:50 INFO - 'name': 'check_screen_resolution'},), 04:56:50 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:56:50 INFO - 'cmd': ('bash', 04:56:50 INFO - '-c', 04:56:50 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:56:50 INFO - 'enabled': True, 04:56:50 INFO - 'halt_on_failure': False, 04:56:50 INFO - 'name': 'check_screen_resolution'},), 04:56:50 INFO - 'run_cmd_checks_enabled': True, 04:56:50 INFO - 'sps_profile': False, 04:56:50 INFO - 'sps_profile_interval': 0, 04:56:50 INFO - 'suite': 'dromaeojs-e10s', 04:56:50 INFO - 'system_bits': '32', 04:56:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:56:50 INFO - 'title': 't-yosemite-r7-0356', 04:56:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:56:50 INFO - 'use_talos_json': True, 04:56:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:56:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:56:50 INFO - 'work_dir': 'build'} 04:56:50 INFO - [mozharness: 2016-10-13 11:56:50.409369Z] Running clobber step. 04:56:50 INFO - Running pre-action listener: _resource_record_pre_action 04:56:50 INFO - Running main action method: clobber 04:56:50 INFO - rmtree: /builds/slave/test/build 04:56:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:56:52 INFO - Running post-action listener: _resource_record_post_action 04:56:52 INFO - [mozharness: 2016-10-13 11:56:52.519797Z] Finished clobber step (success) 04:56:52 INFO - [mozharness: 2016-10-13 11:56:52.519949Z] Running read-buildbot-config step. 04:56:52 INFO - Running pre-action listener: _resource_record_pre_action 04:56:52 INFO - Running main action method: read_buildbot_config 04:56:52 INFO - Using buildbot properties: 04:56:52 INFO - { 04:56:52 INFO - "project": "", 04:56:52 INFO - "product": "firefox", 04:56:52 INFO - "script_repo_revision": "production", 04:56:52 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:56:52 INFO - "repository": "", 04:56:52 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:56:52 INFO - "buildid": "20161013023624", 04:56:52 INFO - "pgo_build": "False", 04:56:52 INFO - "basedir": "/builds/slave/test", 04:56:52 INFO - "buildnumber": 309, 04:56:52 INFO - "slavename": "t-yosemite-r7-0356", 04:56:52 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:56:52 INFO - "platform": "yosemite_r7", 04:56:52 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:56:52 INFO - "branch": "mozilla-central", 04:56:52 INFO - "repo_path": "mozilla-central", 04:56:52 INFO - "revision": "00fdaac3efafd2621ed9849c52527051f9edda53", 04:56:52 INFO - "stage_platform": "macosx64", 04:56:52 INFO - "builduid": "5f5eb7ca508e4712987082af272b41e6", 04:56:52 INFO - "slavebuilddir": "test" 04:56:52 INFO - } 04:56:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 04:56:52 INFO - Running post-action listener: _resource_record_post_action 04:56:52 INFO - [mozharness: 2016-10-13 11:56:52.522856Z] Finished read-buildbot-config step (success) 04:56:52 INFO - [mozharness: 2016-10-13 11:56:52.522958Z] Running download-and-extract step. 04:56:52 INFO - Running pre-action listener: _resource_record_pre_action 04:56:52 INFO - Running main action method: download_and_extract 04:56:52 INFO - mkdir: /builds/slave/test/build/tests 04:56: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')]} 04:56:52 INFO - trying https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 04:56:52 INFO - Downloading https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:56:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 04:56:53 INFO - Downloaded 1199 bytes. 04:56:53 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 04:56:53 INFO - Using the following test package requirements: 04:56:53 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:56:53 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:56:53 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 04:56:53 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:56:53 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 04:56:53 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:56:53 INFO - u'jsshell-mac.zip'], 04:56:53 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:56:53 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 04:56:53 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 04:56:53 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:56:53 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 04:56:53 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:56:53 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 04:56:53 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:56:53 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 04:56:53 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 04:56:53 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 04:56:53 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:56:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:56:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:56:53 INFO - Fetch https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:56:54 INFO - Http code: 200 04:56:54 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 04:56:54 INFO - x-amz-cf-id: _OSgzEBfzfFbXQ5nygd4Lrktl3vdzBVt2fw0P6iDwNG5l3x_DJardg== 04:56:54 INFO - x-amz-version-id: ECwwaruVlyEsY219XxA0qvXnJXzH4pjh 04:56:54 INFO - Expected file size: 16511104 04:56:54 INFO - Obtained file size: 16511104 04:57:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:57:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 04:57:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:57:01 INFO - Fetch https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 04:57:02 INFO - Http code: 200 04:57:02 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 04:57:02 INFO - x-amz-cf-id: 8u7ZjkPZKb3tXPVBOxnq_34tR4R8Ft3UXMjm9kuXiAOBucE2aC56tg== 04:57:02 INFO - x-amz-version-id: ECwwaruVlyEsY219XxA0qvXnJXzH4pjh 04:57:02 INFO - Expected file size: 16511104 04:57:02 INFO - Obtained file size: 16511104 04:57:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 04:57:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:57:08 INFO - Fetch https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 04:57:09 INFO - Http code: 200 04:57:09 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 04:57:09 INFO - x-amz-cf-id: Tu9uk2dPM2Y51m0uOdwnBRzuiBsLWssXO4wSrqZKRZZuNle2YFNS0Q== 04:57:09 INFO - x-amz-version-id: .TCSwr7WVuCTABL6ZkgzwIF.vqmeCvGA 04:57:10 INFO - Expected file size: 14409006 04:57:10 INFO - Obtained file size: 14409006 04:57:10 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')]} 04:57:10 INFO - trying https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:57:10 INFO - Downloading https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 04:57:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 04:57:13 INFO - Downloaded 111666507 bytes. 04:57:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:57:13 INFO - mkdir: /builds/slave/test/properties 04:57:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:57:13 INFO - Writing to file /builds/slave/test/properties/build_url 04:57:13 INFO - Contents: 04:57:13 INFO - build_url:https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 04:57:14 INFO - Running post-action listener: _resource_record_post_action 04:57:14 INFO - Running post-action listener: set_extra_try_arguments 04:57:14 INFO - [mozharness: 2016-10-13 11:57:14.114023Z] Finished download-and-extract step (success) 04:57:14 INFO - [mozharness: 2016-10-13 11:57:14.114184Z] Running populate-webroot step. 04:57:14 INFO - Running pre-action listener: _resource_record_pre_action 04:57:14 INFO - Running main action method: populate_webroot 04:57:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:57:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:57:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:57:14 INFO - '--tppagecycles', 04:57:14 INFO - '7'], 04:57:14 INFO - 'tests': ['tsvgm']}}, 04:57:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:57:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:57:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:57:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:57:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:57:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:57:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:14 INFO - 'talos_options': ['--disable-e10s'], 04:57:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:57:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:14 INFO - 'talos_options': ['--disable-e10s'], 04:57:14 INFO - 'tests': ['damp', 'tps']}, 04:57:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:14 INFO - 'tests': ['damp', 'tps']}, 04:57:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:57:14 INFO - 'tests': ['dromaeo_dom']}, 04:57:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:57:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:57:14 INFO - 'tests': ['basic_compositor_video']}, 04:57:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:57:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:57:14 INFO - 'tests': ['a11yr', 04:57:14 INFO - 'ts_paint', 04:57:14 INFO - 'tpaint', 04:57:14 INFO - 'sessionrestore', 04:57:14 INFO - 'sessionrestore_no_auto_restore', 04:57:14 INFO - 'tabpaint']}, 04:57:14 INFO - 'other-e10s': {'tests': ['a11yr', 04:57:14 INFO - 'ts_paint', 04:57:14 INFO - 'tpaint', 04:57:14 INFO - 'sessionrestore', 04:57:14 INFO - 'sessionrestore_no_auto_restore', 04:57:14 INFO - 'tabpaint']}, 04:57:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:57:14 INFO - 'ts_paint', 04:57:14 INFO - 'tpaint', 04:57:14 INFO - 'sessionrestore', 04:57:14 INFO - 'sessionrestore_no_auto_restore', 04:57:14 INFO - 'tabpaint']}, 04:57:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:57:14 INFO - 'ts_paint', 04:57:14 INFO - 'tpaint', 04:57:14 INFO - 'sessionrestore', 04:57:14 INFO - 'sessionrestore_no_auto_restore', 04:57:14 INFO - 'tabpaint']}, 04:57:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:57:14 INFO - 'tests': ['a11yr', 04:57:14 INFO - 'ts_paint', 04:57:14 INFO - 'tpaint', 04:57:14 INFO - 'sessionrestore', 04:57:14 INFO - 'sessionrestore_no_auto_restore', 04:57:14 INFO - 'tabpaint']}, 04:57:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:57:14 INFO - 'tests': ['a11yr', 04:57:14 INFO - 'ts_paint', 04:57:14 INFO - 'tpaint', 04:57:14 INFO - 'sessionrestore', 04:57:14 INFO - 'sessionrestore_no_auto_restore', 04:57:14 INFO - 'tabpaint']}, 04:57:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:57:14 INFO - 'tests': ['tsvgx', 04:57:14 INFO - 'tsvgr_opacity', 04:57:14 INFO - 'tart', 04:57:14 INFO - 'tscrollx', 04:57:14 INFO - 'cart']}, 04:57:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:57:14 INFO - 'tsvgr_opacity', 04:57:14 INFO - 'tart', 04:57:14 INFO - 'tscrollx', 04:57:14 INFO - 'cart']}, 04:57:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:14 INFO - 'talos_options': ['--disable-e10s'], 04:57:14 INFO - 'tests': ['tp5o']}, 04:57:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:14 INFO - 'tests': ['tp5o']}, 04:57:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:14 INFO - 'talos_options': ['--disable-e10s', 04:57:14 INFO - '--xperf_path', 04:57:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:14 INFO - 'tests': ['tp5n']}, 04:57:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:57:14 INFO - 'talos_options': ['--xperf_path', 04:57:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:57:14 INFO - 'tests': ['tp5n']}}, 04:57:14 INFO - 'talos.zip': {'path': '', 04:57:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:57:14 INFO - Running post-action listener: _resource_record_post_action 04:57:14 INFO - [mozharness: 2016-10-13 11:57:14.133421Z] Finished populate-webroot step (success) 04:57:14 INFO - [mozharness: 2016-10-13 11:57:14.133502Z] Running create-virtualenv step. 04:57:14 INFO - Running pre-action listener: _resource_record_pre_action 04:57:14 INFO - Running main action method: create_virtualenv 04:57:14 INFO - Creating virtualenv /builds/slave/test/build/venv 04:57:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:57:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:57:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:57:14 INFO - Using real prefix '/tools/python27' 04:57:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:57:14 INFO - Installing distribute.............................................................................................................................................................................................done. 04:57:17 INFO - Installing pip.................done. 04:57:17 INFO - Return code: 0 04:57:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:57:18 INFO - Reading from file tmpfile_stdout 04:57:18 INFO - Output received: 04:57:18 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:57:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2395679c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1dad30>, '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 0x10b000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1d2b20>, '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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 04:57:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:57:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:57:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XcOvxFYIQ7/Render', 04:57:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:18 INFO - 'HOME': '/Users/cltbld', 04:57:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:18 INFO - 'LOGNAME': 'cltbld', 04:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:18 INFO - 'MOZ_NO_REMOTE': '1', 04:57:18 INFO - 'NO_EM_RESTART': '1', 04:57:18 INFO - 'PAGER': '/bin/cat', 04:57:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:18 INFO - 'PWD': '/builds/slave/test', 04:57:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:18 INFO - 'SHELL': '/bin/bash', 04:57:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1s2VrUEdj1/Listeners', 04:57:18 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 04:57:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:18 INFO - 'USER': 'cltbld', 04:57:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:18 INFO - 'XPC_FLAGS': '0x0', 04:57:18 INFO - 'XPC_SERVICE_NAME': '0', 04:57:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:18 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 04:57:18 INFO - Cleaning up... 04:57:18 INFO - Return code: 0 04:57:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b3c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2395679c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1dad30>, '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 0x10b000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1d2b20>, '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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 04:57:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:57:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:57:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XcOvxFYIQ7/Render', 04:57:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:18 INFO - 'HOME': '/Users/cltbld', 04:57:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:18 INFO - 'LOGNAME': 'cltbld', 04:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:18 INFO - 'MOZ_NO_REMOTE': '1', 04:57:18 INFO - 'NO_EM_RESTART': '1', 04:57:18 INFO - 'PAGER': '/bin/cat', 04:57:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:18 INFO - 'PWD': '/builds/slave/test', 04:57:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:18 INFO - 'SHELL': '/bin/bash', 04:57:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1s2VrUEdj1/Listeners', 04:57:18 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 04:57:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:18 INFO - 'USER': 'cltbld', 04:57:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:18 INFO - 'XPC_FLAGS': '0x0', 04:57:18 INFO - 'XPC_SERVICE_NAME': '0', 04:57:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:18 INFO - Downloading/unpacking psutil>=3.1.1 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57: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 04:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:57:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:22 INFO - Installing collected packages: psutil 04:57:22 INFO - Running setup.py install for psutil 04:57:22 INFO - building 'psutil._psutil_osx' extension 04:57:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:57:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:57:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:57:22 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 04:57:22 INFO - building 'psutil._psutil_posix' extension 04:57:22 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 04:57:22 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:57:22 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:57:22 INFO - ^ 04:57:22 INFO - 1 warning generated. 04:57:22 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 04:57:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:57:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:57:23 INFO - Successfully installed psutil 04:57:23 INFO - Cleaning up... 04:57:23 INFO - Return code: 0 04:57:23 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:57:23 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')]} 04:57:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:23 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')]} 04:57:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:23 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 0x10b3c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2395679c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1dad30>, '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 0x10b000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1d2b20>, '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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 04:57:23 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 04:57:23 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 04:57:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XcOvxFYIQ7/Render', 04:57:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:23 INFO - 'HOME': '/Users/cltbld', 04:57:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:23 INFO - 'LOGNAME': 'cltbld', 04:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:23 INFO - 'MOZ_NO_REMOTE': '1', 04:57:23 INFO - 'NO_EM_RESTART': '1', 04:57:23 INFO - 'PAGER': '/bin/cat', 04:57:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:23 INFO - 'PWD': '/builds/slave/test', 04:57:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:23 INFO - 'SHELL': '/bin/bash', 04:57:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1s2VrUEdj1/Listeners', 04:57:23 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 04:57:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:23 INFO - 'USER': 'cltbld', 04:57:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:23 INFO - 'XPC_FLAGS': '0x0', 04:57:23 INFO - 'XPC_SERVICE_NAME': '0', 04:57:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:57:23 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 04:57:23 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 04:57:23 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 04:57:23 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 04:57:23 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 04:57:23 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 04:57:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:57:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:57:26 INFO - Installing collected packages: mozsystemmonitor 04:57:26 INFO - Running setup.py install for mozsystemmonitor 04:57:26 INFO - Successfully installed mozsystemmonitor 04:57:26 INFO - Cleaning up... 04:57:26 INFO - Return code: 0 04:57:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:57:26 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')]} 04:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:26 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')]} 04:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:26 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 0x10b3c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2395679c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1dad30>, '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 0x10b000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1d2b20>, '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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 04:57:26 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 04:57:26 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 04:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XcOvxFYIQ7/Render', 04:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:26 INFO - 'HOME': '/Users/cltbld', 04:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:26 INFO - 'LOGNAME': 'cltbld', 04:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:26 INFO - 'MOZ_NO_REMOTE': '1', 04:57:26 INFO - 'NO_EM_RESTART': '1', 04:57:26 INFO - 'PAGER': '/bin/cat', 04:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:26 INFO - 'PWD': '/builds/slave/test', 04:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:26 INFO - 'SHELL': '/bin/bash', 04:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1s2VrUEdj1/Listeners', 04:57:26 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 04:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:26 INFO - 'USER': 'cltbld', 04:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:26 INFO - 'XPC_FLAGS': '0x0', 04:57:26 INFO - 'XPC_SERVICE_NAME': '0', 04:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:26 INFO - Downloading/unpacking jsonschema==2.5.1 04:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:57:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:57:29 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 04:57:29 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 04:57:29 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 04:57:29 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 04:57:29 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 04:57:29 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 04:57:29 INFO - Downloading functools32-3.2.3-2.tar.gz 04:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:57:29 INFO - warning: no files found matching '*.txt' 04:57:29 INFO - no previously-included directories found matching 'build' 04:57:29 INFO - no previously-included directories found matching 'dist' 04:57:29 INFO - no previously-included directories found matching '.git*' 04:57:29 INFO - Installing collected packages: jsonschema, functools32 04:57:29 INFO - Running setup.py install for functools32 04:57:29 INFO - warning: no files found matching '*.txt' 04:57:29 INFO - no previously-included directories found matching 'build' 04:57:29 INFO - no previously-included directories found matching 'dist' 04:57:29 INFO - no previously-included directories found matching '.git*' 04:57:29 INFO - Successfully installed jsonschema functools32 04:57:29 INFO - Cleaning up... 04:57:30 INFO - Return code: 0 04:57:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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')]} 04:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2395679c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1dad30>, '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 0x10b000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1d2b20>, '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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 04:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:57:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XcOvxFYIQ7/Render', 04:57:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:30 INFO - 'HOME': '/Users/cltbld', 04:57:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:30 INFO - 'LOGNAME': 'cltbld', 04:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:30 INFO - 'MOZ_NO_REMOTE': '1', 04:57:30 INFO - 'NO_EM_RESTART': '1', 04:57:30 INFO - 'PAGER': '/bin/cat', 04:57:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:30 INFO - 'PWD': '/builds/slave/test', 04:57:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:30 INFO - 'SHELL': '/bin/bash', 04:57:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1s2VrUEdj1/Listeners', 04:57:30 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 04:57:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:30 INFO - 'USER': 'cltbld', 04:57:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:30 INFO - 'XPC_FLAGS': '0x0', 04:57:30 INFO - 'XPC_SERVICE_NAME': '0', 04:57:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:57:30 INFO - Cleaning up... 04:57:30 INFO - Return code: 0 04:57:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:57: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')]} 04:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57: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')]} 04:57:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b3c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2395679c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1dad30>, '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 0x10b000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1d2b20>, '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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 04:57:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:57:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:57:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XcOvxFYIQ7/Render', 04:57:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:30 INFO - 'HOME': '/Users/cltbld', 04:57:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:30 INFO - 'LOGNAME': 'cltbld', 04:57:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:30 INFO - 'MOZ_NO_REMOTE': '1', 04:57:30 INFO - 'NO_EM_RESTART': '1', 04:57:30 INFO - 'PAGER': '/bin/cat', 04:57:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:30 INFO - 'PWD': '/builds/slave/test', 04:57:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:30 INFO - 'SHELL': '/bin/bash', 04:57:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1s2VrUEdj1/Listeners', 04:57:30 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 04:57:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:30 INFO - 'USER': 'cltbld', 04:57:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:30 INFO - 'XPC_FLAGS': '0x0', 04:57:30 INFO - 'XPC_SERVICE_NAME': '0', 04:57:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:30 INFO - Downloading/unpacking blobuploader==1.2.4 04:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:33 INFO - Downloading blobuploader-1.2.4.tar.gz 04:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:57:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:57:33 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 04:57:33 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 04:57:33 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 04:57:33 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 04:57:33 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 04:57:33 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 04:57:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:57:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:57:33 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 04:57:33 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 04:57:33 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 04:57:33 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 04:57:33 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 04:57:33 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 04:57:34 INFO - Downloading docopt-0.6.1.tar.gz 04:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:57:34 INFO - Installing collected packages: blobuploader, requests, docopt 04:57:34 INFO - Running setup.py install for blobuploader 04:57:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:57:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:57:34 INFO - Running setup.py install for requests 04:57:35 INFO - Running setup.py install for docopt 04:57:35 INFO - Successfully installed blobuploader requests docopt 04:57:35 INFO - Cleaning up... 04:57:35 INFO - Return code: 0 04:57:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:35 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 0x10b3c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2395679c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1dad30>, '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 0x10b000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1d2b20>, '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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 04:57:35 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 04:57:35 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 04:57:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XcOvxFYIQ7/Render', 04:57:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:35 INFO - 'HOME': '/Users/cltbld', 04:57:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:35 INFO - 'LOGNAME': 'cltbld', 04:57:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:35 INFO - 'MOZ_NO_REMOTE': '1', 04:57:35 INFO - 'NO_EM_RESTART': '1', 04:57:35 INFO - 'PAGER': '/bin/cat', 04:57:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:35 INFO - 'PWD': '/builds/slave/test', 04:57:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:35 INFO - 'SHELL': '/bin/bash', 04:57:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1s2VrUEdj1/Listeners', 04:57:35 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 04:57:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:35 INFO - 'USER': 'cltbld', 04:57:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:35 INFO - 'XPC_FLAGS': '0x0', 04:57:35 INFO - 'XPC_SERVICE_NAME': '0', 04:57:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:35 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-Kv8heK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:35 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-84qQcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:35 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-z05L3_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:35 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-FtUicG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-KjhASJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-RTGuEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-FKHB1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-nVrfcG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-0JzTCu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-Pet71F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-AlknZB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-r82BfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-jHAsXc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-oYLIEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:37 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-oI67dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:37 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-JBg79N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:37 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-D4sR8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:57:37 INFO - Running setup.py install for manifestparser 04:57:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:57:37 INFO - Running setup.py install for mozcrash 04:57:37 INFO - Running setup.py install for mozdebug 04:57:37 INFO - Running setup.py install for mozdevice 04:57:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:57:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:57:38 INFO - Running setup.py install for mozfile 04:57:38 INFO - Running setup.py install for mozhttpd 04:57:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:57:38 INFO - Running setup.py install for mozinfo 04:57:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:57:38 INFO - Running setup.py install for mozInstall 04:57:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:57:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:57:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:57:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:57:38 INFO - Running setup.py install for mozleak 04:57:38 INFO - Running setup.py install for mozlog 04:57:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:57:38 INFO - Running setup.py install for moznetwork 04:57:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:57:39 INFO - Running setup.py install for mozprocess 04:57:39 INFO - Running setup.py install for mozprofile 04:57:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:57:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:57:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:57:39 INFO - Running setup.py install for mozrunner 04:57:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:57:39 INFO - Running setup.py install for mozscreenshot 04:57:39 INFO - Running setup.py install for moztest 04:57:39 INFO - Running setup.py install for mozversion 04:57:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:57:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:57:39 INFO - Cleaning up... 04:57:39 INFO - Return code: 0 04:57:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2395679c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1dad30>, '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 0x10b000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1d2b20>, '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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 04:57:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:57:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:57:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XcOvxFYIQ7/Render', 04:57:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:40 INFO - 'HOME': '/Users/cltbld', 04:57:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:40 INFO - 'LOGNAME': 'cltbld', 04:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:40 INFO - 'MOZ_NO_REMOTE': '1', 04:57:40 INFO - 'NO_EM_RESTART': '1', 04:57:40 INFO - 'PAGER': '/bin/cat', 04:57:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:40 INFO - 'PWD': '/builds/slave/test', 04:57:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:40 INFO - 'SHELL': '/bin/bash', 04:57:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1s2VrUEdj1/Listeners', 04:57:40 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 04:57:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:40 INFO - 'USER': 'cltbld', 04:57:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:40 INFO - 'XPC_FLAGS': '0x0', 04:57:40 INFO - 'XPC_SERVICE_NAME': '0', 04:57:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:57:40 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-ZblmVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:57:40 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)) 04:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:57:40 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-YudcLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:57:40 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-nEGx2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:57:40 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)) 04:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:57:40 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-uc_RiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:57:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 04:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:57:40 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-Ivwbxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:57:40 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)) 04:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:57:40 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-ll5XnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:57:40 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)) 04:57:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:57:40 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-lVoqDs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:57:41 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-o_ABPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:57:41 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-lgjbL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:57:41 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)) 04:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:57:41 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-mOLEfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:57:41 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)) 04:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:57:41 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-YtMq_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:57:41 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)) 04:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:57:41 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-1jAn3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 04:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:57:41 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-s1eIrj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:57:41 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)) 04:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:57:41 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-vxi55n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 04:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:41 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-zJdtiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:57:41 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)) 04:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:57:41 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-I3b7xj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:57:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 04:57:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:57:41 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-4xsyuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:57:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:57:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:57:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:57:44 INFO - Downloading blessings-1.6.tar.gz 04:57:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:57:44 INFO - Installing collected packages: blessings 04:57:44 INFO - Running setup.py install for blessings 04:57:44 INFO - Successfully installed blessings 04:57:44 INFO - Cleaning up... 04:57:44 INFO - Return code: 0 04:57:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:57:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:45 INFO - Reading from file tmpfile_stdout 04:57:45 INFO - Current package versions: 04:57:45 INFO - blessings == 1.6 04:57:45 INFO - blobuploader == 1.2.4 04:57:45 INFO - docopt == 0.6.1 04:57:45 INFO - functools32 == 3.2.3-2 04:57:45 INFO - jsonschema == 2.5.1 04:57:45 INFO - manifestparser == 1.1 04:57:45 INFO - mozInstall == 1.12 04:57:45 INFO - mozcrash == 0.17 04:57:45 INFO - mozdebug == 0.1 04:57:45 INFO - mozdevice == 0.48 04:57:45 INFO - mozfile == 1.2 04:57:45 INFO - mozhttpd == 0.7 04:57:45 INFO - mozinfo == 0.9 04:57:45 INFO - mozleak == 0.1 04:57:45 INFO - mozlog == 3.4 04:57:45 INFO - moznetwork == 0.27 04:57:45 INFO - mozprocess == 0.23 04:57:45 INFO - mozprofile == 0.28 04:57:45 INFO - mozrunner == 6.12 04:57:45 INFO - mozscreenshot == 0.1 04:57:45 INFO - mozsystemmonitor == 0.3 04:57:45 INFO - moztest == 0.7 04:57:45 INFO - mozversion == 1.4 04:57:45 INFO - psutil == 3.1.1 04:57:45 INFO - requests == 1.2.3 04:57:45 INFO - wsgiref == 0.1.2 04:57:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:45 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 0x10b3c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2395679c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1dad30>, '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 0x10b000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1d2b20>, '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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 04:57:45 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 04:57:45 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 04:57:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XcOvxFYIQ7/Render', 04:57:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:45 INFO - 'HOME': '/Users/cltbld', 04:57:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:45 INFO - 'LOGNAME': 'cltbld', 04:57:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:45 INFO - 'MOZ_NO_REMOTE': '1', 04:57:45 INFO - 'NO_EM_RESTART': '1', 04:57:45 INFO - 'PAGER': '/bin/cat', 04:57:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:45 INFO - 'PWD': '/builds/slave/test', 04:57:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:45 INFO - 'SHELL': '/bin/bash', 04:57:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1s2VrUEdj1/Listeners', 04:57:45 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 04:57:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:45 INFO - 'USER': 'cltbld', 04:57:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:45 INFO - 'XPC_FLAGS': '0x0', 04:57:45 INFO - 'XPC_SERVICE_NAME': '0', 04:57:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:46 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)) 04:57:46 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)) 04:57:46 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)) 04:57:46 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)) 04:57:46 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)) 04:57:46 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)) 04:57:46 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)) 04:57:46 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)) 04:57:46 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)) 04:57:46 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)) 04:57:46 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)) 04:57:46 INFO - Cleaning up... 04:57:46 INFO - Return code: 0 04:57:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:57:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b3c6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b33c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd2395679c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1dad30>, '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 0x10b000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1d2b20>, '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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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 04:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:57:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XcOvxFYIQ7/Render', 04:57:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:57:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:57:46 INFO - 'HOME': '/Users/cltbld', 04:57:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:57:46 INFO - 'LOGNAME': 'cltbld', 04:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:57:46 INFO - 'MOZ_NO_REMOTE': '1', 04:57:46 INFO - 'NO_EM_RESTART': '1', 04:57:46 INFO - 'PAGER': '/bin/cat', 04:57:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:57:46 INFO - 'PWD': '/builds/slave/test', 04:57:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:57:46 INFO - 'SHELL': '/bin/bash', 04:57:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1s2VrUEdj1/Listeners', 04:57:46 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 04:57:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:57:46 INFO - 'USER': 'cltbld', 04:57:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:57:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:57:46 INFO - 'XPC_FLAGS': '0x0', 04:57:46 INFO - 'XPC_SERVICE_NAME': '0', 04:57:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:57:46 INFO - Cleaning up... 04:57:46 INFO - Return code: 0 04:57:46 INFO - Running post-action listener: _resource_record_post_action 04:57:46 INFO - Running post-action listener: _start_resource_monitoring 04:57:46 INFO - Starting resource monitoring. 04:57:46 INFO - [mozharness: 2016-10-13 11:57:46.891545Z] Finished create-virtualenv step (success) 04:57:46 INFO - [mozharness: 2016-10-13 11:57:46.892381Z] Running install step. 04:57:46 INFO - Running pre-action listener: _resource_record_pre_action 04:57:46 INFO - Running main action method: install 04:57:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:57:47 INFO - Reading from file tmpfile_stdout 04:57:47 INFO - Detecting whether we're running mozinstall >=1.0... 04:57:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:57:47 INFO - Reading from file tmpfile_stdout 04:57:47 INFO - Output received: 04:57:47 INFO - Usage: mozinstall [options] installer 04:57:47 INFO - Options: 04:57:47 INFO - -h, --help show this help message and exit 04:57:47 INFO - -d DEST, --destination=DEST 04:57:47 INFO - Directory to install application into. [default: 04:57:47 INFO - "/builds/slave/test"] 04:57:47 INFO - --app=APP Application being installed. [default: firefox] 04:57:47 INFO - mkdir: /builds/slave/test/build/application 04:57:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:57:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:58:21 INFO - Reading from file tmpfile_stdout 04:58:21 INFO - Output received: 04:58:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:58:21 INFO - Running post-action listener: _resource_record_post_action 04:58:21 INFO - [mozharness: 2016-10-13 11:58:21.336050Z] Finished install step (success) 04:58:21 INFO - [mozharness: 2016-10-13 11:58:21.336190Z] Running run-tests step. 04:58:21 INFO - Running pre-action listener: _resource_record_pre_action 04:58:21 INFO - Running main action method: run_tests 04:58:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:58:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:58:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:58:21 INFO - 2016-10-13 04:58:21.350 screenresolution[1635:7447] starting screenresolution argv=screenresolution get 04:58:21 INFO - 2016-10-13 04:58:21.353 screenresolution[1635:7447] Display 0: 1600x1200x32@60 04:58:21 INFO - 2016-10-13 04:58:21.358 screenresolution[1636:7449] starting screenresolution argv=screenresolution list 04:58:21 INFO - Available Modes on Display 0 04:58:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:58:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:58:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:58:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:58:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:58:21 INFO - Intel Iris: 04:58:21 INFO - Chipset Model: Intel Iris 04:58:21 INFO - Type: GPU 04:58:21 INFO - Bus: Built-In 04:58:21 INFO - VRAM (Dynamic, Max): 1536 MB 04:58:21 INFO - Vendor: Intel (0x8086) 04:58:21 INFO - Device ID: 0x0a2e 04:58:21 INFO - Revision ID: 0x0009 04:58:21 INFO - Displays: 04:58:21 INFO - Display: 04:58:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:58:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:58:21 INFO - Display Serial Number: 1600x1200 60 04:58:21 INFO - Main Display: Yes 04:58:21 INFO - Mirror: Off 04:58:21 INFO - Online: Yes 04:58:21 INFO - Rotation: Supported 04:58:21 INFO - Return code: 0 04:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:58:21 INFO - Python 2.7.3 04:58:21 INFO - Return code: 0 04:58:21 INFO - grabbing minidump binary from tooltool 04:58:21 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')]} 04:58:21 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 0x10b1dad30>, '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 0x10b000db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1d2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:58:21 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 04:58:21 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 04:58:21 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 04:58:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:58:21 INFO - Return code: 0 04:58:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:58:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:58:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:58:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:58:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0356', '--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 04:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0356 --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 04:58:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XcOvxFYIQ7/Render', 04:58:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:21 INFO - 'HOME': '/Users/cltbld', 04:58:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:21 INFO - 'LOGNAME': 'cltbld', 04:58:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:58:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:21 INFO - 'MOZ_NO_REMOTE': '1', 04:58:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:58:21 INFO - 'NO_EM_RESTART': '1', 04:58:21 INFO - 'PAGER': '/bin/cat', 04:58:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:21 INFO - 'PWD': '/builds/slave/test', 04:58:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:58:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:21 INFO - 'SHELL': '/bin/bash', 04:58:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.1s2VrUEdj1/Listeners', 04:58:21 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 04:58:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:21 INFO - 'USER': 'cltbld', 04:58:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:21 INFO - 'XPC_FLAGS': '0x0', 04:58:21 INFO - 'XPC_SERVICE_NAME': '0', 04:58:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0356', '--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 04:58:21 INFO - mozversion application_buildid: 20161013023624 04:58:21 INFO - mozversion application_changeset: 00fdaac3efafd2621ed9849c52527051f9edda53 04:58:21 INFO - mozversion application_display_name: Nightly 04:58:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:58:21 INFO - mozversion application_name: Firefox 04:58:21 INFO - mozversion application_remotingname: firefox 04:58:21 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:58:21 INFO - mozversion application_vendor: Mozilla 04:58:21 INFO - mozversion application_version: 52.0a1 04:58:21 INFO - mozversion platform_buildid: 20161013023624 04:58:21 INFO - mozversion platform_changeset: 00fdaac3efafd2621ed9849c52527051f9edda53 04:58:21 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:58:21 INFO - mozversion platform_version: 52.0a1 04:58:21 INFO - using testdate: 1476359901 04:58:21 INFO - actual date: 1476359901 04:58:21 INFO - starting webserver on 'localhost:49266' 04:58:21 INFO - SUITE-START | Running 2 tests 04:58:21 INFO - TEST-START | dromaeo_css 04:58:21 INFO - operating with platform_type : mac_ 04:58:21 INFO - Initialising browser for dromaeo_css test... 04:58:21 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpM3FMdw/profile http://localhost:49266/getInfo.html) 04:58:24 INFO - PROCESS | 1646 | 2016-10-13 04:58:24.816 plugin-container[1650:7661] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f4b, name = 'com.apple.tsm.portname' 04:58:24 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:24 INFO - PROCESS | 1646 | 2016-10-13 04:58:24.820 plugin-container[1650:7661] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4a17, name = 'com.apple.CFPasteboardClient' 04:58:24 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:24 INFO - PROCESS | 1646 | 2016-10-13 04:58:24.820 plugin-container[1650:7661] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:58:24 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 04:58:24 INFO - PROCESS | 1646 | colorDepth:24 04:58:24 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 04:58:24 INFO - PROCESS | 1646 | __metrics 04:58:24 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 04:58:25 INFO - TEST-INFO | 1646: exit 0 04:58:25 INFO - Browser initialized. 04:58:25 INFO - Running cycle 1/1 for dromaeo_css test... 04:58:25 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpM3FMdw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:58:28 INFO - PROCESS | 1652 | 2016-10-13 04:58:28.162 plugin-container[1653:7792] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8943, name = 'com.apple.tsm.portname' 04:58:28 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:28 INFO - PROCESS | 1652 | 2016-10-13 04:58:28.162 plugin-container[1653:7792] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4317, name = 'com.apple.CFPasteboardClient' 04:58:28 INFO - PROCESS | 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 04:58:28 INFO - PROCESS | 1652 | 2016-10-13 04:58:28.163 plugin-container[1653:7792] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 04:58:37 INFO - PROCESS | 1652 | RSS: Main: 238891008 04:58:37 INFO - PROCESS | 1652 | 04:59:27 INFO - PROCESS | 1652 | 1476359967304 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:01:40 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 05:01:42 INFO - PROCESS | 1652 | RSS: Main: 252170240 05:01:42 INFO - PROCESS | 1652 | 05:04:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 05:04:45 INFO - PROCESS | 1652 | RSS: Main: 265969664 05:04:45 INFO - PROCESS | 1652 | 05:07:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 05:07:48 INFO - PROCESS | 1652 | RSS: Main: 269467648 05:07:48 INFO - PROCESS | 1652 | 05:10:50 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 05:10:50 INFO - PROCESS | 1652 | RSS: Main: 269090816 05:10:50 INFO - PROCESS | 1652 | 05:13:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 05:13:54 INFO - PROCESS | 1652 | RSS: Main: 274292736 05:13:54 INFO - PROCESS | 1652 | 05:16:56 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 05:16:57 INFO - PROCESS | 1652 | RSS: Main: 277000192 05:16:57 INFO - PROCESS | 1652 | 05:16:57 INFO - PROCESS | 1652 | __start_tp_report 05:16:57 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 05:16:57 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 05:16:57 INFO - PROCESS | 1652 | |i|pagename|runs| 05:16:57 INFO - PROCESS | 1652 | |0;dojo.html;2925.985370073149;3214.0518547028623;3237.951430728539;3326.0188244467863;3359.8824041158555;5401.351837779472;5433.592480563953;5485.80799672011;5522.088855338874;5541;5459.945400545993;5482.17767334899;5511.200875872996;5556.777728890839;5562.3047119110115;5021.974890125544;5026.170681837492;5134.204198349262;5134.25553294772;5143.27994080829;4261.296886013804;4884.926726099111;4968.279599458095;5163.302954101186;5189.377274727038;4988.775505102279;5008.824691135829;5023.422306434771;5048.29323894655;5196.480351964811;5065.898682026339;5092.79628814847;5136.357955255593;5166.896662066775;5183;4226.429432026668;4478.776061196927;5022.17134172861;5041.798328066873;5059.873503162414;4681.74250416227;5225.817096401608;5377.704226267554;5547.55619550435;5583.162525621149;5973.342932277446;6006.669633170174;6066.575339726221;6101.398774955092;6109.829807539378;6102.0541816018585;6165.568410211287;6175.722092505803;6190.752369905198;6199.659018753967;5505.587080968943;5649.4633009864;5668.461496157858;5682.943170568324;5702.600817942745;6119.106526814625;6163.137160797492;6178.443940045418;6183.227096612924;6258.405451482102;5865.941340586625;5947.762089516457;5964.910526342108;5965.254343207099;5972.85067873298;5909.497692696169;6059.424354686298;6100.69496525172;6170.784022559189;6190.7523699051535;5846.678432686158;5913.674747888907;5939.613925094855;5963.5527335450015;6068.180795592627;5986.311574168939;6040.848978775478;6062.151298818169;6071.635701857903;6072.119542666377;4797.328374027639;4799.136155492045;4800.3279540864305;4807.038592281488;4817.964137710409;3456.6197718250974;3882.8835134946;4112.280350938574;4239.427677263591;4260.318349064135;5036.6726162799305;5665.858353541194;5676.432356764373;5698.373178950312;5751.166080918243;6095.35998720128;6138.324784273726;6164.291106522717;6167.96916015426;6191.442770150708;4577.771111444415;5536.640118392292;5579.107342825209;5703.08750599902;5720.141978703145;5211;5260.421353651095;5275.525202731773;5337.066013447708;5388.218708287355;6277.372262773686;6299.527535434769;6312.747490100344;6318.210223722035;6346.587471814225;4602.516735742699;5946.43508866657;6140.5701600887505;6149.954507733606;6152.169457123231;6193.225846769154;6207.379262073937;6246.344133865879;6335.746570137143;6342.016987366966;5956.344802071682;6034.164680541241;6034.366391528826;6043;6111.865232675556;5914.408559144051;6147.692615369124;6150.323464419;6157.230346206724;6171.197744293213;5795.304563452412;5849.53203743708;5851.414858514115;5852.590318677651;5857.58996870215;5842.5325973921135;5844.12338149281;5851.327097383855;5857.970710146422;5866.67733274674;5552.389237183826;5556.222128901876;5560.527355174693;5773.422657734193;5846.824595262149;5860.38465961085;5913.645181289136;5930.911036334544;5934.910976335272;5937.376575459687;5573.52625026861;5788.247527821356;5793;5799.768009279582;5813.709314534341 05:16:57 INFO - PROCESS | 1652 | |1;ext.html;444.2248276757059;460.730472673486;480.4594830815333;486.20748180465847;531.7235037780355;29213;38034.239315213716;39947.60052399475;40056;40076.398854017214;41200;41547.58452415475;41851.372229416585;41872.37191442131;42031.369529457086;9481.573329200202;9583.95208023959;9599.568019439108;9600.711978640651;9745.02549745027;9473.621055157786;9593.184579310768;9596.520173991272;9601.327907046509;9619.374740641835;9069.274458043341;9488.288378371615;9533.523323833815;9568.808623827554;9629.807403851919;9508.47703376314;9517.952410237975;9553.235741140692;9571.952140239324;9582.377145485521;9447.52762361886;9456.952715236379;9535.856962145504;9540.761480962961;9564.521773911347;39548.802255988536;39645.801770991246;39856;39856.800715996236;39988.40017399741;3179.8410079496166;3291.489819078047;3307.2889328794427;3317.286783341569;3433.5021421893684;30356;31223.219419514695;31553.84223078893;32385.51421728676;32543.186420339443;3143.685631436861;3215.4051500472488;3243.8702451901895;3270.7318039542056;3355.144438168276;470276;471473;473008;474420.25579744106;475245;61712.69143654253;62228;62234;62445.68777156176;62510.374896251364;63231;64456.35543644503;64596;64635;64671.67664161743;16055.839441605434;16165.676686466204;16372.181390930406;16373.508794736177;16381.508554743377;10482;12435;12537.310447925269;12539.435725392379;12545.059120565995;17656.23959116485;18698.065096745107;18864.24543018264;18974.62050758977;18996.810031899506;7262;7500.624968751541;7690.692372305157;7739.460156168029;7837.960810196027;838.6854929401475;944.5135755086136;953.2945620240972;1003.4330603209163;1009.9545520451597;27364.042258521255;28338.574921376196;29392.853035734686;29788.10635680933;30433;813.345257068054;968.5883499512679;1000.3997601439224;1012.1497941728983;1014.3102690170607;15044;15486.457973970857;15496.380144794082;15631.770755329422;15855;616342;621867.8906605438;628611;630765.0002749899;632015;57446.712766436736;57844.421555783905;57925;58126.4187358121;58130;1056.3397876327294;1166.6674997625637;1260.521002019227;1311.9448340345941;1359.5377571625497;23637.881810591523;28603;29671.554926675686;30064.3987120252;30423.54364684487;41314.96712582209;50733.23900141575;50850.491495086055;51488.22767658563;51498.97002059863;626321.289116206;627831.8608406929;628582;629416;630892;26446.338841529116;26570.335741606614;26629.60055599129;26736.465270694865;26862.32844178833;37517.24965500729;46849.06301873875;47266.291005635634;47372.05255894932;47555.04889902252;38114.42828357632;39422;40095;40308.798456007535;40547.391789122594;38678.419823702105;39133.60866391299;39298.80350598229;40204.39693404543;40364.78905632836;37989.62010379861;38363.23273534569;38483.615163848;38756.6124338753;38851.6114838848;31647.36705265928;33460.49809252912;33909.66090339164;34027.829860850536;34146.65853341534;21368.78631213668;25595.36011599725;25824.22527324183;25833.741662583132;26055.739442605332 05:16:57 INFO - PROCESS | 1652 | |2;jquery.html;369.9241655460631;371.88657459474865;375.5324620847045;379.2926192650707;395.2726982352471;19402.932838693865;20123.89318587477;20456.590868182626;20651.17395304186;20837.062332195048;19283.903580482114;20427;20532.89733551334;20584.485387865312;20838;4894.412670479547;5339.466053394668;5568.86077848053;5737.168110623978;5887.087501437284;5764.82705518833;5879.383169628365;5885.823425297226;5892.086726557369;5897.970510147443;5521.337439507265;5607.943920560803;5643.040683083865;5651.463111004448;5804.535637149018;5663.5186009189265;5663.830085097454;5671.262735844334;5737.454941780524;5750.3962083981205;5038.420581633122;5293.947060529384;5299.814506492293;5360.839174824761;5409.404965453797;12587.874121258854;12673.93663031688;12706.745865082647;12750.10749247553;12772.169808962388;2169.262450766731;2254.9436264093365;2315.722113346409;2380.5119950410126;2765.92129069663;9640.132388085036;9641.891182514031;9700.854487182698;10082.04220599042;10233.48832558369;1759.357834390451;1817.472932849472;1837;1845.723141528768;1847.29802674984;105992.47003765008;107288.99999999921;114475;114519;115098.42450787776;11106.888931110747;11232.66302010941;11335.546578136948;11496.712582185512;11614.593489227836;11317;11486.138539609563;11653.6503904883;11788.821117888314;14169.645758856112;6889.793306200822;7211.531250468703;7977.7207797726805;8015.797630355493;8426.662933482714;7205.7838264852135;7218.772808622547;8173.67305307781;8208.138145494757;8369.246767790928;3649.270145970763;3788.924221515554;4362.9147311313245;4460.0633866887665;4557.475890272594;1588.6187315044538;1822.489702883195;1918.1847714721187;1922.6827573450503;1936.138418403825;819.5615345789973;880.4981160738317;898.6315610599753;942.707760594218;978.6232300564334;19906;20753.273635422687;20986.2654807081;21015.369538913856;21150.682739758915;882.5587206396801;902.9413088149249;903.1871315815687;918;930.55798495714;10779.02988731018;11181.83227251592;11213.215074944676;11230.15773816967;11232.831507527393;589687.9796419333;590668;595619;607812;608447;84769;115129;115333.4233328828;119125;121104.97237568955;865.0095640491728;904.1230006893303;948.8719022931816;957.3968399908014;972.5866506734609;15242.695146096794;16603.66792664164;18039.819601803814;18121.81878181254;18249.543761406072;40662;49754.50245497499;50652;50795.492045079074;51650.22524662058;71911;72866.63566682133;73026;73268.90096648448;73904.26095739189;7965.442419030844;7975.880361794694;8064.435489515678;8135;8242.381821363302;8571.442856214326;12353.752924941631;12522.998160146984;12839.165454245818;13174.880135188616;9333.906660933575;10570.735731606772;10745.892541074489;10985.61550345734;11434.771304574027;10832.5125369357;10846.403447810446;11091.500882460146;11122.944385278022;11365.829512557484;11260.099192064452;11686.799374278364;11767;11845;11845.289282643069;8057.959710201411;8258.752237432887;8279.834403312021;8320.70877519284;8372.037215720271;10575.206859485723;10590.364578125336;11276.774464510829;11460.255083419552;11467.942660286979 05:16:57 INFO - PROCESS | 1652 | |3;mootools.html;1492.8357880633127;1534.593332766817;1535.9539213823584;1713.1862365376448;1812.4381441753048;7818.100918394386;8168.101508834024;8261.793455163624;8810.823783524334;8821.206091451777;8224.83550328993;8578.270846978;8592.398532102756;8639.827203455927;8674.262687671555;2277.8974946127382;2315.5716192504356;2319.5013072189477;2323.721153461587;2325.162941341124;2292.060255295329;2304.997326163116;2319.7912187903084;2335.9532809343805;2340.9765902341014;2303.55080759252;2306.4349234437586;2308.4459729664927;2318.5594736999915;2339.3917581428864;2276.4081338851934;2301.309607117858;2302.5510025545027;2308.68832707584;2310.2491690200586;2304.953900921972;2307.8038366738847;2308.180595888452;2308.665243539694;2321.489272360095;8672;8672.783180420476;8762.079981601968;8786.121387861227;8843.955780221122;5118.974405127988;5185.870353241162;5226.05930932432;5287.180487024518;5306.787728490855;3342.097633638928;3412.1128506588466;3516.2088530080528;3543.2382037861985;3544.468329750558;1000.5747557288123;1007.6070332570304;1055.941923194224;1058.074185088048;1078.4122653153972;11110.944445277722;11280.2667826591;11350.262232954832;11456.541738330458;11497.540098396054;4448.799804008828;4534.909301813946;4661;4687.179743544866;4720.504347043511;9737.026297370207;9747.463889486004;9749.317547771589;9765.804683906283;9791.853122203172;5201.271821944931;5204.297419848272;5223.242629818655;5234.398044224887;5239.738013099406;4297.806598703066;4457.576530229623;4607.101615185007;4767.6662633615315;4767.713937163781;3769.849206031783;3814.713896457721;3858.7684738915195;3908.6286802753693;3918.3534716771414;1090.798202332571;1266.5567051531891;1268.0933132810085;1275.5089290623177;1279.33474593211;796.6176235407037;864.5115509737104;888.7866911941088;895.83427065993;921.1663444582664;5541.418151094158;5660.462256085665;5750.654960702288;5834.591578589458;5885.264341957255;414.43843591933097;416.991660166795;432.1508236315592;433.07538405504476;434.9347597860283;3794.867179648699;3872.593377695358;3911.3546264866545;3957.7229593928723;4154.273002224599;8895.288376929959;10341.069303762548;10428.791424171473;10669.466526673636;10669.573217071385;8844.850169477926;10479.68560943173;10529.684109476728;10607.257491975488;10614.522346494427;6487.902681459782;7827.45207835446;7941.252924356632;7979.8404031919035;8127.512349259064;5874.412558744091;5889.349504078311;5979.133025711334;6002.0996850472775;6081.939180608138;9787.559559819967;9788.559514821993;9895.901040989786;9977.850332245167;10034.69895903124;8388.958055209685;9439.811203776024;10071.244656650928;10135.341202821794;10165.593376264867;6685.298043705536;6769.796906092825;7016.158061032709;7083;7256.346928776436;8077.515349079074;8306.377021723274;8345.248927596303;8380.371472139492;8411.831763364577;7340.412766978522;7466.4026877848555;7483.251674832473;7544.8491030180185;7682.423818213544;7139.714411423485;7223.061002069698;7231.096112985877;7324.4140468763435;7345.6694448751;6779.661016949231;6783.186017677713;6818.318168183142;6852.862942741217;6878.55289406187;4747.691400058985;4798.016406636701;4806.903861922812;4886.853394398174;4961.255811628141;4737.502562231054;4790.305405716082;4830.372051633265;4912.557869791736;4945.67853089548 05:16:57 INFO - PROCESS | 1652 | |4;prototype.html;286.5730062207311;299.99850000750007;309.5789725972677;313.8430784607696;314.6900303201345;5131.820386286481;5306.442823503535;5374.89250214996;5390.973045134774;5454.808936771989;5103.311053007843;5256.395514515832;5288.831579052589;5317.973410132953;5340.359156901168;4104.363823607338;4104.87116043089;4149.439825623547;4154.940490175001;4167.811898753149;3102.440486598554;3403.4384326586082;3832.9808350958347;4069.9389509157386;4166.6874984376145;3783.6405541473514;3868.013656517584;4055.229506393776;4067.3085575452096;4130;3683.097641077953;4036.9394459083137;4092.7339722918214;4104.384342348671;4110.527289361732;3000.4449176902344;3183.729383002448;3412.3516531859113;3605.4231322988194;3617.276544691072;5025.899482010376;5139.383274007106;5217.634765566412;5229.320188375525;5270.8155214567305;3895.922081558353;4660.906781864343;4684.767510417801;4700.55344742249;4707.882302942419;4859.902801943977;5431.4840090191365;5651.350094739076;5662.915056274159;5671.461211184931;3176.2689334312854;3449.4991131429765;3479.704225140866;3572.642395889571;3973.284808734427;5356.464353564613;5436.21174929637;5442.2380866678695;5495.488740596328;5918.768080822189;2936.045785119845;3239.5788547488673;3399.5750531183603;3698.9815050925113;3912.295786758411;3525.435930251199;3680.9509289852263;3765.039914821703;3952.3873799561115;3993.1813978134414;3871.264459752638;4031.6169963853386;4533.591976722045;4543.477500087466;4566.0411313623845;5653.406392328829;5672.546196304285;5676.347220069662;5710.942890571124;5731.598788084877;1056.587930707025;1091.2430986112354;1174.9177557571059;1295.4429595274123;1324.3047400114824;777.7783331750423;835.4068611285934;848.5036253791478;902.309733054214;908.1871724806261;4372.519022907478;4647.419072615923;5243.632945693841;5284.493919233;5320.255164277004;5074;5301.469853014745;5679.2333035040565;5693.202951586781;5772.884542309131;4684.765761711901;4871.244957031666;4980.762504372115;4990.775415106329;5283.550898173698;2532.531481675896;2879.61125248093;3037.179961410407;3068.9539656904717;3139.9215019624235;6048.727807248684;6063.939360606426;6078.878422431527;6099.542534309944;6124.6926659604205;5603.80386686464;5630.60585758993;5726.940516004553;5812.738426770806;6004.729787159588;5038.254151487448;5651.467832604622;5857.736401861926;6005.939940600538;6052.757889684363;5354.518093371459;5461.863453413537;5759.539236860957;5764.48119669215;5823.534117270524;5103.682606305782;5764.596478246483;5820.594951953155;5824.534037276923;5839.328477225004;5094.643374963717;5225.294585230945;5365.651232669864;6070.878582428415;6170.81487555374;2984.0749367696085;3545.1137215696076;3669.3854703930187;3893.7274390792372;3902.3951287550476;4587.449506059294;4631.814727410866;5005.249212618136;5795.971020144872;5816.767329306949;4470.217711900469;4737.786799594095;4944.332515110558;5238.580913526833;5715.828525144252;5094.643374963865;5654.660720356792;5670.370962583867;5675.262215911905;5711.914321285267;4841.709497430165;5385.730713464232;5540;5555.999920014437;5604.383517812956;5615.410381910004;5642.294713160855;5648.587853036741;5682.261306030355;5697.601167918206;4824.565789079;4957.4794646561595;5099.821506247412;5102.872428189325;5624.268845050117 05:16:57 INFO - PROCESS | 1652 | |5;yui.html;671.9966400167999;703.0403499223559;758.3402439877308;775.4416819889681;794.2811755361396;13803.654908627277;14693.632659183499;14730.63173420665;14733.778993315109;14759.483418080355;12415.813762793543;13324.666883327922;13441.663958401045;13597.252151131685;13603.047786654937;648.8669822686362;672.4889084295946;798.0264077825044;807.0436532708759;822.0998007182155;827.4993628854546;835.2816577743137;840.9747707568782;842.7345386203357;843.7426584891606;882.5102068352062;883.9922488363271;886.1227384888978;886.9379143459961;887.3611000079965;877.7805548612815;878.44218920985;879.8988116366604;879.9120087991214;884.8186121845006;635.1933045032782;651.2998526583941;652.7715299645087;653.1737352249409;653.5229282623711;13353.732925341536;13448.596542103753;13679.974001949893;13705.725885482334;13712.45150193991;11767.176297659167;14266.785998210034;14282.928585357111;14298.428062877472;14357.425702971974;10911.07255883251;11252.54989800407;11427;11638.243514171552;11732.530698772125;4455.643548516144;4486.528914463999;4501.234790085693;4542;4681.438227412698;89723;107816.92183078147;108613;109923;113496.4325178377;10151.64469243573;10428.270021098602;10552.577896884039;10699.625513107005;10868.239223254297;20392.59214815725;20439.591208175752;20736.89631551863;20781.272655456985;20838.1664733412;7329.157146928065;7380.77857664271;7400.444966627524;7468.066491688539;7509;4072.3280658690983;4078.898027549276;4084.2852500812237;4092.6903390915218;4115.444415003936;2832.9433411331656;2951.6162898823445;2980.2996295870453;3365.8892565453343;3403.9319213616086;652.1294072413381;658.716751796732;663.5090033375268;664.8232628247974;677.928817474168;504.77789772500716;510.4104759003357;523.6936392210599;537.4464301769184;580.2543731305252;8256.545889976109;8435.451695639764;8516.914830851736;8647.740567782977;8828.117188281121;550.2626480516128;563.5632384901734;590.4862769390572;595.4373117404011;631.0943795653252;4107.753534787922;4450.132224216247;4475.4181956345465;4498.302763071729;4524.502304746476;102491;116582.33899723066;124010;155297;158185;104733;105975;128325;134364.32817835847;141037.29481352732;82691.17308826956;89861.4631609996;114562;114902.4254878737;117470.9999999983;6693.230278518033;7587.886181707168;8107.797305067421;8541.932258467692;9047.683331083645;34872.82563587166;44587.554124458344;52962.47037529575;59877.50306242379;61836.690816545626;66855;67943.18831927887;88513;93517;94115;12660.556880509139;13161.210327380004;13259.66850828737;13271.071025028155;13554.322283885964;14493.637659058186;14596.416143354572;14685.339159737623;14691.632709182357;14743.778843317144;13471.865281347062;13710.65723356924;13718.725625487235;13757.31213439344;14267.571972840831;13569.932150339186;13690.65773355674;13693.520726774914;13999.790003150165;14032.811751556534;13160.407781649657;13467.3939672713;13492;13723.794143088062;13926.860731392962;10888.128949683847;11097.112231021338;11319.490622922152;11350.602728904449;11722.238054526428;8788.472691638523;9731.34567123605;11149.386783726974;11591.536338546364;11616.651500455 05:16:57 INFO - PROCESS | 1652 | __end_tp_report 05:16:57 INFO - PROCESS | 1652 | __start_cc_report 05:16:57 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,363 05:16:57 INFO - PROCESS | 1652 | __end_cc_report 05:16:57 INFO - PROCESS | 1652 | __startTimestamp1476361017094__endTimestamp 05:16:57 INFO - PROCESS | 1652 | 05:16:57 INFO - PROCESS | 1652 | ------- Summary: start ------- 05:16:57 INFO - PROCESS | 1652 | Number of tests: 6 05:16:57 INFO - PROCESS | 1652 | 05:16:57 INFO - PROCESS | 1652 | [#0] dojo.html Cycles:165 Average:5553.10 Median:5793.00 stddev:693.17 (12.0%) stddev-sans-first:663.96 05:16:57 INFO - PROCESS | 1652 | Values: 2926.0 3214.1 3238.0 3326.0 3359.9 5401.4 5433.6 5485.8 5522.1 5541.0 5459.9 5482.2 5511.2 5556.8 5562.3 5022.0 5026.2 5134.2 5134.3 5143.3 4261.3 4884.9 4968.3 5163.3 5189.4 4988.8 5008.8 5023.4 5048.3 5196.5 5065.9 5092.8 5136.4 5166.9 5183.0 4226.4 4478.8 5022.2 5041.8 5059.9 4681.7 5225.8 5377.7 5547.6 5583.2 5973.3 6006.7 6066.6 6101.4 6109.8 6102.1 6165.6 6175.7 6190.8 6199.7 5505.6 5649.5 5668.5 5682.9 5702.6 6119.1 6163.1 6178.4 6183.2 6258.4 5865.9 5947.8 5964.9 5965.3 5972.9 5909.5 6059.4 6100.7 6170.8 6190.8 5846.7 5913.7 5939.6 5963.6 6068.2 5986.3 6040.8 6062.2 6071.6 6072.1 4797.3 4799.1 4800.3 4807.0 4818.0 3456.6 3882.9 4112.3 4239.4 4260.3 5036.7 5665.9 5676.4 5698.4 5751.2 6095.4 6138.3 6164.3 6168.0 6191.4 4577.8 5536.6 5579.1 5703.1 5720.1 5211.0 5260.4 5275.5 5337.1 5388.2 6277.4 6299.5 6312.7 6318.2 6346.6 4602.5 5946.4 6140.6 6150.0 6152.2 6193.2 6207.4 6246.3 6335.7 6342.0 5956.3 6034.2 6034.4 6043.0 6111.9 5914.4 6147.7 6150.3 6157.2 6171.2 5795.3 5849.5 5851.4 5852.6 5857.6 5842.5 5844.1 5851.3 5858.0 5866.7 5552.4 5556.2 5560.5 5773.4 5846.8 5860.4 5913.6 5930.9 5934.9 5937.4 5573.5 5788.2 5793.0 5799.8 5813.7 05:16:57 INFO - PROCESS | 1652 | 05:16:57 INFO - PROCESS | 1652 | [#1] ext.html Cycles:180 Average:70699.43 Median:40085.70 stddev:155218.88 (387.2%) stddev-sans-first:155564.68 05:16:57 INFO - PROCESS | 1652 | Values: 444.2 460.7 480.5 486.2 531.7 29213.0 38034.2 39947.6 40056.0 40076.4 41200.0 41547.6 41851.4 41872.4 42031.4 9481.6 9584.0 9599.6 9600.7 9745.0 9473.6 9593.2 9596.5 9601.3 9619.4 9069.3 9488.3 9533.5 9568.8 9629.8 9508.5 9518.0 9553.2 9572.0 9582.4 9447.5 9457.0 9535.9 9540.8 9564.5 39548.8 39645.8 39856.0 39856.8 39988.4 3179.8 3291.5 3307.3 3317.3 3433.5 30356.0 31223.2 31553.8 32385.5 32543.2 3143.7 3215.4 3243.9 3270.7 3355.1 470276.0 471473.0 473008.0 474420.3 475245.0 61712.7 62228.0 62234.0 62445.7 62510.4 63231.0 64456.4 64596.0 64635.0 64671.7 16055.8 16165.7 16372.2 16373.5 16381.5 10482.0 12435.0 12537.3 12539.4 12545.1 17656.2 18698.1 18864.2 18974.6 18996.8 7262.0 7500.6 7690.7 7739.5 7838.0 838.7 944.5 953.3 1003.4 1010.0 27364.0 28338.6 29392.9 29788.1 30433.0 813.3 968.6 1000.4 1012.1 1014.3 15044.0 15486.5 15496.4 15631.8 15855.0 616342.0 621867.9 628611.0 630765.0 632015.0 57446.7 57844.4 57925.0 58126.4 58130.0 1056.3 1166.7 1260.5 1311.9 1359.5 23637.9 28603.0 29671.6 30064.4 30423.5 41315.0 50733.2 50850.5 51488.2 51499.0 626321.3 627831.9 628582.0 629416.0 630892.0 26446.3 26570.3 26629.6 26736.5 26862.3 37517.2 46849.1 47266.3 47372.1 47555.0 38114.4 39422.0 40095.0 40308.8 40547.4 38678.4 39133.6 39298.8 40204.4 40364.8 37989.6 38363.2 38483.6 38756.6 38851.6 31647.4 33460.5 33909.7 34027.8 34146.7 21368.8 25595.4 25824.2 25833.7 26055.7 05:16:57 INFO - PROCESS | 1652 | 05:16:57 INFO - PROCESS | 1652 | [#2] jquery.html Cycles:180 Average:33554.41 Median:370.91 stddev:99390.60 (26796.8%) stddev-sans-first:99638.19 05:16:57 INFO - PROCESS | 1652 | Values: 369.9 371.9 375.5 379.3 395.3 19402.9 20123.9 20456.6 20651.2 20837.1 19283.9 20427.0 20532.9 20584.5 20838.0 4894.4 5339.5 5568.9 5737.2 5887.1 5764.8 5879.4 5885.8 5892.1 5898.0 5521.3 5607.9 5643.0 5651.5 5804.5 5663.5 5663.8 5671.3 5737.5 5750.4 5038.4 5293.9 5299.8 5360.8 5409.4 12587.9 12673.9 12706.7 12750.1 12772.2 2169.3 2254.9 2315.7 2380.5 2765.9 9640.1 9641.9 9700.9 10082.0 10233.5 1759.4 1817.5 1837.0 1845.7 1847.3 105992.5 107289.0 114475.0 114519.0 115098.4 11106.9 11232.7 11335.5 11496.7 11614.6 11317.0 11486.1 11653.7 11788.8 14169.6 6889.8 7211.5 7977.7 8015.8 8426.7 7205.8 7218.8 8173.7 8208.1 8369.2 3649.3 3788.9 4362.9 4460.1 4557.5 1588.6 1822.5 1918.2 1922.7 1936.1 819.6 880.5 898.6 942.7 978.6 19906.0 20753.3 20986.3 21015.4 21150.7 882.6 902.9 903.2 918.0 930.6 10779.0 11181.8 11213.2 11230.2 11232.8 589688.0 590668.0 595619.0 607812.0 608447.0 84769.0 115129.0 115333.4 119125.0 121105.0 865.0 904.1 948.9 957.4 972.6 15242.7 16603.7 18039.8 18121.8 18249.5 40662.0 49754.5 50652.0 50795.5 51650.2 71911.0 72866.6 73026.0 73268.9 73904.3 7965.4 7975.9 8064.4 8135.0 8242.4 8571.4 12353.8 12523.0 12839.2 13174.9 9333.9 10570.7 10745.9 10985.6 11434.8 10832.5 10846.4 11091.5 11122.9 11365.8 11260.1 11686.8 11767.0 11845.0 11845.3 8058.0 8258.8 8279.8 8320.7 8372.0 10575.2 10590.4 11276.8 11460.3 11467.9 05:16:57 INFO - PROCESS | 1652 | 05:16:57 INFO - PROCESS | 1652 | [#3] mootools.html Cycles:180 Average:5562.96 Median:4802.46 stddev:3126.74 (65.1%) stddev-sans-first:3120.55 05:16:57 INFO - PROCESS | 1652 | Values: 1492.8 1534.6 1536.0 1713.2 1812.4 7818.1 8168.1 8261.8 8810.8 8821.2 8224.8 8578.3 8592.4 8639.8 8674.3 2277.9 2315.6 2319.5 2323.7 2325.2 2292.1 2305.0 2319.8 2336.0 2341.0 2303.6 2306.4 2308.4 2318.6 2339.4 2276.4 2301.3 2302.6 2308.7 2310.2 2305.0 2307.8 2308.2 2308.7 2321.5 8672.0 8672.8 8762.1 8786.1 8844.0 5119.0 5185.9 5226.1 5287.2 5306.8 3342.1 3412.1 3516.2 3543.2 3544.5 1000.6 1007.6 1055.9 1058.1 1078.4 11110.9 11280.3 11350.3 11456.5 11497.5 4448.8 4534.9 4661.0 4687.2 4720.5 9737.0 9747.5 9749.3 9765.8 9791.9 5201.3 5204.3 5223.2 5234.4 5239.7 4297.8 4457.6 4607.1 4767.7 4767.7 3769.8 3814.7 3858.8 3908.6 3918.4 1090.8 1266.6 1268.1 1275.5 1279.3 796.6 864.5 888.8 895.8 921.2 5541.4 5660.5 5750.7 5834.6 5885.3 414.4 417.0 432.2 433.1 434.9 3794.9 3872.6 3911.4 3957.7 4154.3 8895.3 10341.1 10428.8 10669.5 10669.6 8844.9 10479.7 10529.7 10607.3 10614.5 6487.9 7827.5 7941.3 7979.8 8127.5 5874.4 5889.3 5979.1 6002.1 6081.9 9787.6 9788.6 9895.9 9977.9 10034.7 8389.0 9439.8 10071.2 10135.3 10165.6 6685.3 6769.8 7016.2 7083.0 7256.3 8077.5 8306.4 8345.2 8380.4 8411.8 7340.4 7466.4 7483.3 7544.8 7682.4 7139.7 7223.1 7231.1 7324.4 7345.7 6779.7 6783.2 6818.3 6852.9 6878.6 4747.7 4798.0 4806.9 4886.9 4961.3 4737.5 4790.3 4830.4 4912.6 4945.7 05:16:57 INFO - PROCESS | 1652 | 05:16:57 INFO - PROCESS | 1652 | [#4] prototype.html Cycles:180 Average:4497.72 Median:5097.23 stddev:1428.47 (28.0%) stddev-sans-first:1397.07 05:16:57 INFO - PROCESS | 1652 | Values: 286.6 300.0 309.6 313.8 314.7 5131.8 5306.4 5374.9 5391.0 5454.8 5103.3 5256.4 5288.8 5318.0 5340.4 4104.4 4104.9 4149.4 4154.9 4167.8 3102.4 3403.4 3833.0 4069.9 4166.7 3783.6 3868.0 4055.2 4067.3 4130.0 3683.1 4036.9 4092.7 4104.4 4110.5 3000.4 3183.7 3412.4 3605.4 3617.3 5025.9 5139.4 5217.6 5229.3 5270.8 3895.9 4660.9 4684.8 4700.6 4707.9 4859.9 5431.5 5651.4 5662.9 5671.5 3176.3 3449.5 3479.7 3572.6 3973.3 5356.5 5436.2 5442.2 5495.5 5918.8 2936.0 3239.6 3399.6 3699.0 3912.3 3525.4 3681.0 3765.0 3952.4 3993.2 3871.3 4031.6 4533.6 4543.5 4566.0 5653.4 5672.5 5676.3 5710.9 5731.6 1056.6 1091.2 1174.9 1295.4 1324.3 777.8 835.4 848.5 902.3 908.2 4372.5 4647.4 5243.6 5284.5 5320.3 5074.0 5301.5 5679.2 5693.2 5772.9 4684.8 4871.2 4980.8 4990.8 5283.6 2532.5 2879.6 3037.2 3069.0 3139.9 6048.7 6063.9 6078.9 6099.5 6124.7 5603.8 5630.6 5726.9 5812.7 6004.7 5038.3 5651.5 5857.7 6005.9 6052.8 5354.5 5461.9 5759.5 5764.5 5823.5 5103.7 5764.6 5820.6 5824.5 5839.3 5094.6 5225.3 5365.7 6070.9 6170.8 2984.1 3545.1 3669.4 3893.7 3902.4 4587.4 4631.8 5005.2 5796.0 5816.8 4470.2 4737.8 4944.3 5238.6 5715.8 5094.6 5654.7 5670.4 5675.3 5711.9 4841.7 5385.7 5540.0 5556.0 5604.4 5615.4 5642.3 5648.6 5682.3 5697.6 4824.6 4957.5 5099.8 5102.9 5624.3 05:16:57 INFO - PROCESS | 1652 | 05:16:57 INFO - PROCESS | 1652 | [#5] yui.html Cycles:180 Average:23117.20 Median:19472.58 stddev:36836.37 (189.2%) stddev-sans-first:36901.16 05:16:57 INFO - PROCESS | 1652 | Values: 672.0 703.0 758.3 775.4 794.3 13803.7 14693.6 14730.6 14733.8 14759.5 12415.8 13324.7 13441.7 13597.3 13603.0 648.9 672.5 798.0 807.0 822.1 827.5 835.3 841.0 842.7 843.7 882.5 884.0 886.1 886.9 887.4 877.8 878.4 879.9 879.9 884.8 635.2 651.3 652.8 653.2 653.5 13353.7 13448.6 13680.0 13705.7 13712.5 11767.2 14266.8 14282.9 14298.4 14357.4 10911.1 11252.5 11427.0 11638.2 11732.5 4455.6 4486.5 4501.2 4542.0 4681.4 89723.0 107816.9 108613.0 109923.0 113496.4 10151.6 10428.3 10552.6 10699.6 10868.2 20392.6 20439.6 20736.9 20781.3 20838.2 7329.2 7380.8 7400.4 7468.1 7509.0 4072.3 4078.9 4084.3 4092.7 4115.4 2832.9 2951.6 2980.3 3365.9 3403.9 652.1 658.7 663.5 664.8 677.9 504.8 510.4 523.7 537.4 580.3 8256.5 8435.5 8516.9 8647.7 8828.1 550.3 563.6 590.5 595.4 631.1 4107.8 4450.1 4475.4 4498.3 4524.5 102491.0 116582.3 124010.0 155297.0 158185.0 104733.0 105975.0 128325.0 134364.3 141037.3 82691.2 89861.5 114562.0 114902.4 117471.0 6693.2 7587.9 8107.8 8541.9 9047.7 34872.8 44587.6 52962.5 59877.5 61836.7 66855.0 67943.2 88513.0 93517.0 94115.0 12660.6 13161.2 13259.7 13271.1 13554.3 14493.6 14596.4 14685.3 14691.6 14743.8 13471.9 13710.7 13718.7 13757.3 14267.6 13569.9 13690.7 13693.5 13999.8 14032.8 13160.4 13467.4 13492.0 13723.8 13926.9 10888.1 11097.1 11319.5 11350.6 11722.2 8788.5 9731.3 11149.4 11591.5 11616.7 05:16:57 INFO - PROCESS | 1652 | -------- Summary: end -------- 05:16:57 INFO - PROCESS | 1652 | 05:16:57 INFO - TEST-INFO | 1652: exit 0 05:16:57 INFO - TEST-OK | dromaeo_css | took 1115764ms 05:16:57 INFO - TEST-START | kraken 05:16:57 INFO - operating with platform_type : mac_ 05:16:57 INFO - Initialising browser for kraken test... 05:16:57 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmp3TYBgg/profile http://localhost:49266/getInfo.html) 05:17:00 INFO - PROCESS | 1660 | 2016-10-13 05:17:00.522 plugin-container[1661:9901] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e47, name = 'com.apple.tsm.portname' 05:17:00 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:17:00 INFO - PROCESS | 1660 | 2016-10-13 05:17:00.526 plugin-container[1661:9901] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900f, name = 'com.apple.CFPasteboardClient' 05:17:00 INFO - PROCESS | 1660 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:17:00 INFO - PROCESS | 1660 | 2016-10-13 05:17:00.526 plugin-container[1661:9901] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:17:00 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 05:17:00 INFO - PROCESS | 1660 | colorDepth:24 05:17:00 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 05:17:00 INFO - PROCESS | 1660 | __metrics 05:17:00 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 05:17:01 INFO - TEST-INFO | 1660: exit 0 05:17:01 INFO - Browser initialized. 05:17:01 INFO - Running cycle 1/1 for kraken test... 05:17:01 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmp3TYBgg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:03 INFO - PROCESS | 1662 | 2016-10-13 05:17:03.831 plugin-container[1663:10023] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 05:17:03 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:17:03 INFO - PROCESS | 1662 | 2016-10-13 05:17:03.832 plugin-container[1663:10023] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 05:17:03 INFO - PROCESS | 1662 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:17:03 INFO - PROCESS | 1662 | 2016-10-13 05:17:03.832 plugin-container[1663:10023] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:17:13 INFO - PROCESS | 1662 | RSS: Main: 239308800 05:17:13 INFO - PROCESS | 1662 | 05:17:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 05:17:17 INFO - PROCESS | 1662 | RSS: Main: 252547072 05:17:17 INFO - PROCESS | 1662 | 05:17:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 05:17:20 INFO - PROCESS | 1662 | RSS: Main: 260083712 05:17:20 INFO - PROCESS | 1662 | 05:17:24 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 05:17:24 INFO - PROCESS | 1662 | RSS: Main: 260997120 05:17:24 INFO - PROCESS | 1662 | 05:17:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 05:17:27 INFO - PROCESS | 1662 | RSS: Main: 262070272 05:17:27 INFO - PROCESS | 1662 | 05:17:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:17:29 INFO - PROCESS | 1662 | RSS: Main: 263696384 05:17:29 INFO - PROCESS | 1662 | 05:17:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 05:17:33 INFO - PROCESS | 1662 | RSS: Main: 264351744 05:17:33 INFO - PROCESS | 1662 | 05:17:36 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 05:17:37 INFO - PROCESS | 1662 | RSS: Main: 264556544 05:17:37 INFO - PROCESS | 1662 | 05:17:40 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 05:17:40 INFO - PROCESS | 1662 | RSS: Main: 264810496 05:17:40 INFO - PROCESS | 1662 | 05:17:42 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:17:43 INFO - PROCESS | 1662 | RSS: Main: 264478720 05:17:43 INFO - PROCESS | 1662 | 05:17:45 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:17:45 INFO - PROCESS | 1662 | RSS: Main: 264507392 05:17:45 INFO - PROCESS | 1662 | 05:17:47 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:17:48 INFO - PROCESS | 1662 | RSS: Main: 264581120 05:17:48 INFO - PROCESS | 1662 | 05:17:51 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:17:52 INFO - PROCESS | 1662 | RSS: Main: 264974336 05:17:52 INFO - PROCESS | 1662 | 05:17:55 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:17:56 INFO - PROCESS | 1662 | RSS: Main: 264749056 05:17:56 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 05:17:58 INFO - PROCESS | 1662 | RSS: Main: 266502144 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | __start_tp_report 05:17:58 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 05:17:58 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 05:17:58 INFO - PROCESS | 1662 | |i|pagename|runs| 05:17:58 INFO - PROCESS | 1662 | |0;ai-astar;106;113;118;115;117;169;96;146;114;166 05:17:58 INFO - PROCESS | 1662 | |1;audio-beat-detection;150;134;145;185;146;116;117;119;144;149 05:17:58 INFO - PROCESS | 1662 | |2;audio-dft;274;252;231;197;194;201;195;257;193;194 05:17:58 INFO - PROCESS | 1662 | |3;audio-fft;85;61;59;85;61;63;58;64;106;86 05:17:58 INFO - PROCESS | 1662 | |4;audio-oscillator;90;74;88;72;71;71;91;89;68;89 05:17:58 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;90;87;92;86;89;87;89;87;89;90 05:17:58 INFO - PROCESS | 1662 | |6;imaging-darkroom;96;100;95;112;155;119;153;96;128;142 05:17:58 INFO - PROCESS | 1662 | |7;imaging-desaturate;139;145;90;93;136;83;147;150;95;90 05:17:58 INFO - PROCESS | 1662 | |8;json-parse-financial;57;58;58;58;58;58;58;56;59;58 05:17:58 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;66;73;74;80;73;69;70;70;72;73 05:17:58 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;83;89;94;89;90;86;90;107;89;80 05:17:58 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;151;146;148;151;132;168;151;153;262;152 05:17:58 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;179;185;172;192;219;174;249;241;186;176 05:17:58 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;69;70;88;73;64;89;91;90;64;84 05:17:58 INFO - PROCESS | 1662 | __end_tp_report 05:17:58 INFO - PROCESS | 1662 | __start_cc_report 05:17:58 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,953 05:17:58 INFO - PROCESS | 1662 | __end_cc_report 05:17:58 INFO - PROCESS | 1662 | __startTimestamp1476361078297__endTimestamp 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | ------- Summary: start ------- 05:17:58 INFO - PROCESS | 1662 | Number of tests: 14 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:126.00 Median:132.00 stddev:25.23 (19.1%) stddev-sans-first:25.70 05:17:58 INFO - PROCESS | 1662 | Values: 106.0 113.0 118.0 115.0 117.0 169.0 96.0 146.0 114.0 166.0 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:145.50 stddev:20.72 (14.2%) stddev-sans-first:21.69 05:17:58 INFO - PROCESS | 1662 | Values: 150.0 134.0 145.0 185.0 146.0 116.0 117.0 119.0 144.0 149.0 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:218.80 Median:216.00 stddev:31.64 (14.6%) stddev-sans-first:26.52 05:17:58 INFO - PROCESS | 1662 | Values: 274.0 252.0 231.0 197.0 194.0 201.0 195.0 257.0 193.0 194.0 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:72.80 Median:63.50 stddev:16.45 (25.9%) stddev-sans-first:16.85 05:17:58 INFO - PROCESS | 1662 | Values: 85.0 61.0 59.0 85.0 61.0 63.0 58.0 64.0 106.0 86.0 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:80.30 Median:88.50 stddev:9.73 (11.0%) stddev-sans-first:9.67 05:17:58 INFO - PROCESS | 1662 | Values: 90.0 74.0 88.0 72.0 71.0 71.0 91.0 89.0 68.0 89.0 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:89.00 stddev:1.84 (2.1%) stddev-sans-first:1.88 05:17:58 INFO - PROCESS | 1662 | Values: 90.0 87.0 92.0 86.0 89.0 87.0 89.0 87.0 89.0 90.0 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:119.60 Median:154.00 stddev:23.81 (15.5%) stddev-sans-first:23.67 05:17:58 INFO - PROCESS | 1662 | Values: 96.0 100.0 95.0 112.0 155.0 119.0 153.0 96.0 128.0 142.0 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:116.80 Median:86.50 stddev:28.46 (32.9%) stddev-sans-first:29.03 05:17:58 INFO - PROCESS | 1662 | Values: 139.0 145.0 90.0 93.0 136.0 83.0 147.0 150.0 95.0 90.0 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:57.80 Median:58.00 stddev:0.79 (1.4%) stddev-sans-first:0.78 05:17:58 INFO - PROCESS | 1662 | Values: 57.0 58.0 58.0 58.0 58.0 58.0 58.0 56.0 59.0 58.0 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:72.00 Median:73.00 stddev:3.71 (5.1%) stddev-sans-first:3.24 05:17:58 INFO - PROCESS | 1662 | Values: 66.0 73.0 74.0 80.0 73.0 69.0 70.0 70.0 72.0 73.0 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:89.70 Median:89.00 stddev:7.24 (8.1%) stddev-sans-first:7.26 05:17:58 INFO - PROCESS | 1662 | Values: 83.0 89.0 94.0 89.0 90.0 86.0 90.0 107.0 89.0 80.0 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:161.40 Median:151.50 stddev:36.41 (24.0%) stddev-sans-first:38.42 05:17:58 INFO - PROCESS | 1662 | Values: 151.0 146.0 148.0 151.0 132.0 168.0 151.0 153.0 262.0 152.0 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.30 Median:189.00 stddev:28.54 (15.1%) stddev-sans-first:29.50 05:17:58 INFO - PROCESS | 1662 | Values: 179.0 185.0 172.0 192.0 219.0 174.0 249.0 241.0 186.0 176.0 05:17:58 INFO - PROCESS | 1662 | 05:17:58 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:86.00 stddev:11.21 (13.0%) stddev-sans-first:11.39 05:17:58 INFO - PROCESS | 1662 | Values: 69.0 70.0 88.0 73.0 64.0 89.0 91.0 90.0 64.0 84.0 05:17:58 INFO - PROCESS | 1662 | -------- Summary: end -------- 05:17:58 INFO - PROCESS | 1662 | 05:17:59 INFO - TEST-INFO | 1662: exit 0 05:17:59 INFO - TEST-OK | kraken | took 61668ms 05:17:59 INFO - SUITE-END | took 1177s 05:17:59 INFO - Completed test suite (00:19:37) 05:17:59 INFO - javascript benchmark 05:17:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7118.309099375174, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2925.985370073149, 3214.0518547028623, 3237.951430728539, 3326.0188244467863, 3359.8824041158555, 5401.351837779472, 5433.592480563953, 5485.80799672011, 5522.088855338874, 5541.0, 5459.945400545993, 5482.17767334899, 5511.200875872996, 5556.777728890839, 5562.3047119110115, 5021.974890125544, 5026.170681837492, 5134.204198349262, 5134.25553294772, 5143.27994080829, 4261.296886013804, 4884.926726099111, 4968.279599458095, 5163.302954101186, 5189.377274727038, 4988.775505102279, 5008.824691135829, 5023.422306434771, 5048.29323894655, 5196.480351964811, 5065.898682026339, 5092.79628814847, 5136.357955255593, 5166.896662066775, 5183.0, 4226.429432026668, 4478.776061196927, 5022.17134172861, 5041.798328066873, 5059.873503162414, 4681.74250416227, 5225.817096401608, 5377.704226267554, 5547.55619550435, 5583.162525621149, 5973.342932277446, 6006.669633170174, 6066.575339726221, 6101.398774955092, 6109.829807539378, 6102.0541816018585, 6165.568410211287, 6175.722092505803, 6190.752369905198, 6199.659018753967, 5505.587080968943, 5649.4633009864, 5668.461496157858, 5682.943170568324, 5702.600817942745, 6119.106526814625, 6163.137160797492, 6178.443940045418, 6183.227096612924, 6258.405451482102, 5865.941340586625, 5947.762089516457, 5964.910526342108, 5965.254343207099, 5972.85067873298, 5909.497692696169, 6059.424354686298, 6100.69496525172, 6170.784022559189, 6190.7523699051535, 5846.678432686158, 5913.674747888907, 5939.613925094855, 5963.5527335450015, 6068.180795592627, 5986.311574168939, 6040.848978775478, 6062.151298818169, 6071.635701857903, 6072.119542666377, 4797.328374027639, 4799.136155492045, 4800.3279540864305, 4807.038592281488, 4817.964137710409, 3456.6197718250974, 3882.8835134946, 4112.280350938574, 4239.427677263591, 4260.318349064135, 5036.6726162799305, 5665.858353541194, 5676.432356764373, 5698.373178950312, 5751.166080918243, 6095.35998720128, 6138.324784273726, 6164.291106522717, 6167.96916015426, 6191.442770150708, 4577.771111444415, 5536.640118392292, 5579.107342825209, 5703.08750599902, 5720.141978703145, 5211.0, 5260.421353651095, 5275.525202731773, 5337.066013447708, 5388.218708287355, 6277.372262773686, 6299.527535434769, 6312.747490100344, 6318.210223722035, 6346.587471814225, 4602.516735742699, 5946.43508866657, 6140.5701600887505, 6149.954507733606, 6152.169457123231, 6193.225846769154, 6207.379262073937, 6246.344133865879, 6335.746570137143, 6342.016987366966, 5956.344802071682, 6034.164680541241, 6034.366391528826, 6043.0, 6111.865232675556, 5914.408559144051, 6147.692615369124, 6150.323464419, 6157.230346206724, 6171.197744293213, 5795.304563452412, 5849.53203743708, 5851.414858514115, 5852.590318677651, 5857.58996870215, 5842.5325973921135, 5844.12338149281, 5851.327097383855, 5857.970710146422, 5866.67733274674, 5552.389237183826, 5556.222128901876, 5560.527355174693, 5773.422657734193, 5846.824595262149, 5860.38465961085, 5913.645181289136, 5930.911036334544, 5934.910976335272, 5937.376575459687, 5573.52625026861, 5788.247527821356, 5793.0, 5799.768009279582, 5813.709314534341], "value": 5505.849487885542, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [444.2248276757059, 460.730472673486, 480.4594830815333, 486.20748180465847, 531.7235037780355, 29213.0, 38034.239315213716, 39947.60052399475, 40056.0, 40076.398854017214, 41200.0, 41547.58452415475, 41851.372229416585, 41872.37191442131, 42031.369529457086, 9481.573329200202, 9583.95208023959, 9599.568019439108, 9600.711978640651, 9745.02549745027, 9473.621055157786, 9593.184579310768, 9596.520173991272, 9601.327907046509, 9619.374740641835, 9069.274458043341, 9488.288378371615, 9533.523323833815, 9568.808623827554, 9629.807403851919, 9508.47703376314, 9517.952410237975, 9553.235741140692, 9571.952140239324, 9582.377145485521, 9447.52762361886, 9456.952715236379, 9535.856962145504, 9540.761480962961, 9564.521773911347, 39548.802255988536, 39645.801770991246, 39856.0, 39856.800715996236, 39988.40017399741, 3179.8410079496166, 3291.489819078047, 3307.2889328794427, 3317.286783341569, 3433.5021421893684, 30356.0, 31223.219419514695, 31553.84223078893, 32385.51421728676, 32543.186420339443, 3143.685631436861, 3215.4051500472488, 3243.8702451901895, 3270.7318039542056, 3355.144438168276, 470276.0, 471473.0, 473008.0, 474420.25579744106, 475245.0, 61712.69143654253, 62228.0, 62234.0, 62445.68777156176, 62510.374896251364, 63231.0, 64456.35543644503, 64596.0, 64635.0, 64671.67664161743, 16055.839441605434, 16165.676686466204, 16372.181390930406, 16373.508794736177, 16381.508554743377, 10482.0, 12435.0, 12537.310447925269, 12539.435725392379, 12545.059120565995, 17656.23959116485, 18698.065096745107, 18864.24543018264, 18974.62050758977, 18996.810031899506, 7262.0, 7500.624968751541, 7690.692372305157, 7739.460156168029, 7837.960810196027, 838.6854929401475, 944.5135755086136, 953.2945620240972, 1003.4330603209163, 1009.9545520451597, 27364.042258521255, 28338.574921376196, 29392.853035734686, 29788.10635680933, 30433.0, 813.345257068054, 968.5883499512679, 1000.3997601439224, 1012.1497941728983, 1014.3102690170607, 15044.0, 15486.457973970857, 15496.380144794082, 15631.770755329422, 15855.0, 616342.0, 621867.8906605438, 628611.0, 630765.0002749899, 632015.0, 57446.712766436736, 57844.421555783905, 57925.0, 58126.4187358121, 58130.0, 1056.3397876327294, 1166.6674997625637, 1260.521002019227, 1311.9448340345941, 1359.5377571625497, 23637.881810591523, 28603.0, 29671.554926675686, 30064.3987120252, 30423.54364684487, 41314.96712582209, 50733.23900141575, 50850.491495086055, 51488.22767658563, 51498.97002059863, 626321.289116206, 627831.8608406929, 628582.0, 629416.0, 630892.0, 26446.338841529116, 26570.335741606614, 26629.60055599129, 26736.465270694865, 26862.32844178833, 37517.24965500729, 46849.06301873875, 47266.291005635634, 47372.05255894932, 47555.04889902252, 38114.42828357632, 39422.0, 40095.0, 40308.798456007535, 40547.391789122594, 38678.419823702105, 39133.60866391299, 39298.80350598229, 40204.39693404543, 40364.78905632836, 37989.62010379861, 38363.23273534569, 38483.615163848, 38756.6124338753, 38851.6114838848, 31647.36705265928, 33460.49809252912, 33909.66090339164, 34027.829860850536, 34146.65853341534, 21368.78631213668, 25595.36011599725, 25824.22527324183, 25833.741662583132, 26055.739442605332], "value": 19725.62291672908, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.9241655460631, 371.88657459474865, 375.5324620847045, 379.2926192650707, 395.2726982352471, 19402.932838693865, 20123.89318587477, 20456.590868182626, 20651.17395304186, 20837.062332195048, 19283.903580482114, 20427.0, 20532.89733551334, 20584.485387865312, 20838.0, 4894.412670479547, 5339.466053394668, 5568.86077848053, 5737.168110623978, 5887.087501437284, 5764.82705518833, 5879.383169628365, 5885.823425297226, 5892.086726557369, 5897.970510147443, 5521.337439507265, 5607.943920560803, 5643.040683083865, 5651.463111004448, 5804.535637149018, 5663.5186009189265, 5663.830085097454, 5671.262735844334, 5737.454941780524, 5750.3962083981205, 5038.420581633122, 5293.947060529384, 5299.814506492293, 5360.839174824761, 5409.404965453797, 12587.874121258854, 12673.93663031688, 12706.745865082647, 12750.10749247553, 12772.169808962388, 2169.262450766731, 2254.9436264093365, 2315.722113346409, 2380.5119950410126, 2765.92129069663, 9640.132388085036, 9641.891182514031, 9700.854487182698, 10082.04220599042, 10233.48832558369, 1759.357834390451, 1817.472932849472, 1837.0, 1845.723141528768, 1847.29802674984, 105992.47003765008, 107288.99999999921, 114475.0, 114519.0, 115098.42450787776, 11106.888931110747, 11232.66302010941, 11335.546578136948, 11496.712582185512, 11614.593489227836, 11317.0, 11486.138539609563, 11653.6503904883, 11788.821117888314, 14169.645758856112, 6889.793306200822, 7211.531250468703, 7977.7207797726805, 8015.797630355493, 8426.662933482714, 7205.7838264852135, 7218.772808622547, 8173.67305307781, 8208.138145494757, 8369.246767790928, 3649.270145970763, 3788.924221515554, 4362.9147311313245, 4460.0633866887665, 4557.475890272594, 1588.6187315044538, 1822.489702883195, 1918.1847714721187, 1922.6827573450503, 1936.138418403825, 819.5615345789973, 880.4981160738317, 898.6315610599753, 942.707760594218, 978.6232300564334, 19906.0, 20753.273635422687, 20986.2654807081, 21015.369538913856, 21150.682739758915, 882.5587206396801, 902.9413088149249, 903.1871315815687, 918.0, 930.55798495714, 10779.02988731018, 11181.83227251592, 11213.215074944676, 11230.15773816967, 11232.831507527393, 589687.9796419333, 590668.0, 595619.0, 607812.0, 608447.0, 84769.0, 115129.0, 115333.4233328828, 119125.0, 121104.97237568955, 865.0095640491728, 904.1230006893303, 948.8719022931816, 957.3968399908014, 972.5866506734609, 15242.695146096794, 16603.66792664164, 18039.819601803814, 18121.81878181254, 18249.543761406072, 40662.0, 49754.50245497499, 50652.0, 50795.492045079074, 51650.22524662058, 71911.0, 72866.63566682133, 73026.0, 73268.90096648448, 73904.26095739189, 7965.442419030844, 7975.880361794694, 8064.435489515678, 8135.0, 8242.381821363302, 8571.442856214326, 12353.752924941631, 12522.998160146984, 12839.165454245818, 13174.880135188616, 9333.906660933575, 10570.735731606772, 10745.892541074489, 10985.61550345734, 11434.771304574027, 10832.5125369357, 10846.403447810446, 11091.500882460146, 11122.944385278022, 11365.829512557484, 11260.099192064452, 11686.799374278364, 11767.0, 11845.0, 11845.289282643069, 8057.959710201411, 8258.752237432887, 8279.834403312021, 8320.70877519284, 8372.037215720271, 10575.206859485723, 10590.364578125336, 11276.774464510829, 11460.255083419552, 11467.942660286979], "value": 9058.326531927405, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1492.8357880633127, 1534.593332766817, 1535.9539213823584, 1713.1862365376448, 1812.4381441753048, 7818.100918394386, 8168.101508834024, 8261.793455163624, 8810.823783524334, 8821.206091451777, 8224.83550328993, 8578.270846978, 8592.398532102756, 8639.827203455927, 8674.262687671555, 2277.8974946127382, 2315.5716192504356, 2319.5013072189477, 2323.721153461587, 2325.162941341124, 2292.060255295329, 2304.997326163116, 2319.7912187903084, 2335.9532809343805, 2340.9765902341014, 2303.55080759252, 2306.4349234437586, 2308.4459729664927, 2318.5594736999915, 2339.3917581428864, 2276.4081338851934, 2301.309607117858, 2302.5510025545027, 2308.68832707584, 2310.2491690200586, 2304.953900921972, 2307.8038366738847, 2308.180595888452, 2308.665243539694, 2321.489272360095, 8672.0, 8672.783180420476, 8762.079981601968, 8786.121387861227, 8843.955780221122, 5118.974405127988, 5185.870353241162, 5226.05930932432, 5287.180487024518, 5306.787728490855, 3342.097633638928, 3412.1128506588466, 3516.2088530080528, 3543.2382037861985, 3544.468329750558, 1000.5747557288123, 1007.6070332570304, 1055.941923194224, 1058.074185088048, 1078.4122653153972, 11110.944445277722, 11280.2667826591, 11350.262232954832, 11456.541738330458, 11497.540098396054, 4448.799804008828, 4534.909301813946, 4661.0, 4687.179743544866, 4720.504347043511, 9737.026297370207, 9747.463889486004, 9749.317547771589, 9765.804683906283, 9791.853122203172, 5201.271821944931, 5204.297419848272, 5223.242629818655, 5234.398044224887, 5239.738013099406, 4297.806598703066, 4457.576530229623, 4607.101615185007, 4767.6662633615315, 4767.713937163781, 3769.849206031783, 3814.713896457721, 3858.7684738915195, 3908.6286802753693, 3918.3534716771414, 1090.798202332571, 1266.5567051531891, 1268.0933132810085, 1275.5089290623177, 1279.33474593211, 796.6176235407037, 864.5115509737104, 888.7866911941088, 895.83427065993, 921.1663444582664, 5541.418151094158, 5660.462256085665, 5750.654960702288, 5834.591578589458, 5885.264341957255, 414.43843591933097, 416.991660166795, 432.1508236315592, 433.07538405504476, 434.9347597860283, 3794.867179648699, 3872.593377695358, 3911.3546264866545, 3957.7229593928723, 4154.273002224599, 8895.288376929959, 10341.069303762548, 10428.791424171473, 10669.466526673636, 10669.573217071385, 8844.850169477926, 10479.68560943173, 10529.684109476728, 10607.257491975488, 10614.522346494427, 6487.902681459782, 7827.45207835446, 7941.252924356632, 7979.8404031919035, 8127.512349259064, 5874.412558744091, 5889.349504078311, 5979.133025711334, 6002.0996850472775, 6081.939180608138, 9787.559559819967, 9788.559514821993, 9895.901040989786, 9977.850332245167, 10034.69895903124, 8388.958055209685, 9439.811203776024, 10071.244656650928, 10135.341202821794, 10165.593376264867, 6685.298043705536, 6769.796906092825, 7016.158061032709, 7083.0, 7256.346928776436, 8077.515349079074, 8306.377021723274, 8345.248927596303, 8380.371472139492, 8411.831763364577, 7340.412766978522, 7466.4026877848555, 7483.251674832473, 7544.8491030180185, 7682.423818213544, 7139.714411423485, 7223.061002069698, 7231.096112985877, 7324.4140468763435, 7345.6694448751, 6779.661016949231, 6783.186017677713, 6818.318168183142, 6852.862942741217, 6878.55289406187, 4747.691400058985, 4798.016406636701, 4806.903861922812, 4886.853394398174, 4961.255811628141, 4737.502562231054, 4790.305405716082, 4830.372051633265, 4912.557869791736, 4945.67853089548], "value": 4396.212347717782, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.5730062207311, 299.99850000750007, 309.5789725972677, 313.8430784607696, 314.6900303201345, 5131.820386286481, 5306.442823503535, 5374.89250214996, 5390.973045134774, 5454.808936771989, 5103.311053007843, 5256.395514515832, 5288.831579052589, 5317.973410132953, 5340.359156901168, 4104.363823607338, 4104.87116043089, 4149.439825623547, 4154.940490175001, 4167.811898753149, 3102.440486598554, 3403.4384326586082, 3832.9808350958347, 4069.9389509157386, 4166.6874984376145, 3783.6405541473514, 3868.013656517584, 4055.229506393776, 4067.3085575452096, 4130.0, 3683.097641077953, 4036.9394459083137, 4092.7339722918214, 4104.384342348671, 4110.527289361732, 3000.4449176902344, 3183.729383002448, 3412.3516531859113, 3605.4231322988194, 3617.276544691072, 5025.899482010376, 5139.383274007106, 5217.634765566412, 5229.320188375525, 5270.8155214567305, 3895.922081558353, 4660.906781864343, 4684.767510417801, 4700.55344742249, 4707.882302942419, 4859.902801943977, 5431.4840090191365, 5651.350094739076, 5662.915056274159, 5671.461211184931, 3176.2689334312854, 3449.4991131429765, 3479.704225140866, 3572.642395889571, 3973.284808734427, 5356.464353564613, 5436.21174929637, 5442.2380866678695, 5495.488740596328, 5918.768080822189, 2936.045785119845, 3239.5788547488673, 3399.5750531183603, 3698.9815050925113, 3912.295786758411, 3525.435930251199, 3680.9509289852263, 3765.039914821703, 3952.3873799561115, 3993.1813978134414, 3871.264459752638, 4031.6169963853386, 4533.591976722045, 4543.477500087466, 4566.0411313623845, 5653.406392328829, 5672.546196304285, 5676.347220069662, 5710.942890571124, 5731.598788084877, 1056.587930707025, 1091.2430986112354, 1174.9177557571059, 1295.4429595274123, 1324.3047400114824, 777.7783331750423, 835.4068611285934, 848.5036253791478, 902.309733054214, 908.1871724806261, 4372.519022907478, 4647.419072615923, 5243.632945693841, 5284.493919233, 5320.255164277004, 5074.0, 5301.469853014745, 5679.2333035040565, 5693.202951586781, 5772.884542309131, 4684.765761711901, 4871.244957031666, 4980.762504372115, 4990.775415106329, 5283.550898173698, 2532.531481675896, 2879.61125248093, 3037.179961410407, 3068.9539656904717, 3139.9215019624235, 6048.727807248684, 6063.939360606426, 6078.878422431527, 6099.542534309944, 6124.6926659604205, 5603.80386686464, 5630.60585758993, 5726.940516004553, 5812.738426770806, 6004.729787159588, 5038.254151487448, 5651.467832604622, 5857.736401861926, 6005.939940600538, 6052.757889684363, 5354.518093371459, 5461.863453413537, 5759.539236860957, 5764.48119669215, 5823.534117270524, 5103.682606305782, 5764.596478246483, 5820.594951953155, 5824.534037276923, 5839.328477225004, 5094.643374963717, 5225.294585230945, 5365.651232669864, 6070.878582428415, 6170.81487555374, 2984.0749367696085, 3545.1137215696076, 3669.3854703930187, 3893.7274390792372, 3902.3951287550476, 4587.449506059294, 4631.814727410866, 5005.249212618136, 5795.971020144872, 5816.767329306949, 4470.217711900469, 4737.786799594095, 4944.332515110558, 5238.580913526833, 5715.828525144252, 5094.643374963865, 5654.660720356792, 5670.370962583867, 5675.262215911905, 5711.914321285267, 4841.709497430165, 5385.730713464232, 5540.0, 5555.999920014437, 5604.383517812956, 5615.410381910004, 5642.294713160855, 5648.587853036741, 5682.261306030355, 5697.601167918206, 4824.565789079, 4957.4794646561595, 5099.821506247412, 5102.872428189325, 5624.268845050117], "value": 4037.3398575864935, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.9966400167999, 703.0403499223559, 758.3402439877308, 775.4416819889681, 794.2811755361396, 13803.654908627277, 14693.632659183499, 14730.63173420665, 14733.778993315109, 14759.483418080355, 12415.813762793543, 13324.666883327922, 13441.663958401045, 13597.252151131685, 13603.047786654937, 648.8669822686362, 672.4889084295946, 798.0264077825044, 807.0436532708759, 822.0998007182155, 827.4993628854546, 835.2816577743137, 840.9747707568782, 842.7345386203357, 843.7426584891606, 882.5102068352062, 883.9922488363271, 886.1227384888978, 886.9379143459961, 887.3611000079965, 877.7805548612815, 878.44218920985, 879.8988116366604, 879.9120087991214, 884.8186121845006, 635.1933045032782, 651.2998526583941, 652.7715299645087, 653.1737352249409, 653.5229282623711, 13353.732925341536, 13448.596542103753, 13679.974001949893, 13705.725885482334, 13712.45150193991, 11767.176297659167, 14266.785998210034, 14282.928585357111, 14298.428062877472, 14357.425702971974, 10911.07255883251, 11252.54989800407, 11427.0, 11638.243514171552, 11732.530698772125, 4455.643548516144, 4486.528914463999, 4501.234790085693, 4542.0, 4681.438227412698, 89723.0, 107816.92183078147, 108613.0, 109923.0, 113496.4325178377, 10151.64469243573, 10428.270021098602, 10552.577896884039, 10699.625513107005, 10868.239223254297, 20392.59214815725, 20439.591208175752, 20736.89631551863, 20781.272655456985, 20838.1664733412, 7329.157146928065, 7380.77857664271, 7400.444966627524, 7468.066491688539, 7509.0, 4072.3280658690983, 4078.898027549276, 4084.2852500812237, 4092.6903390915218, 4115.444415003936, 2832.9433411331656, 2951.6162898823445, 2980.2996295870453, 3365.8892565453343, 3403.9319213616086, 652.1294072413381, 658.716751796732, 663.5090033375268, 664.8232628247974, 677.928817474168, 504.77789772500716, 510.4104759003357, 523.6936392210599, 537.4464301769184, 580.2543731305252, 8256.545889976109, 8435.451695639764, 8516.914830851736, 8647.740567782977, 8828.117188281121, 550.2626480516128, 563.5632384901734, 590.4862769390572, 595.4373117404011, 631.0943795653252, 4107.753534787922, 4450.132224216247, 4475.4181956345465, 4498.302763071729, 4524.502304746476, 102491.0, 116582.33899723066, 124010.0, 155297.0, 158185.0, 104733.0, 105975.0, 128325.0, 134364.32817835847, 141037.29481352732, 82691.17308826956, 89861.4631609996, 114562.0, 114902.4254878737, 117470.9999999983, 6693.230278518033, 7587.886181707168, 8107.797305067421, 8541.932258467692, 9047.683331083645, 34872.82563587166, 44587.554124458344, 52962.47037529575, 59877.50306242379, 61836.690816545626, 66855.0, 67943.18831927887, 88513.0, 93517.0, 94115.0, 12660.556880509139, 13161.210327380004, 13259.66850828737, 13271.071025028155, 13554.322283885964, 14493.637659058186, 14596.416143354572, 14685.339159737623, 14691.632709182357, 14743.778843317144, 13471.865281347062, 13710.65723356924, 13718.725625487235, 13757.31213439344, 14267.571972840831, 13569.932150339186, 13690.65773355674, 13693.520726774914, 13999.790003150165, 14032.811751556534, 13160.407781649657, 13467.3939672713, 13492.0, 13723.794143088062, 13926.860731392962, 10888.128949683847, 11097.112231021338, 11319.490622922152, 11350.602728904449, 11722.238054526428, 8788.472691638523, 9731.34567123605, 11149.386783726974, 11591.536338546364, 11616.651500455], "value": 7449.66312327332, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1619.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 113.0, 118.0, 115.0, 117.0, 169.0, 96.0, 146.0, 114.0, 166.0], "value": 126.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 134.0, 145.0, 185.0, 146.0, 116.0, 117.0, 119.0, 144.0, 149.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [274.0, 252.0, 231.0, 197.0, 194.0, 201.0, 195.0, 257.0, 193.0, 194.0], "value": 218.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 61.0, 59.0, 85.0, 61.0, 63.0, 58.0, 64.0, 106.0, 86.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 74.0, 88.0, 72.0, 71.0, 71.0, 91.0, 89.0, 68.0, 89.0], "value": 80.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 92.0, 86.0, 89.0, 87.0, 89.0, 87.0, 89.0, 90.0], "value": 88.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 100.0, 95.0, 112.0, 155.0, 119.0, 153.0, 96.0, 128.0, 142.0], "value": 119.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 145.0, 90.0, 93.0, 136.0, 83.0, 147.0, 150.0, 95.0, 90.0], "value": 116.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 58.0, 58.0, 58.0, 58.0, 58.0, 56.0, 59.0, 58.0], "value": 57.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 74.0, 80.0, 73.0, 69.0, 70.0, 70.0, 72.0, 73.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 89.0, 94.0, 89.0, 90.0, 86.0, 90.0, 107.0, 89.0, 80.0], "value": 89.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 146.0, 148.0, 151.0, 132.0, 168.0, 151.0, 153.0, 262.0, 152.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 185.0, 172.0, 192.0, 219.0, 174.0, 249.0, 241.0, 186.0, 176.0], "value": 197.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 88.0, 73.0, 64.0, 89.0, 91.0, 90.0, 64.0, 84.0], "value": 78.2, "unit": "score"}]}]} 05:17:59 INFO - Return code: 0 05:17:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:17:59 ERROR - # TBPL SUCCESS # 05:17:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:17:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:17:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:17:59 INFO - 2016-10-13 05:17:59.629 screenresolution[1667:10404] starting screenresolution argv=screenresolution get 05:17:59 INFO - 2016-10-13 05:17:59.632 screenresolution[1667:10404] Display 0: 1600x1200x32@60 05:17:59 INFO - 2016-10-13 05:17:59.637 screenresolution[1668:10407] starting screenresolution argv=screenresolution list 05:17:59 INFO - Available Modes on Display 0 05:17:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:17:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:17:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:17:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:17:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:17:59 INFO - Intel Iris: 05:17:59 INFO - Chipset Model: Intel Iris 05:17:59 INFO - Type: GPU 05:17:59 INFO - Bus: Built-In 05:17:59 INFO - VRAM (Dynamic, Max): 1536 MB 05:17:59 INFO - Vendor: Intel (0x8086) 05:17:59 INFO - Device ID: 0x0a2e 05:17:59 INFO - Revision ID: 0x0009 05:17:59 INFO - Displays: 05:17:59 INFO - Display: 05:17:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:17:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:17:59 INFO - Display Serial Number: 1600x1200 60 05:17:59 INFO - Main Display: Yes 05:17:59 INFO - Mirror: Off 05:17:59 INFO - Online: Yes 05:17:59 INFO - Rotation: Supported 05:17:59 INFO - Return code: 0 05:17:59 INFO - Running post-action listener: _resource_record_post_action 05:17:59 INFO - [mozharness: 2016-10-13 12:17:59.881638Z] Finished run-tests step (success) 05:17:59 INFO - Running post-run listener: _resource_record_post_run 05:17:59 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 37939712; Write bytes: 711282176; Read time: 243; Write time: 2044 05:17:59 INFO - TinderboxPrint: CPU usage
54.4% 05:17:59 INFO - TinderboxPrint: I/O read bytes / time
37,939,712 / 243 05:17:59 INFO - TinderboxPrint: I/O write bytes / time
711,282,176 / 2,044 05:17:59 INFO - TinderboxPrint: CPU idle
2,212.3 (45.6%) 05:17:59 INFO - TinderboxPrint: CPU system
985.8 (20.3%) 05:17:59 INFO - TinderboxPrint: CPU user
1,651.7 (34.1%) 05:17:59 INFO - TinderboxPrint: Swap in / out
445,693,952 / 0 05:17:59 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 399632896; Write bytes: 392886272; Read time: 29617; Write time: 831 05:17:59 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 35883520; Write bytes: 301385216; Read time: 224; Write time: 1164 05:18:00 INFO - Running post-run listener: _upload_blobber_files 05:18:00 INFO - Blob upload gear active. 05:18:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:18:00 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 05:18:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:18:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:18:00 INFO - (blobuploader) - INFO - Open directory for files ... 05:18:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:18:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:18:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:01 INFO - (blobuploader) - INFO - Done attempting. 05:18:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:18:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:18:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:02 INFO - (blobuploader) - INFO - Done attempting. 05:18:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:18:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:18:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:05 INFO - (blobuploader) - INFO - Done attempting. 05:18:05 INFO - (blobuploader) - INFO - Iteration through files over. 05:18:05 INFO - Return code: 0 05:18:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:18:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:18:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6590f851d202339614a139a7229e36a6cb889817ea1815edbe2312f89cf548fb5142a745147f5c0c5510dbae304f3c58c5984f35d87b6e7c9a2bf21ffff0ea2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f67ea3e6476526858710a86251fbf65f5769fecd23aa46f451fc77f8e4875ceb06bc7f9072797aa9cddc4c5346e1b623e234b2b93f6de7230232850835571ec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5d5ba456aad5ffb481367960d6e648b0d71116813b587199f089f5501803735980c2017acabc2e6cae680ac19e6c7f8e6f9b1f2c1aeabe0ff1ad5772eed3d0c"} 05:18:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:18:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:18:05 INFO - Contents: 05:18:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6590f851d202339614a139a7229e36a6cb889817ea1815edbe2312f89cf548fb5142a745147f5c0c5510dbae304f3c58c5984f35d87b6e7c9a2bf21ffff0ea2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f67ea3e6476526858710a86251fbf65f5769fecd23aa46f451fc77f8e4875ceb06bc7f9072797aa9cddc4c5346e1b623e234b2b93f6de7230232850835571ec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5d5ba456aad5ffb481367960d6e648b0d71116813b587199f089f5501803735980c2017acabc2e6cae680ac19e6c7f8e6f9b1f2c1aeabe0ff1ad5772eed3d0c"} 05:18:05 INFO - Running post-run listener: copy_logs_to_upload_dir 05:18:05 INFO - Copying logs to upload dir... 05:18:05 INFO - mkdir: /builds/slave/test/build/upload/logs 05:18:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.860791 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-13 05:18:05.122752) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 05:18:05.127652) ========= 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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6590f851d202339614a139a7229e36a6cb889817ea1815edbe2312f89cf548fb5142a745147f5c0c5510dbae304f3c58c5984f35d87b6e7c9a2bf21ffff0ea2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f67ea3e6476526858710a86251fbf65f5769fecd23aa46f451fc77f8e4875ceb06bc7f9072797aa9cddc4c5346e1b623e234b2b93f6de7230232850835571ec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5d5ba456aad5ffb481367960d6e648b0d71116813b587199f089f5501803735980c2017acabc2e6cae680ac19e6c7f8e6f9b1f2c1aeabe0ff1ad5772eed3d0c"} build_url:https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011002 build_url: 'https://queue.taskcluster.net/v1/task/CwkeBvFIRUS_Ud3O6zX0hQ/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6590f851d202339614a139a7229e36a6cb889817ea1815edbe2312f89cf548fb5142a745147f5c0c5510dbae304f3c58c5984f35d87b6e7c9a2bf21ffff0ea2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f67ea3e6476526858710a86251fbf65f5769fecd23aa46f451fc77f8e4875ceb06bc7f9072797aa9cddc4c5346e1b623e234b2b93f6de7230232850835571ec0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d5d5ba456aad5ffb481367960d6e648b0d71116813b587199f089f5501803735980c2017acabc2e6cae680ac19e6c7f8e6f9b1f2c1aeabe0ff1ad5772eed3d0c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 05:18:05.163456) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:18:05.163828) ========= 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.XcOvxFYIQ7/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.1s2VrUEdj1/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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.005126 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 05:18:05.211961) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 05:18:05.212280) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 05:18:05.212603) ========= ========= Total master_lag: 0.19 =========