builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0099 starttime: 1477830712.45 results: success (0) buildid: 20161030030204 builduid: ad75f2f9f6854d1b9de0e8158fcf7f67 revision: 969c3295d3aa77931cca26eddb047d9d74bd9858 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 05:31:52.447555) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-30 05:31:52.448293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 05:31:52.448595) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-30 05:31:52.472892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:31:52.473298) ========= 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.1q6UhxtbP5/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.etjrJGrwXN/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-30 05:31:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-10-30 05:31:52 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.452851 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:31:52.948601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:31:52.948938) ========= 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.1q6UhxtbP5/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.etjrJGrwXN/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.020260 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:31:52.998432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 05:31:52.998796) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 969c3295d3aa77931cca26eddb047d9d74bd9858 --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 969c3295d3aa77931cca26eddb047d9d74bd9858 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1q6UhxtbP5/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.etjrJGrwXN/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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-30 05:31:53,075 truncating revision to first 12 chars 2016-10-30 05:31:53,076 Setting DEBUG logging. 2016-10-30 05:31:53,076 attempt 1/10 2016-10-30 05:31:53,076 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/969c3295d3aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-30 05:31:53,822 unpacking tar archive at: mozilla-central-969c3295d3aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.006504 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-30 05:31:54.028115) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 05:31:54.028467) ========= script_repo_revision: 969c3295d3aa77931cca26eddb047d9d74bd9858 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-30 05:31:54.028933) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 05:31:54.029302) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-30 05:31:54.048067) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-30 05:31:54.048484) ========= /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.1q6UhxtbP5/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.etjrJGrwXN/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:31:54 INFO - MultiFileLogger online at 20161030 05:31:54 in /builds/slave/test 05:31:54 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 05:31:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:54 INFO - {'append_to_log': False, 05:31:54 INFO - 'base_work_dir': '/builds/slave/test', 05:31:54 INFO - 'blob_upload_branch': 'Firefox', 05:31:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:54 INFO - 'branch': 'Firefox', 05:31:54 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:54 INFO - 'config_files': ('talos/mac_config.py',), 05:31:54 INFO - 'default_actions': ('clobber', 05:31:54 INFO - 'read-buildbot-config', 05:31:54 INFO - 'download-and-extract', 05:31:54 INFO - 'populate-webroot', 05:31:54 INFO - 'create-virtualenv', 05:31:54 INFO - 'install', 05:31:54 INFO - 'run-tests'), 05:31:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:54 INFO - 'download_minidump_stackwalk': True, 05:31:54 INFO - 'download_symbols': 'ondemand', 05:31:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:54 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:54 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:54 INFO - 'installer_path': 'installer.exe', 05:31:54 INFO - 'log_level': 'info', 05:31:54 INFO - 'log_name': 'talos', 05:31:54 INFO - 'log_to_console': True, 05:31:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:31:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:31:54 INFO - 'opt_config_files': (), 05:31:54 INFO - 'pip_index': False, 05:31:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:54 INFO - 'cmd': ('bash', 05:31:54 INFO - '-c', 05:31:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:54 INFO - 'enabled': True, 05:31:54 INFO - 'halt_on_failure': False, 05:31:54 INFO - 'name': 'check_screen_resolution'},), 05:31:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:54 INFO - 'cmd': ('bash', 05:31:54 INFO - '-c', 05:31:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:54 INFO - 'enabled': True, 05:31:54 INFO - 'halt_on_failure': False, 05:31:54 INFO - 'name': 'check_screen_resolution'},), 05:31:54 INFO - 'run_cmd_checks_enabled': True, 05:31:54 INFO - 'sps_profile': False, 05:31:54 INFO - 'sps_profile_interval': 0, 05:31:54 INFO - 'suite': 'dromaeojs-e10s', 05:31:54 INFO - 'system_bits': '32', 05:31:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:54 INFO - 'title': 't-yosemite-r7-0099', 05:31:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:54 INFO - 'use_talos_json': True, 05:31:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:54 INFO - 'work_dir': 'build'} 05:31:54 INFO - [mozharness: 2016-10-30 12:31:54.249490Z] Running clobber step. 05:31:54 INFO - Running pre-action listener: _resource_record_pre_action 05:31:54 INFO - Running main action method: clobber 05:31:54 INFO - rmtree: /builds/slave/test/build 05:31:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:54 INFO - Running post-action listener: _resource_record_post_action 05:31:54 INFO - [mozharness: 2016-10-30 12:31:54.423689Z] Finished clobber step (success) 05:31:54 INFO - [mozharness: 2016-10-30 12:31:54.423818Z] Running read-buildbot-config step. 05:31:54 INFO - Running pre-action listener: _resource_record_pre_action 05:31:54 INFO - Running main action method: read_buildbot_config 05:31:54 INFO - Using buildbot properties: 05:31:54 INFO - { 05:31:54 INFO - "project": "", 05:31:54 INFO - "product": "firefox", 05:31:54 INFO - "script_repo_revision": "production", 05:31:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 05:31:54 INFO - "repository": "", 05:31:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 05:31:54 INFO - "buildid": "20161030030204", 05:31:54 INFO - "stage_platform": "macosx64", 05:31:54 INFO - "basedir": "/builds/slave/test", 05:31:54 INFO - "nightly_build": "True", 05:31:54 INFO - "buildnumber": 60, 05:31:54 INFO - "slavename": "t-yosemite-r7-0099", 05:31:54 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 05:31:54 INFO - "platform": "yosemite_r7", 05:31:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:31:54 INFO - "branch": "mozilla-central", 05:31:54 INFO - "repo_path": "mozilla-central", 05:31:54 INFO - "revision": "969c3295d3aa77931cca26eddb047d9d74bd9858", 05:31:54 INFO - "pgo_build": "False", 05:31:54 INFO - "builduid": "ad75f2f9f6854d1b9de0e8158fcf7f67", 05:31:54 INFO - "slavebuilddir": "test" 05:31:54 INFO - } 05:31:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:31:54 INFO - Running post-action listener: _resource_record_post_action 05:31:54 INFO - [mozharness: 2016-10-30 12:31:54.427549Z] Finished read-buildbot-config step (success) 05:31:54 INFO - [mozharness: 2016-10-30 12:31:54.427690Z] Running download-and-extract step. 05:31:54 INFO - Running pre-action listener: _resource_record_pre_action 05:31:54 INFO - Running main action method: download_and_extract 05:31:54 INFO - mkdir: /builds/slave/test/build/tests 05:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:31:54 INFO - trying https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:31:54 INFO - Downloading https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/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 05:31:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/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 05:31:55 INFO - Downloaded 1199 bytes. 05:31:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:31:55 INFO - Using the following test package requirements: 05:31:55 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:31:55 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:31:55 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:31:55 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'jsshell-mac.zip'], 05:31:55 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:31:55 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:31:55 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:31:55 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:31:55 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:31:55 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:31:55 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:31:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:31:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:31:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:31:55 INFO - Fetch https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:31:56 INFO - Http code: 200 05:31:56 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 05:31:56 INFO - x-amz-cf-id: e0LnnvOrM7O0b_n-CF4kWz_AMVKz_tuXyzUBkxUSdJGw9fdLQ9Yc3g== 05:31:56 INFO - x-amz-version-id: Q._ezRc3jRAUrX1eK9tZpX1HsaMBt6C0 05:31:57 INFO - Expected file size: 16391782 05:31:57 INFO - Obtained file size: 16391782 05:32:04 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 05:32:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:32:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:32:04 INFO - Fetch https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:32:04 INFO - Http code: 200 05:32:04 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 05:32:04 INFO - x-amz-cf-id: 8QveJXHz3DLWX13KGoQPnnJXMUhWON65bZE5wWDK9-pgJLL9EEXjmA== 05:32:04 INFO - x-amz-version-id: Q._ezRc3jRAUrX1eK9tZpX1HsaMBt6C0 05:32:05 INFO - Expected file size: 16391782 05:32:05 INFO - Obtained file size: 16391782 05:32:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:32:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:32:11 INFO - Fetch https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:32:12 INFO - Http code: 200 05:32:12 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 05:32:12 INFO - x-amz-cf-id: pLlNjE_J9Vvtk_hTB8h9-ls3CkmCxCuOj-GBQu2qi7PUbIgg3JZdvA== 05:32:12 INFO - x-amz-version-id: g9C_TCMV_FZwAoK8WtXR2bHg5_NMloIT 05:32:12 INFO - Expected file size: 14409038 05:32:12 INFO - Obtained file size: 14409038 05:32:13 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')]} 05:32:13 INFO - trying https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:32:13 INFO - Downloading https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:32:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/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 05:32:16 INFO - Downloaded 112185659 bytes. 05:32:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:32:16 INFO - mkdir: /builds/slave/test/properties 05:32:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:16 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:16 INFO - Contents: 05:32:16 INFO - build_url:https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:32:17 INFO - Running post-action listener: _resource_record_post_action 05:32:17 INFO - Running post-action listener: set_extra_try_arguments 05:32:17 INFO - [mozharness: 2016-10-30 12:32:17.374525Z] Finished download-and-extract step (success) 05:32:17 INFO - [mozharness: 2016-10-30 12:32:17.374642Z] Running populate-webroot step. 05:32:17 INFO - Running pre-action listener: _resource_record_pre_action 05:32:17 INFO - Running main action method: populate_webroot 05:32:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:17 INFO - '--tppagecycles', 05:32:17 INFO - '7'], 05:32:17 INFO - 'tests': ['tsvgm']}}, 05:32:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:32:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:32:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:32:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:32:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:32:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:17 INFO - 'talos_options': ['--disable-e10s'], 05:32:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:17 INFO - 'talos_options': ['--disable-e10s'], 05:32:17 INFO - 'tests': ['damp', 'tps']}, 05:32:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:17 INFO - 'tests': ['damp', 'tps']}, 05:32:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:32:17 INFO - 'tests': ['dromaeo_dom']}, 05:32:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:32:17 INFO - 'tests': ['basic_compositor_video']}, 05:32:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:32:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:32:17 INFO - 'tests': ['a11yr', 05:32:17 INFO - 'ts_paint', 05:32:17 INFO - 'tpaint', 05:32:17 INFO - 'sessionrestore', 05:32:17 INFO - 'sessionrestore_no_auto_restore', 05:32:17 INFO - 'tabpaint']}, 05:32:17 INFO - 'other-e10s': {'tests': ['a11yr', 05:32:17 INFO - 'ts_paint', 05:32:17 INFO - 'tpaint', 05:32:17 INFO - 'sessionrestore', 05:32:17 INFO - 'sessionrestore_no_auto_restore', 05:32:17 INFO - 'tabpaint']}, 05:32:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:32:17 INFO - 'ts_paint', 05:32:17 INFO - 'tpaint', 05:32:17 INFO - 'sessionrestore', 05:32:17 INFO - 'sessionrestore_no_auto_restore', 05:32:17 INFO - 'tabpaint']}, 05:32:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:32:17 INFO - 'ts_paint', 05:32:17 INFO - 'tpaint', 05:32:17 INFO - 'sessionrestore', 05:32:17 INFO - 'sessionrestore_no_auto_restore', 05:32:17 INFO - 'tabpaint']}, 05:32:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:32:17 INFO - 'tests': ['a11yr', 05:32:17 INFO - 'ts_paint', 05:32:17 INFO - 'tpaint', 05:32:17 INFO - 'sessionrestore', 05:32:17 INFO - 'sessionrestore_no_auto_restore', 05:32:17 INFO - 'tabpaint']}, 05:32:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:32:17 INFO - 'tests': ['a11yr', 05:32:17 INFO - 'ts_paint', 05:32:17 INFO - 'tpaint', 05:32:17 INFO - 'sessionrestore', 05:32:17 INFO - 'sessionrestore_no_auto_restore', 05:32:17 INFO - 'tabpaint']}, 05:32:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:32:17 INFO - 'tests': ['tsvgx', 05:32:17 INFO - 'tsvgr_opacity', 05:32:17 INFO - 'tart', 05:32:17 INFO - 'tscrollx', 05:32:17 INFO - 'cart']}, 05:32:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:32:17 INFO - 'tsvgr_opacity', 05:32:17 INFO - 'tart', 05:32:17 INFO - 'tscrollx', 05:32:17 INFO - 'cart']}, 05:32:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:17 INFO - 'talos_options': ['--disable-e10s'], 05:32:17 INFO - 'tests': ['tp5o']}, 05:32:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:17 INFO - 'tests': ['tp5o']}, 05:32:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:17 INFO - 'talos_options': ['--disable-e10s', 05:32:17 INFO - '--xperf_path', 05:32:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:17 INFO - 'tests': ['tp5n']}, 05:32:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:17 INFO - 'talos_options': ['--xperf_path', 05:32:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:17 INFO - 'tests': ['tp5n']}}, 05:32:17 INFO - 'talos.zip': {'path': '', 05:32:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:17 INFO - Running post-action listener: _resource_record_post_action 05:32:17 INFO - [mozharness: 2016-10-30 12:32:17.393458Z] Finished populate-webroot step (success) 05:32:17 INFO - [mozharness: 2016-10-30 12:32:17.393586Z] Running create-virtualenv step. 05:32:17 INFO - Running pre-action listener: _resource_record_pre_action 05:32:17 INFO - Running main action method: create_virtualenv 05:32:17 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:17 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 05:32:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:17 INFO - Using real prefix '/tools/python27' 05:32:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:18 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:21 INFO - Installing pip.................done. 05:32:21 INFO - Return code: 0 05:32:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:32:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:32:21 INFO - Reading from file tmpfile_stdout 05:32:21 INFO - Output received: 05:32:21 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) 05:32:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:21 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 0x106434490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb9561e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106248d30>, '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 0x10606edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106240b20>, '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.1q6UhxtbP5/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.etjrJGrwXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:32:21 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 05:32:21 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 05:32:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1q6UhxtbP5/Render', 05:32:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:21 INFO - 'HOME': '/Users/cltbld', 05:32:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:21 INFO - 'LOGNAME': 'cltbld', 05:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:21 INFO - 'MOZ_NO_REMOTE': '1', 05:32:21 INFO - 'NO_EM_RESTART': '1', 05:32:21 INFO - 'PAGER': '/bin/cat', 05:32:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:21 INFO - 'PWD': '/builds/slave/test', 05:32:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:21 INFO - 'SHELL': '/bin/bash', 05:32:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.etjrJGrwXN/Listeners', 05:32:21 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:32:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:21 INFO - 'USER': 'cltbld', 05:32:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:21 INFO - 'XPC_FLAGS': '0x0', 05:32:21 INFO - 'XPC_SERVICE_NAME': '0', 05:32:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:21 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 05:32:21 INFO - Cleaning up... 05:32:21 INFO - Return code: 0 05:32:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:21 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 0x106434490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb9561e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106248d30>, '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 0x10606edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106240b20>, '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.1q6UhxtbP5/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.etjrJGrwXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:32:21 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 05:32:21 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 05:32:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1q6UhxtbP5/Render', 05:32:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:21 INFO - 'HOME': '/Users/cltbld', 05:32:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:21 INFO - 'LOGNAME': 'cltbld', 05:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:21 INFO - 'MOZ_NO_REMOTE': '1', 05:32:21 INFO - 'NO_EM_RESTART': '1', 05:32:21 INFO - 'PAGER': '/bin/cat', 05:32:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:21 INFO - 'PWD': '/builds/slave/test', 05:32:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:21 INFO - 'SHELL': '/bin/bash', 05:32:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.etjrJGrwXN/Listeners', 05:32:21 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:32:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:21 INFO - 'USER': 'cltbld', 05:32:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:21 INFO - 'XPC_FLAGS': '0x0', 05:32:21 INFO - 'XPC_SERVICE_NAME': '0', 05:32:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:21 INFO - Downloading/unpacking psutil>=3.1.1 05:32:21 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 05:32:21 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 05:32:21 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 05:32:21 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 05:32:21 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 05:32:21 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 05:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:25 INFO - Installing collected packages: psutil 05:32:25 INFO - Running setup.py install for psutil 05:32:26 INFO - building 'psutil._psutil_osx' extension 05:32:26 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 05:32:26 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 05:32:26 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 05:32:26 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 05:32:26 INFO - building 'psutil._psutil_posix' extension 05:32:26 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 05:32:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:26 INFO - ^ 05:32:26 INFO - 1 warning generated. 05:32:26 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 05:32:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:26 INFO - Successfully installed psutil 05:32:26 INFO - Cleaning up... 05:32:26 INFO - Return code: 0 05:32:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106434490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb9561e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106248d30>, '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 0x10606edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106240b20>, '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.1q6UhxtbP5/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.etjrJGrwXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:32: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:32: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 mozsystemmonitor==0.3 05:32:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1q6UhxtbP5/Render', 05:32:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:26 INFO - 'HOME': '/Users/cltbld', 05:32:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:26 INFO - 'LOGNAME': 'cltbld', 05:32:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:26 INFO - 'MOZ_NO_REMOTE': '1', 05:32:26 INFO - 'NO_EM_RESTART': '1', 05:32:26 INFO - 'PAGER': '/bin/cat', 05:32:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:26 INFO - 'PWD': '/builds/slave/test', 05:32:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:26 INFO - 'SHELL': '/bin/bash', 05:32:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.etjrJGrwXN/Listeners', 05:32:26 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:32:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:26 INFO - 'USER': 'cltbld', 05:32:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:26 INFO - 'XPC_FLAGS': '0x0', 05:32:26 INFO - 'XPC_SERVICE_NAME': '0', 05:32:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:32:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:32:29 INFO - Installing collected packages: mozsystemmonitor 05:32:29 INFO - Running setup.py install for mozsystemmonitor 05:32:29 INFO - Successfully installed mozsystemmonitor 05:32:29 INFO - Cleaning up... 05:32:29 INFO - Return code: 0 05:32:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:32:29 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')]} 05:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:29 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')]} 05:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:29 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 0x106434490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb9561e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106248d30>, '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 0x10606edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106240b20>, '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.1q6UhxtbP5/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.etjrJGrwXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:32:29 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 05:32:29 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 05:32:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1q6UhxtbP5/Render', 05:32:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:29 INFO - 'HOME': '/Users/cltbld', 05:32:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:29 INFO - 'LOGNAME': 'cltbld', 05:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:29 INFO - 'MOZ_NO_REMOTE': '1', 05:32:29 INFO - 'NO_EM_RESTART': '1', 05:32:29 INFO - 'PAGER': '/bin/cat', 05:32:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:29 INFO - 'PWD': '/builds/slave/test', 05:32:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:29 INFO - 'SHELL': '/bin/bash', 05:32:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.etjrJGrwXN/Listeners', 05:32:29 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:32:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:29 INFO - 'USER': 'cltbld', 05:32:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:29 INFO - 'XPC_FLAGS': '0x0', 05:32:29 INFO - 'XPC_SERVICE_NAME': '0', 05:32:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:30 INFO - Downloading/unpacking jsonschema==2.5.1 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:32:32 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 05:32:32 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 05:32:32 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 05:32:32 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 05:32:32 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 05:32:32 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 05:32:33 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:33 INFO - warning: no files found matching '*.txt' 05:32:33 INFO - no previously-included directories found matching 'build' 05:32:33 INFO - no previously-included directories found matching 'dist' 05:32:33 INFO - no previously-included directories found matching '.git*' 05:32:33 INFO - Installing collected packages: jsonschema, functools32 05:32:33 INFO - Running setup.py install for functools32 05:32:33 INFO - warning: no files found matching '*.txt' 05:32:33 INFO - no previously-included directories found matching 'build' 05:32:33 INFO - no previously-included directories found matching 'dist' 05:32:33 INFO - no previously-included directories found matching '.git*' 05:32:33 INFO - Successfully installed jsonschema functools32 05:32:33 INFO - Cleaning up... 05:32:33 INFO - Return code: 0 05:32:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:32:33 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')]} 05:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:33 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')]} 05:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:33 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 0x106434490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb9561e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106248d30>, '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 0x10606edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106240b20>, '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.1q6UhxtbP5/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.etjrJGrwXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:32:33 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 05:32:33 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 05:32:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1q6UhxtbP5/Render', 05:32:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:33 INFO - 'HOME': '/Users/cltbld', 05:32:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:33 INFO - 'LOGNAME': 'cltbld', 05:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:33 INFO - 'MOZ_NO_REMOTE': '1', 05:32:33 INFO - 'NO_EM_RESTART': '1', 05:32:33 INFO - 'PAGER': '/bin/cat', 05:32:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:33 INFO - 'PWD': '/builds/slave/test', 05:32:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:33 INFO - 'SHELL': '/bin/bash', 05:32:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.etjrJGrwXN/Listeners', 05:32:33 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:32:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:33 INFO - 'USER': 'cltbld', 05:32:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:33 INFO - 'XPC_FLAGS': '0x0', 05:32:33 INFO - 'XPC_SERVICE_NAME': '0', 05:32:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:32:33 INFO - Cleaning up... 05:32:33 INFO - Return code: 0 05:32:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32:33 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')]} 05:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:33 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')]} 05:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:33 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 0x106434490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb9561e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106248d30>, '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 0x10606edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106240b20>, '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.1q6UhxtbP5/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.etjrJGrwXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:32:33 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 05:32:33 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 05:32:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1q6UhxtbP5/Render', 05:32:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:33 INFO - 'HOME': '/Users/cltbld', 05:32:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:33 INFO - 'LOGNAME': 'cltbld', 05:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:33 INFO - 'MOZ_NO_REMOTE': '1', 05:32:33 INFO - 'NO_EM_RESTART': '1', 05:32:33 INFO - 'PAGER': '/bin/cat', 05:32:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:33 INFO - 'PWD': '/builds/slave/test', 05:32:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:33 INFO - 'SHELL': '/bin/bash', 05:32:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.etjrJGrwXN/Listeners', 05:32:33 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:32:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:33 INFO - 'USER': 'cltbld', 05:32:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:33 INFO - 'XPC_FLAGS': '0x0', 05:32:33 INFO - 'XPC_SERVICE_NAME': '0', 05:32:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:33 INFO - Downloading/unpacking blobuploader==1.2.4 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32: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 05:32:36 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:36 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 05:32:36 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 05:32:36 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 05:32:36 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 05:32:36 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 05:32:36 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 05:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:37 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 05:32:37 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 05:32:37 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 05:32:37 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 05:32:37 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 05:32:37 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 05:32:37 INFO - Downloading docopt-0.6.1.tar.gz 05:32:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:37 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:37 INFO - Running setup.py install for blobuploader 05:32:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:37 INFO - Running setup.py install for requests 05:32:38 INFO - Running setup.py install for docopt 05:32:38 INFO - Successfully installed blobuploader requests docopt 05:32:38 INFO - Cleaning up... 05:32:38 INFO - Return code: 0 05:32:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:38 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')]} 05:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:38 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')]} 05:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:38 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 0x106434490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb9561e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106248d30>, '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 0x10606edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106240b20>, '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.1q6UhxtbP5/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.etjrJGrwXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:32:38 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 05:32:38 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 05:32:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1q6UhxtbP5/Render', 05:32:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:38 INFO - 'HOME': '/Users/cltbld', 05:32:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:38 INFO - 'LOGNAME': 'cltbld', 05:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:38 INFO - 'MOZ_NO_REMOTE': '1', 05:32:38 INFO - 'NO_EM_RESTART': '1', 05:32:38 INFO - 'PAGER': '/bin/cat', 05:32:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:38 INFO - 'PWD': '/builds/slave/test', 05:32:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:38 INFO - 'SHELL': '/bin/bash', 05:32:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.etjrJGrwXN/Listeners', 05:32:38 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:32:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:38 INFO - 'USER': 'cltbld', 05:32:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:38 INFO - 'XPC_FLAGS': '0x0', 05:32:38 INFO - 'XPC_SERVICE_NAME': '0', 05:32:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:38 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-AcwMkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:38 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-FEMhM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-KNgs_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-QRdaBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-2MUDul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-1ghsEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-MZAsQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-QYsW1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-L6i0Xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-AREHd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-g433I0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:39 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-AISmz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:40 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-qdy9qX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:40 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-BPVTTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:40 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-tDmf2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:40 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-4YKs4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:40 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-FMsrNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:40 INFO - Running setup.py install for manifestparser 05:32:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:40 INFO - Running setup.py install for mozcrash 05:32:40 INFO - Running setup.py install for mozdebug 05:32:41 INFO - Running setup.py install for mozdevice 05:32:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Running setup.py install for mozfile 05:32:41 INFO - Running setup.py install for mozhttpd 05:32:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Running setup.py install for mozinfo 05:32:41 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Running setup.py install for mozInstall 05:32:41 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:41 INFO - Running setup.py install for mozleak 05:32:41 INFO - Running setup.py install for mozlog 05:32:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:42 INFO - Running setup.py install for moznetwork 05:32:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:42 INFO - Running setup.py install for mozprocess 05:32:42 INFO - Running setup.py install for mozprofile 05:32:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:42 INFO - Running setup.py install for mozrunner 05:32:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:42 INFO - Running setup.py install for mozscreenshot 05:32:42 INFO - Running setup.py install for moztest 05:32:43 INFO - Running setup.py install for mozversion 05:32:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:43 INFO - Cleaning up... 05:32:43 INFO - Return code: 0 05:32:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:43 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 0x106434490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb9561e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106248d30>, '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 0x10606edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106240b20>, '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.1q6UhxtbP5/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.etjrJGrwXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:32:43 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 05:32:43 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 05:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1q6UhxtbP5/Render', 05:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:43 INFO - 'HOME': '/Users/cltbld', 05:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:43 INFO - 'LOGNAME': 'cltbld', 05:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:43 INFO - 'MOZ_NO_REMOTE': '1', 05:32:43 INFO - 'NO_EM_RESTART': '1', 05:32:43 INFO - 'PAGER': '/bin/cat', 05:32:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:43 INFO - 'PWD': '/builds/slave/test', 05:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:43 INFO - 'SHELL': '/bin/bash', 05:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.etjrJGrwXN/Listeners', 05:32:43 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:43 INFO - 'USER': 'cltbld', 05:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:43 INFO - 'XPC_FLAGS': '0x0', 05:32:43 INFO - 'XPC_SERVICE_NAME': '0', 05:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-sWBmbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-wLwfvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-bHCDvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-MqeFdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:43 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)) 05:32:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:43 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-aFbACI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:44 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)) 05:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-AcK1RK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:44 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)) 05:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-fv_rTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:44 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)) 05:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-YIXr3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:44 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)) 05:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-dK5ziD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:44 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)) 05:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-7nSFUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:44 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)) 05:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-ZoZho4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:44 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)) 05:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-UXhitx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:44 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)) 05:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-ZnUxeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:44 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)) 05:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-g1TWZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:44 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)) 05:32:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:44 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-XP5kNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:45 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)) 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:45 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-JcO_iF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:45 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)) 05:32:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:45 INFO - Running setup.py (path:/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/pip-nyMA8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:45 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)) 05:32:45 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)) 05:32:45 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)) 05:32:45 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)) 05:32:45 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)) 05:32:45 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)) 05:32:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:45 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 05:32:45 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 05:32:45 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 05:32:45 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 05:32:45 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 05:32:45 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 05:32:47 INFO - Downloading blessings-1.6.tar.gz 05:32:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:47 INFO - Installing collected packages: blessings 05:32:47 INFO - Running setup.py install for blessings 05:32:48 INFO - Successfully installed blessings 05:32:48 INFO - Cleaning up... 05:32:48 INFO - Return code: 0 05:32:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:48 INFO - Reading from file tmpfile_stdout 05:32:48 INFO - Current package versions: 05:32:48 INFO - blessings == 1.6 05:32:48 INFO - blobuploader == 1.2.4 05:32:48 INFO - docopt == 0.6.1 05:32:48 INFO - functools32 == 3.2.3-2 05:32:48 INFO - jsonschema == 2.5.1 05:32:48 INFO - manifestparser == 1.1 05:32:48 INFO - mozInstall == 1.12 05:32:48 INFO - mozcrash == 0.17 05:32:48 INFO - mozdebug == 0.1 05:32:48 INFO - mozdevice == 0.48 05:32:48 INFO - mozfile == 1.2 05:32:48 INFO - mozhttpd == 0.7 05:32:48 INFO - mozinfo == 0.9 05:32:48 INFO - mozleak == 0.1 05:32:48 INFO - mozlog == 3.4 05:32:48 INFO - moznetwork == 0.27 05:32:48 INFO - mozprocess == 0.23 05:32:48 INFO - mozprofile == 0.28 05:32:48 INFO - mozrunner == 6.12 05:32:48 INFO - mozscreenshot == 0.1 05:32:48 INFO - mozsystemmonitor == 0.3 05:32:48 INFO - moztest == 0.7 05:32:48 INFO - mozversion == 1.4 05:32:48 INFO - psutil == 3.1.1 05:32:48 INFO - requests == 1.2.3 05:32:48 INFO - wsgiref == 0.1.2 05:32:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:48 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 0x106434490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb9561e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106248d30>, '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 0x10606edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106240b20>, '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.1q6UhxtbP5/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.etjrJGrwXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:32:48 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 05:32:48 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 05:32:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1q6UhxtbP5/Render', 05:32:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:48 INFO - 'HOME': '/Users/cltbld', 05:32:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:48 INFO - 'LOGNAME': 'cltbld', 05:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:48 INFO - 'MOZ_NO_REMOTE': '1', 05:32:48 INFO - 'NO_EM_RESTART': '1', 05:32:48 INFO - 'PAGER': '/bin/cat', 05:32:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:48 INFO - 'PWD': '/builds/slave/test', 05:32:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:48 INFO - 'SHELL': '/bin/bash', 05:32:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.etjrJGrwXN/Listeners', 05:32:48 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:32:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:48 INFO - 'USER': 'cltbld', 05:32:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:48 INFO - 'XPC_FLAGS': '0x0', 05:32:48 INFO - 'XPC_SERVICE_NAME': '0', 05:32:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:48 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)) 05:32:48 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)) 05:32:48 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)) 05:32:48 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)) 05:32:48 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)) 05:32:48 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)) 05:32:48 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)) 05:32:48 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)) 05:32:48 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)) 05:32:48 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)) 05:32:48 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)) 05:32:48 INFO - Cleaning up... 05:32:48 INFO - Return code: 0 05:32:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:32:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106434490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063aa570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffbb9561e90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106248d30>, '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 0x10606edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106240b20>, '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.1q6UhxtbP5/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.etjrJGrwXN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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 05:32:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:32:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:32:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1q6UhxtbP5/Render', 05:32:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:48 INFO - 'HOME': '/Users/cltbld', 05:32:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:48 INFO - 'LOGNAME': 'cltbld', 05:32:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:48 INFO - 'MOZ_NO_REMOTE': '1', 05:32:48 INFO - 'NO_EM_RESTART': '1', 05:32:48 INFO - 'PAGER': '/bin/cat', 05:32:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:48 INFO - 'PWD': '/builds/slave/test', 05:32:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:48 INFO - 'SHELL': '/bin/bash', 05:32:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.etjrJGrwXN/Listeners', 05:32:48 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:32:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:48 INFO - 'USER': 'cltbld', 05:32:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:48 INFO - 'XPC_FLAGS': '0x0', 05:32:48 INFO - 'XPC_SERVICE_NAME': '0', 05:32:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:32:48 INFO - Cleaning up... 05:32:49 INFO - Return code: 0 05:32:49 INFO - Running post-action listener: _resource_record_post_action 05:32:49 INFO - Running post-action listener: _start_resource_monitoring 05:32:49 INFO - Starting resource monitoring. 05:32:49 INFO - [mozharness: 2016-10-30 12:32:49.036490Z] Finished create-virtualenv step (success) 05:32:49 INFO - [mozharness: 2016-10-30 12:32:49.037506Z] Running install step. 05:32:49 INFO - Running pre-action listener: _resource_record_pre_action 05:32:49 INFO - Running main action method: install 05:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:49 INFO - Reading from file tmpfile_stdout 05:32:49 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:49 INFO - Reading from file tmpfile_stdout 05:32:49 INFO - Output received: 05:32:49 INFO - Usage: mozinstall [options] installer 05:32:49 INFO - Options: 05:32:49 INFO - -h, --help show this help message and exit 05:32:49 INFO - -d DEST, --destination=DEST 05:32:49 INFO - Directory to install application into. [default: 05:32:49 INFO - "/builds/slave/test"] 05:32:49 INFO - --app=APP Application being installed. [default: firefox] 05:32:49 INFO - mkdir: /builds/slave/test/build/application 05:32:49 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'] 05:32:49 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 05:33:23 INFO - Reading from file tmpfile_stdout 05:33:23 INFO - Output received: 05:33:23 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:33:23 INFO - Running post-action listener: _resource_record_post_action 05:33:23 INFO - [mozharness: 2016-10-30 12:33:23.807425Z] Finished install step (success) 05:33:23 INFO - [mozharness: 2016-10-30 12:33:23.807563Z] Running run-tests step. 05:33:23 INFO - Running pre-action listener: _resource_record_pre_action 05:33:23 INFO - Running main action method: run_tests 05:33:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:23 INFO - 2016-10-30 05:33:23.822 screenresolution[2085:23959] starting screenresolution argv=screenresolution get 05:33:23 INFO - 2016-10-30 05:33:23.824 screenresolution[2085:23959] Display 0: 1600x1200x32@60 05:33:23 INFO - 2016-10-30 05:33:23.830 screenresolution[2086:23961] starting screenresolution argv=screenresolution list 05:33:23 INFO - Available Modes on Display 0 05:33:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:24 INFO - Intel Iris: 05:33:24 INFO - Chipset Model: Intel Iris 05:33:24 INFO - Type: GPU 05:33:24 INFO - Bus: Built-In 05:33:24 INFO - VRAM (Dynamic, Max): 1536 MB 05:33:24 INFO - Vendor: Intel (0x8086) 05:33:24 INFO - Device ID: 0x0a2e 05:33:24 INFO - Revision ID: 0x0009 05:33:24 INFO - Displays: 05:33:24 INFO - Display: 05:33:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:24 INFO - Display Serial Number: 1600x1200 60 05:33:24 INFO - Main Display: Yes 05:33:24 INFO - Mirror: Off 05:33:24 INFO - Online: Yes 05:33:24 INFO - Rotation: Supported 05:33:24 INFO - Return code: 0 05:33:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:24 INFO - Python 2.7.3 05:33:24 INFO - Return code: 0 05:33:24 INFO - grabbing minidump binary from tooltool 05:33:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:33:24 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 0x106248d30>, '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 0x10606edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106240b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:24 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 05:33:24 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 05:33:24 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 05:33:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:24 INFO - Return code: 0 05:33:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:24 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 05:33:24 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0099 --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 05:33:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1q6UhxtbP5/Render', 05:33:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:24 INFO - 'HOME': '/Users/cltbld', 05:33:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:24 INFO - 'LOGNAME': 'cltbld', 05:33:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:24 INFO - 'MOZ_NO_REMOTE': '1', 05:33:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:24 INFO - 'NO_EM_RESTART': '1', 05:33:24 INFO - 'PAGER': '/bin/cat', 05:33:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:24 INFO - 'PWD': '/builds/slave/test', 05:33:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:24 INFO - 'SHELL': '/bin/bash', 05:33:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.etjrJGrwXN/Listeners', 05:33:24 INFO - 'TMPDIR': '/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/', 05:33:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:24 INFO - 'USER': 'cltbld', 05:33:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:24 INFO - 'XPC_FLAGS': '0x0', 05:33:24 INFO - 'XPC_SERVICE_NAME': '0', 05:33:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:33:24 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0099', '--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 05:33:24 INFO - mozversion application_buildid: 20161030030204 05:33:24 INFO - mozversion application_changeset: 969c3295d3aa77931cca26eddb047d9d74bd9858 05:33:24 INFO - mozversion application_display_name: Nightly 05:33:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:24 INFO - mozversion application_name: Firefox 05:33:24 INFO - mozversion application_remotingname: firefox 05:33:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:33:24 INFO - mozversion application_vendor: Mozilla 05:33:24 INFO - mozversion application_version: 52.0a1 05:33:24 INFO - mozversion platform_buildid: 20161030030204 05:33:24 INFO - mozversion platform_changeset: 969c3295d3aa77931cca26eddb047d9d74bd9858 05:33:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:33:24 INFO - mozversion platform_version: 52.0a1 05:33:24 INFO - using testdate: 1477830804 05:33:24 INFO - actual date: 1477830804 05:33:24 INFO - starting webserver on 'localhost:49374' 05:33:24 INFO - SUITE-START | Running 2 tests 05:33:24 INFO - TEST-START | dromaeo_css 05:33:24 INFO - operating with platform_type : mac_ 05:33:24 INFO - Initialising browser for dromaeo_css test... 05:33:24 INFO - TEST-INFO | started process 2096 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpp5a6VR/profile http://localhost:49374/getInfo.html) 05:33:27 INFO - PROCESS | 2096 | 2016-10-30 05:33:27.416 plugin-container[2099:24126] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d47, name = 'com.apple.tsm.portname' 05:33:27 INFO - PROCESS | 2096 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:27 INFO - PROCESS | 2096 | 2016-10-30 05:33:27.417 plugin-container[2099:24126] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9603, name = 'com.apple.CFPasteboardClient' 05:33:27 INFO - PROCESS | 2096 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:27 INFO - PROCESS | 2096 | 2016-10-30 05:33:27.417 plugin-container[2099:24126] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:33:27 INFO - PROCESS | 2096 | __metrics Screen width/height:1600/1200 05:33:27 INFO - PROCESS | 2096 | colorDepth:24 05:33:27 INFO - PROCESS | 2096 | Browser inner width/height: 1024/689 05:33:27 INFO - PROCESS | 2096 | __metrics 05:33:27 ERROR - PROCESS | 2096 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 05:33:28 INFO - TEST-INFO | 2096: exit 0 05:33:28 INFO - Browser initialized. 05:33:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:33:28 INFO - TEST-INFO | started process 2101 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpp5a6VR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:33:30 INFO - PROCESS | 2101 | 2016-10-30 05:33:30.730 plugin-container[2102:24255] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883b, name = 'com.apple.tsm.portname' 05:33:30 INFO - PROCESS | 2101 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:30 INFO - PROCESS | 2101 | 2016-10-30 05:33:30.731 plugin-container[2102:24255] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0f, name = 'com.apple.CFPasteboardClient' 05:33:30 INFO - PROCESS | 2101 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:33:30 INFO - PROCESS | 2101 | 2016-10-30 05:33:30.731 plugin-container[2102:24255] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:33:40 INFO - PROCESS | 2101 | RSS: Main: 238039040 05:33:40 INFO - PROCESS | 2101 | 05:34:29 INFO - PROCESS | 2101 | 1477830869897 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:36:43 INFO - PROCESS | 2101 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49374/tests/dromaeo/cssquery-ext.html) 05:36:45 INFO - PROCESS | 2101 | RSS: Main: 250310656 05:36:45 INFO - PROCESS | 2101 | 05:39:47 INFO - PROCESS | 2101 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-ext.html (next: http://localhost:49374/tests/dromaeo/cssquery-jquery.html) 05:39:48 INFO - PROCESS | 2101 | RSS: Main: 262483968 05:39:48 INFO - PROCESS | 2101 | 05:42:50 INFO - PROCESS | 2101 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49374/tests/dromaeo/cssquery-mootools.html) 05:42:50 INFO - PROCESS | 2101 | RSS: Main: 267079680 05:42:50 INFO - PROCESS | 2101 | 05:45:52 INFO - PROCESS | 2101 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49374/tests/dromaeo/cssquery-prototype.html) 05:45:53 INFO - PROCESS | 2101 | RSS: Main: 266715136 05:45:53 INFO - PROCESS | 2101 | 05:48:56 INFO - PROCESS | 2101 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49374/tests/dromaeo/cssquery-yui.html) 05:48:57 INFO - PROCESS | 2101 | RSS: Main: 273055744 05:48:57 INFO - PROCESS | 2101 | 05:51:59 INFO - PROCESS | 2101 | Cycle 1(1): loaded http://localhost:49374/tests/dromaeo/cssquery-yui.html (next: http://localhost:49374/tests/dromaeo/cssquery-dojo.html) 05:52:00 INFO - PROCESS | 2101 | RSS: Main: 274857984 05:52:00 INFO - PROCESS | 2101 | 05:52:00 INFO - PROCESS | 2101 | __start_tp_report 05:52:00 INFO - PROCESS | 2101 | _x_x_mozilla_page_load 05:52:00 INFO - PROCESS | 2101 | _x_x_mozilla_page_load_details 05:52:00 INFO - PROCESS | 2101 | |i|pagename|runs| 05:52:00 INFO - PROCESS | 2101 | |0;dojo.html;3326.501024846273;3348.4475061614835;3367.276035652335;3380.2901390707934;3384.8476818543163;5578.442155784424;5624.775008999635;5661.065924122515;5662.801801936933;5710.457506536883;4499.505054444016;4907.8711896263885;5288.444713305105;5518.751656175472;5603.887922241553;5134.332536770224;5209.479052094779;5223.529882310591;5224.268602395668;5269.394019687727;5159.32928719266;5221.71280579568;5263.1578947368425;5296.549793267577;5315.840524784263;5228.581713462933;5286.10136276832;5290.656107353029;5335.946640533603;5340.305760251162;5124.0776660201145;5124.410692770304;5152.9742351288005;5190.091733946544;5203.297554830087;5136.332276804029;5137.126688462933;5143.202803565453;5164.535191832753;5174.197999310113;5464.398916119224;5618.988442897974;5640.379558248589;5693;5756.769729210827;6017.69911504423;6100.490342048325;6120.477608373095;6133.6626485543275;6171.166892469504;6219.47134493564;6225.039112679491;6235.594686345373;6236.688165591702;6258.249010118815;5816.5928385013485;5823.272090988627;5833.212516310328;5855.707214639251;5878.61788983719;6130.581587307925;6186.628802271878;6190.535709821781;6231.065340198916;6233.501319894398;6051.939480605138;6103.155845961415;6104.732011601517;6105.035213715927;6117.857853872152;6122.326544080148;6129.172561704202;6179.3202747697715;6216.689165541705;6235.563510554309;6086.995645718407;6144.078388241799;6177.938220617736;6191.164192834;6204.503639708812;6084.5436592255755;6104.7926496150985;6135.785247516315;6137.723802428812;6138.478229350555;4889.071076495455;4893.119238537098;4894.706317620954;4900.509949005071;4951.232558953368;4327;4375.993521490075;4409.162259170747;4426.291793313055;4448.110377924428;4509.977450112794;5584.301962254718;5750.7987220447085;5789.942100579025;5790.449907258803;6067.817965461043;6174.629522228681;6221.96889015552;6233.532485063638;6256.311805701369;5773.566982476331;5848.152017957373;5850.853728656818;5861.70691465425;5865.941340586625;5238.449962753933;5310.415854256029;5317.468253174651;5345.946540534623;5364.249005139283;6283.277423096311;6295.748170073146;6299.464545513682;6308.936910630835;6328.082428047999;6164.260288765377;6223.408776166257;6231.626102433868;6239.625622462667;6250.718717657625;6102.511799055976;6155.938440615537;6196.783112591038;6272.905906411316;6307.621542707452;6056.90914636272;6111.95640283616;6132.84504737327;6137.407629318989;6139.614800607318;6198.256209254918;6200.627962322275;6204;6208.627482351073;6213;5816.8947899898885;5865.472107510344;5969.641821490724;6087.634741915499;6098.237720284965;5388.892222155613;5526.723663816873;5855.268091488564;6009.188759517584;6057.091436284416;4447.444069491314;4799.088173247072;5911.3201981772645;5971.4327138921735;5978.222831031938;5520.641158324696;5869.295684517885;5908;6090.421409966046;6100.786472473442;5935.436133567304;6002.159697642421;6002.639841609517;6018.337982821974;6038.154658347747 05:52:00 INFO - PROCESS | 2101 | |1;ext.html;473.14124863372973;475.4342332624178;521.4576840086311;523.2360753300181;528.7858417340979;39402.605973940255;40998.795006024964;41153.38269925946;43358.349624755654;43569.56430435694;42688;42909.57090429095;43115.35326970098;43165;43174.35238471426;9462.810743785138;9644.22846172308;9650.613975440974;9658.758531036745;9671.709848704515;9475.905240947606;9494.430334179937;9567.186789122932;9574.090461406155;9596.808063838718;9536.666216682417;9542.80914381712;9562.56968436422;9596.28027897907;9624.326297159201;9499.81000379992;9589.328746987714;9595.520223988773;9601.327907046509;9615.951920240354;9291.907080929239;9296.256299496024;9301.72094837156;9379.202767764747;9390.765230869214;40681.59318406808;40885.18229635421;41117.79441102805;41317.58682413167;41365.1726965462;3456.879009234665;3637.6726094651344;3647.598764135943;3676.6507181817683;4273.957260427418;29715.554266686016;31346.686533134605;31722.524162137586;31725.84137079323;31852.522212166838;2625.9474810503684;2663.840169589831;2734.931626709348;3351.8659253629826;3359.5464612277274;458835;463018;464248;466845;468883;61683.074753878725;62037;62105.06842397367;62123;62309.68845155745;64420;64699;64785;65141.02288465677;65230.34769652338;16192.271347789378;16378.50864474044;16386.344546218257;16425.67148657044;16442.588935276475;12682;12682.49270029207;12704.809427858405;12746.553870614483;12757.043221758406;12055.939720301518;16878.07170605604;17251;17514.737278940825;17632.735508967377;2738.3838636306673;3265.248992731685;3303.339332133583;7044.894326585106;7158.856822863513;732.5128789355019;821.8191997760483;944.5985456181232;1065.4992153687908;1067.402254737334;26494.735052649612;30073.69926300753;30714.84642576773;31340.84329578383;31408.05775826729;985.9654912078042;1057.1173070486077;1155.191366043756;1175.4416652090188;1216.0482425706791;13284.269365184815;15512.92243538775;15891;16013.679726405406;16187.757183642254;624594;626927;631840;634715;635847;57848;58316.708416457644;58359.83280334369;58426.4157358421;58567;1354.9932250338882;1410.7037522120265;1424.5583869000643;1425.4227038049398;1426.187073368191;30087;30741;31025.844870776404;31282.68717312798;32007.679923201402;57571.71214143903;58233.4176658228;58266.126008109066;58276;58455;535058;542436;542571;544078;549253;43155.78422107995;43279;43900.56099439092;43976.78011609922;44176.77911610421;47469.52530474651;47834.04331913412;47869;48372.516274838206;48897.51102489072;34132.488012679336;40086.39870401888;40200.597994019685;40941.77174684764;41654.37518437165;39580.60419395769;39969;40018.599814001485;40277.231469356804;41212.26059003133;38456;38679.03302417462;39081.80459097686;39110.69782323999;39161.804190978866;33676.831615841766;34973.300533988666;35745.64254357527;35798.642013579534;35899.82050089837;25868.870655646602;26138.085167019064;26196.821143048226;26276.21171364862;26888.462230755667 05:52:00 INFO - PROCESS | 2101 | |2;jquery.html;374.51313292719476;375.59811002227616;380.01386402286073;382.9674477669398;401.3037380145449;15058;19531.21875124995;20011.599768004668;20133.899330503344;20364.08361623727;10808.891911080887;11149.386783726892;11720.941395293034;12038;12056.879431205685;5121.9743901280535;5295.152775555912;5374.6237763356385;5385.246065550826;5396.595255355864;3803.410471376927;4063.9593604063875;5276.683398996053;5399.784008639669;5682.744276507547;5940.52475801937;6046.6999595087045;6052.878942421149;6059.091136329564;6069.666168360738;5804.129380592903;5982.401759824004;6015.789447369365;6016.669083200422;6062.120992456091;5398.703071331075;5800.274965629296;5800.636850340166;5812.302523697141;5820.185174075633;12684.30236337001;13473.595792126252;20454.977251137385;24741.87629061843;25476.36309092269;2133.5732853429377;2210.6462965925534;2250.9212177573704;2418.794402475774;2778.7082356352494;9221.585028673726;9363.906360936371;9761.658341957997;9937.90062099377;10372.94813525935;1776.4759395978217;1854.4343975087593;1857;1875.6436277107307;1902.7431296775035;94645;99725;110159.44920275347;117862.82137178605;122937;9477.857832132524;10714.73213169677;11311;11561.42192890352;11791.29252244851;14461.710765784625;14463.13221206731;14467.914906382064;14505.274736263145;14507.347169377403;8130.268275855202;8456;8462.492250464991;8520.403571749917;8598;8305.626246818907;8349.373796965252;8371;8467.83064338722;8488.405811593253;3585.5697316322207;4507.729536227836;4516.367708520744;4582.839600614029;4628.930566041512;1538.96152596186;1581.5887869154103;1650.6286085630636;1901.2300018492533;1947.5033866363985;765.2959277464746;852.9957350213209;891.4072142025481;957.5978089202551;962.9181519570915;15916.602084947968;20474.590508189754;20606.793932060787;21579.460513486974;21847.235346762787;809.3498322565273;901.4005686218591;922.5341202692597;975.331897650112;980.1864452504404;9247.213986811063;11060.728016278232;11323.207375483636;11348.262362946381;11367.976882080653;563174;573733;577879;578177.3273400902;582323;130213;132741;132874.33562832125;134217;136383;956.660385563129;972.5651031297307;985.571276494727;987.2052997337213;996.4569309726072;15527.922360388578;18143.002134882707;18519.814801851808;18904;19158.946257955948;56917;57076;57189.71405142947;57794.13308800456;58346;71071.64464177853;73453;80848.19151808407;81350.18649813662;83402.58298708468;6917.342852429011;7149.8540642117305;7301.4158867289425;7333.559986400833;7483.176850546327;10577.31247468912;12922.901553368069;13281.80077298822;13508;13636.454541818217;10447.843282350923;10818.080463160719;10863.197880741676;11081.002709755838;11261.324320540794;10724.678259652223;11217.326960382403;11294.717632059264;11410.657680269605;11549.538018479503;9530.85703714431;11585.594504192313;11596.826047609124;11673.357965311989;11775.705607359885;6383.712732926937;7295.8540829184185;7429.182789893;7508.0990281166605;7644.541327520366;8042.597870106589;11572.537098515964;11602.361870096887;11722.70693232676;11730.12024098179 05:52:00 INFO - PROCESS | 2101 | |3;mootools.html;1568.2550788375522;1592.0686398456903;1855.6103218324151;1919.04047976012;1942.5629233422474;7547.283008114234;7807.336376407998;8120.187981201884;8546.359023073263;8560.571971401429;8038;8342.207490288412;8351.874721879176;8450.028246751626;8481.660733570665;2281.4638559938403;2292.8509646872985;2302.297799171252;2302.804261637763;2310.780475854791;2302.5279817637343;2323.8721870297127;2334.8365614407;2336.4158960259933;2337.9532409351805;2228.6211344071467;2289.6222123349626;2304.9308520744403;2315.8610483370967;2319.1651005637955;1778.5020194345605;2012.9935032483759;2258.3225032490186;2275.954480910389;2287.965680514802;2298.230092918874;2303.4126297794123;2324.407276144589;2328.4528135888054;2328.8253380996493;8378.706745263886;8460.323174146115;8500.872486912702;8520.977482702054;8624.353173511949;5057.266696329012;5220.2430647556275;5224.712640804754;5232.659877107976;5254.710990895499;3309.4373956427467;3362.2098806780386;3649.324874898126;3659.2435630897317;3663.6336366363416;1027.5067967375626;1043.8538604595362;1066.9626563070333;1087.9728006799814;1088.5754555723274;10641.36151830885;10890.074343680797;10924.836127458095;10936.835947460795;10942.45287735618;4409.096135292258;4544.091181763661;4629.213033784265;4655.3947986761505;4686.226772582486;9350.57922393494;9410.294227932796;9416.62333506652;9427.962924078345;9432.292578056673;5204.089284375219;5214.843554693365;5215.6609820361555;5222.712750798667;5237.9476205238225;4268.146370725867;4268.807903644343;4673.626109911199;4771.23660214364;4805.063012712488;3724.5902950675404;3774.981125094357;3824.101336185994;3853.0560012797046;3860.536735591691;1088.4109200567102;1263.7346157307068;1271.2245530226555;1277.8849903508542;1282.1473719976111;827.4993628854456;917.7934964632905;924.3483344242293;929.2983797233046;954.6897258391051;5625.578081643893;5626.381098079208;5794.855128621818;5852.297724273115;5959.374265702038;447.95744404281544;448.44616898130784;455.3147512992924;987.6370608560285;1001.1690297053428;3319.7842140260805;3638.927221455609;3824.2160357126722;3924.3524818404644;3966.2265858157384;9895.505224738734;10236.385816851012;10240.590376385011;10253.025962533697;10276.897231027744;9445.102715242041;10125.898741012643;10202.897971020344;10219.693409197736;10241.129503992244;7412.332890039922;7970.884076229332;7971.441999060126;7977.3618110551015;7987.241212084843;4443;5553.16702494629;5756.280464941882;5895.734691938959;5903.645781253139;7644.197359277196;9259.67591134307;9364.438133711727;9426.104520070583;9441.480718560546;9485.336026478357;9563.09150630689;9571.282153838629;9662.468564228753;9701.320907536405;5507.504324610804;6799.592024478349;6965.930340696731;7103;7284.38082762971;6401.903971440339;7958.84082318362;7979.361651067785;8001.519908805491;8017.438779285628;7064.293570642894;7184;7192.676329565287;7239.601821899846;7303.926960730325;6895.793126206222;7014;7037.683304251219;7043.330883566053;7065;6547.214334279726;6592.373724496165;6676.098726672031;6677.599344039373;6696.799096027127;4815.494373090775;4834.830780922651;4884.658073934933;4896.632752543503;4914.70511769295;4861.319415281792;4861.683990540745;4889.779959901742;4958.859462323614;4962.627802914723 05:52:00 INFO - PROCESS | 2101 | |4;prototype.html;268.4871894681159;297.73650319467265;311.2887053083704;313.4733647472246;315.98568594810655;4744.33579298898;5338.786448542063;5484.177373393993;5524.944750552499;5580.233342493816;4476.462824461061;4544.477385100715;4903.170377178476;5196.688198708081;5279.706471914376;3096;3415.7608967372294;3752.748350989405;4175.457190565222;4198.6850986176005;3158.6051743532057;3627.6372362763645;3655.7204978257664;3951.7826519541413;4202.747835129887;3132.9661211800167;4041.2721413046074;4099.3031184698675;4108.753474791507;4116.0327323079055;3394.5587073680263;4064.8983775405554;4118.094019315746;4119.938200926988;4134.415990006246;3010.7741919356135;3530.5763308402898;3568;3593.8382772775026;3594.3350480161253;4286.7856607169515;5136.64043516954;5308.283381743454;5330.307060082203;5443.319585051869;4101.938470922939;4558.430196225472;4708.693934894221;4710.152172608929;4721.740304283263;5512.145617429264;5779.884402311972;5807.970960145172;5821.584042622307;5849.415058494159;3271.3947919634943;3627.4196128619296;3784.7161462890117;3896.3181443247604;3899.161680238734;5763.625364351304;6058.727357268934;6068.514518838482;6097.42074502926;6127.863692007877;3957.6635985940943;3971.6624086952934;3972.0268534209304;3992.2215168041953;3994.121293315466;3159.273367125574;3880.534335879656;4019.4975628046495;4028.751087162989;4053.1691003344245;4636.721796692142;4655.37152484417;4678.976605117021;4689.038747056845;4696.553827386393;5796.13091519692;5798;5811.302643682785;5822.7670893163795;5840.211571437886;1250.3870007689977;1288.8646692097382;1328.9003324750681;1339.8794108530278;1356.66761643398;794.922879498283;812.6424373275858;911.4732822522249;924.9086078427385;925.8287216864901;4552.476465206543;4705;5197.58419326453;5343.358796944314;5392.975334686397;5650.067738823131;5887.76448942046;5911.674857882857;5937.228160339215;5948.483136800089;4603.194440972883;5072.239164125411;5378.327709036371;5392.703401312965;5395.541378982752;2558.411565339982;2571.85854777989;2580.7935365170742;2673.772729317991;2681.3241723922547;4158.625723684883;4348.608625223682;4691.006322313004;5172.560332371715;5243.003829272426;4119.237940980868;4124.8143833527565;4317.740935543878;4977;5079.771410286546;4228.70399072062;4455.821767129279;4646.581807637396;4714.976425117852;5011.346255735599;4371.803268852973;4389.209942210305;4551.499335073073;4885.1450996076255;4968.751562421937;4368.366586844953;4647.9767601161775;4675.6259499239295;4680.472544825756;4704.600108990638;5863.501602363847;6183.876322473615;6258.746851133497;6261.311255761953;6266.937330626635;3779.527559055118;3973.4437178794415;3990.4413382127104;3996.56037835832;4018.1963607278076;5842.766289348378;5961.7615295387695;6081.300650425258;6082.695865206811;6115.969420152871;4960.454350021567;5088.592912566912;5831.533477321889;5852.678102704393;5857.656937225144;5740.971295143498;5816.5055970243;5849;5869.295684517714;5882.94117058841;5308.734563271898;5442.210879422382;5452.773126046766;5744.741486633196;5750.30996280449;4663.906721865475;5781.4218578141845;5859.798741258117;5868.180863932194;6075.326856183266;4940.580050695731;4994.725290108933;5083.923741143812;5734.7132643368495;5748.562859285179 05:52:00 INFO - PROCESS | 2101 | |5;yui.html;736.403513154345;746.3357611725562;781.4881252779425;808.6199486241464;862.2024627219822;14332.283385830706;15068.869834762396;15080.321385537649;15088.622784430394;15143.015703979234;14233.288335583231;14345.139291642508;14358.138511689305;14375.424983000694;14387.568372948828;869.1525762381675;880.828238493494;905.2622112977934;908.9091090890925;929.5770424456856;895.7671005538574;899.8380291547519;900.9233965411336;902.715644571961;903.575319599787;946.0823001688385;948.2224575847807;949.6723630347519;949.9287553433486;953.4184147669915;913.9954300228522;928.2620316848122;938.9014153513886;939.8496240601539;948.1608776233049;691.6783695581579;697.3688811625487;697.7732237022988;701.1411021498624;701.2461603775961;15068.171250581214;15251;15288.617784555363;15301.846981530265;15314.234288285541;13433.126846755027;13616.863831361758;13803.03378763487;13846.376913038937;14151.433942642281;10325.328853624565;11156.274842135235;11596.304221746637;11910.58312959051;11930.642080737593;3718.0704823794053;3746.981265093657;3752.2046075673525;3878.592747761501;3881.6700580450697;95707;96567.03432965651;97798;98419.50790246074;99252;10500.579976800842;10589.947050264853;10676.0391564758;10677.359358438518;10767.515461804238;21284.680729789066;21366.78633213679;21453.67819482709;21463.926803659753;21690;7639.656215470317;7649.847003059907;7653.425993050432;7853.607319633996;7891.092524359658;3732.2162345907664;4321.395004699345;4338.522762496123;4365.869023929287;4403.559644035571;3419.3845107880325;3490.441529355291;3509.5262139610827;3527.7530572859655;3603.963960360415;682.8770821252223;696.0568429777679;703.4196787650209;715.9248278930742;719.9632529157996;625.08425157145;665.1951139121717;672.9615784731939;678.803147087349;687.8555503344254;8975.32685048611;8982.86525702115;9308.767280817898;9392.436453812656;9501.904980950101;643.334149155631;652.6051738698019;662.3872917551246;682.5938566552893;688.1501345837886;4389.934150987738;4579.58033009768;4634.165850146938;4689.460712018094;4700.95299047012;67092.66453667701;68371.3162868375;80808;85686;98760;98196.50901745446;100492;100515;103071;105148;83324;84109;86343.56828215944;87244.12755872487;87505.56247218723;9594.280428967715;9815.36200146988;9821.36161149523;9832.410055396698;9889.752756180866;39809.60190398175;45263.32105018493;46026.38907638217;47808.023997000375;50143.498565013884;62895.05657415051;64195.67902160459;71505.21236969117;73753;80162.19837801547;12162.574309899112;12215.755684886075;12580.433880475217;12989.675258118245;13169.802452963022;11679.708007299545;13856.237906915216;14056.226907520184;14069.085509441853;14325.355359008661;10512.42181680015;11663.88336116628;12991.740165196832;13220.338983051;13356.933215333862;12744.10791244604;13308.324401571805;13563;13649.727005460034;13697.726045478836;12995.220286782824;12995.610131696065;13035.47858085666;13072.477100915858;13254.933725331312;10080.798384032132;10948.452577370941;11061.391623460788;11284.32294062359;11379.772404552028;8994.415363001384;9483.478408687588;11148.331100134017;11424.82862757076;11614.70963225926 05:52:00 INFO - PROCESS | 2101 | __end_tp_report 05:52:00 INFO - PROCESS | 2101 | __start_cc_report 05:52:00 INFO - PROCESS | 2101 | _x_x_mozilla_cycle_collect,367 05:52:00 INFO - PROCESS | 2101 | __end_cc_report 05:52:00 INFO - PROCESS | 2101 | __startTimestamp1477831920029__endTimestamp 05:52:00 INFO - PROCESS | 2101 | 05:52:00 INFO - PROCESS | 2101 | ------- Summary: start ------- 05:52:00 INFO - PROCESS | 2101 | Number of tests: 6 05:52:00 INFO - PROCESS | 2101 | 05:52:00 INFO - PROCESS | 2101 | [#0] dojo.html Cycles:165 Average:5668.25 Median:5869.30 stddev:649.32 (11.1%) stddev-sans-first:624.78 05:52:00 INFO - PROCESS | 2101 | Values: 3326.5 3348.4 3367.3 3380.3 3384.8 5578.4 5624.8 5661.1 5662.8 5710.5 4499.5 4907.9 5288.4 5518.8 5603.9 5134.3 5209.5 5223.5 5224.3 5269.4 5159.3 5221.7 5263.2 5296.5 5315.8 5228.6 5286.1 5290.7 5335.9 5340.3 5124.1 5124.4 5153.0 5190.1 5203.3 5136.3 5137.1 5143.2 5164.5 5174.2 5464.4 5619.0 5640.4 5693.0 5756.8 6017.7 6100.5 6120.5 6133.7 6171.2 6219.5 6225.0 6235.6 6236.7 6258.2 5816.6 5823.3 5833.2 5855.7 5878.6 6130.6 6186.6 6190.5 6231.1 6233.5 6051.9 6103.2 6104.7 6105.0 6117.9 6122.3 6129.2 6179.3 6216.7 6235.6 6087.0 6144.1 6177.9 6191.2 6204.5 6084.5 6104.8 6135.8 6137.7 6138.5 4889.1 4893.1 4894.7 4900.5 4951.2 4327.0 4376.0 4409.2 4426.3 4448.1 4510.0 5584.3 5750.8 5789.9 5790.4 6067.8 6174.6 6222.0 6233.5 6256.3 5773.6 5848.2 5850.9 5861.7 5865.9 5238.4 5310.4 5317.5 5345.9 5364.2 6283.3 6295.7 6299.5 6308.9 6328.1 6164.3 6223.4 6231.6 6239.6 6250.7 6102.5 6155.9 6196.8 6272.9 6307.6 6056.9 6112.0 6132.8 6137.4 6139.6 6198.3 6200.6 6204.0 6208.6 6213.0 5816.9 5865.5 5969.6 6087.6 6098.2 5388.9 5526.7 5855.3 6009.2 6057.1 4447.4 4799.1 5911.3 5971.4 5978.2 5520.6 5869.3 5908.0 6090.4 6100.8 5935.4 6002.2 6002.6 6018.3 6038.2 05:52:00 INFO - PROCESS | 2101 | 05:52:00 INFO - PROCESS | 2101 | [#1] ext.html Cycles:180 Average:69299.81 Median:42171.19 stddev:146699.10 (347.9%) stddev-sans-first:147019.61 05:52:00 INFO - PROCESS | 2101 | Values: 473.1 475.4 521.5 523.2 528.8 39402.6 40998.8 41153.4 43358.3 43569.6 42688.0 42909.6 43115.4 43165.0 43174.4 9462.8 9644.2 9650.6 9658.8 9671.7 9475.9 9494.4 9567.2 9574.1 9596.8 9536.7 9542.8 9562.6 9596.3 9624.3 9499.8 9589.3 9595.5 9601.3 9616.0 9291.9 9296.3 9301.7 9379.2 9390.8 40681.6 40885.2 41117.8 41317.6 41365.2 3456.9 3637.7 3647.6 3676.7 4274.0 29715.6 31346.7 31722.5 31725.8 31852.5 2625.9 2663.8 2734.9 3351.9 3359.5 458835.0 463018.0 464248.0 466845.0 468883.0 61683.1 62037.0 62105.1 62123.0 62309.7 64420.0 64699.0 64785.0 65141.0 65230.3 16192.3 16378.5 16386.3 16425.7 16442.6 12682.0 12682.5 12704.8 12746.6 12757.0 12055.9 16878.1 17251.0 17514.7 17632.7 2738.4 3265.2 3303.3 7044.9 7158.9 732.5 821.8 944.6 1065.5 1067.4 26494.7 30073.7 30714.8 31340.8 31408.1 986.0 1057.1 1155.2 1175.4 1216.0 13284.3 15512.9 15891.0 16013.7 16187.8 624594.0 626927.0 631840.0 634715.0 635847.0 57848.0 58316.7 58359.8 58426.4 58567.0 1355.0 1410.7 1424.6 1425.4 1426.2 30087.0 30741.0 31025.8 31282.7 32007.7 57571.7 58233.4 58266.1 58276.0 58455.0 535058.0 542436.0 542571.0 544078.0 549253.0 43155.8 43279.0 43900.6 43976.8 44176.8 47469.5 47834.0 47869.0 48372.5 48897.5 34132.5 40086.4 40200.6 40941.8 41654.4 39580.6 39969.0 40018.6 40277.2 41212.3 38456.0 38679.0 39081.8 39110.7 39161.8 33676.8 34973.3 35745.6 35798.6 35899.8 25868.9 26138.1 26196.8 26276.2 26888.5 05:52:00 INFO - PROCESS | 2101 | 05:52:00 INFO - PROCESS | 2101 | [#2] jquery.html Cycles:180 Average:33799.89 Median:392.14 stddev:96311.59 (24560.8%) stddev-sans-first:96549.07 05:52:00 INFO - PROCESS | 2101 | Values: 374.5 375.6 380.0 383.0 401.3 15058.0 19531.2 20011.6 20133.9 20364.1 10808.9 11149.4 11720.9 12038.0 12056.9 5122.0 5295.2 5374.6 5385.2 5396.6 3803.4 4064.0 5276.7 5399.8 5682.7 5940.5 6046.7 6052.9 6059.1 6069.7 5804.1 5982.4 6015.8 6016.7 6062.1 5398.7 5800.3 5800.6 5812.3 5820.2 12684.3 13473.6 20455.0 24741.9 25476.4 2133.6 2210.6 2250.9 2418.8 2778.7 9221.6 9363.9 9761.7 9937.9 10372.9 1776.5 1854.4 1857.0 1875.6 1902.7 94645.0 99725.0 110159.4 117862.8 122937.0 9477.9 10714.7 11311.0 11561.4 11791.3 14461.7 14463.1 14467.9 14505.3 14507.3 8130.3 8456.0 8462.5 8520.4 8598.0 8305.6 8349.4 8371.0 8467.8 8488.4 3585.6 4507.7 4516.4 4582.8 4628.9 1539.0 1581.6 1650.6 1901.2 1947.5 765.3 853.0 891.4 957.6 962.9 15916.6 20474.6 20606.8 21579.5 21847.2 809.3 901.4 922.5 975.3 980.2 9247.2 11060.7 11323.2 11348.3 11368.0 563174.0 573733.0 577879.0 578177.3 582323.0 130213.0 132741.0 132874.3 134217.0 136383.0 956.7 972.6 985.6 987.2 996.5 15527.9 18143.0 18519.8 18904.0 19158.9 56917.0 57076.0 57189.7 57794.1 58346.0 71071.6 73453.0 80848.2 81350.2 83402.6 6917.3 7149.9 7301.4 7333.6 7483.2 10577.3 12922.9 13281.8 13508.0 13636.5 10447.8 10818.1 10863.2 11081.0 11261.3 10724.7 11217.3 11294.7 11410.7 11549.5 9530.9 11585.6 11596.8 11673.4 11775.7 6383.7 7295.9 7429.2 7508.1 7644.5 8042.6 11572.5 11602.4 11722.7 11730.1 05:52:00 INFO - PROCESS | 2101 | 05:52:00 INFO - PROCESS | 2101 | [#3] mootools.html Cycles:180 Average:5441.23 Median:4936.78 stddev:2994.74 (60.7%) stddev-sans-first:2988.99 05:52:00 INFO - PROCESS | 2101 | Values: 1568.3 1592.1 1855.6 1919.0 1942.6 7547.3 7807.3 8120.2 8546.4 8560.6 8038.0 8342.2 8351.9 8450.0 8481.7 2281.5 2292.9 2302.3 2302.8 2310.8 2302.5 2323.9 2334.8 2336.4 2338.0 2228.6 2289.6 2304.9 2315.9 2319.2 1778.5 2013.0 2258.3 2276.0 2288.0 2298.2 2303.4 2324.4 2328.5 2328.8 8378.7 8460.3 8500.9 8521.0 8624.4 5057.3 5220.2 5224.7 5232.7 5254.7 3309.4 3362.2 3649.3 3659.2 3663.6 1027.5 1043.9 1067.0 1088.0 1088.6 10641.4 10890.1 10924.8 10936.8 10942.5 4409.1 4544.1 4629.2 4655.4 4686.2 9350.6 9410.3 9416.6 9428.0 9432.3 5204.1 5214.8 5215.7 5222.7 5237.9 4268.1 4268.8 4673.6 4771.2 4805.1 3724.6 3775.0 3824.1 3853.1 3860.5 1088.4 1263.7 1271.2 1277.9 1282.1 827.5 917.8 924.3 929.3 954.7 5625.6 5626.4 5794.9 5852.3 5959.4 448.0 448.4 455.3 987.6 1001.2 3319.8 3638.9 3824.2 3924.4 3966.2 9895.5 10236.4 10240.6 10253.0 10276.9 9445.1 10125.9 10202.9 10219.7 10241.1 7412.3 7970.9 7971.4 7977.4 7987.2 4443.0 5553.2 5756.3 5895.7 5903.6 7644.2 9259.7 9364.4 9426.1 9441.5 9485.3 9563.1 9571.3 9662.5 9701.3 5507.5 6799.6 6965.9 7103.0 7284.4 6401.9 7958.8 7979.4 8001.5 8017.4 7064.3 7184.0 7192.7 7239.6 7303.9 6895.8 7014.0 7037.7 7043.3 7065.0 6547.2 6592.4 6676.1 6677.6 6696.8 4815.5 4834.8 4884.7 4896.6 4914.7 4861.3 4861.7 4889.8 4958.9 4962.6 05:52:00 INFO - PROCESS | 2101 | 05:52:00 INFO - PROCESS | 2101 | [#4] prototype.html Cycles:180 Average:4463.05 Median:4706.85 stddev:1419.40 (30.2%) stddev-sans-first:1388.03 05:52:00 INFO - PROCESS | 2101 | Values: 268.5 297.7 311.3 313.5 316.0 4744.3 5338.8 5484.2 5524.9 5580.2 4476.5 4544.5 4903.2 5196.7 5279.7 3096.0 3415.8 3752.7 4175.5 4198.7 3158.6 3627.6 3655.7 3951.8 4202.7 3133.0 4041.3 4099.3 4108.8 4116.0 3394.6 4064.9 4118.1 4119.9 4134.4 3010.8 3530.6 3568.0 3593.8 3594.3 4286.8 5136.6 5308.3 5330.3 5443.3 4101.9 4558.4 4708.7 4710.2 4721.7 5512.1 5779.9 5808.0 5821.6 5849.4 3271.4 3627.4 3784.7 3896.3 3899.2 5763.6 6058.7 6068.5 6097.4 6127.9 3957.7 3971.7 3972.0 3992.2 3994.1 3159.3 3880.5 4019.5 4028.8 4053.2 4636.7 4655.4 4679.0 4689.0 4696.6 5796.1 5798.0 5811.3 5822.8 5840.2 1250.4 1288.9 1328.9 1339.9 1356.7 794.9 812.6 911.5 924.9 925.8 4552.5 4705.0 5197.6 5343.4 5393.0 5650.1 5887.8 5911.7 5937.2 5948.5 4603.2 5072.2 5378.3 5392.7 5395.5 2558.4 2571.9 2580.8 2673.8 2681.3 4158.6 4348.6 4691.0 5172.6 5243.0 4119.2 4124.8 4317.7 4977.0 5079.8 4228.7 4455.8 4646.6 4715.0 5011.3 4371.8 4389.2 4551.5 4885.1 4968.8 4368.4 4648.0 4675.6 4680.5 4704.6 5863.5 6183.9 6258.7 6261.3 6266.9 3779.5 3973.4 3990.4 3996.6 4018.2 5842.8 5961.8 6081.3 6082.7 6116.0 4960.5 5088.6 5831.5 5852.7 5857.7 5741.0 5816.5 5849.0 5869.3 5882.9 5308.7 5442.2 5452.8 5744.7 5750.3 4663.9 5781.4 5859.8 5868.2 6075.3 4940.6 4994.7 5083.9 5734.7 5748.6 05:52:00 INFO - PROCESS | 2101 | 05:52:00 INFO - PROCESS | 2101 | [#5] yui.html Cycles:180 Average:19988.54 Median:25302.98 stddev:28665.70 (113.3%) stddev-sans-first:28709.67 05:52:00 INFO - PROCESS | 2101 | Values: 736.4 746.3 781.5 808.6 862.2 14332.3 15068.9 15080.3 15088.6 15143.0 14233.3 14345.1 14358.1 14375.4 14387.6 869.2 880.8 905.3 908.9 929.6 895.8 899.8 900.9 902.7 903.6 946.1 948.2 949.7 949.9 953.4 914.0 928.3 938.9 939.8 948.2 691.7 697.4 697.8 701.1 701.2 15068.2 15251.0 15288.6 15301.8 15314.2 13433.1 13616.9 13803.0 13846.4 14151.4 10325.3 11156.3 11596.3 11910.6 11930.6 3718.1 3747.0 3752.2 3878.6 3881.7 95707.0 96567.0 97798.0 98419.5 99252.0 10500.6 10589.9 10676.0 10677.4 10767.5 21284.7 21366.8 21453.7 21463.9 21690.0 7639.7 7649.8 7653.4 7853.6 7891.1 3732.2 4321.4 4338.5 4365.9 4403.6 3419.4 3490.4 3509.5 3527.8 3604.0 682.9 696.1 703.4 715.9 720.0 625.1 665.2 673.0 678.8 687.9 8975.3 8982.9 9308.8 9392.4 9501.9 643.3 652.6 662.4 682.6 688.2 4389.9 4579.6 4634.2 4689.5 4701.0 67092.7 68371.3 80808.0 85686.0 98760.0 98196.5 100492.0 100515.0 103071.0 105148.0 83324.0 84109.0 86343.6 87244.1 87505.6 9594.3 9815.4 9821.4 9832.4 9889.8 39809.6 45263.3 46026.4 47808.0 50143.5 62895.1 64195.7 71505.2 73753.0 80162.2 12162.6 12215.8 12580.4 12989.7 13169.8 11679.7 13856.2 14056.2 14069.1 14325.4 10512.4 11663.9 12991.7 13220.3 13356.9 12744.1 13308.3 13563.0 13649.7 13697.7 12995.2 12995.6 13035.5 13072.5 13254.9 10080.8 10948.5 11061.4 11284.3 11379.8 8994.4 9483.5 11148.3 11424.8 11614.7 05:52:00 INFO - PROCESS | 2101 | -------- Summary: end -------- 05:52:00 INFO - PROCESS | 2101 | 05:52:00 INFO - TEST-INFO | 2101: exit 0 05:52:00 INFO - TEST-OK | dromaeo_css | took 1116238ms 05:52:00 INFO - TEST-START | kraken 05:52:00 INFO - operating with platform_type : mac_ 05:52:00 INFO - Initialising browser for kraken test... 05:52:00 INFO - TEST-INFO | started process 2106 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpAroPJ9/profile http://localhost:49374/getInfo.html) 05:52:03 INFO - PROCESS | 2106 | 2016-10-30 05:52:03.223 plugin-container[2108:26388] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b4b, name = 'com.apple.tsm.portname' 05:52:03 INFO - PROCESS | 2106 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:52:03 INFO - PROCESS | 2106 | 2016-10-30 05:52:03.223 plugin-container[2108:26388] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 05:52:03 INFO - PROCESS | 2106 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:52:03 INFO - PROCESS | 2106 | 2016-10-30 05:52:03.223 plugin-container[2108:26388] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:52:03 INFO - PROCESS | 2106 | __metrics Screen width/height:1600/1200 05:52:03 INFO - PROCESS | 2106 | colorDepth:24 05:52:03 INFO - PROCESS | 2106 | Browser inner width/height: 1024/689 05:52:03 INFO - PROCESS | 2106 | __metrics 05:52:03 ERROR - PROCESS | 2106 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3131: TypeError: this.tabs is undefined 05:52:04 INFO - TEST-INFO | 2106: exit 0 05:52:04 INFO - Browser initialized. 05:52:04 INFO - Running cycle 1/1 for kraken test... 05:52:04 INFO - TEST-INFO | started process 2109 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/T/tmpAroPJ9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:52:06 INFO - PROCESS | 2109 | 2016-10-30 05:52:06.800 plugin-container[2110:26509] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 05:52:06 INFO - PROCESS | 2109 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:52:06 INFO - PROCESS | 2109 | 2016-10-30 05:52:06.801 plugin-container[2110:26509] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 05:52:06 INFO - PROCESS | 2109 | See /usr/include/servers/bootstrap_defs.h for the error codes. 05:52:06 INFO - PROCESS | 2109 | 2016-10-30 05:52:06.801 plugin-container[2110:26509] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 05:52:16 INFO - PROCESS | 2109 | RSS: Main: 238055424 05:52:16 INFO - PROCESS | 2109 | 05:52:18 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:19 INFO - PROCESS | 2109 | RSS: Main: 250544128 05:52:19 INFO - PROCESS | 2109 | 05:52:22 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-dft) 05:52:23 INFO - PROCESS | 2109 | RSS: Main: 258265088 05:52:23 INFO - PROCESS | 2109 | 05:52:26 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-fft) 05:52:27 INFO - PROCESS | 2109 | RSS: Main: 260984832 05:52:27 INFO - PROCESS | 2109 | 05:52:29 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49374/tests/kraken/driver.html?testName=audio-oscillator) 05:52:29 INFO - PROCESS | 2109 | RSS: Main: 263270400 05:52:29 INFO - PROCESS | 2109 | 05:52:31 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:32 INFO - PROCESS | 2109 | RSS: Main: 263614464 05:52:32 INFO - PROCESS | 2109 | 05:52:35 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:36 INFO - PROCESS | 2109 | RSS: Main: 263872512 05:52:36 INFO - PROCESS | 2109 | 05:52:39 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49374/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:39 INFO - PROCESS | 2109 | RSS: Main: 264048640 05:52:39 INFO - PROCESS | 2109 | 05:52:42 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49374/tests/kraken/driver.html?testName=json-parse-financial) 05:52:43 INFO - PROCESS | 2109 | RSS: Main: 264790016 05:52:43 INFO - PROCESS | 2109 | 05:52:45 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49374/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:45 INFO - PROCESS | 2109 | RSS: Main: 264232960 05:52:45 INFO - PROCESS | 2109 | 05:52:47 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:48 INFO - PROCESS | 2109 | RSS: Main: 264306688 05:52:48 INFO - PROCESS | 2109 | 05:52:50 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:51 INFO - PROCESS | 2109 | RSS: Main: 264335360 05:52:51 INFO - PROCESS | 2109 | 05:52:54 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:55 INFO - PROCESS | 2109 | RSS: Main: 264699904 05:52:55 INFO - PROCESS | 2109 | 05:52:57 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:58 INFO - PROCESS | 2109 | RSS: Main: 264687616 05:52:58 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | Cycle 1(1): loaded http://localhost:49374/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49374/tests/kraken/driver.html?testName=ai-astar) 05:53:00 INFO - PROCESS | 2109 | RSS: Main: 265965568 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | __start_tp_report 05:53:00 INFO - PROCESS | 2109 | _x_x_mozilla_page_load 05:53:00 INFO - PROCESS | 2109 | _x_x_mozilla_page_load_details 05:53:00 INFO - PROCESS | 2109 | |i|pagename|runs| 05:53:00 INFO - PROCESS | 2109 | |0;ai-astar;105;120;117;117;118;117;118;116;119;118 05:53:00 INFO - PROCESS | 2109 | |1;audio-beat-detection;148;116;120;172;149;119;113;119;145;116 05:53:00 INFO - PROCESS | 2109 | |2;audio-dft;192;230;261;232;200;200;198;197;210;199 05:53:00 INFO - PROCESS | 2109 | |3;audio-fft;85;62;60;85;62;61;61;60;79;63 05:53:00 INFO - PROCESS | 2109 | |4;audio-oscillator;88;82;90;105;100;65;117;100;103;109 05:53:00 INFO - PROCESS | 2109 | |5;imaging-gaussian-blur;89;75;131;132;138;86;91;87;88;86 05:53:00 INFO - PROCESS | 2109 | |6;imaging-darkroom;134;113;96;95;95;95;95;155;152;95 05:53:00 INFO - PROCESS | 2109 | |7;imaging-desaturate;138;142;93;84;86;89;90;89;90;102 05:53:00 INFO - PROCESS | 2109 | |8;json-parse-financial;54;63;92;91;93;91;88;52;53;80 05:53:00 INFO - PROCESS | 2109 | |9;json-stringify-tinderbox;66;76;75;79;76;77;60;68;76;107 05:53:00 INFO - PROCESS | 2109 | |10;stanford-crypto-aes;91;89;89;90;91;96;79;104;114;110 05:53:00 INFO - PROCESS | 2109 | |11;stanford-crypto-ccm;160;152;162;155;185;144;154;162;202;149 05:53:00 INFO - PROCESS | 2109 | |12;stanford-crypto-pbkdf2;161;181;174;174;174;183;172;170;171;174 05:53:00 INFO - PROCESS | 2109 | |13;stanford-crypto-sha256-iterative;68;67;68;68;70;67;68;68;70;68 05:53:00 INFO - PROCESS | 2109 | __end_tp_report 05:53:00 INFO - PROCESS | 2109 | __start_cc_report 05:53:00 INFO - PROCESS | 2109 | _x_x_mozilla_cycle_collect,967 05:53:00 INFO - PROCESS | 2109 | __end_cc_report 05:53:00 INFO - PROCESS | 2109 | __startTimestamp1477831980506__endTimestamp 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | ------- Summary: start ------- 05:53:00 INFO - PROCESS | 2109 | Number of tests: 14 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#0] ai-astar Cycles:10 Average:116.50 Median:118.00 stddev:4.20 (3.6%) stddev-sans-first:1.20 05:53:00 INFO - PROCESS | 2109 | Values: 105.0 120.0 117.0 117.0 118.0 117.0 118.0 116.0 119.0 118.0 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#1] audio-beat-detection Cycles:10 Average:131.70 Median:132.50 stddev:20.19 (15.2%) stddev-sans-first:20.53 05:53:00 INFO - PROCESS | 2109 | Values: 148.0 116.0 120.0 172.0 149.0 119.0 113.0 119.0 145.0 116.0 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#2] audio-dft Cycles:10 Average:211.90 Median:205.00 stddev:22.13 (10.8%) stddev-sans-first:22.27 05:53:00 INFO - PROCESS | 2109 | Values: 192.0 230.0 261.0 232.0 200.0 200.0 198.0 197.0 210.0 199.0 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#3] audio-fft Cycles:10 Average:67.80 Median:62.50 stddev:10.65 (17.0%) stddev-sans-first:9.31 05:53:00 INFO - PROCESS | 2109 | Values: 85.0 62.0 60.0 85.0 62.0 61.0 61.0 60.0 79.0 63.0 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:91.00 stddev:15.01 (16.5%) stddev-sans-first:15.65 05:53:00 INFO - PROCESS | 2109 | Values: 88.0 82.0 90.0 105.0 100.0 65.0 117.0 100.0 103.0 109.0 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#5] imaging-gaussian-blur Cycles:10 Average:100.30 Median:86.50 stddev:23.48 (27.1%) stddev-sans-first:24.54 05:53:00 INFO - PROCESS | 2109 | Values: 89.0 75.0 131.0 132.0 138.0 86.0 91.0 87.0 88.0 86.0 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#6] imaging-darkroom Cycles:10 Average:112.50 Median:95.00 stddev:25.02 (26.3%) stddev-sans-first:25.30 05:53:00 INFO - PROCESS | 2109 | Values: 134.0 113.0 96.0 95.0 95.0 95.0 95.0 155.0 152.0 95.0 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#7] imaging-desaturate Cycles:10 Average:100.30 Median:89.00 stddev:21.48 (24.1%) stddev-sans-first:17.94 05:53:00 INFO - PROCESS | 2109 | Values: 138.0 142.0 93.0 84.0 86.0 89.0 90.0 89.0 90.0 102.0 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#8] json-parse-financial Cycles:10 Average:75.70 Median:89.50 stddev:17.99 (20.1%) stddev-sans-first:17.28 05:53:00 INFO - PROCESS | 2109 | Values: 54.0 63.0 92.0 91.0 93.0 91.0 88.0 52.0 53.0 80.0 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#9] json-stringify-tinderbox Cycles:10 Average:76.00 Median:76.00 stddev:12.44 (16.4%) stddev-sans-first:12.65 05:53:00 INFO - PROCESS | 2109 | Values: 66.0 76.0 75.0 79.0 76.0 77.0 60.0 68.0 76.0 107.0 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#10] stanford-crypto-aes Cycles:10 Average:95.30 Median:89.50 stddev:10.81 (12.1%) stddev-sans-first:11.36 05:53:00 INFO - PROCESS | 2109 | Values: 91.0 89.0 89.0 90.0 91.0 96.0 79.0 104.0 114.0 110.0 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#11] stanford-crypto-ccm Cycles:10 Average:162.50 Median:161.00 stddev:17.75 (11.0%) stddev-sans-first:18.81 05:53:00 INFO - PROCESS | 2109 | Values: 160.0 152.0 162.0 155.0 185.0 144.0 154.0 162.0 202.0 149.0 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.40 Median:174.00 stddev:6.00 (3.5%) stddev-sans-first:4.38 05:53:00 INFO - PROCESS | 2109 | Values: 161.0 181.0 174.0 174.0 174.0 183.0 172.0 170.0 171.0 174.0 05:53:00 INFO - PROCESS | 2109 | 05:53:00 INFO - PROCESS | 2109 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.20 Median:68.00 stddev:1.03 (1.5%) stddev-sans-first:1.09 05:53:00 INFO - PROCESS | 2109 | Values: 68.0 67.0 68.0 68.0 70.0 67.0 68.0 68.0 70.0 68.0 05:53:00 INFO - PROCESS | 2109 | -------- Summary: end -------- 05:53:00 INFO - PROCESS | 2109 | 05:53:01 INFO - TEST-INFO | 2109: exit 0 05:53:01 INFO - TEST-OK | kraken | took 60708ms 05:53:01 INFO - SUITE-END | took 1176s 05:53:01 INFO - Completed test suite (00:19:37) 05:53:01 INFO - javascript benchmark 05:53:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7168.622108869913, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3326.501024846273, 3348.4475061614835, 3367.276035652335, 3380.2901390707934, 3384.8476818543163, 5578.442155784424, 5624.775008999635, 5661.065924122515, 5662.801801936933, 5710.457506536883, 4499.505054444016, 4907.8711896263885, 5288.444713305105, 5518.751656175472, 5603.887922241553, 5134.332536770224, 5209.479052094779, 5223.529882310591, 5224.268602395668, 5269.394019687727, 5159.32928719266, 5221.71280579568, 5263.1578947368425, 5296.549793267577, 5315.840524784263, 5228.581713462933, 5286.10136276832, 5290.656107353029, 5335.946640533603, 5340.305760251162, 5124.0776660201145, 5124.410692770304, 5152.9742351288005, 5190.091733946544, 5203.297554830087, 5136.332276804029, 5137.126688462933, 5143.202803565453, 5164.535191832753, 5174.197999310113, 5464.398916119224, 5618.988442897974, 5640.379558248589, 5693.0, 5756.769729210827, 6017.69911504423, 6100.490342048325, 6120.477608373095, 6133.6626485543275, 6171.166892469504, 6219.47134493564, 6225.039112679491, 6235.594686345373, 6236.688165591702, 6258.249010118815, 5816.5928385013485, 5823.272090988627, 5833.212516310328, 5855.707214639251, 5878.61788983719, 6130.581587307925, 6186.628802271878, 6190.535709821781, 6231.065340198916, 6233.501319894398, 6051.939480605138, 6103.155845961415, 6104.732011601517, 6105.035213715927, 6117.857853872152, 6122.326544080148, 6129.172561704202, 6179.3202747697715, 6216.689165541705, 6235.563510554309, 6086.995645718407, 6144.078388241799, 6177.938220617736, 6191.164192834, 6204.503639708812, 6084.5436592255755, 6104.7926496150985, 6135.785247516315, 6137.723802428812, 6138.478229350555, 4889.071076495455, 4893.119238537098, 4894.706317620954, 4900.509949005071, 4951.232558953368, 4327.0, 4375.993521490075, 4409.162259170747, 4426.291793313055, 4448.110377924428, 4509.977450112794, 5584.301962254718, 5750.7987220447085, 5789.942100579025, 5790.449907258803, 6067.817965461043, 6174.629522228681, 6221.96889015552, 6233.532485063638, 6256.311805701369, 5773.566982476331, 5848.152017957373, 5850.853728656818, 5861.70691465425, 5865.941340586625, 5238.449962753933, 5310.415854256029, 5317.468253174651, 5345.946540534623, 5364.249005139283, 6283.277423096311, 6295.748170073146, 6299.464545513682, 6308.936910630835, 6328.082428047999, 6164.260288765377, 6223.408776166257, 6231.626102433868, 6239.625622462667, 6250.718717657625, 6102.511799055976, 6155.938440615537, 6196.783112591038, 6272.905906411316, 6307.621542707452, 6056.90914636272, 6111.95640283616, 6132.84504737327, 6137.407629318989, 6139.614800607318, 6198.256209254918, 6200.627962322275, 6204.0, 6208.627482351073, 6213.0, 5816.8947899898885, 5865.472107510344, 5969.641821490724, 6087.634741915499, 6098.237720284965, 5388.892222155613, 5526.723663816873, 5855.268091488564, 6009.188759517584, 6057.091436284416, 4447.444069491314, 4799.088173247072, 5911.3201981772645, 5971.4327138921735, 5978.222831031938, 5520.641158324696, 5869.295684517885, 5908.0, 6090.421409966046, 6100.786472473442, 5935.436133567304, 6002.159697642421, 6002.639841609517, 6018.337982821974, 6038.154658347747], "value": 5627.947151228387, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.14124863372973, 475.4342332624178, 521.4576840086311, 523.2360753300181, 528.7858417340979, 39402.605973940255, 40998.795006024964, 41153.38269925946, 43358.349624755654, 43569.56430435694, 42688.0, 42909.57090429095, 43115.35326970098, 43165.0, 43174.35238471426, 9462.810743785138, 9644.22846172308, 9650.613975440974, 9658.758531036745, 9671.709848704515, 9475.905240947606, 9494.430334179937, 9567.186789122932, 9574.090461406155, 9596.808063838718, 9536.666216682417, 9542.80914381712, 9562.56968436422, 9596.28027897907, 9624.326297159201, 9499.81000379992, 9589.328746987714, 9595.520223988773, 9601.327907046509, 9615.951920240354, 9291.907080929239, 9296.256299496024, 9301.72094837156, 9379.202767764747, 9390.765230869214, 40681.59318406808, 40885.18229635421, 41117.79441102805, 41317.58682413167, 41365.1726965462, 3456.879009234665, 3637.6726094651344, 3647.598764135943, 3676.6507181817683, 4273.957260427418, 29715.554266686016, 31346.686533134605, 31722.524162137586, 31725.84137079323, 31852.522212166838, 2625.9474810503684, 2663.840169589831, 2734.931626709348, 3351.8659253629826, 3359.5464612277274, 458835.0, 463018.0, 464248.0, 466845.0, 468883.0, 61683.074753878725, 62037.0, 62105.06842397367, 62123.0, 62309.68845155745, 64420.0, 64699.0, 64785.0, 65141.02288465677, 65230.34769652338, 16192.271347789378, 16378.50864474044, 16386.344546218257, 16425.67148657044, 16442.588935276475, 12682.0, 12682.49270029207, 12704.809427858405, 12746.553870614483, 12757.043221758406, 12055.939720301518, 16878.07170605604, 17251.0, 17514.737278940825, 17632.735508967377, 2738.3838636306673, 3265.248992731685, 3303.339332133583, 7044.894326585106, 7158.856822863513, 732.5128789355019, 821.8191997760483, 944.5985456181232, 1065.4992153687908, 1067.402254737334, 26494.735052649612, 30073.69926300753, 30714.84642576773, 31340.84329578383, 31408.05775826729, 985.9654912078042, 1057.1173070486077, 1155.191366043756, 1175.4416652090188, 1216.0482425706791, 13284.269365184815, 15512.92243538775, 15891.0, 16013.679726405406, 16187.757183642254, 624594.0, 626927.0, 631840.0, 634715.0, 635847.0, 57848.0, 58316.708416457644, 58359.83280334369, 58426.4157358421, 58567.0, 1354.9932250338882, 1410.7037522120265, 1424.5583869000643, 1425.4227038049398, 1426.187073368191, 30087.0, 30741.0, 31025.844870776404, 31282.68717312798, 32007.679923201402, 57571.71214143903, 58233.4176658228, 58266.126008109066, 58276.0, 58455.0, 535058.0, 542436.0, 542571.0, 544078.0, 549253.0, 43155.78422107995, 43279.0, 43900.56099439092, 43976.78011609922, 44176.77911610421, 47469.52530474651, 47834.04331913412, 47869.0, 48372.516274838206, 48897.51102489072, 34132.488012679336, 40086.39870401888, 40200.597994019685, 40941.77174684764, 41654.37518437165, 39580.60419395769, 39969.0, 40018.599814001485, 40277.231469356804, 41212.26059003133, 38456.0, 38679.03302417462, 39081.80459097686, 39110.69782323999, 39161.804190978866, 33676.831615841766, 34973.300533988666, 35745.64254357527, 35798.642013579534, 35899.82050089837, 25868.870655646602, 26138.085167019064, 26196.821143048226, 26276.21171364862, 26888.462230755667], "value": 20133.4186557976, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.51313292719476, 375.59811002227616, 380.01386402286073, 382.9674477669398, 401.3037380145449, 15058.0, 19531.21875124995, 20011.599768004668, 20133.899330503344, 20364.08361623727, 10808.891911080887, 11149.386783726892, 11720.941395293034, 12038.0, 12056.879431205685, 5121.9743901280535, 5295.152775555912, 5374.6237763356385, 5385.246065550826, 5396.595255355864, 3803.410471376927, 4063.9593604063875, 5276.683398996053, 5399.784008639669, 5682.744276507547, 5940.52475801937, 6046.6999595087045, 6052.878942421149, 6059.091136329564, 6069.666168360738, 5804.129380592903, 5982.401759824004, 6015.789447369365, 6016.669083200422, 6062.120992456091, 5398.703071331075, 5800.274965629296, 5800.636850340166, 5812.302523697141, 5820.185174075633, 12684.30236337001, 13473.595792126252, 20454.977251137385, 24741.87629061843, 25476.36309092269, 2133.5732853429377, 2210.6462965925534, 2250.9212177573704, 2418.794402475774, 2778.7082356352494, 9221.585028673726, 9363.906360936371, 9761.658341957997, 9937.90062099377, 10372.94813525935, 1776.4759395978217, 1854.4343975087593, 1857.0, 1875.6436277107307, 1902.7431296775035, 94645.0, 99725.0, 110159.44920275347, 117862.82137178605, 122937.0, 9477.857832132524, 10714.73213169677, 11311.0, 11561.42192890352, 11791.29252244851, 14461.710765784625, 14463.13221206731, 14467.914906382064, 14505.274736263145, 14507.347169377403, 8130.268275855202, 8456.0, 8462.492250464991, 8520.403571749917, 8598.0, 8305.626246818907, 8349.373796965252, 8371.0, 8467.83064338722, 8488.405811593253, 3585.5697316322207, 4507.729536227836, 4516.367708520744, 4582.839600614029, 4628.930566041512, 1538.96152596186, 1581.5887869154103, 1650.6286085630636, 1901.2300018492533, 1947.5033866363985, 765.2959277464746, 852.9957350213209, 891.4072142025481, 957.5978089202551, 962.9181519570915, 15916.602084947968, 20474.590508189754, 20606.793932060787, 21579.460513486974, 21847.235346762787, 809.3498322565273, 901.4005686218591, 922.5341202692597, 975.331897650112, 980.1864452504404, 9247.213986811063, 11060.728016278232, 11323.207375483636, 11348.262362946381, 11367.976882080653, 563174.0, 573733.0, 577879.0, 578177.3273400902, 582323.0, 130213.0, 132741.0, 132874.33562832125, 134217.0, 136383.0, 956.660385563129, 972.5651031297307, 985.571276494727, 987.2052997337213, 996.4569309726072, 15527.922360388578, 18143.002134882707, 18519.814801851808, 18904.0, 19158.946257955948, 56917.0, 57076.0, 57189.71405142947, 57794.13308800456, 58346.0, 71071.64464177853, 73453.0, 80848.19151808407, 81350.18649813662, 83402.58298708468, 6917.342852429011, 7149.8540642117305, 7301.4158867289425, 7333.559986400833, 7483.176850546327, 10577.31247468912, 12922.901553368069, 13281.80077298822, 13508.0, 13636.454541818217, 10447.843282350923, 10818.080463160719, 10863.197880741676, 11081.002709755838, 11261.324320540794, 10724.678259652223, 11217.326960382403, 11294.717632059264, 11410.657680269605, 11549.538018479503, 9530.85703714431, 11585.594504192313, 11596.826047609124, 11673.357965311989, 11775.705607359885, 6383.712732926937, 7295.8540829184185, 7429.182789893, 7508.0990281166605, 7644.541327520366, 8042.597870106589, 11572.537098515964, 11602.361870096887, 11722.70693232676, 11730.12024098179], "value": 9126.794789057953, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1568.2550788375522, 1592.0686398456903, 1855.6103218324151, 1919.04047976012, 1942.5629233422474, 7547.283008114234, 7807.336376407998, 8120.187981201884, 8546.359023073263, 8560.571971401429, 8038.0, 8342.207490288412, 8351.874721879176, 8450.028246751626, 8481.660733570665, 2281.4638559938403, 2292.8509646872985, 2302.297799171252, 2302.804261637763, 2310.780475854791, 2302.5279817637343, 2323.8721870297127, 2334.8365614407, 2336.4158960259933, 2337.9532409351805, 2228.6211344071467, 2289.6222123349626, 2304.9308520744403, 2315.8610483370967, 2319.1651005637955, 1778.5020194345605, 2012.9935032483759, 2258.3225032490186, 2275.954480910389, 2287.965680514802, 2298.230092918874, 2303.4126297794123, 2324.407276144589, 2328.4528135888054, 2328.8253380996493, 8378.706745263886, 8460.323174146115, 8500.872486912702, 8520.977482702054, 8624.353173511949, 5057.266696329012, 5220.2430647556275, 5224.712640804754, 5232.659877107976, 5254.710990895499, 3309.4373956427467, 3362.2098806780386, 3649.324874898126, 3659.2435630897317, 3663.6336366363416, 1027.5067967375626, 1043.8538604595362, 1066.9626563070333, 1087.9728006799814, 1088.5754555723274, 10641.36151830885, 10890.074343680797, 10924.836127458095, 10936.835947460795, 10942.45287735618, 4409.096135292258, 4544.091181763661, 4629.213033784265, 4655.3947986761505, 4686.226772582486, 9350.57922393494, 9410.294227932796, 9416.62333506652, 9427.962924078345, 9432.292578056673, 5204.089284375219, 5214.843554693365, 5215.6609820361555, 5222.712750798667, 5237.9476205238225, 4268.146370725867, 4268.807903644343, 4673.626109911199, 4771.23660214364, 4805.063012712488, 3724.5902950675404, 3774.981125094357, 3824.101336185994, 3853.0560012797046, 3860.536735591691, 1088.4109200567102, 1263.7346157307068, 1271.2245530226555, 1277.8849903508542, 1282.1473719976111, 827.4993628854456, 917.7934964632905, 924.3483344242293, 929.2983797233046, 954.6897258391051, 5625.578081643893, 5626.381098079208, 5794.855128621818, 5852.297724273115, 5959.374265702038, 447.95744404281544, 448.44616898130784, 455.3147512992924, 987.6370608560285, 1001.1690297053428, 3319.7842140260805, 3638.927221455609, 3824.2160357126722, 3924.3524818404644, 3966.2265858157384, 9895.505224738734, 10236.385816851012, 10240.590376385011, 10253.025962533697, 10276.897231027744, 9445.102715242041, 10125.898741012643, 10202.897971020344, 10219.693409197736, 10241.129503992244, 7412.332890039922, 7970.884076229332, 7971.441999060126, 7977.3618110551015, 7987.241212084843, 4443.0, 5553.16702494629, 5756.280464941882, 5895.734691938959, 5903.645781253139, 7644.197359277196, 9259.67591134307, 9364.438133711727, 9426.104520070583, 9441.480718560546, 9485.336026478357, 9563.09150630689, 9571.282153838629, 9662.468564228753, 9701.320907536405, 5507.504324610804, 6799.592024478349, 6965.930340696731, 7103.0, 7284.38082762971, 6401.903971440339, 7958.84082318362, 7979.361651067785, 8001.519908805491, 8017.438779285628, 7064.293570642894, 7184.0, 7192.676329565287, 7239.601821899846, 7303.926960730325, 6895.793126206222, 7014.0, 7037.683304251219, 7043.330883566053, 7065.0, 6547.214334279726, 6592.373724496165, 6676.098726672031, 6677.599344039373, 6696.799096027127, 4815.494373090775, 4834.830780922651, 4884.658073934933, 4896.632752543503, 4914.70511769295, 4861.319415281792, 4861.683990540745, 4889.779959901742, 4958.859462323614, 4962.627802914723], "value": 4387.167863007929, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.4871894681159, 297.73650319467265, 311.2887053083704, 313.4733647472246, 315.98568594810655, 4744.33579298898, 5338.786448542063, 5484.177373393993, 5524.944750552499, 5580.233342493816, 4476.462824461061, 4544.477385100715, 4903.170377178476, 5196.688198708081, 5279.706471914376, 3096.0, 3415.7608967372294, 3752.748350989405, 4175.457190565222, 4198.6850986176005, 3158.6051743532057, 3627.6372362763645, 3655.7204978257664, 3951.7826519541413, 4202.747835129887, 3132.9661211800167, 4041.2721413046074, 4099.3031184698675, 4108.753474791507, 4116.0327323079055, 3394.5587073680263, 4064.8983775405554, 4118.094019315746, 4119.938200926988, 4134.415990006246, 3010.7741919356135, 3530.5763308402898, 3568.0, 3593.8382772775026, 3594.3350480161253, 4286.7856607169515, 5136.64043516954, 5308.283381743454, 5330.307060082203, 5443.319585051869, 4101.938470922939, 4558.430196225472, 4708.693934894221, 4710.152172608929, 4721.740304283263, 5512.145617429264, 5779.884402311972, 5807.970960145172, 5821.584042622307, 5849.415058494159, 3271.3947919634943, 3627.4196128619296, 3784.7161462890117, 3896.3181443247604, 3899.161680238734, 5763.625364351304, 6058.727357268934, 6068.514518838482, 6097.42074502926, 6127.863692007877, 3957.6635985940943, 3971.6624086952934, 3972.0268534209304, 3992.2215168041953, 3994.121293315466, 3159.273367125574, 3880.534335879656, 4019.4975628046495, 4028.751087162989, 4053.1691003344245, 4636.721796692142, 4655.37152484417, 4678.976605117021, 4689.038747056845, 4696.553827386393, 5796.13091519692, 5798.0, 5811.302643682785, 5822.7670893163795, 5840.211571437886, 1250.3870007689977, 1288.8646692097382, 1328.9003324750681, 1339.8794108530278, 1356.66761643398, 794.922879498283, 812.6424373275858, 911.4732822522249, 924.9086078427385, 925.8287216864901, 4552.476465206543, 4705.0, 5197.58419326453, 5343.358796944314, 5392.975334686397, 5650.067738823131, 5887.76448942046, 5911.674857882857, 5937.228160339215, 5948.483136800089, 4603.194440972883, 5072.239164125411, 5378.327709036371, 5392.703401312965, 5395.541378982752, 2558.411565339982, 2571.85854777989, 2580.7935365170742, 2673.772729317991, 2681.3241723922547, 4158.625723684883, 4348.608625223682, 4691.006322313004, 5172.560332371715, 5243.003829272426, 4119.237940980868, 4124.8143833527565, 4317.740935543878, 4977.0, 5079.771410286546, 4228.70399072062, 4455.821767129279, 4646.581807637396, 4714.976425117852, 5011.346255735599, 4371.803268852973, 4389.209942210305, 4551.499335073073, 4885.1450996076255, 4968.751562421937, 4368.366586844953, 4647.9767601161775, 4675.6259499239295, 4680.472544825756, 4704.600108990638, 5863.501602363847, 6183.876322473615, 6258.746851133497, 6261.311255761953, 6266.937330626635, 3779.527559055118, 3973.4437178794415, 3990.4413382127104, 3996.56037835832, 4018.1963607278076, 5842.766289348378, 5961.7615295387695, 6081.300650425258, 6082.695865206811, 6115.969420152871, 4960.454350021567, 5088.592912566912, 5831.533477321889, 5852.678102704393, 5857.656937225144, 5740.971295143498, 5816.5055970243, 5849.0, 5869.295684517714, 5882.94117058841, 5308.734563271898, 5442.210879422382, 5452.773126046766, 5744.741486633196, 5750.30996280449, 4663.906721865475, 5781.4218578141845, 5859.798741258117, 5868.180863932194, 6075.326856183266, 4940.580050695731, 4994.725290108933, 5083.923741143812, 5734.7132643368495, 5748.562859285179], "value": 4015.6981155338294, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.403513154345, 746.3357611725562, 781.4881252779425, 808.6199486241464, 862.2024627219822, 14332.283385830706, 15068.869834762396, 15080.321385537649, 15088.622784430394, 15143.015703979234, 14233.288335583231, 14345.139291642508, 14358.138511689305, 14375.424983000694, 14387.568372948828, 869.1525762381675, 880.828238493494, 905.2622112977934, 908.9091090890925, 929.5770424456856, 895.7671005538574, 899.8380291547519, 900.9233965411336, 902.715644571961, 903.575319599787, 946.0823001688385, 948.2224575847807, 949.6723630347519, 949.9287553433486, 953.4184147669915, 913.9954300228522, 928.2620316848122, 938.9014153513886, 939.8496240601539, 948.1608776233049, 691.6783695581579, 697.3688811625487, 697.7732237022988, 701.1411021498624, 701.2461603775961, 15068.171250581214, 15251.0, 15288.617784555363, 15301.846981530265, 15314.234288285541, 13433.126846755027, 13616.863831361758, 13803.03378763487, 13846.376913038937, 14151.433942642281, 10325.328853624565, 11156.274842135235, 11596.304221746637, 11910.58312959051, 11930.642080737593, 3718.0704823794053, 3746.981265093657, 3752.2046075673525, 3878.592747761501, 3881.6700580450697, 95707.0, 96567.03432965651, 97798.0, 98419.50790246074, 99252.0, 10500.579976800842, 10589.947050264853, 10676.0391564758, 10677.359358438518, 10767.515461804238, 21284.680729789066, 21366.78633213679, 21453.67819482709, 21463.926803659753, 21690.0, 7639.656215470317, 7649.847003059907, 7653.425993050432, 7853.607319633996, 7891.092524359658, 3732.2162345907664, 4321.395004699345, 4338.522762496123, 4365.869023929287, 4403.559644035571, 3419.3845107880325, 3490.441529355291, 3509.5262139610827, 3527.7530572859655, 3603.963960360415, 682.8770821252223, 696.0568429777679, 703.4196787650209, 715.9248278930742, 719.9632529157996, 625.08425157145, 665.1951139121717, 672.9615784731939, 678.803147087349, 687.8555503344254, 8975.32685048611, 8982.86525702115, 9308.767280817898, 9392.436453812656, 9501.904980950101, 643.334149155631, 652.6051738698019, 662.3872917551246, 682.5938566552893, 688.1501345837886, 4389.934150987738, 4579.58033009768, 4634.165850146938, 4689.460712018094, 4700.95299047012, 67092.66453667701, 68371.3162868375, 80808.0, 85686.0, 98760.0, 98196.50901745446, 100492.0, 100515.0, 103071.0, 105148.0, 83324.0, 84109.0, 86343.56828215944, 87244.12755872487, 87505.56247218723, 9594.280428967715, 9815.36200146988, 9821.36161149523, 9832.410055396698, 9889.752756180866, 39809.60190398175, 45263.32105018493, 46026.38907638217, 47808.023997000375, 50143.498565013884, 62895.05657415051, 64195.67902160459, 71505.21236969117, 73753.0, 80162.19837801547, 12162.574309899112, 12215.755684886075, 12580.433880475217, 12989.675258118245, 13169.802452963022, 11679.708007299545, 13856.237906915216, 14056.226907520184, 14069.085509441853, 14325.355359008661, 10512.42181680015, 11663.88336116628, 12991.740165196832, 13220.338983051, 13356.933215333862, 12744.10791244604, 13308.324401571805, 13563.0, 13649.727005460034, 13697.726045478836, 12995.220286782824, 12995.610131696065, 13035.47858085666, 13072.477100915858, 13254.933725331312, 10080.798384032132, 10948.452577370941, 11061.391623460788, 11284.32294062359, 11379.772404552028, 8994.415363001384, 9483.478408687588, 11148.331100134017, 11424.82862757076, 11614.70963225926], "value": 7447.915302049062, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1588.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 120.0, 117.0, 117.0, 118.0, 117.0, 118.0, 116.0, 119.0, 118.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 116.0, 120.0, 172.0, 149.0, 119.0, 113.0, 119.0, 145.0, 116.0], "value": 131.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 230.0, 261.0, 232.0, 200.0, 200.0, 198.0, 197.0, 210.0, 199.0], "value": 211.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 62.0, 60.0, 85.0, 62.0, 61.0, 61.0, 60.0, 79.0, 63.0], "value": 67.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 90.0, 105.0, 100.0, 65.0, 117.0, 100.0, 103.0, 109.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 75.0, 131.0, 132.0, 138.0, 86.0, 91.0, 87.0, 88.0, 86.0], "value": 100.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 113.0, 96.0, 95.0, 95.0, 95.0, 95.0, 155.0, 152.0, 95.0], "value": 112.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 142.0, 93.0, 84.0, 86.0, 89.0, 90.0, 89.0, 90.0, 102.0], "value": 100.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 63.0, 92.0, 91.0, 93.0, 91.0, 88.0, 52.0, 53.0, 80.0], "value": 75.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 76.0, 75.0, 79.0, 76.0, 77.0, 60.0, 68.0, 76.0, 107.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 89.0, 89.0, 90.0, 91.0, 96.0, 79.0, 104.0, 114.0, 110.0], "value": 95.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 152.0, 162.0, 155.0, 185.0, 144.0, 154.0, 162.0, 202.0, 149.0], "value": 162.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 181.0, 174.0, 174.0, 174.0, 183.0, 172.0, 170.0, 171.0, 174.0], "value": 173.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 68.0, 70.0, 67.0, 68.0, 68.0, 70.0, 68.0], "value": 68.2, "unit": "score"}]}]} 05:53:01 INFO - Return code: 0 05:53:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:53:01 ERROR - # TBPL SUCCESS # 05:53:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:01 INFO - 2016-10-30 05:53:01.819 screenresolution[2114:26881] starting screenresolution argv=screenresolution get 05:53:01 INFO - 2016-10-30 05:53:01.822 screenresolution[2114:26881] Display 0: 1600x1200x32@60 05:53:01 INFO - 2016-10-30 05:53:01.828 screenresolution[2115:26884] starting screenresolution argv=screenresolution list 05:53:01 INFO - Available Modes on Display 0 05:53:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:02 INFO - Intel Iris: 05:53:02 INFO - Chipset Model: Intel Iris 05:53:02 INFO - Type: GPU 05:53:02 INFO - Bus: Built-In 05:53:02 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:02 INFO - Vendor: Intel (0x8086) 05:53:02 INFO - Device ID: 0x0a2e 05:53:02 INFO - Revision ID: 0x0009 05:53:02 INFO - Displays: 05:53:02 INFO - Display: 05:53:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:02 INFO - Display Serial Number: 1600x1200 60 05:53:02 INFO - Main Display: Yes 05:53:02 INFO - Mirror: Off 05:53:02 INFO - Online: Yes 05:53:02 INFO - Rotation: Supported 05:53:02 INFO - Return code: 0 05:53:02 INFO - Running post-action listener: _resource_record_post_action 05:53:02 INFO - [mozharness: 2016-10-30 12:53:02.071543Z] Finished run-tests step (success) 05:53:02 INFO - Running post-run listener: _resource_record_post_run 05:53:02 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 31783936; Write bytes: 711133184; Read time: 297; Write time: 1920 05:53:02 INFO - TinderboxPrint: CPU usage
54.4% 05:53:02 INFO - TinderboxPrint: I/O read bytes / time
31,783,936 / 297 05:53:02 INFO - TinderboxPrint: I/O write bytes / time
711,133,184 / 1,920 05:53:02 INFO - TinderboxPrint: CPU idle
2,211.5 (45.6%) 05:53:02 INFO - TinderboxPrint: CPU system
977.4 (20.2%) 05:53:02 INFO - TinderboxPrint: CPU user
1,660.9 (34.2%) 05:53:02 INFO - TinderboxPrint: Swap in / out
433,852,416 / 0 05:53:02 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 391256576; Write bytes: 385353728; Read time: 29404; Write time: 721 05:53:02 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 31783936; Write bytes: 301973504; Read time: 297; Write time: 1147 05:53:02 INFO - Running post-run listener: _upload_blobber_files 05:53:02 INFO - Blob upload gear active. 05:53:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:53:02 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:53:02 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:53:02 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:53:02 INFO - (blobuploader) - INFO - Open directory for files ... 05:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:53:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:04 INFO - (blobuploader) - INFO - Done attempting. 05:53:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:53:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:53:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:05 INFO - (blobuploader) - INFO - Done attempting. 05:53:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:53:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:53:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:53:07 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:53:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:53:07 INFO - (blobuploader) - INFO - Done attempting. 05:53:07 INFO - (blobuploader) - INFO - Iteration through files over. 05:53:07 INFO - Return code: 0 05:53:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:53:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:53:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92a703d6e3ee114bbb5f78a8c7810f6d5e7e47c49e88714d7dd94f3c9e409808ce8be9c731cef3310dd95e9c0668fd4b005a127408160cc53bf181f69484848d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e474231375263c5454bc9e7b020eec03a3dd14d50b56c2714b57abfbe0658117bccc5f6cef8494939ad8c6312fbfe5f2ab8ff07cd0644e97b79d4866be9e3254", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e827cee668ca2bda078dd63bd2961da4585a7cb2dca8049e3d3e1bd2b1c0cbe74b32088729930e5c1aa294f65b7f3f5b620adf8c07619dafe1612925e74d448"} 05:53:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:53:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:53:07 INFO - Contents: 05:53:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92a703d6e3ee114bbb5f78a8c7810f6d5e7e47c49e88714d7dd94f3c9e409808ce8be9c731cef3310dd95e9c0668fd4b005a127408160cc53bf181f69484848d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e474231375263c5454bc9e7b020eec03a3dd14d50b56c2714b57abfbe0658117bccc5f6cef8494939ad8c6312fbfe5f2ab8ff07cd0644e97b79d4866be9e3254", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e827cee668ca2bda078dd63bd2961da4585a7cb2dca8049e3d3e1bd2b1c0cbe74b32088729930e5c1aa294f65b7f3f5b620adf8c07619dafe1612925e74d448"} 05:53:07 INFO - Running post-run listener: copy_logs_to_upload_dir 05:53:07 INFO - Copying logs to upload dir... 05:53:07 INFO - mkdir: /builds/slave/test/build/upload/logs 05:53:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.748781 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-30 05:53:07.837901) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 05:53:07.841797) ========= 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.1q6UhxtbP5/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.etjrJGrwXN/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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/92a703d6e3ee114bbb5f78a8c7810f6d5e7e47c49e88714d7dd94f3c9e409808ce8be9c731cef3310dd95e9c0668fd4b005a127408160cc53bf181f69484848d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e474231375263c5454bc9e7b020eec03a3dd14d50b56c2714b57abfbe0658117bccc5f6cef8494939ad8c6312fbfe5f2ab8ff07cd0644e97b79d4866be9e3254", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e827cee668ca2bda078dd63bd2961da4585a7cb2dca8049e3d3e1bd2b1c0cbe74b32088729930e5c1aa294f65b7f3f5b620adf8c07619dafe1612925e74d448"} build_url:https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010711 build_url: 'https://queue.taskcluster.net/v1/task/POFsch2yRKi-Y9msGELByw/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/92a703d6e3ee114bbb5f78a8c7810f6d5e7e47c49e88714d7dd94f3c9e409808ce8be9c731cef3310dd95e9c0668fd4b005a127408160cc53bf181f69484848d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e474231375263c5454bc9e7b020eec03a3dd14d50b56c2714b57abfbe0658117bccc5f6cef8494939ad8c6312fbfe5f2ab8ff07cd0644e97b79d4866be9e3254", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e827cee668ca2bda078dd63bd2961da4585a7cb2dca8049e3d3e1bd2b1c0cbe74b32088729930e5c1aa294f65b7f3f5b620adf8c07619dafe1612925e74d448"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-30 05:53:07.874804) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:53:07.875180) ========= 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.1q6UhxtbP5/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.etjrJGrwXN/Listeners TMPDIR=/var/folders/6d/dwmd8vqs4mj6zk_cht8x51b800000w/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.004928 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-30 05:53:07.924321) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 05:53:07.924661) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-30 05:53:07.925009) ========= ========= Total master_lag: 0.18 =========