builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0065 starttime: 1485276033.04 results: success (0) buildid: 20170124061149 builduid: 5ae163d1ca454843b68f9332f9323325 revision: 49ee6ecf35c2b576755453eebd648035d882779b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:33.038162) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:33.038636) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:33.038989) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:33.063937) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:33.064255) ========= 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.8wxStlKjjp/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.2HSEWrOTNd/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-24 08:40:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2017-01-24 08:40:33 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136861 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:33.224579) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:33.224918) ========= 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.8wxStlKjjp/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.2HSEWrOTNd/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.019793 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:33.276314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-24 08:40:33.277132) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 49ee6ecf35c2b576755453eebd648035d882779b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 49ee6ecf35c2b576755453eebd648035d882779b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8wxStlKjjp/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.2HSEWrOTNd/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-24 08:40:33,368 truncating revision to first 12 chars 2017-01-24 08:40:33,368 Setting DEBUG logging. 2017-01-24 08:40:33,368 attempt 1/10 2017-01-24 08:40:33,368 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/49ee6ecf35c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 08:40:35,264 unpacking tar archive at: mozilla-beta-49ee6ecf35c2/testing/mozharness/ program finished with exit code 0 elapsedTime=2.126560 ========= master_lag: 2.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 4 secs) (at 2017-01-24 08:40:37.427506) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:37.427843) ========= script_repo_revision: 49ee6ecf35c2b576755453eebd648035d882779b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:37.428301) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:37.428566) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 08:40:37.459635) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-24 08:40:37.460036) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8wxStlKjjp/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.2HSEWrOTNd/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:40:37 INFO - MultiFileLogger online at 20170124 08:40:37 in /builds/slave/test 08:40:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:40:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:40:37 INFO - {'append_to_log': False, 08:40:37 INFO - 'base_work_dir': '/builds/slave/test', 08:40:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:40:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:40:37 INFO - 'branch': 'Mozilla-Beta', 08:40:37 INFO - 'buildbot_json_path': 'buildprops.json', 08:40:37 INFO - 'config_files': ('talos/mac_config.py',), 08:40:37 INFO - 'default_actions': ('clobber', 08:40:37 INFO - 'read-buildbot-config', 08:40:37 INFO - 'download-and-extract', 08:40:37 INFO - 'populate-webroot', 08:40:37 INFO - 'create-virtualenv', 08:40:37 INFO - 'install', 08:40:37 INFO - 'run-tests'), 08:40:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:40:37 INFO - 'download_minidump_stackwalk': True, 08:40:37 INFO - 'download_symbols': 'ondemand', 08:40:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:40:37 INFO - 'tooltool.py': '/tools/tooltool.py', 08:40:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:40:37 INFO - '/tools/misc-python/virtualenv.py')}, 08:40:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:40:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:40:37 INFO - 'installer_path': 'installer.exe', 08:40:37 INFO - 'log_level': 'info', 08:40:37 INFO - 'log_name': 'talos', 08:40:37 INFO - 'log_to_console': True, 08:40:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:40:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:40:37 INFO - 'opt_config_files': (), 08:40:37 INFO - 'pip_index': False, 08:40:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:37 INFO - 'cmd': ('bash', 08:40:37 INFO - '-c', 08:40:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:37 INFO - 'enabled': True, 08:40:37 INFO - 'halt_on_failure': False, 08:40:37 INFO - 'name': 'check_screen_resolution'},), 08:40:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:40:37 INFO - 'cmd': ('bash', 08:40:37 INFO - '-c', 08:40:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:40:37 INFO - 'enabled': True, 08:40:37 INFO - 'halt_on_failure': False, 08:40:37 INFO - 'name': 'check_screen_resolution'},), 08:40:37 INFO - 'run_cmd_checks_enabled': True, 08:40:37 INFO - 'sps_profile': False, 08:40:37 INFO - 'sps_profile_interval': 0, 08:40:37 INFO - 'suite': 'dromaeojs-e10s', 08:40:37 INFO - 'system_bits': '32', 08:40:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:40:37 INFO - 'title': 't-yosemite-r7-0065', 08:40:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:40:37 INFO - 'use_talos_json': True, 08:40:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:40:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:40:37 INFO - 'work_dir': 'build'} 08:40:37 INFO - [mozharness: 2017-01-24 16:40:37.674054Z] Running clobber step. 08:40:37 INFO - Running pre-action listener: _resource_record_pre_action 08:40:37 INFO - Running main action method: clobber 08:40:37 INFO - rmtree: /builds/slave/test/build 08:40:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:40:39 INFO - Running post-action listener: _resource_record_post_action 08:40:39 INFO - [mozharness: 2017-01-24 16:40:39.480042Z] Finished clobber step (success) 08:40:39 INFO - [mozharness: 2017-01-24 16:40:39.480281Z] Running read-buildbot-config step. 08:40:39 INFO - Running pre-action listener: _resource_record_pre_action 08:40:39 INFO - Running main action method: read_buildbot_config 08:40:39 INFO - Using buildbot properties: 08:40:39 INFO - { 08:40:39 INFO - "project": "", 08:40:39 INFO - "product": "firefox", 08:40:39 INFO - "script_repo_revision": "production", 08:40:39 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 08:40:39 INFO - "repository": "", 08:40:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 08:40:39 INFO - "buildid": "20170124061149", 08:40:39 INFO - "pgo_build": "False", 08:40:39 INFO - "basedir": "/builds/slave/test", 08:40:39 INFO - "buildnumber": 8, 08:40:39 INFO - "slavename": "t-yosemite-r7-0065", 08:40:39 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:40:39 INFO - "platform": "yosemite_r7", 08:40:39 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:40:39 INFO - "branch": "mozilla-beta", 08:40:39 INFO - "repo_path": "releases/mozilla-beta", 08:40:39 INFO - "revision": "49ee6ecf35c2b576755453eebd648035d882779b", 08:40:39 INFO - "stage_platform": "macosx64", 08:40:39 INFO - "builduid": "5ae163d1ca454843b68f9332f9323325", 08:40:39 INFO - "slavebuilddir": "test" 08:40:39 INFO - } 08:40:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 08:40:39 INFO - Running post-action listener: _resource_record_post_action 08:40:39 INFO - [mozharness: 2017-01-24 16:40:39.483944Z] Finished read-buildbot-config step (success) 08:40:39 INFO - [mozharness: 2017-01-24 16:40:39.484057Z] Running download-and-extract step. 08:40:39 INFO - Running pre-action listener: _resource_record_pre_action 08:40:39 INFO - Running main action method: download_and_extract 08:40:39 INFO - mkdir: /builds/slave/test/build/tests 08:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:40:39 INFO - trying https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 08:40:39 INFO - Downloading https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:40:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 08:40:40 INFO - Downloaded 1165 bytes. 08:40:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 08:40:40 INFO - Using the following test package requirements: 08:40:40 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:40:40 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:40 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 08:40:40 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:40 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 08:40:40 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:40:40 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:40 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 08:40:40 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 08:40:40 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:40 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 08:40:40 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:40 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 08:40:40 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:40 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 08:40:40 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 08:40:40 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 08:40:40 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 08:40:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:40:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:40:40 INFO - Fetch https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:40:40 INFO - Http code: 200 08:40:40 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 08:40:40 INFO - x-amz-cf-id: XF6j7uE7YQqhN_45DeCETskLSKat5wzKtWlNcfSSqmBaUo5zYwtAOQ== 08:40:40 INFO - x-amz-version-id: jDpPpMSdVcDS5YTaMwnQFS6RhQeSj523 08:40:40 INFO - Expected file size: 16086062 08:40:40 INFO - Obtained file size: 16086062 08:40:47 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:40:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 08:40:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 08:40:47 INFO - Fetch https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 08:40:48 INFO - Http code: 200 08:40:48 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 08:40:48 INFO - x-amz-cf-id: 9AxwF06VZ0rRXgDC6G9cAoHs5cg9o1zUbiGhtHnpi5RhCzX5jO_Zgw== 08:40:48 INFO - x-amz-version-id: jDpPpMSdVcDS5YTaMwnQFS6RhQeSj523 08:40:48 INFO - Expected file size: 16086062 08:40:48 INFO - Obtained file size: 16086062 08:40:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 08:40:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 08:40:54 INFO - Fetch https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 08:40:55 INFO - Http code: 200 08:40:55 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 08:40:55 INFO - x-amz-cf-id: Pg0vT7uGOXF5g-BhHnjJQMMqgobqB_1fNC1Wa9QdWn8mWza2Fp94zA== 08:40:55 INFO - x-amz-version-id: a2nHYwbTG_cZ.emPLagtAeWGxAd3KyTB 08:40:55 INFO - Expected file size: 14402992 08:40:55 INFO - Obtained file size: 14402992 08:40:55 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')]} 08:40:55 INFO - trying https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:40:55 INFO - Downloading https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 08:40:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 08:40:58 INFO - Downloaded 82123758 bytes. 08:40:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:40:58 INFO - mkdir: /builds/slave/test/properties 08:40:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:40:58 INFO - Writing to file /builds/slave/test/properties/build_url 08:40:58 INFO - Contents: 08:40:58 INFO - build_url:https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg 08:40:58 INFO - Running post-action listener: _resource_record_post_action 08:40:58 INFO - Running post-action listener: set_extra_try_arguments 08:40:58 INFO - [mozharness: 2017-01-24 16:40:58.867762Z] Finished download-and-extract step (success) 08:40:58 INFO - [mozharness: 2017-01-24 16:40:58.867881Z] Running populate-webroot step. 08:40:58 INFO - Running pre-action listener: _resource_record_pre_action 08:40:58 INFO - Running main action method: populate_webroot 08:40:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:40:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:40:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:40:58 INFO - '--tppagecycles', 08:40:58 INFO - '7'], 08:40:58 INFO - 'tests': ['tsvgm']}}, 08:40:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:40:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:40:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:40:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:40:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:40:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:40:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:58 INFO - 'talos_options': ['--disable-e10s'], 08:40:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:40:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:58 INFO - 'talos_options': ['--disable-e10s'], 08:40:58 INFO - 'tests': ['damp', 'tps']}, 08:40:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:58 INFO - 'tests': ['damp', 'tps']}, 08:40:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:40:58 INFO - 'tests': ['dromaeo_dom']}, 08:40:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:40:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:40:58 INFO - 'tests': ['basic_compositor_video']}, 08:40:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:40:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:40:58 INFO - 'tests': ['a11yr', 08:40:58 INFO - 'ts_paint', 08:40:58 INFO - 'tpaint', 08:40:58 INFO - 'sessionrestore', 08:40:58 INFO - 'sessionrestore_no_auto_restore', 08:40:58 INFO - 'tabpaint']}, 08:40:58 INFO - 'other-e10s': {'tests': ['a11yr', 08:40:58 INFO - 'ts_paint', 08:40:58 INFO - 'tpaint', 08:40:58 INFO - 'sessionrestore', 08:40:58 INFO - 'sessionrestore_no_auto_restore', 08:40:58 INFO - 'tabpaint']}, 08:40:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:40:58 INFO - 'ts_paint', 08:40:58 INFO - 'tpaint', 08:40:58 INFO - 'sessionrestore', 08:40:58 INFO - 'sessionrestore_no_auto_restore', 08:40:58 INFO - 'tabpaint']}, 08:40:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:40:58 INFO - 'ts_paint', 08:40:58 INFO - 'tpaint', 08:40:58 INFO - 'sessionrestore', 08:40:58 INFO - 'sessionrestore_no_auto_restore', 08:40:58 INFO - 'tabpaint']}, 08:40:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:40:58 INFO - 'tests': ['a11yr', 08:40:58 INFO - 'ts_paint', 08:40:58 INFO - 'tpaint', 08:40:58 INFO - 'sessionrestore', 08:40:58 INFO - 'sessionrestore_no_auto_restore', 08:40:58 INFO - 'tabpaint']}, 08:40:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:40:58 INFO - 'tests': ['a11yr', 08:40:58 INFO - 'ts_paint', 08:40:58 INFO - 'tpaint', 08:40:58 INFO - 'sessionrestore', 08:40:58 INFO - 'sessionrestore_no_auto_restore', 08:40:58 INFO - 'tabpaint']}, 08:40:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:40:58 INFO - 'tests': ['tsvgx', 08:40:58 INFO - 'tsvgr_opacity', 08:40:58 INFO - 'tart', 08:40:58 INFO - 'tscrollx', 08:40:58 INFO - 'cart']}, 08:40:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:40:58 INFO - 'tsvgr_opacity', 08:40:58 INFO - 'tart', 08:40:58 INFO - 'tscrollx', 08:40:58 INFO - 'cart']}, 08:40:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:58 INFO - 'talos_options': ['--disable-e10s'], 08:40:58 INFO - 'tests': ['tp5o']}, 08:40:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:58 INFO - 'tests': ['tp5o']}, 08:40:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:58 INFO - 'talos_options': ['--disable-e10s', 08:40:58 INFO - '--xperf_path', 08:40:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:58 INFO - 'tests': ['tp5n']}, 08:40:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:40:58 INFO - 'talos_options': ['--xperf_path', 08:40:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:40:58 INFO - 'tests': ['tp5n']}}, 08:40:58 INFO - 'talos.zip': {'path': '', 08:40:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:40:58 INFO - Running post-action listener: _resource_record_post_action 08:40:58 INFO - [mozharness: 2017-01-24 16:40:58.886986Z] Finished populate-webroot step (success) 08:40:58 INFO - [mozharness: 2017-01-24 16:40:58.887072Z] Running create-virtualenv step. 08:40:58 INFO - Running pre-action listener: _resource_record_pre_action 08:40:58 INFO - Running main action method: create_virtualenv 08:40:58 INFO - Creating virtualenv /builds/slave/test/build/venv 08:40:58 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 08:40:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:40:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:40:59 INFO - Using real prefix '/tools/python27' 08:40:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:40:59 INFO - Installing distribute.............................................................................................................................................................................................done. 08:41:02 INFO - Installing pip.................done. 08:41:02 INFO - Return code: 0 08:41:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:41:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:41:02 INFO - Reading from file tmpfile_stdout 08:41:02 INFO - Output received: 08:41:02 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) 08:41:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:02 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 0x10b39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d84d3420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b1d30>, '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 0x10b017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a9b20>, '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.8wxStlKjjp/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.2HSEWrOTNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:41:02 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 08:41:02 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 08:41:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8wxStlKjjp/Render', 08:41:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:02 INFO - 'HOME': '/Users/cltbld', 08:41:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:02 INFO - 'LOGNAME': 'cltbld', 08:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:02 INFO - 'MOZ_NO_REMOTE': '1', 08:41:02 INFO - 'NO_EM_RESTART': '1', 08:41:02 INFO - 'PAGER': '/bin/cat', 08:41:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:02 INFO - 'PWD': '/builds/slave/test', 08:41:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:02 INFO - 'SHELL': '/bin/bash', 08:41:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2HSEWrOTNd/Listeners', 08:41:02 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:41:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:02 INFO - 'USER': 'cltbld', 08:41:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:02 INFO - 'XPC_FLAGS': '0x0', 08:41:02 INFO - 'XPC_SERVICE_NAME': '0', 08:41:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:41:03 INFO - Cleaning up... 08:41:03 INFO - Return code: 0 08:41:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d84d3420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b1d30>, '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 0x10b017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a9b20>, '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.8wxStlKjjp/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.2HSEWrOTNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:41:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:41:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:41:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8wxStlKjjp/Render', 08:41:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:03 INFO - 'HOME': '/Users/cltbld', 08:41:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:03 INFO - 'LOGNAME': 'cltbld', 08:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:03 INFO - 'MOZ_NO_REMOTE': '1', 08:41:03 INFO - 'NO_EM_RESTART': '1', 08:41:03 INFO - 'PAGER': '/bin/cat', 08:41:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:03 INFO - 'PWD': '/builds/slave/test', 08:41:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:03 INFO - 'SHELL': '/bin/bash', 08:41:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2HSEWrOTNd/Listeners', 08:41:03 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:41:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:03 INFO - 'USER': 'cltbld', 08:41:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:03 INFO - 'XPC_FLAGS': '0x0', 08:41:03 INFO - 'XPC_SERVICE_NAME': '0', 08:41:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:03 INFO - Downloading/unpacking psutil>=3.1.1 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:41:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:06 INFO - Installing collected packages: psutil 08:41:06 INFO - Running setup.py install for psutil 08:41:06 INFO - building 'psutil._psutil_osx' extension 08:41:06 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 08:41:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:41:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:41:07 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:41:07 INFO - building 'psutil._psutil_posix' extension 08:41:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:41:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:41:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:41:07 INFO - ^ 08:41:07 INFO - 1 warning generated. 08:41:07 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 08:41:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:41:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:41:07 INFO - Successfully installed psutil 08:41:07 INFO - Cleaning up... 08:41:07 INFO - Return code: 0 08:41:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:07 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 0x10b39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d84d3420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b1d30>, '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 0x10b017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a9b20>, '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.8wxStlKjjp/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.2HSEWrOTNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:41:07 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 08:41:07 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 08:41:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8wxStlKjjp/Render', 08:41:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:07 INFO - 'HOME': '/Users/cltbld', 08:41:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:07 INFO - 'LOGNAME': 'cltbld', 08:41:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:07 INFO - 'MOZ_NO_REMOTE': '1', 08:41:07 INFO - 'NO_EM_RESTART': '1', 08:41:07 INFO - 'PAGER': '/bin/cat', 08:41:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:07 INFO - 'PWD': '/builds/slave/test', 08:41:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:07 INFO - 'SHELL': '/bin/bash', 08:41:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2HSEWrOTNd/Listeners', 08:41:07 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:41:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:07 INFO - 'USER': 'cltbld', 08:41:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:07 INFO - 'XPC_FLAGS': '0x0', 08:41:07 INFO - 'XPC_SERVICE_NAME': '0', 08:41:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:41:07 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 08:41:07 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 08:41:07 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 08:41:07 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 08:41:07 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 08:41:07 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 08:41:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:41:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:41:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:41:10 INFO - Installing collected packages: mozsystemmonitor 08:41:10 INFO - Running setup.py install for mozsystemmonitor 08:41:10 INFO - Successfully installed mozsystemmonitor 08:41:10 INFO - Cleaning up... 08:41:10 INFO - Return code: 0 08:41:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:10 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 0x10b39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d84d3420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b1d30>, '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 0x10b017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a9b20>, '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.8wxStlKjjp/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.2HSEWrOTNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:41:10 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 08:41:10 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 08:41:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8wxStlKjjp/Render', 08:41:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:10 INFO - 'HOME': '/Users/cltbld', 08:41:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:10 INFO - 'LOGNAME': 'cltbld', 08:41:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:10 INFO - 'MOZ_NO_REMOTE': '1', 08:41:10 INFO - 'NO_EM_RESTART': '1', 08:41:10 INFO - 'PAGER': '/bin/cat', 08:41:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:10 INFO - 'PWD': '/builds/slave/test', 08:41:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:10 INFO - 'SHELL': '/bin/bash', 08:41:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2HSEWrOTNd/Listeners', 08:41:10 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:41:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:10 INFO - 'USER': 'cltbld', 08:41:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:10 INFO - 'XPC_FLAGS': '0x0', 08:41:10 INFO - 'XPC_SERVICE_NAME': '0', 08:41:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:11 INFO - Downloading/unpacking jsonschema==2.5.1 08:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:41:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:41:13 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 08:41:13 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 08:41:13 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 08:41:13 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 08:41:13 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 08:41:13 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 08:41:14 INFO - Downloading functools32-3.2.3-2.tar.gz 08:41:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:41:14 INFO - warning: no files found matching '*.txt' 08:41:14 INFO - no previously-included directories found matching 'build' 08:41:14 INFO - no previously-included directories found matching 'dist' 08:41:14 INFO - no previously-included directories found matching '.git*' 08:41:14 INFO - Installing collected packages: jsonschema, functools32 08:41:14 INFO - Running setup.py install for functools32 08:41:14 INFO - warning: no files found matching '*.txt' 08:41:14 INFO - no previously-included directories found matching 'build' 08:41:14 INFO - no previously-included directories found matching 'dist' 08:41:14 INFO - no previously-included directories found matching '.git*' 08:41:14 INFO - Successfully installed jsonschema functools32 08:41:14 INFO - Cleaning up... 08:41:14 INFO - Return code: 0 08:41:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:41:14 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')]} 08:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:14 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')]} 08:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:14 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 0x10b39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d84d3420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b1d30>, '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 0x10b017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a9b20>, '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.8wxStlKjjp/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.2HSEWrOTNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:41:14 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 08:41:14 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 08:41:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8wxStlKjjp/Render', 08:41:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:14 INFO - 'HOME': '/Users/cltbld', 08:41:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:14 INFO - 'LOGNAME': 'cltbld', 08:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:14 INFO - 'MOZ_NO_REMOTE': '1', 08:41:14 INFO - 'NO_EM_RESTART': '1', 08:41:14 INFO - 'PAGER': '/bin/cat', 08:41:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:14 INFO - 'PWD': '/builds/slave/test', 08:41:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:14 INFO - 'SHELL': '/bin/bash', 08:41:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2HSEWrOTNd/Listeners', 08:41:14 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:41:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:14 INFO - 'USER': 'cltbld', 08:41:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:14 INFO - 'XPC_FLAGS': '0x0', 08:41:14 INFO - 'XPC_SERVICE_NAME': '0', 08:41:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:41:14 INFO - Cleaning up... 08:41:14 INFO - Return code: 0 08:41:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:41:14 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')]} 08:41:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:14 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')]} 08:41:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:14 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 0x10b39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d84d3420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b1d30>, '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 0x10b017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a9b20>, '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.8wxStlKjjp/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.2HSEWrOTNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:41:14 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 08:41:14 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 08:41:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8wxStlKjjp/Render', 08:41:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:14 INFO - 'HOME': '/Users/cltbld', 08:41:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:14 INFO - 'LOGNAME': 'cltbld', 08:41:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:14 INFO - 'MOZ_NO_REMOTE': '1', 08:41:14 INFO - 'NO_EM_RESTART': '1', 08:41:14 INFO - 'PAGER': '/bin/cat', 08:41:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:14 INFO - 'PWD': '/builds/slave/test', 08:41:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:14 INFO - 'SHELL': '/bin/bash', 08:41:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2HSEWrOTNd/Listeners', 08:41:14 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:41:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:14 INFO - 'USER': 'cltbld', 08:41:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:14 INFO - 'XPC_FLAGS': '0x0', 08:41:14 INFO - 'XPC_SERVICE_NAME': '0', 08:41:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:15 INFO - Downloading/unpacking blobuploader==1.2.4 08:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:17 INFO - Downloading blobuploader-1.2.4.tar.gz 08:41:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:41:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:41:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:19 INFO - Downloading docopt-0.6.1.tar.gz 08:41:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:41:19 INFO - Installing collected packages: blobuploader, requests, docopt 08:41:19 INFO - Running setup.py install for blobuploader 08:41:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:41:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:41:19 INFO - Running setup.py install for requests 08:41:19 INFO - Running setup.py install for docopt 08:41:20 INFO - Successfully installed blobuploader requests docopt 08:41:20 INFO - Cleaning up... 08:41:20 INFO - Return code: 0 08:41:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d84d3420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b1d30>, '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 0x10b017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a9b20>, '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.8wxStlKjjp/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.2HSEWrOTNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:41:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8wxStlKjjp/Render', 08:41:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:20 INFO - 'HOME': '/Users/cltbld', 08:41:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:20 INFO - 'LOGNAME': 'cltbld', 08:41:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:20 INFO - 'MOZ_NO_REMOTE': '1', 08:41:20 INFO - 'NO_EM_RESTART': '1', 08:41:20 INFO - 'PAGER': '/bin/cat', 08:41:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:20 INFO - 'PWD': '/builds/slave/test', 08:41:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:20 INFO - 'SHELL': '/bin/bash', 08:41:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2HSEWrOTNd/Listeners', 08:41:20 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:41:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:20 INFO - 'USER': 'cltbld', 08:41:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:20 INFO - 'XPC_FLAGS': '0x0', 08:41:20 INFO - 'XPC_SERVICE_NAME': '0', 08:41:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-eT789d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-FOMTci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Cq5Hrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-LgP3G6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-HU0JzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:20 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-GQbUL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-ys50ST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-x8w39L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-UOE_yx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-5LoVFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-RDMcPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-ys8ZUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-faXyam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-aL04C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-NJ87Rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:21 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-b5YdaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:22 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-XnhZ9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:41:22 INFO - Running setup.py install for manifestparser 08:41:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:41:22 INFO - Running setup.py install for mozcrash 08:41:22 INFO - Running setup.py install for mozdebug 08:41:22 INFO - Running setup.py install for mozdevice 08:41:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:41:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:41:22 INFO - Running setup.py install for mozfile 08:41:22 INFO - Running setup.py install for mozhttpd 08:41:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:41:23 INFO - Running setup.py install for mozinfo 08:41:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:41:23 INFO - Running setup.py install for mozInstall 08:41:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:41:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:41:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:41:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:41:23 INFO - Running setup.py install for mozleak 08:41:23 INFO - Running setup.py install for mozlog 08:41:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:41:23 INFO - Running setup.py install for moznetwork 08:41:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:41:23 INFO - Running setup.py install for mozprocess 08:41:23 INFO - Running setup.py install for mozprofile 08:41:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:41:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:41:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:41:24 INFO - Running setup.py install for mozrunner 08:41:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:41:24 INFO - Running setup.py install for mozscreenshot 08:41:24 INFO - Running setup.py install for moztest 08:41:24 INFO - Running setup.py install for mozversion 08:41:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:41:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:41:24 INFO - Cleaning up... 08:41:24 INFO - Return code: 0 08:41:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41: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')]} 08:41:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41: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')]} 08:41:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d84d3420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b1d30>, '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 0x10b017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a9b20>, '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.8wxStlKjjp/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.2HSEWrOTNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:41:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:41:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8wxStlKjjp/Render', 08:41:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:24 INFO - 'HOME': '/Users/cltbld', 08:41:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:24 INFO - 'LOGNAME': 'cltbld', 08:41:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:24 INFO - 'MOZ_NO_REMOTE': '1', 08:41:24 INFO - 'NO_EM_RESTART': '1', 08:41:24 INFO - 'PAGER': '/bin/cat', 08:41:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:24 INFO - 'PWD': '/builds/slave/test', 08:41:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:24 INFO - 'SHELL': '/bin/bash', 08:41:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2HSEWrOTNd/Listeners', 08:41:24 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:41:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:24 INFO - 'USER': 'cltbld', 08:41:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:24 INFO - 'XPC_FLAGS': '0x0', 08:41:24 INFO - 'XPC_SERVICE_NAME': '0', 08:41:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:41:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-lrupnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:41:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Imfm8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:41:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-JlJPhP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:41:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-6pSoMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:41:25 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)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:41:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-HsD4P_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:41:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-6culQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:41:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-CQPaK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:41:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-qrMTm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:41:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:41:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:41:25 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-HMBLdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:41:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-nTGLC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:41:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Si8N3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:41:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-Mtvyas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:41:26 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)) 08:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:41:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-r2Vi7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:41:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-dkx3dz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-dMx9BH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:41:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-0ZAr0U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:41:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:41:26 INFO - Running setup.py (path:/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/pip-RZxNWc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:41:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:41:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:41:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:41:29 INFO - Downloading blessings-1.6.tar.gz 08:41:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:41:29 INFO - Installing collected packages: blessings 08:41:29 INFO - Running setup.py install for blessings 08:41:29 INFO - Successfully installed blessings 08:41:29 INFO - Cleaning up... 08:41:29 INFO - Return code: 0 08:41:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:41:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:30 INFO - Reading from file tmpfile_stdout 08:41:30 INFO - Current package versions: 08:41:30 INFO - blessings == 1.6 08:41:30 INFO - blobuploader == 1.2.4 08:41:30 INFO - docopt == 0.6.1 08:41:30 INFO - functools32 == 3.2.3-2 08:41:30 INFO - jsonschema == 2.5.1 08:41:30 INFO - manifestparser == 1.1 08:41:30 INFO - mozInstall == 1.12 08:41:30 INFO - mozcrash == 1.0 08:41:30 INFO - mozdebug == 0.1 08:41:30 INFO - mozdevice == 0.48 08:41:30 INFO - mozfile == 1.2 08:41:30 INFO - mozhttpd == 0.7 08:41:30 INFO - mozinfo == 0.9 08:41:30 INFO - mozleak == 0.1 08:41:30 INFO - mozlog == 3.4 08:41:30 INFO - moznetwork == 0.27 08:41:30 INFO - mozprocess == 0.23 08:41:30 INFO - mozprofile == 0.28 08:41:30 INFO - mozrunner == 6.13 08:41:30 INFO - mozscreenshot == 0.1 08:41:30 INFO - mozsystemmonitor == 0.3 08:41:30 INFO - moztest == 0.8 08:41:30 INFO - mozversion == 1.4 08:41:30 INFO - psutil == 3.1.1 08:41:30 INFO - requests == 1.2.3 08:41:30 INFO - wsgiref == 0.1.2 08:41:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d84d3420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b1d30>, '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 0x10b017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a9b20>, '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.8wxStlKjjp/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.2HSEWrOTNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:41:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8wxStlKjjp/Render', 08:41:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:31 INFO - 'HOME': '/Users/cltbld', 08:41:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:31 INFO - 'LOGNAME': 'cltbld', 08:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:31 INFO - 'MOZ_NO_REMOTE': '1', 08:41:31 INFO - 'NO_EM_RESTART': '1', 08:41:31 INFO - 'PAGER': '/bin/cat', 08:41:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:31 INFO - 'PWD': '/builds/slave/test', 08:41:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:31 INFO - 'SHELL': '/bin/bash', 08:41:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2HSEWrOTNd/Listeners', 08:41:31 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:41:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:31 INFO - 'USER': 'cltbld', 08:41:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:31 INFO - 'XPC_FLAGS': '0x0', 08:41:31 INFO - 'XPC_SERVICE_NAME': '0', 08:41:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:41:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:41:31 INFO - Cleaning up... 08:41:31 INFO - Return code: 0 08:41:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:41:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:41:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b39d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b313570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe1d84d3420>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b1b1d30>, '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 0x10b017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a9b20>, '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.8wxStlKjjp/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.2HSEWrOTNd/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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 08:41:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:41:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:41:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8wxStlKjjp/Render', 08:41:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:31 INFO - 'HOME': '/Users/cltbld', 08:41:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:31 INFO - 'LOGNAME': 'cltbld', 08:41:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:31 INFO - 'MOZ_NO_REMOTE': '1', 08:41:31 INFO - 'NO_EM_RESTART': '1', 08:41:31 INFO - 'PAGER': '/bin/cat', 08:41:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:31 INFO - 'PWD': '/builds/slave/test', 08:41:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:31 INFO - 'SHELL': '/bin/bash', 08:41:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2HSEWrOTNd/Listeners', 08:41:31 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:41:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:31 INFO - 'USER': 'cltbld', 08:41:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:31 INFO - 'XPC_FLAGS': '0x0', 08:41:31 INFO - 'XPC_SERVICE_NAME': '0', 08:41:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:41:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:41:32 INFO - Cleaning up... 08:41:32 INFO - Return code: 0 08:41:32 INFO - Running post-action listener: _resource_record_post_action 08:41:32 INFO - Running post-action listener: _start_resource_monitoring 08:41:32 INFO - Starting resource monitoring. 08:41:32 INFO - [mozharness: 2017-01-24 16:41:32.194199Z] Finished create-virtualenv step (success) 08:41:32 INFO - [mozharness: 2017-01-24 16:41:32.195103Z] Running install step. 08:41:32 INFO - Running pre-action listener: _resource_record_pre_action 08:41:32 INFO - Running main action method: install 08:41:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:41:32 INFO - Reading from file tmpfile_stdout 08:41:32 INFO - Detecting whether we're running mozinstall >=1.0... 08:41:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:41:32 INFO - Reading from file tmpfile_stdout 08:41:32 INFO - Output received: 08:41:32 INFO - Usage: mozinstall [options] installer 08:41:32 INFO - Options: 08:41:32 INFO - -h, --help show this help message and exit 08:41:32 INFO - -d DEST, --destination=DEST 08:41:32 INFO - Directory to install application into. [default: 08:41:32 INFO - "/builds/slave/test"] 08:41:32 INFO - --app=APP Application being installed. [default: firefox] 08:41:32 INFO - mkdir: /builds/slave/test/build/application 08:41:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:41:53 INFO - Reading from file tmpfile_stdout 08:41:53 INFO - Output received: 08:41:53 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:41:53 INFO - Running post-action listener: _resource_record_post_action 08:41:53 INFO - [mozharness: 2017-01-24 16:41:53.974129Z] Finished install step (success) 08:41:53 INFO - [mozharness: 2017-01-24 16:41:53.974284Z] Running run-tests step. 08:41:53 INFO - Running pre-action listener: _resource_record_pre_action 08:41:53 INFO - Running main action method: run_tests 08:41:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:41:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:41:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:41:53 INFO - 2017-01-24 08:41:53.988 screenresolution[1906:16605] starting screenresolution argv=screenresolution get 08:41:53 INFO - 2017-01-24 08:41:53.991 screenresolution[1906:16605] Display 0: 1600x1200x32@60 08:41:53 INFO - 2017-01-24 08:41:53.997 screenresolution[1907:16607] starting screenresolution argv=screenresolution list 08:41:54 INFO - Available Modes on Display 0 08:41:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:41:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:41:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:41:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:41:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:41:54 INFO - Intel Iris: 08:41:54 INFO - Chipset Model: Intel Iris 08:41:54 INFO - Type: GPU 08:41:54 INFO - Bus: Built-In 08:41:54 INFO - VRAM (Dynamic, Max): 1536 MB 08:41:54 INFO - Vendor: Intel (0x8086) 08:41:54 INFO - Device ID: 0x0a2e 08:41:54 INFO - Revision ID: 0x0009 08:41:54 INFO - Displays: 08:41:54 INFO - Display: 08:41:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:41:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:41:54 INFO - Display Serial Number: 1600x1200 60 08:41:54 INFO - Main Display: Yes 08:41:54 INFO - Mirror: Off 08:41:54 INFO - Online: Yes 08:41:54 INFO - Rotation: Supported 08:41:54 INFO - Return code: 0 08:41:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:41:54 INFO - Python 2.7.3 08:41:54 INFO - Return code: 0 08:41:54 INFO - grabbing minidump binary from tooltool 08:41: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')]} 08:41:54 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 0x10b1b1d30>, '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 0x10b017db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b1a9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:41:54 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 08:41:54 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 08:41:54 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 08:41:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:41:54 INFO - Return code: 0 08:41:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:41:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:41:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:41:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:41:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:41:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--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 08:41:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0065 --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 08:41:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8wxStlKjjp/Render', 08:41:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:41:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:41:54 INFO - 'HOME': '/Users/cltbld', 08:41:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:41:54 INFO - 'LOGNAME': 'cltbld', 08:41:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:41:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:41:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:41:54 INFO - 'MOZ_NO_REMOTE': '1', 08:41:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:41:54 INFO - 'NO_EM_RESTART': '1', 08:41:54 INFO - 'PAGER': '/bin/cat', 08:41:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:41:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:41:54 INFO - 'PWD': '/builds/slave/test', 08:41:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:41:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:41:54 INFO - 'SHELL': '/bin/bash', 08:41:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2HSEWrOTNd/Listeners', 08:41:54 INFO - 'TMPDIR': '/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/', 08:41:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:41:54 INFO - 'USER': 'cltbld', 08:41:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:41:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:41:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:41:54 INFO - 'XPC_FLAGS': '0x0', 08:41:54 INFO - 'XPC_SERVICE_NAME': '0', 08:41:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:41:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0065', '--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 08:41:54 INFO - mozversion application_buildid: 20170124061149 08:41:54 INFO - mozversion application_changeset: 49ee6ecf35c2b576755453eebd648035d882779b 08:41:54 INFO - mozversion application_display_name: Firefox 08:41:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:41:54 INFO - mozversion application_name: Firefox 08:41:54 INFO - mozversion application_remotingname: firefox 08:41:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:54 INFO - mozversion application_vendor: Mozilla 08:41:54 INFO - mozversion application_version: 52.0 08:41:54 INFO - mozversion platform_buildid: 20170124061149 08:41:54 INFO - mozversion platform_changeset: 49ee6ecf35c2b576755453eebd648035d882779b 08:41:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:41:54 INFO - mozversion platform_version: 52.0 08:41:54 INFO - using testdate: 1485276114 08:41:54 INFO - actual date: 1485276114 08:41:54 INFO - starting webserver on 'localhost:53988' 08:41:54 INFO - SUITE-START | Running 2 tests 08:41:54 INFO - TEST-START | dromaeo_css 08:41:54 INFO - operating with platform_type : mac_ 08:41:54 INFO - Initialising browser for dromaeo_css test... 08:41:54 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmp_aOcL5/profile http://localhost:53988/getInfo.html) 08:41:57 INFO - PROCESS | 1917 | 2017-01-24 08:41:57.391 plugin-container[1920:16773] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c43, name = 'com.apple.tsm.portname' 08:41:57 INFO - PROCESS | 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:41:57 INFO - PROCESS | 1917 | 2017-01-24 08:41:57.393 plugin-container[1920:16773] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0f, name = 'com.apple.CFPasteboardClient' 08:41:57 INFO - PROCESS | 1917 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:41:57 INFO - PROCESS | 1917 | 2017-01-24 08:41:57.393 plugin-container[1920:16773] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:41:57 INFO - PROCESS | 1917 | __metrics Screen width/height:1600/1200 08:41:57 INFO - PROCESS | 1917 | colorDepth:24 08:41:57 INFO - PROCESS | 1917 | Browser inner width/height: 1024/689 08:41:57 INFO - PROCESS | 1917 | __metrics 08:41:57 ERROR - PROCESS | 1917 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 08:41:58 INFO - TEST-INFO | 1917: exit 0 08:41:58 INFO - Browser initialized. 08:41:58 INFO - Running cycle 1/1 for dromaeo_css test... 08:41:58 INFO - TEST-INFO | started process 1921 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmp_aOcL5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:42:00 INFO - PROCESS | 1921 | 2017-01-24 08:42:00.915 plugin-container[1922:16899] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x424b, name = 'com.apple.tsm.portname' 08:42:00 INFO - PROCESS | 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:42:00 INFO - PROCESS | 1921 | 2017-01-24 08:42:00.915 plugin-container[1922:16899] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4617, name = 'com.apple.CFPasteboardClient' 08:42:00 INFO - PROCESS | 1921 | See /usr/include/servers/bootstrap_defs.h for the error codes. 08:42:00 INFO - PROCESS | 1921 | 2017-01-24 08:42:00.915 plugin-container[1922:16899] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 08:42:10 INFO - PROCESS | 1921 | RSS: Main: 178774016 08:42:10 INFO - PROCESS | 1921 | 08:45:12 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:53988/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53988/tests/dromaeo/cssquery-ext.html) 08:45:14 INFO - PROCESS | 1921 | RSS: Main: 183599104 08:45:14 INFO - PROCESS | 1921 | 08:48:16 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:53988/tests/dromaeo/cssquery-ext.html (next: http://localhost:53988/tests/dromaeo/cssquery-jquery.html) 08:48:17 INFO - PROCESS | 1921 | RSS: Main: 195084288 08:48:17 INFO - PROCESS | 1921 | 08:51:19 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:53988/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53988/tests/dromaeo/cssquery-mootools.html) 08:51:20 INFO - PROCESS | 1921 | RSS: Main: 196898816 08:51:20 INFO - PROCESS | 1921 | 08:54:21 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:53988/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53988/tests/dromaeo/cssquery-prototype.html) 08:54:22 INFO - PROCESS | 1921 | RSS: Main: 200003584 08:54:22 INFO - PROCESS | 1921 | 08:57:25 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:53988/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53988/tests/dromaeo/cssquery-yui.html) 08:57:25 INFO - PROCESS | 1921 | RSS: Main: 201338880 08:57:25 INFO - PROCESS | 1921 | 09:00:28 INFO - PROCESS | 1921 | Cycle 1(1): loaded http://localhost:53988/tests/dromaeo/cssquery-yui.html (next: http://localhost:53988/tests/dromaeo/cssquery-dojo.html) 09:00:28 INFO - PROCESS | 1921 | RSS: Main: 201502720 09:00:28 INFO - PROCESS | 1921 | 09:00:28 INFO - PROCESS | 1921 | __start_tp_report 09:00:28 INFO - PROCESS | 1921 | _x_x_mozilla_page_load 09:00:28 INFO - PROCESS | 1921 | _x_x_mozilla_page_load_details 09:00:28 INFO - PROCESS | 1921 | |i|pagename|runs| 09:00:28 INFO - PROCESS | 1921 | |0;dojo.html;3584.1577229351105;3604.4773507841346;3627.038834708804;3632.5096112024876;3661.3775658138115;5974.970125149379;6044.516438684906;6051.818445446638;6061.151438798572;6062.211912451381;6008.459238668519;6029.1257767623665;6089.391060893909;6136.877262454748;6140.048292514667;4700.247960326348;5374.032674118657;5406.432324605899;5421.756020979045;5452.945470545304;5471.316085489314;5475.233467314579;5499.202615620733;5511.3937466878815;5525.364583072957;5364.570834333244;5409.215663728757;5473.616846820724;5482.122860342346;5485.424030476803;5411.648242864201;5423.891522169554;5473.972630136864;5488.121900495901;5549.084401073818;5133.897322053538;5276.657017293864;5413;5415.864603384907;5436.592255580807;5828.97085514574;6002.669853158074;6050.788222412239;6089.421504957022;6131.325554189036;5359.892802143935;6228.096925945712;6236.126942228092;6245.906311405332;6259.561830671855;5341.359036915556;6334;6349.714262858182;6382.393672601095;6401.231852177769;6154.292256390483;6156.384361563808;6158.199434073586;6164.6917654117115;6177.907331390033;6437.774677886251;6448.548601597843;6500.3499650035565;6520.119783829123;6558.80323590293;5789.189513468118;5878.971180043475;6282.183316168869;6306.959351707009;6335;6247.468965137923;6254.2807577129215;6378.266499352541;6401.103845461639;6401.551891367652;6186.443220110122;6244.4380005798785;6278.654673992883;6298.842528936813;6319.873602527924;6289.905651415233;6294.276158241769;6295.685215739195;6330.68346582669;6335.746570137235;5073.949260507347;5180.948190518046;5211.739413029409;5235.162374020215;5250.1337279349245;4563.224251877189;4564.475085365159;4594.563516465931;4609.101225261109;4696.060787842445;5081.263216833612;6170.136180934673;6215.96892015537;6222.471089957314;6259.906101408483;6381.649009304533;6389.2652344980925;6392.137061496638;6395.392437718409;6402.679866006681;5979.402059793986;6016;6162.476189523851;6167.414095660905;6215.751369945152;5649.971750141223;5669.6314739541795;5671.943280567224;5676.858078547987;5693.231413759172;6625.569337993112;6633.237177724431;6665.600063996176;6674.23246326669;6684.4318232950745;6190.969045154746;6209.906851397323;6275.96862015687;6320.652364119834;6377.713002914973;6222.973209420576;6607.141071660845;6647.60114393138;6654.76708315226;6659.933400665931;5782.768689252551;6337.524685648503;6346.650934198663;6349.9682501587195;6358.364163583605;6125.326214116354;6251.906221406592;6255.781047663492;6359.777407790705;6367.204099487564;6136.764169924236;6251.124842522141;6265.843353916189;6279.277883043325;6342.23893132827;5297.496737809902;6241.563090583797;6276.089966954674;6278.215223097113;6300.9684951574945;5321.9467805323;5975.402459754164;6096.603720758137;6264.561480696308;6275.497960163085;6194.5973511721595;6197.907031394623;6200.720967556381;6289.685515724104;6296.496280297473;6212.937870621417;6267.780627678009;6268.561200715906;6302.747890084345;6314.242290924934 09:00:28 INFO - PROCESS | 1921 | |1;ext.html;514.8301060649985;543.4022575167317;549.6701978812711;553.9307586551681;575.1487798058876;37634.811825940866;40131.39802902955;40150.996225094386;40192.79903600481;40241.59154429595;33670;41527;41693.79153104238;41702;41725.165496690046;8983.505907175102;9698.806023879519;9703.2722545809;9710.465924374157;9722.756931076745;9659.5170241488;9717.659881904136;9722.465264410455;9725.805483890317;9732.854007189897;9685.806283874319;9738.367006144577;9744.561494732754;9753.414795112281;9775.657851975182;9583.66457173999;9665.5167241638;9687.70936871895;9696.272779541563;9773.755656108655;9572.808543829155;9608.423494590346;9627.518624068838;9646.517674116336;9687.70936871895;32808.179795505064;39250.21499570021;39471.40792888109;39679.8016009921;39756.801215994026;3254.544363789071;3483.651634836496;3541.8760343388117;3693.519842420495;3802.16352402471;28849.56725649117;29327;30213.546796798066;30647;30647.69352306493;2890.913272601825;3284.983575082133;3322.734181265493;3331.8667253309836;3415.777974431654;493548;500269;501215;503106;503932.99999999633;57597;58101.709491452275;58515.70742146347;58525.70737146287;58592;60407.093893591635;60470.395296047354;60707.39292607106;61026;61181.08228376489;16382.83617163837;16388.180590970405;16639.16804159787;16647.001179929244;16679.583010424838;11038;12992.960563154926;13002.479900804052;13025.088243823031;13035.674108147372;14169.149851008973;14853;15109;15110.622234444007;15135.470258540898;3305.5537502437346;5900.380460051632;6107.297660769068;6793.864122717617;6811.693473793691;899.3389858454032;1001.2590682894605;1032.3135115148493;1095.315427857589;1114.3425379026414;27270.181894543195;27605.447891042066;30160.84919575432;30433.847830760704;30693.69306306953;995.6166875752888;1031.9690409287584;1058.2116323339008;1063.7819247054335;1066.5840322274319;14937.327820248114;15191.392344306105;15267.694646107017;15488.303026363841;15512.767308490382;678241;686094;693807;697013;698447;53698.73150634222;54503;54703.72648136734;54890.725546372014;54968.9999999992;1223.528941357566;1383.6610030542581;1411.7105993271355;1417.4046900301898;1419.9432022719182;28518;29411.823527059532;29416.852915735286;29458.852705736335;29968.550471743376;48579;49451;49785.25322120244;50250;50401.74799125981;615388;620078;622601;623892;624095;25829.3542661435;26048;26200.606990894772;26233.213003609922;26294.342641434116;43740.781296093315;44150.11699766051;44689.55310446854;44978;45338;37271.62728372682;37455.625443745215;37644;37838.62161378351;38036.42945355877;37001.074973125884;37161.88514344574;38103.61896381112;38148.61851381451;38281.23437531178;37607;38515.807420962716;38523.42214866723;39207.80396098001;39763.80118099391;32489.83755081304;34348;34667.653323466446;34738.65261347354;34765;25883.482330353665;25912;26013.73986260113;26057.218283451526;26337.07820226283 09:00:28 INFO - PROCESS | 1921 | |2;jquery.html;351.446471806904;366.152357292867;381.79192340174603;392.25471603952496;399.4228340048631;19594.608107837834;20985.37043888684;21015.054322555483;21314.89342553287;21494.785052149473;20662.76023438591;20791.896040519812;20917.372478825622;20922.163113475443;21213.045412956417;5997.550183736215;6084.1786358841655;6104.2980057293535;6107.7556897724035;6208.689565521706;4324.740515569076;4587.311903214511;5821.883562328772;6184.381561843802;6185.752569897199;6460.547761656686;6734.494912881529;6785.6267905265195;6862.656867156647;6874.862502749942;6735.8989615155815;6821.863562728718;6831.282715314895;6844.589324640488;6857.417119544844;5250.369955605352;5892.646441213498;5930.495907847838;6058.242719660043;6073.574849760518;13366.33168341579;13372.465101395932;20150.891700956443;23788.762112378827;25205.243842684748;1756.9458325005023;1966.8524860635366;2231.0852550454397;2405.711314642254;2767.9896837654314;8429.578521073921;10267.178625709925;10442.79114417715;10789.892101079045;10834.241603087787;1667.9310069472228;1877.8122187781112;1938.8642795004355;1939.41817454763;2046.9590608187752;125622.37188813997;126097;132855.33572332174;133155;135026.6497335024;11803.940980295043;11818.468168932419;11876.22804517721;11929.582464613697;12005.579804706793;15147.015443996104;15152.31814568347;15204.543863684106;15209;15211.935164538376;7434.36807871337;8684.56577171139;8751.124887511325;8839.381243312906;8979.865302020475;8776.648934042567;8803.471791692391;8840.646374145092;8975.237104846161;9020.8646870297;4323.610875021263;4570.840020599263;4710.175719249118;4711.387519622495;4749.097671442415;1623.602217456707;1713.1605513298643;1948.6395016921915;2004.298495526554;2009.2063634864146;821.2198411508971;825.8761185822175;937.8686983822271;1025.3079171559168;1032.8812186598636;21438;21791.23730669419;21807.345779626638;21864;21977.560448790933;916.5188276154938;921.9400738951947;961.485605201214;1023.2785885950387;1026.5423099199156;11198.496067676973;11232.93287137737;11545.191836571359;11626.186166968231;11680.474378652982;613058;615435;622176;625808;629243;136186.31906840403;137271;138774;139263;141999.2900035493;957.7126861941529;966.1353088985319;972.3728195313982;974.6637410093506;1002.173207104142;18167.36414225496;18898.338558150397;19290.035498225312;19393.32123375675;19416.320428784926;40738;55962;57118.7144064277;57466.7126664364;58486;75667.62166189133;77749.61125194338;78385.21614784007;78819;80060;6022.969885150546;6915.619640919797;7376.225496322809;7416.666250018654;7716.575588342471;7141.357277845019;9193.218720627992;12815.295158766357;12961;12977.35113244353;7456.4034877208605;11127.054200393057;11277.266977646426;11362.261453005529;11604.593839215588;10978.725531861768;11187.384693841592;11484.655460336204;11531.250468719507;11661;10928.289661171999;11452.541898324307;11541.537538738512;11653.834616538279;11830.881691183322;6562.5406221564035;7326.194118647051;7629;7702.42231832626;7868.488548244346;9707.126358627758;11326.037286830711;11346.716332091764;11397.544098235978;11615 09:00:28 INFO - PROCESS | 1921 | |3;mootools.html;1391.144446165608;1524.184561259726;1706.0957692423012;1854.805245449227;1874.5219968907927;7519.135299440566;7736.535807851533;7962.402819788517;8384.958075209623;8401.53791541465;7855.960720196405;8146.185381461865;8152.714654987077;8242.464239824407;8253.628586713598;2013.798620137989;2338.3569518382496;2372.430616652008;2375.0737212487143;2383.3207535852284;2365.136725095345;2393.7845593896545;2424.987875060622;2427.8421902576365;2428.9757102428925;2361.3034154924253;2369.7748713872156;2381.5117900830287;2390.091765129257;2390.6772585700883;2017.5964807038504;2341.262502311775;2374.9881250593635;2382.6902502674716;2382.797462215705;2372.1223147435385;2384.0463814474174;2400.603900356439;2413.5655581995234;2414.6619473273754;8233.34133269343;8259.876101858477;8336.583170841493;8350.415470917038;8350.707725229588;5102.540771330598;5243.947560524384;5257.763400646942;5262.02652509287;5277.182036784305;3485.4597537381746;3494.8776792812127;3509.982450087759;3547.7161827053774;3616.5298511193378;1041.8801837788676;1066.2216581895182;1073.640330489287;1097.286763603664;1100.3782862682558;10495.002974717467;10550.841737373945;10585.682429527204;10604.628837990711;10612.416317102556;4094.3039683253323;4440.511543730187;4467.888302792456;4663.930041049387;4696.788644511005;9170.266378689688;9250.814983700287;9260.907390926139;9265.25877929764;9278.768030799283;5208.869778255574;5215.973920130375;5216.895662086737;5217.713025783542;5221.791128354899;4369.497507786582;4371.69398142127;4731.881702957454;4794.664373493892;4815.15734746418;3827.3110840048503;3874.49631547897;3909.6285852843935;3954.5847685992558;3975.5626881043063;1102.2174256277972;1286.9356532173354;1288.6327396691897;1301.9739605208033;1303.7848754955517;810.266708628692;867.7223288547605;921.4425272709914;926.3284119013796;926.6154545863391;5541.806036788693;5595.496405323541;5636.689982050944;5720.998825205573;5722.7424765885635;442.6234410981844;451.10680851913395;460.39458112582514;461.0617393604;465.03041159182806;3836;3858.5176852893387;3903.316919539126;3923.6272554107313;3984.8007599619905;9531.952340238255;9689.951550242204;9795;9815.754606134904;9999.950000249952;9736.659216927515;9748;9750.463724495221;9751.804963900682;9774.022597740312;7361.595112268769;7678.462507624413;7795.610219488889;7823.921760782433;7847.176046515148;5441.891162176655;5590.664560126405;5646.181303710857;5671.092625180117;5674.148877668383;9085.954570227106;9104.362694611315;9116.954415227881;9170.44977301364;9223.953880230556;9269.30480214;9332.486713230837;9342.859857102285;9348.439093654402;9457;6500.414962653384;6713.261541230363;6883.862322753617;7011.964940175267;7106.609136497542;7686.3466605336935;7885.64514596833;7888.48724832884;7893.6580781266175;7910.169432209535;6951.270116637883;7146.535475194096;7147.606881621353;7175.533590316612;7192;6935.89596156048;6970.79087627372;6985.441164706913;7024.438044956493;7070.71717131309;6600.339966003361;6627.668616569249;6711.664416779239;6725.361090696376;6732.966335168293;4543.273076307775;4658.114958157939;4856.320115183948;4867;4942.431620363561;4882.584980276716;4931.161702510653;4940.160172770566;4963.726995015309;4986.700797952134 09:00:28 INFO - PROCESS | 1921 | |4;prototype.html;290.0818908155687;297.16941149487184;299.61200245681846;304.52494109189666;304.7333583114774;5248.790048398069;5449.346078470584;5456.554013186509;5459.3994660587305;5524.9999999999945;5283.418823929364;5397.487238712326;5415.756290966906;5452.154915988019;5461.208124821898;3936.7637941723447;4019;4059.2084543514025;4077.7961101944784;4111.588841115894;3929.6659783918403;4102.261592913274;4111.417104414807;4134.131832315203;4172.207280616673;4083.4691490106393;4083.8570650027254;4089.243489954353;4095.692823038269;4146.502419709639;3986.3223252047223;4011.358182690785;4084.407760874686;4095.4471146395153;4116.711830171889;3562.2341196642587;3564.8254564715503;3570.0539357070397;3592.550931133608;3597.748157628967;5302.628815982883;5303.496167864047;5321.552086040388;5323.349761573924;5330.840074797762;3871.8838434847;4422.248217802981;4565.817367305303;4749.335093086971;4780.545848144421;5193.584513238932;5304.708241046741;5734.7025460360455;5752.712364381764;5798.333191682968;3863.860161252437;3964.2448498293697;3984.6613037891816;3989.4614227079264;4001.479807625019;5195.740212989335;5509.752061157257;5640.153976903497;6027.397260273981;6058.455093951058;3791.8479265204555;3804.087019115392;4007.358822588372;4019.764089907594;4029.234445455354;4079.4492743479846;4098.4876890388705;4105.85629502966;4114.855980040684;4120.052387950788;3959.5644479107277;4146.626803587631;4158.979205103955;4729.503402142795;4730.077634861169;5265.315508983884;5484.698341591251;5731.512821410143;5750.223719797774;5754.539636829044;1258.8489381274305;1262.4950019991893;1315.7171757536325;1340.9798853017212;1343.6640839790052;850.8511010573249;853.5774791478258;900.5362238447204;910.1035480052143;915.5056269614333;4621.735349678701;5026.949730502722;5081.568066714371;5418.701971391532;5480.7533660985355;5944.346121926585;5955.367225992141;5977.163197152315;6013.368596297413;6065.484433823174;5283.260343551906;5494.36814766299;5531.446855314436;5547.472990065938;5607.299087614048;2499.262717498342;2671.4523522677805;2834.957475637867;2931.692172321918;2996.475616767057;5376.55900223857;5716.828495145152;5902.793402230901;5908.556858235649;5993.700314984233;5420.268263784339;5466.398696143421;5785.421457854265;5844.707764611752;5947.494462970696;4672.182368085571;4793.616510679207;5429.457054294539;5721.256236689287;5978.342382337939;5254.842354729364;5281.815136470205;5447.945520544902;5760.567957403127;5793.26202139365;4998.750062496788;5241.31862857826;5462.535684466865;5616.001758435078;5648.519875810603;5054.91319366338;5236.941370437941;5242.906685055683;5901.203337549376;5925.970370148294;3475.548178736748;3540.5574303212097;3793.374093274689;3843.1160833008007;3879.049632839972;5239.711815850165;5671.404502527175;5675.976760566846;5686.038316780704;5725.139329717775;4671.135839869635;5008.774605142705;5099.56653684441;5334.11987022137;5510.586705996986;4538.2738761797955;4603.792829322755;5446.863828404322;5489.807856724996;5553.194786755978;4787.664863459524;5346.6257361985845;5357.705326207096;5395.892082158413;5401.864953376197;4552;5360.356757189163;5703.657780533182;5762.974438419863;5775.556110972257;4688.437387513521;5306.389765177054;5510.448955104457;5620.8875822482505;5669.886602268014 09:00:28 INFO - PROCESS | 1921 | |5;yui.html;650.9357200976403;727.294524311418;731.3417923868515;745.1728581274784;788.47943930351;11889.583864564742;14475.638109047279;14659.926700366497;15422.768658470131;15611.84388156118;14692.338844751985;15461.381544738226;15502.06987580746;15555.144467054308;15724.606884827885;878.9165029322204;882.686646240585;904.1952662130709;905.5653286422488;906.8095699902996;711.2070041903266;728.7922941961542;889.89321281446;892.4065496444856;893.7810236492036;909.9181073703365;929.372673445425;943.8678584998106;944.551338114397;946.8816397950256;927.2813569483636;928.4058202750246;928.8420968435382;929.4702019848689;935.957881895313;675.4528831646332;696.4150113904344;696.9651517424109;699.6851416862432;702.4450683959666;14628.488002919954;14695.971282010263;14961.102333860003;15062.849371506254;15140;13368.465261389532;13501.2574308413;13531.32343382827;13805.585832425044;13878.097923635032;12614.68463288416;12727.93636031814;12787.296698681568;12932.28872412017;12968.157069790434;4405.493368262627;4440.222960981848;4506.369108324837;4542.454905411372;4633.911030907734;87311.56344218302;88577.11422885754;90119;96728.51635741776;96790.0320996788;9833.721616189992;11048.668539943814;11123.221374503868;11129.554817807197;11130.944345278222;21076.156953721988;21248.25631102904;21449.249276275255;21547.461313467287;21638.783612163676;7865.764027079197;8099.595020248964;8155.918440815634;8157.306628936607;8279.089300176976;4311.353297005411;4482.75344856036;4563.133004729091;4590;4637.860864174013;3404.1659793350786;3491.4239150540384;3510.8069056201643;3522.682958533744;3548.379033669149;640.145405883142;659.4987809264993;661.5600625583933;666.9199696036507;671.0471130994;636.7994081864198;678.8744082344782;685.1401491128602;687.5737043033251;721.2535026247808;9090.545472726337;9382.718518444457;9443.102905223992;9552.713418597454;9690.70927872165;637.7704026550438;645.1838424393146;697.2539382860392;700.9964950175216;702.9156501219784;4245.108527209259;4482.955170448319;4585.312203169551;4705.341252224691;4711.199096153662;77402;80450.59774701089;98357.5246371305;118658;130289.34855325663;92462.53768731114;112534;113801.86198137913;115837;116037;68750;95744.56383154259;96037.5198124005;98110.01889981152;100526;8799.692010779592;9024.503652299187;9143.222826059859;9147.908520914705;9156.221721153777;44832.32751508665;51722.448326550264;59412.70293648504;62382;62695;79917;90219.09780902107;91531.54234228787;91816.54091729499;92169;11854.703632409259;11969.940150299193;11983.400829958642;12026.458809353775;12296.938515307365;10708.785824283315;12613.36933153357;12899.871001289866;12940.547080852126;13140.934295328461;11997.184131988772;12069.456874440846;12278;12325.876741232833;12330.951869090868;11966.22219555726;12260.632181034583;12268.38658067111;12396.81404778911;12424.75150497003;12104.75790484203;12105;12174.817377739519;12209.389530523616;12260.38698065111;10430.16558675289;10478.109360704426;10604.734881628021;10909;10959.506822192861;9621.807563848824;9842;10425.374477531372;10452.738681533023;10458.47707614601 09:00:28 INFO - PROCESS | 1921 | __end_tp_report 09:00:28 INFO - PROCESS | 1921 | __start_cc_report 09:00:28 INFO - PROCESS | 1921 | _x_x_mozilla_cycle_collect,363 09:00:28 INFO - PROCESS | 1921 | __end_cc_report 09:00:28 INFO - PROCESS | 1921 | __startTimestamp1485277228661__endTimestamp 09:00:28 INFO - PROCESS | 1921 | 09:00:28 INFO - PROCESS | 1921 | ------- Summary: start ------- 09:00:28 INFO - PROCESS | 1921 | Number of tests: 6 09:00:28 INFO - PROCESS | 1921 | 09:00:28 INFO - PROCESS | 1921 | [#0] dojo.html Cycles:165 Average:5923.51 Median:6186.44 stddev:629.05 (10.2%) stddev-sans-first:603.62 09:00:28 INFO - PROCESS | 1921 | Values: 3584.2 3604.5 3627.0 3632.5 3661.4 5975.0 6044.5 6051.8 6061.2 6062.2 6008.5 6029.1 6089.4 6136.9 6140.0 4700.2 5374.0 5406.4 5421.8 5452.9 5471.3 5475.2 5499.2 5511.4 5525.4 5364.6 5409.2 5473.6 5482.1 5485.4 5411.6 5423.9 5474.0 5488.1 5549.1 5133.9 5276.7 5413.0 5415.9 5436.6 5829.0 6002.7 6050.8 6089.4 6131.3 5359.9 6228.1 6236.1 6245.9 6259.6 5341.4 6334.0 6349.7 6382.4 6401.2 6154.3 6156.4 6158.2 6164.7 6177.9 6437.8 6448.5 6500.3 6520.1 6558.8 5789.2 5879.0 6282.2 6307.0 6335.0 6247.5 6254.3 6378.3 6401.1 6401.6 6186.4 6244.4 6278.7 6298.8 6319.9 6289.9 6294.3 6295.7 6330.7 6335.7 5073.9 5180.9 5211.7 5235.2 5250.1 4563.2 4564.5 4594.6 4609.1 4696.1 5081.3 6170.1 6216.0 6222.5 6259.9 6381.6 6389.3 6392.1 6395.4 6402.7 5979.4 6016.0 6162.5 6167.4 6215.8 5650.0 5669.6 5671.9 5676.9 5693.2 6625.6 6633.2 6665.6 6674.2 6684.4 6191.0 6209.9 6276.0 6320.7 6377.7 6223.0 6607.1 6647.6 6654.8 6659.9 5782.8 6337.5 6346.7 6350.0 6358.4 6125.3 6251.9 6255.8 6359.8 6367.2 6136.8 6251.1 6265.8 6279.3 6342.2 5297.5 6241.6 6276.1 6278.2 6301.0 5321.9 5975.4 6096.6 6264.6 6275.5 6194.6 6197.9 6200.7 6289.7 6296.5 6212.9 6267.8 6268.6 6302.7 6314.2 09:00:28 INFO - PROCESS | 1921 | 09:00:28 INFO - PROCESS | 1921 | [#1] ext.html Cycles:180 Average:72537.45 Median:39229.01 stddev:163255.66 (416.2%) stddev-sans-first:163624.07 09:00:28 INFO - PROCESS | 1921 | Values: 514.8 543.4 549.7 553.9 575.1 37634.8 40131.4 40151.0 40192.8 40241.6 33670.0 41527.0 41693.8 41702.0 41725.2 8983.5 9698.8 9703.3 9710.5 9722.8 9659.5 9717.7 9722.5 9725.8 9732.9 9685.8 9738.4 9744.6 9753.4 9775.7 9583.7 9665.5 9687.7 9696.3 9773.8 9572.8 9608.4 9627.5 9646.5 9687.7 32808.2 39250.2 39471.4 39679.8 39756.8 3254.5 3483.7 3541.9 3693.5 3802.2 28849.6 29327.0 30213.5 30647.0 30647.7 2890.9 3285.0 3322.7 3331.9 3415.8 493548.0 500269.0 501215.0 503106.0 503933.0 57597.0 58101.7 58515.7 58525.7 58592.0 60407.1 60470.4 60707.4 61026.0 61181.1 16382.8 16388.2 16639.2 16647.0 16679.6 11038.0 12993.0 13002.5 13025.1 13035.7 14169.1 14853.0 15109.0 15110.6 15135.5 3305.6 5900.4 6107.3 6793.9 6811.7 899.3 1001.3 1032.3 1095.3 1114.3 27270.2 27605.4 30160.8 30433.8 30693.7 995.6 1032.0 1058.2 1063.8 1066.6 14937.3 15191.4 15267.7 15488.3 15512.8 678241.0 686094.0 693807.0 697013.0 698447.0 53698.7 54503.0 54703.7 54890.7 54969.0 1223.5 1383.7 1411.7 1417.4 1419.9 28518.0 29411.8 29416.9 29458.9 29968.6 48579.0 49451.0 49785.3 50250.0 50401.7 615388.0 620078.0 622601.0 623892.0 624095.0 25829.4 26048.0 26200.6 26233.2 26294.3 43740.8 44150.1 44689.6 44978.0 45338.0 37271.6 37455.6 37644.0 37838.6 38036.4 37001.1 37161.9 38103.6 38148.6 38281.2 37607.0 38515.8 38523.4 39207.8 39763.8 32489.8 34348.0 34667.7 34738.7 34765.0 25883.5 25912.0 26013.7 26057.2 26337.1 09:00:28 INFO - PROCESS | 1921 | 09:00:28 INFO - PROCESS | 1921 | [#2] jquery.html Cycles:180 Average:36253.95 Median:13009.92 stddev:104069.04 (799.9%) stddev-sans-first:104326.07 09:00:28 INFO - PROCESS | 1921 | Values: 351.4 366.2 381.8 392.3 399.4 19594.6 20985.4 21015.1 21314.9 21494.8 20662.8 20791.9 20917.4 20922.2 21213.0 5997.6 6084.2 6104.3 6107.8 6208.7 4324.7 4587.3 5821.9 6184.4 6185.8 6460.5 6734.5 6785.6 6862.7 6874.9 6735.9 6821.9 6831.3 6844.6 6857.4 5250.4 5892.6 5930.5 6058.2 6073.6 13366.3 13372.5 20150.9 23788.8 25205.2 1756.9 1966.9 2231.1 2405.7 2768.0 8429.6 10267.2 10442.8 10789.9 10834.2 1667.9 1877.8 1938.9 1939.4 2047.0 125622.4 126097.0 132855.3 133155.0 135026.6 11803.9 11818.5 11876.2 11929.6 12005.6 15147.0 15152.3 15204.5 15209.0 15211.9 7434.4 8684.6 8751.1 8839.4 8979.9 8776.6 8803.5 8840.6 8975.2 9020.9 4323.6 4570.8 4710.2 4711.4 4749.1 1623.6 1713.2 1948.6 2004.3 2009.2 821.2 825.9 937.9 1025.3 1032.9 21438.0 21791.2 21807.3 21864.0 21977.6 916.5 921.9 961.5 1023.3 1026.5 11198.5 11232.9 11545.2 11626.2 11680.5 613058.0 615435.0 622176.0 625808.0 629243.0 136186.3 137271.0 138774.0 139263.0 141999.3 957.7 966.1 972.4 974.7 1002.2 18167.4 18898.3 19290.0 19393.3 19416.3 40738.0 55962.0 57118.7 57466.7 58486.0 75667.6 77749.6 78385.2 78819.0 80060.0 6023.0 6915.6 7376.2 7416.7 7716.6 7141.4 9193.2 12815.3 12961.0 12977.4 7456.4 11127.1 11277.3 11362.3 11604.6 10978.7 11187.4 11484.7 11531.3 11661.0 10928.3 11452.5 11541.5 11653.8 11830.9 6562.5 7326.2 7629.0 7702.4 7868.5 9707.1 11326.0 11346.7 11397.5 11615.0 09:00:28 INFO - PROCESS | 1921 | 09:00:28 INFO - PROCESS | 1921 | [#3] mootools.html Cycles:180 Average:5400.70 Median:5232.87 stddev:2913.69 (55.7%) stddev-sans-first:2906.28 09:00:28 INFO - PROCESS | 1921 | Values: 1391.1 1524.2 1706.1 1854.8 1874.5 7519.1 7736.5 7962.4 8385.0 8401.5 7856.0 8146.2 8152.7 8242.5 8253.6 2013.8 2338.4 2372.4 2375.1 2383.3 2365.1 2393.8 2425.0 2427.8 2429.0 2361.3 2369.8 2381.5 2390.1 2390.7 2017.6 2341.3 2375.0 2382.7 2382.8 2372.1 2384.0 2400.6 2413.6 2414.7 8233.3 8259.9 8336.6 8350.4 8350.7 5102.5 5243.9 5257.8 5262.0 5277.2 3485.5 3494.9 3510.0 3547.7 3616.5 1041.9 1066.2 1073.6 1097.3 1100.4 10495.0 10550.8 10585.7 10604.6 10612.4 4094.3 4440.5 4467.9 4663.9 4696.8 9170.3 9250.8 9260.9 9265.3 9278.8 5208.9 5216.0 5216.9 5217.7 5221.8 4369.5 4371.7 4731.9 4794.7 4815.2 3827.3 3874.5 3909.6 3954.6 3975.6 1102.2 1286.9 1288.6 1302.0 1303.8 810.3 867.7 921.4 926.3 926.6 5541.8 5595.5 5636.7 5721.0 5722.7 442.6 451.1 460.4 461.1 465.0 3836.0 3858.5 3903.3 3923.6 3984.8 9532.0 9690.0 9795.0 9815.8 10000.0 9736.7 9748.0 9750.5 9751.8 9774.0 7361.6 7678.5 7795.6 7823.9 7847.2 5441.9 5590.7 5646.2 5671.1 5674.1 9086.0 9104.4 9117.0 9170.4 9224.0 9269.3 9332.5 9342.9 9348.4 9457.0 6500.4 6713.3 6883.9 7012.0 7106.6 7686.3 7885.6 7888.5 7893.7 7910.2 6951.3 7146.5 7147.6 7175.5 7192.0 6935.9 6970.8 6985.4 7024.4 7070.7 6600.3 6627.7 6711.7 6725.4 6733.0 4543.3 4658.1 4856.3 4867.0 4942.4 4882.6 4931.2 4940.2 4963.7 4986.7 09:00:28 INFO - PROCESS | 1921 | 09:00:28 INFO - PROCESS | 1921 | [#4] prototype.html Cycles:180 Average:4564.66 Median:5245.85 stddev:1388.34 (26.5%) stddev-sans-first:1354.65 09:00:28 INFO - PROCESS | 1921 | Values: 290.1 297.2 299.6 304.5 304.7 5248.8 5449.3 5456.6 5459.4 5525.0 5283.4 5397.5 5415.8 5452.2 5461.2 3936.8 4019.0 4059.2 4077.8 4111.6 3929.7 4102.3 4111.4 4134.1 4172.2 4083.5 4083.9 4089.2 4095.7 4146.5 3986.3 4011.4 4084.4 4095.4 4116.7 3562.2 3564.8 3570.1 3592.6 3597.7 5302.6 5303.5 5321.6 5323.3 5330.8 3871.9 4422.2 4565.8 4749.3 4780.5 5193.6 5304.7 5734.7 5752.7 5798.3 3863.9 3964.2 3984.7 3989.5 4001.5 5195.7 5509.8 5640.2 6027.4 6058.5 3791.8 3804.1 4007.4 4019.8 4029.2 4079.4 4098.5 4105.9 4114.9 4120.1 3959.6 4146.6 4159.0 4729.5 4730.1 5265.3 5484.7 5731.5 5750.2 5754.5 1258.8 1262.5 1315.7 1341.0 1343.7 850.9 853.6 900.5 910.1 915.5 4621.7 5026.9 5081.6 5418.7 5480.8 5944.3 5955.4 5977.2 6013.4 6065.5 5283.3 5494.4 5531.4 5547.5 5607.3 2499.3 2671.5 2835.0 2931.7 2996.5 5376.6 5716.8 5902.8 5908.6 5993.7 5420.3 5466.4 5785.4 5844.7 5947.5 4672.2 4793.6 5429.5 5721.3 5978.3 5254.8 5281.8 5447.9 5760.6 5793.3 4998.8 5241.3 5462.5 5616.0 5648.5 5054.9 5236.9 5242.9 5901.2 5926.0 3475.5 3540.6 3793.4 3843.1 3879.0 5239.7 5671.4 5676.0 5686.0 5725.1 4671.1 5008.8 5099.6 5334.1 5510.6 4538.3 4603.8 5446.9 5489.8 5553.2 4787.7 5346.6 5357.7 5395.9 5401.9 4552.0 5360.4 5703.7 5763.0 5775.6 4688.4 5306.4 5510.4 5620.9 5669.9 09:00:28 INFO - PROCESS | 1921 | 09:00:28 INFO - PROCESS | 1921 | [#5] yui.html Cycles:180 Average:21562.62 Median:4611.96 stddev:32231.24 (698.9%) stddev-sans-first:32283.42 09:00:28 INFO - PROCESS | 1921 | Values: 650.9 727.3 731.3 745.2 788.5 11889.6 14475.6 14659.9 15422.8 15611.8 14692.3 15461.4 15502.1 15555.1 15724.6 878.9 882.7 904.2 905.6 906.8 711.2 728.8 889.9 892.4 893.8 909.9 929.4 943.9 944.6 946.9 927.3 928.4 928.8 929.5 936.0 675.5 696.4 697.0 699.7 702.4 14628.5 14696.0 14961.1 15062.8 15140.0 13368.5 13501.3 13531.3 13805.6 13878.1 12614.7 12727.9 12787.3 12932.3 12968.2 4405.5 4440.2 4506.4 4542.5 4633.9 87311.6 88577.1 90119.0 96728.5 96790.0 9833.7 11048.7 11123.2 11129.6 11130.9 21076.2 21248.3 21449.2 21547.5 21638.8 7865.8 8099.6 8155.9 8157.3 8279.1 4311.4 4482.8 4563.1 4590.0 4637.9 3404.2 3491.4 3510.8 3522.7 3548.4 640.1 659.5 661.6 666.9 671.0 636.8 678.9 685.1 687.6 721.3 9090.5 9382.7 9443.1 9552.7 9690.7 637.8 645.2 697.3 701.0 702.9 4245.1 4483.0 4585.3 4705.3 4711.2 77402.0 80450.6 98357.5 118658.0 130289.3 92462.5 112534.0 113801.9 115837.0 116037.0 68750.0 95744.6 96037.5 98110.0 100526.0 8799.7 9024.5 9143.2 9147.9 9156.2 44832.3 51722.4 59412.7 62382.0 62695.0 79917.0 90219.1 91531.5 91816.5 92169.0 11854.7 11969.9 11983.4 12026.5 12296.9 10708.8 12613.4 12899.9 12940.5 13140.9 11997.2 12069.5 12278.0 12325.9 12331.0 11966.2 12260.6 12268.4 12396.8 12424.8 12104.8 12105.0 12174.8 12209.4 12260.4 10430.2 10478.1 10604.7 10909.0 10959.5 9621.8 9842.0 10425.4 10452.7 10458.5 09:00:28 INFO - PROCESS | 1921 | -------- Summary: end -------- 09:00:28 INFO - PROCESS | 1921 | 09:00:29 INFO - TEST-INFO | 1921: exit 0 09:00:29 INFO - TEST-OK | dromaeo_css | took 1114678ms 09:00:29 INFO - TEST-START | kraken 09:00:29 INFO - operating with platform_type : mac_ 09:00:29 INFO - Initialising browser for kraken test... 09:00:29 INFO - TEST-INFO | started process 1927 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpoXxbHz/profile http://localhost:53988/getInfo.html) 09:00:31 INFO - PROCESS | 1927 | 2017-01-24 09:00:31.882 plugin-container[1929:18827] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x853f, name = 'com.apple.tsm.portname' 09:00:31 INFO - PROCESS | 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:00:31 INFO - PROCESS | 1927 | 2017-01-24 09:00:31.883 plugin-container[1929:18827] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 09:00:31 INFO - PROCESS | 1927 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:00:31 INFO - PROCESS | 1927 | 2017-01-24 09:00:31.883 plugin-container[1929:18827] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:00:31 INFO - PROCESS | 1927 | __metrics Screen width/height:1600/1200 09:00:31 INFO - PROCESS | 1927 | colorDepth:24 09:00:31 INFO - PROCESS | 1927 | Browser inner width/height: 1024/689 09:00:31 INFO - PROCESS | 1927 | __metrics 09:00:32 ERROR - PROCESS | 1927 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3181: TypeError: this.tabs is undefined 09:00:32 INFO - TEST-INFO | 1927: exit 0 09:00:32 INFO - Browser initialized. 09:00:32 INFO - Running cycle 1/1 for kraken test... 09:00:32 INFO - TEST-INFO | started process 1930 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/tmpoXxbHz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:00:35 INFO - PROCESS | 1930 | 2017-01-24 09:00:35.386 plugin-container[1931:18967] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4543, name = 'com.apple.tsm.portname' 09:00:35 INFO - PROCESS | 1930 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:00:35 INFO - PROCESS | 1930 | 2017-01-24 09:00:35.386 plugin-container[1931:18967] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 09:00:35 INFO - PROCESS | 1930 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:00:35 INFO - PROCESS | 1930 | 2017-01-24 09:00:35.386 plugin-container[1931:18967] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:00:45 INFO - PROCESS | 1930 | RSS: Main: 178364416 09:00:45 INFO - PROCESS | 1930 | 09:00:48 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53988/tests/kraken/driver.html?testName=audio-beat-detection) 09:00:49 INFO - PROCESS | 1930 | RSS: Main: 190648320 09:00:49 INFO - PROCESS | 1930 | 09:00:51 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53988/tests/kraken/driver.html?testName=audio-dft) 09:00:52 INFO - PROCESS | 1930 | RSS: Main: 198742016 09:00:52 INFO - PROCESS | 1930 | 09:00:55 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53988/tests/kraken/driver.html?testName=audio-fft) 09:00:56 INFO - PROCESS | 1930 | RSS: Main: 202694656 09:00:56 INFO - PROCESS | 1930 | 09:00:57 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53988/tests/kraken/driver.html?testName=audio-oscillator) 09:00:58 INFO - PROCESS | 1930 | RSS: Main: 203833344 09:00:58 INFO - PROCESS | 1930 | 09:01:00 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53988/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:01:01 INFO - PROCESS | 1930 | RSS: Main: 204185600 09:01:01 INFO - PROCESS | 1930 | 09:01:03 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53988/tests/kraken/driver.html?testName=imaging-darkroom) 09:01:04 INFO - PROCESS | 1930 | RSS: Main: 207888384 09:01:04 INFO - PROCESS | 1930 | 09:01:07 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53988/tests/kraken/driver.html?testName=imaging-desaturate) 09:01:08 INFO - PROCESS | 1930 | RSS: Main: 208269312 09:01:08 INFO - PROCESS | 1930 | 09:01:11 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53988/tests/kraken/driver.html?testName=json-parse-financial) 09:01:11 INFO - PROCESS | 1930 | RSS: Main: 207572992 09:01:11 INFO - PROCESS | 1930 | 09:01:13 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53988/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:01:13 INFO - PROCESS | 1930 | RSS: Main: 206782464 09:01:13 INFO - PROCESS | 1930 | 09:01:15 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:01:16 INFO - PROCESS | 1930 | RSS: Main: 207093760 09:01:16 INFO - PROCESS | 1930 | 09:01:18 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:01:19 INFO - PROCESS | 1930 | RSS: Main: 207065088 09:01:19 INFO - PROCESS | 1930 | 09:01:22 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:01:22 INFO - PROCESS | 1930 | RSS: Main: 206921728 09:01:22 INFO - PROCESS | 1930 | 09:01:25 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:01:26 INFO - PROCESS | 1930 | RSS: Main: 207278080 09:01:26 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | Cycle 1(1): loaded http://localhost:53988/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53988/tests/kraken/driver.html?testName=ai-astar) 09:01:28 INFO - PROCESS | 1930 | RSS: Main: 208941056 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | __start_tp_report 09:01:28 INFO - PROCESS | 1930 | _x_x_mozilla_page_load 09:01:28 INFO - PROCESS | 1930 | _x_x_mozilla_page_load_details 09:01:28 INFO - PROCESS | 1930 | |i|pagename|runs| 09:01:28 INFO - PROCESS | 1930 | |0;ai-astar;105;118;117;118;140;156;118;117;117;116 09:01:28 INFO - PROCESS | 1930 | |1;audio-beat-detection;142;111;113;142;115;143;142;111;137;111 09:01:28 INFO - PROCESS | 1930 | |2;audio-dft;198;200;197;201;199;195;200;197;199;197 09:01:28 INFO - PROCESS | 1930 | |3;audio-fft;81;58;60;96;58;57;58;58;76;59 09:01:28 INFO - PROCESS | 1930 | |4;audio-oscillator;86;70;88;72;69;70;86;69;74;85 09:01:28 INFO - PROCESS | 1930 | |5;imaging-gaussian-blur;90;87;89;87;91;86;89;87;105;87 09:01:28 INFO - PROCESS | 1930 | |6;imaging-darkroom;102;155;117;133;97;169;169;122;97;99 09:01:28 INFO - PROCESS | 1930 | |7;imaging-desaturate;107;143;125;85;87;91;90;90;87;110 09:01:28 INFO - PROCESS | 1930 | |8;json-parse-financial;54;55;54;56;58;60;59;60;59;59 09:01:28 INFO - PROCESS | 1930 | |9;json-stringify-tinderbox;67;71;69;75;70;69;72;70;70;70 09:01:28 INFO - PROCESS | 1930 | |10;stanford-crypto-aes;82;83;81;84;84;83;81;86;83;74 09:01:28 INFO - PROCESS | 1930 | |11;stanford-crypto-ccm;154;152;147;144;138;155;161;162;183;162 09:01:28 INFO - PROCESS | 1930 | |12;stanford-crypto-pbkdf2;167;169;163;176;222;215;171;165;164;182 09:01:28 INFO - PROCESS | 1930 | |13;stanford-crypto-sha256-iterative;69;69;66;65;66;64;69;68;67;65 09:01:28 INFO - PROCESS | 1930 | __end_tp_report 09:01:28 INFO - PROCESS | 1930 | __start_cc_report 09:01:28 INFO - PROCESS | 1930 | _x_x_mozilla_cycle_collect,928 09:01:28 INFO - PROCESS | 1930 | __end_cc_report 09:01:28 INFO - PROCESS | 1930 | __startTimestamp1485277288314__endTimestamp 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | ------- Summary: start ------- 09:01:28 INFO - PROCESS | 1930 | Number of tests: 14 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#0] ai-astar Cycles:10 Average:122.20 Median:118.00 stddev:14.63 (12.4%) stddev-sans-first:14.14 09:01:28 INFO - PROCESS | 1930 | Values: 105.0 118.0 117.0 118.0 140.0 156.0 118.0 117.0 117.0 116.0 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:139.50 stddev:15.41 (11.0%) stddev-sans-first:15.32 09:01:28 INFO - PROCESS | 1930 | Values: 142.0 111.0 113.0 142.0 115.0 143.0 142.0 111.0 137.0 111.0 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#2] audio-dft Cycles:10 Average:198.30 Median:199.00 stddev:1.83 (0.9%) stddev-sans-first:1.94 09:01:28 INFO - PROCESS | 1930 | Values: 198.0 200.0 197.0 201.0 199.0 195.0 200.0 197.0 199.0 197.0 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#3] audio-fft Cycles:10 Average:66.10 Median:59.50 stddev:13.53 (22.7%) stddev-sans-first:13.23 09:01:28 INFO - PROCESS | 1930 | Values: 81.0 58.0 60.0 96.0 58.0 57.0 58.0 58.0 76.0 59.0 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:79.50 stddev:8.21 (10.3%) stddev-sans-first:8.02 09:01:28 INFO - PROCESS | 1930 | Values: 86.0 70.0 88.0 72.0 69.0 70.0 86.0 69.0 74.0 85.0 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#5] imaging-gaussian-blur Cycles:10 Average:89.80 Median:88.00 stddev:5.57 (6.3%) stddev-sans-first:5.91 09:01:28 INFO - PROCESS | 1930 | Values: 90.0 87.0 89.0 87.0 91.0 86.0 89.0 87.0 105.0 87.0 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#6] imaging-darkroom Cycles:10 Average:126.00 Median:169.00 stddev:29.20 (17.3%) stddev-sans-first:29.65 09:01:28 INFO - PROCESS | 1930 | Values: 102.0 155.0 117.0 133.0 97.0 169.0 169.0 122.0 97.0 99.0 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#7] imaging-desaturate Cycles:10 Average:101.50 Median:87.00 stddev:19.56 (22.5%) stddev-sans-first:20.65 09:01:28 INFO - PROCESS | 1930 | Values: 107.0 143.0 125.0 85.0 87.0 91.0 90.0 90.0 87.0 110.0 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#8] json-parse-financial Cycles:10 Average:57.40 Median:59.00 stddev:2.41 (4.1%) stddev-sans-first:2.22 09:01:28 INFO - PROCESS | 1930 | Values: 54.0 55.0 54.0 56.0 58.0 60.0 59.0 60.0 59.0 59.0 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.00 stddev:2.11 (3.0%) stddev-sans-first:1.87 09:01:28 INFO - PROCESS | 1930 | Values: 67.0 71.0 69.0 75.0 70.0 69.0 72.0 70.0 70.0 70.0 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:83.00 stddev:3.21 (3.9%) stddev-sans-first:3.41 09:01:28 INFO - PROCESS | 1930 | Values: 82.0 83.0 81.0 84.0 84.0 83.0 81.0 86.0 83.0 74.0 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#11] stanford-crypto-ccm Cycles:10 Average:155.80 Median:158.00 stddev:12.45 (7.9%) stddev-sans-first:13.19 09:01:28 INFO - PROCESS | 1930 | Values: 154.0 152.0 147.0 144.0 138.0 155.0 161.0 162.0 183.0 162.0 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:173.50 stddev:21.46 (12.4%) stddev-sans-first:22.29 09:01:28 INFO - PROCESS | 1930 | Values: 167.0 169.0 163.0 176.0 222.0 215.0 171.0 165.0 164.0 182.0 09:01:28 INFO - PROCESS | 1930 | 09:01:28 INFO - PROCESS | 1930 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.50 stddev:1.87 (2.8%) stddev-sans-first:1.81 09:01:28 INFO - PROCESS | 1930 | Values: 69.0 69.0 66.0 65.0 66.0 64.0 69.0 68.0 67.0 65.0 09:01:28 INFO - PROCESS | 1930 | -------- Summary: end -------- 09:01:28 INFO - PROCESS | 1930 | 09:01:29 INFO - TEST-INFO | 1930: exit 0 09:01:29 INFO - TEST-OK | kraken | took 60078ms 09:01:29 INFO - SUITE-END | took 1174s 09:01:29 INFO - Completed test suite (00:19:34) 09:01:29 INFO - javascript benchmark 09:01:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7293.917353255042, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3584.1577229351105, 3604.4773507841346, 3627.038834708804, 3632.5096112024876, 3661.3775658138115, 5974.970125149379, 6044.516438684906, 6051.818445446638, 6061.151438798572, 6062.211912451381, 6008.459238668519, 6029.1257767623665, 6089.391060893909, 6136.877262454748, 6140.048292514667, 4700.247960326348, 5374.032674118657, 5406.432324605899, 5421.756020979045, 5452.945470545304, 5471.316085489314, 5475.233467314579, 5499.202615620733, 5511.3937466878815, 5525.364583072957, 5364.570834333244, 5409.215663728757, 5473.616846820724, 5482.122860342346, 5485.424030476803, 5411.648242864201, 5423.891522169554, 5473.972630136864, 5488.121900495901, 5549.084401073818, 5133.897322053538, 5276.657017293864, 5413.0, 5415.864603384907, 5436.592255580807, 5828.97085514574, 6002.669853158074, 6050.788222412239, 6089.421504957022, 6131.325554189036, 5359.892802143935, 6228.096925945712, 6236.126942228092, 6245.906311405332, 6259.561830671855, 5341.359036915556, 6334.0, 6349.714262858182, 6382.393672601095, 6401.231852177769, 6154.292256390483, 6156.384361563808, 6158.199434073586, 6164.6917654117115, 6177.907331390033, 6437.774677886251, 6448.548601597843, 6500.3499650035565, 6520.119783829123, 6558.80323590293, 5789.189513468118, 5878.971180043475, 6282.183316168869, 6306.959351707009, 6335.0, 6247.468965137923, 6254.2807577129215, 6378.266499352541, 6401.103845461639, 6401.551891367652, 6186.443220110122, 6244.4380005798785, 6278.654673992883, 6298.842528936813, 6319.873602527924, 6289.905651415233, 6294.276158241769, 6295.685215739195, 6330.68346582669, 6335.746570137235, 5073.949260507347, 5180.948190518046, 5211.739413029409, 5235.162374020215, 5250.1337279349245, 4563.224251877189, 4564.475085365159, 4594.563516465931, 4609.101225261109, 4696.060787842445, 5081.263216833612, 6170.136180934673, 6215.96892015537, 6222.471089957314, 6259.906101408483, 6381.649009304533, 6389.2652344980925, 6392.137061496638, 6395.392437718409, 6402.679866006681, 5979.402059793986, 6016.0, 6162.476189523851, 6167.414095660905, 6215.751369945152, 5649.971750141223, 5669.6314739541795, 5671.943280567224, 5676.858078547987, 5693.231413759172, 6625.569337993112, 6633.237177724431, 6665.600063996176, 6674.23246326669, 6684.4318232950745, 6190.969045154746, 6209.906851397323, 6275.96862015687, 6320.652364119834, 6377.713002914973, 6222.973209420576, 6607.141071660845, 6647.60114393138, 6654.76708315226, 6659.933400665931, 5782.768689252551, 6337.524685648503, 6346.650934198663, 6349.9682501587195, 6358.364163583605, 6125.326214116354, 6251.906221406592, 6255.781047663492, 6359.777407790705, 6367.204099487564, 6136.764169924236, 6251.124842522141, 6265.843353916189, 6279.277883043325, 6342.23893132827, 5297.496737809902, 6241.563090583797, 6276.089966954674, 6278.215223097113, 6300.9684951574945, 5321.9467805323, 5975.402459754164, 6096.603720758137, 6264.561480696308, 6275.497960163085, 6194.5973511721595, 6197.907031394623, 6200.720967556381, 6289.685515724104, 6296.496280297473, 6212.937870621417, 6267.780627678009, 6268.561200715906, 6302.747890084345, 6314.242290924934], "value": 5887.3873550986655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [514.8301060649985, 543.4022575167317, 549.6701978812711, 553.9307586551681, 575.1487798058876, 37634.811825940866, 40131.39802902955, 40150.996225094386, 40192.79903600481, 40241.59154429595, 33670.0, 41527.0, 41693.79153104238, 41702.0, 41725.165496690046, 8983.505907175102, 9698.806023879519, 9703.2722545809, 9710.465924374157, 9722.756931076745, 9659.5170241488, 9717.659881904136, 9722.465264410455, 9725.805483890317, 9732.854007189897, 9685.806283874319, 9738.367006144577, 9744.561494732754, 9753.414795112281, 9775.657851975182, 9583.66457173999, 9665.5167241638, 9687.70936871895, 9696.272779541563, 9773.755656108655, 9572.808543829155, 9608.423494590346, 9627.518624068838, 9646.517674116336, 9687.70936871895, 32808.179795505064, 39250.21499570021, 39471.40792888109, 39679.8016009921, 39756.801215994026, 3254.544363789071, 3483.651634836496, 3541.8760343388117, 3693.519842420495, 3802.16352402471, 28849.56725649117, 29327.0, 30213.546796798066, 30647.0, 30647.69352306493, 2890.913272601825, 3284.983575082133, 3322.734181265493, 3331.8667253309836, 3415.777974431654, 493548.0, 500269.0, 501215.0, 503106.0, 503932.99999999633, 57597.0, 58101.709491452275, 58515.70742146347, 58525.70737146287, 58592.0, 60407.093893591635, 60470.395296047354, 60707.39292607106, 61026.0, 61181.08228376489, 16382.83617163837, 16388.180590970405, 16639.16804159787, 16647.001179929244, 16679.583010424838, 11038.0, 12992.960563154926, 13002.479900804052, 13025.088243823031, 13035.674108147372, 14169.149851008973, 14853.0, 15109.0, 15110.622234444007, 15135.470258540898, 3305.5537502437346, 5900.380460051632, 6107.297660769068, 6793.864122717617, 6811.693473793691, 899.3389858454032, 1001.2590682894605, 1032.3135115148493, 1095.315427857589, 1114.3425379026414, 27270.181894543195, 27605.447891042066, 30160.84919575432, 30433.847830760704, 30693.69306306953, 995.6166875752888, 1031.9690409287584, 1058.2116323339008, 1063.7819247054335, 1066.5840322274319, 14937.327820248114, 15191.392344306105, 15267.694646107017, 15488.303026363841, 15512.767308490382, 678241.0, 686094.0, 693807.0, 697013.0, 698447.0, 53698.73150634222, 54503.0, 54703.72648136734, 54890.725546372014, 54968.9999999992, 1223.528941357566, 1383.6610030542581, 1411.7105993271355, 1417.4046900301898, 1419.9432022719182, 28518.0, 29411.823527059532, 29416.852915735286, 29458.852705736335, 29968.550471743376, 48579.0, 49451.0, 49785.25322120244, 50250.0, 50401.74799125981, 615388.0, 620078.0, 622601.0, 623892.0, 624095.0, 25829.3542661435, 26048.0, 26200.606990894772, 26233.213003609922, 26294.342641434116, 43740.781296093315, 44150.11699766051, 44689.55310446854, 44978.0, 45338.0, 37271.62728372682, 37455.625443745215, 37644.0, 37838.62161378351, 38036.42945355877, 37001.074973125884, 37161.88514344574, 38103.61896381112, 38148.61851381451, 38281.23437531178, 37607.0, 38515.807420962716, 38523.42214866723, 39207.80396098001, 39763.80118099391, 32489.83755081304, 34348.0, 34667.653323466446, 34738.65261347354, 34765.0, 25883.482330353665, 25912.0, 26013.73986260113, 26057.218283451526, 26337.07820226283], "value": 19697.128125221385, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.446471806904, 366.152357292867, 381.79192340174603, 392.25471603952496, 399.4228340048631, 19594.608107837834, 20985.37043888684, 21015.054322555483, 21314.89342553287, 21494.785052149473, 20662.76023438591, 20791.896040519812, 20917.372478825622, 20922.163113475443, 21213.045412956417, 5997.550183736215, 6084.1786358841655, 6104.2980057293535, 6107.7556897724035, 6208.689565521706, 4324.740515569076, 4587.311903214511, 5821.883562328772, 6184.381561843802, 6185.752569897199, 6460.547761656686, 6734.494912881529, 6785.6267905265195, 6862.656867156647, 6874.862502749942, 6735.8989615155815, 6821.863562728718, 6831.282715314895, 6844.589324640488, 6857.417119544844, 5250.369955605352, 5892.646441213498, 5930.495907847838, 6058.242719660043, 6073.574849760518, 13366.33168341579, 13372.465101395932, 20150.891700956443, 23788.762112378827, 25205.243842684748, 1756.9458325005023, 1966.8524860635366, 2231.0852550454397, 2405.711314642254, 2767.9896837654314, 8429.578521073921, 10267.178625709925, 10442.79114417715, 10789.892101079045, 10834.241603087787, 1667.9310069472228, 1877.8122187781112, 1938.8642795004355, 1939.41817454763, 2046.9590608187752, 125622.37188813997, 126097.0, 132855.33572332174, 133155.0, 135026.6497335024, 11803.940980295043, 11818.468168932419, 11876.22804517721, 11929.582464613697, 12005.579804706793, 15147.015443996104, 15152.31814568347, 15204.543863684106, 15209.0, 15211.935164538376, 7434.36807871337, 8684.56577171139, 8751.124887511325, 8839.381243312906, 8979.865302020475, 8776.648934042567, 8803.471791692391, 8840.646374145092, 8975.237104846161, 9020.8646870297, 4323.610875021263, 4570.840020599263, 4710.175719249118, 4711.387519622495, 4749.097671442415, 1623.602217456707, 1713.1605513298643, 1948.6395016921915, 2004.298495526554, 2009.2063634864146, 821.2198411508971, 825.8761185822175, 937.8686983822271, 1025.3079171559168, 1032.8812186598636, 21438.0, 21791.23730669419, 21807.345779626638, 21864.0, 21977.560448790933, 916.5188276154938, 921.9400738951947, 961.485605201214, 1023.2785885950387, 1026.5423099199156, 11198.496067676973, 11232.93287137737, 11545.191836571359, 11626.186166968231, 11680.474378652982, 613058.0, 615435.0, 622176.0, 625808.0, 629243.0, 136186.31906840403, 137271.0, 138774.0, 139263.0, 141999.2900035493, 957.7126861941529, 966.1353088985319, 972.3728195313982, 974.6637410093506, 1002.173207104142, 18167.36414225496, 18898.338558150397, 19290.035498225312, 19393.32123375675, 19416.320428784926, 40738.0, 55962.0, 57118.7144064277, 57466.7126664364, 58486.0, 75667.62166189133, 77749.61125194338, 78385.21614784007, 78819.0, 80060.0, 6022.969885150546, 6915.619640919797, 7376.225496322809, 7416.666250018654, 7716.575588342471, 7141.357277845019, 9193.218720627992, 12815.295158766357, 12961.0, 12977.35113244353, 7456.4034877208605, 11127.054200393057, 11277.266977646426, 11362.261453005529, 11604.593839215588, 10978.725531861768, 11187.384693841592, 11484.655460336204, 11531.250468719507, 11661.0, 10928.289661171999, 11452.541898324307, 11541.537538738512, 11653.834616538279, 11830.881691183322, 6562.5406221564035, 7326.194118647051, 7629.0, 7702.42231832626, 7868.488548244346, 9707.126358627758, 11326.037286830711, 11346.716332091764, 11397.544098235978, 11615.0], "value": 9620.967236655186, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.144446165608, 1524.184561259726, 1706.0957692423012, 1854.805245449227, 1874.5219968907927, 7519.135299440566, 7736.535807851533, 7962.402819788517, 8384.958075209623, 8401.53791541465, 7855.960720196405, 8146.185381461865, 8152.714654987077, 8242.464239824407, 8253.628586713598, 2013.798620137989, 2338.3569518382496, 2372.430616652008, 2375.0737212487143, 2383.3207535852284, 2365.136725095345, 2393.7845593896545, 2424.987875060622, 2427.8421902576365, 2428.9757102428925, 2361.3034154924253, 2369.7748713872156, 2381.5117900830287, 2390.091765129257, 2390.6772585700883, 2017.5964807038504, 2341.262502311775, 2374.9881250593635, 2382.6902502674716, 2382.797462215705, 2372.1223147435385, 2384.0463814474174, 2400.603900356439, 2413.5655581995234, 2414.6619473273754, 8233.34133269343, 8259.876101858477, 8336.583170841493, 8350.415470917038, 8350.707725229588, 5102.540771330598, 5243.947560524384, 5257.763400646942, 5262.02652509287, 5277.182036784305, 3485.4597537381746, 3494.8776792812127, 3509.982450087759, 3547.7161827053774, 3616.5298511193378, 1041.8801837788676, 1066.2216581895182, 1073.640330489287, 1097.286763603664, 1100.3782862682558, 10495.002974717467, 10550.841737373945, 10585.682429527204, 10604.628837990711, 10612.416317102556, 4094.3039683253323, 4440.511543730187, 4467.888302792456, 4663.930041049387, 4696.788644511005, 9170.266378689688, 9250.814983700287, 9260.907390926139, 9265.25877929764, 9278.768030799283, 5208.869778255574, 5215.973920130375, 5216.895662086737, 5217.713025783542, 5221.791128354899, 4369.497507786582, 4371.69398142127, 4731.881702957454, 4794.664373493892, 4815.15734746418, 3827.3110840048503, 3874.49631547897, 3909.6285852843935, 3954.5847685992558, 3975.5626881043063, 1102.2174256277972, 1286.9356532173354, 1288.6327396691897, 1301.9739605208033, 1303.7848754955517, 810.266708628692, 867.7223288547605, 921.4425272709914, 926.3284119013796, 926.6154545863391, 5541.806036788693, 5595.496405323541, 5636.689982050944, 5720.998825205573, 5722.7424765885635, 442.6234410981844, 451.10680851913395, 460.39458112582514, 461.0617393604, 465.03041159182806, 3836.0, 3858.5176852893387, 3903.316919539126, 3923.6272554107313, 3984.8007599619905, 9531.952340238255, 9689.951550242204, 9795.0, 9815.754606134904, 9999.950000249952, 9736.659216927515, 9748.0, 9750.463724495221, 9751.804963900682, 9774.022597740312, 7361.595112268769, 7678.462507624413, 7795.610219488889, 7823.921760782433, 7847.176046515148, 5441.891162176655, 5590.664560126405, 5646.181303710857, 5671.092625180117, 5674.148877668383, 9085.954570227106, 9104.362694611315, 9116.954415227881, 9170.44977301364, 9223.953880230556, 9269.30480214, 9332.486713230837, 9342.859857102285, 9348.439093654402, 9457.0, 6500.414962653384, 6713.261541230363, 6883.862322753617, 7011.964940175267, 7106.609136497542, 7686.3466605336935, 7885.64514596833, 7888.48724832884, 7893.6580781266175, 7910.169432209535, 6951.270116637883, 7146.535475194096, 7147.606881621353, 7175.533590316612, 7192.0, 6935.89596156048, 6970.79087627372, 6985.441164706913, 7024.438044956493, 7070.71717131309, 6600.339966003361, 6627.668616569249, 6711.664416779239, 6725.361090696376, 6732.966335168293, 4543.273076307775, 4658.114958157939, 4856.320115183948, 4867.0, 4942.431620363561, 4882.584980276716, 4931.161702510653, 4940.160172770566, 4963.726995015309, 4986.700797952134], "value": 4340.475196688045, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.0818908155687, 297.16941149487184, 299.61200245681846, 304.52494109189666, 304.7333583114774, 5248.790048398069, 5449.346078470584, 5456.554013186509, 5459.3994660587305, 5524.9999999999945, 5283.418823929364, 5397.487238712326, 5415.756290966906, 5452.154915988019, 5461.208124821898, 3936.7637941723447, 4019.0, 4059.2084543514025, 4077.7961101944784, 4111.588841115894, 3929.6659783918403, 4102.261592913274, 4111.417104414807, 4134.131832315203, 4172.207280616673, 4083.4691490106393, 4083.8570650027254, 4089.243489954353, 4095.692823038269, 4146.502419709639, 3986.3223252047223, 4011.358182690785, 4084.407760874686, 4095.4471146395153, 4116.711830171889, 3562.2341196642587, 3564.8254564715503, 3570.0539357070397, 3592.550931133608, 3597.748157628967, 5302.628815982883, 5303.496167864047, 5321.552086040388, 5323.349761573924, 5330.840074797762, 3871.8838434847, 4422.248217802981, 4565.817367305303, 4749.335093086971, 4780.545848144421, 5193.584513238932, 5304.708241046741, 5734.7025460360455, 5752.712364381764, 5798.333191682968, 3863.860161252437, 3964.2448498293697, 3984.6613037891816, 3989.4614227079264, 4001.479807625019, 5195.740212989335, 5509.752061157257, 5640.153976903497, 6027.397260273981, 6058.455093951058, 3791.8479265204555, 3804.087019115392, 4007.358822588372, 4019.764089907594, 4029.234445455354, 4079.4492743479846, 4098.4876890388705, 4105.85629502966, 4114.855980040684, 4120.052387950788, 3959.5644479107277, 4146.626803587631, 4158.979205103955, 4729.503402142795, 4730.077634861169, 5265.315508983884, 5484.698341591251, 5731.512821410143, 5750.223719797774, 5754.539636829044, 1258.8489381274305, 1262.4950019991893, 1315.7171757536325, 1340.9798853017212, 1343.6640839790052, 850.8511010573249, 853.5774791478258, 900.5362238447204, 910.1035480052143, 915.5056269614333, 4621.735349678701, 5026.949730502722, 5081.568066714371, 5418.701971391532, 5480.7533660985355, 5944.346121926585, 5955.367225992141, 5977.163197152315, 6013.368596297413, 6065.484433823174, 5283.260343551906, 5494.36814766299, 5531.446855314436, 5547.472990065938, 5607.299087614048, 2499.262717498342, 2671.4523522677805, 2834.957475637867, 2931.692172321918, 2996.475616767057, 5376.55900223857, 5716.828495145152, 5902.793402230901, 5908.556858235649, 5993.700314984233, 5420.268263784339, 5466.398696143421, 5785.421457854265, 5844.707764611752, 5947.494462970696, 4672.182368085571, 4793.616510679207, 5429.457054294539, 5721.256236689287, 5978.342382337939, 5254.842354729364, 5281.815136470205, 5447.945520544902, 5760.567957403127, 5793.26202139365, 4998.750062496788, 5241.31862857826, 5462.535684466865, 5616.001758435078, 5648.519875810603, 5054.91319366338, 5236.941370437941, 5242.906685055683, 5901.203337549376, 5925.970370148294, 3475.548178736748, 3540.5574303212097, 3793.374093274689, 3843.1160833008007, 3879.049632839972, 5239.711815850165, 5671.404502527175, 5675.976760566846, 5686.038316780704, 5725.139329717775, 4671.135839869635, 5008.774605142705, 5099.56653684441, 5334.11987022137, 5510.586705996986, 4538.2738761797955, 4603.792829322755, 5446.863828404322, 5489.807856724996, 5553.194786755978, 4787.664863459524, 5346.6257361985845, 5357.705326207096, 5395.892082158413, 5401.864953376197, 4552.0, 5360.356757189163, 5703.657780533182, 5762.974438419863, 5775.556110972257, 4688.437387513521, 5306.389765177054, 5510.448955104457, 5620.8875822482505, 5669.886602268014], "value": 4114.607592766708, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [650.9357200976403, 727.294524311418, 731.3417923868515, 745.1728581274784, 788.47943930351, 11889.583864564742, 14475.638109047279, 14659.926700366497, 15422.768658470131, 15611.84388156118, 14692.338844751985, 15461.381544738226, 15502.06987580746, 15555.144467054308, 15724.606884827885, 878.9165029322204, 882.686646240585, 904.1952662130709, 905.5653286422488, 906.8095699902996, 711.2070041903266, 728.7922941961542, 889.89321281446, 892.4065496444856, 893.7810236492036, 909.9181073703365, 929.372673445425, 943.8678584998106, 944.551338114397, 946.8816397950256, 927.2813569483636, 928.4058202750246, 928.8420968435382, 929.4702019848689, 935.957881895313, 675.4528831646332, 696.4150113904344, 696.9651517424109, 699.6851416862432, 702.4450683959666, 14628.488002919954, 14695.971282010263, 14961.102333860003, 15062.849371506254, 15140.0, 13368.465261389532, 13501.2574308413, 13531.32343382827, 13805.585832425044, 13878.097923635032, 12614.68463288416, 12727.93636031814, 12787.296698681568, 12932.28872412017, 12968.157069790434, 4405.493368262627, 4440.222960981848, 4506.369108324837, 4542.454905411372, 4633.911030907734, 87311.56344218302, 88577.11422885754, 90119.0, 96728.51635741776, 96790.0320996788, 9833.721616189992, 11048.668539943814, 11123.221374503868, 11129.554817807197, 11130.944345278222, 21076.156953721988, 21248.25631102904, 21449.249276275255, 21547.461313467287, 21638.783612163676, 7865.764027079197, 8099.595020248964, 8155.918440815634, 8157.306628936607, 8279.089300176976, 4311.353297005411, 4482.75344856036, 4563.133004729091, 4590.0, 4637.860864174013, 3404.1659793350786, 3491.4239150540384, 3510.8069056201643, 3522.682958533744, 3548.379033669149, 640.145405883142, 659.4987809264993, 661.5600625583933, 666.9199696036507, 671.0471130994, 636.7994081864198, 678.8744082344782, 685.1401491128602, 687.5737043033251, 721.2535026247808, 9090.545472726337, 9382.718518444457, 9443.102905223992, 9552.713418597454, 9690.70927872165, 637.7704026550438, 645.1838424393146, 697.2539382860392, 700.9964950175216, 702.9156501219784, 4245.108527209259, 4482.955170448319, 4585.312203169551, 4705.341252224691, 4711.199096153662, 77402.0, 80450.59774701089, 98357.5246371305, 118658.0, 130289.34855325663, 92462.53768731114, 112534.0, 113801.86198137913, 115837.0, 116037.0, 68750.0, 95744.56383154259, 96037.5198124005, 98110.01889981152, 100526.0, 8799.692010779592, 9024.503652299187, 9143.222826059859, 9147.908520914705, 9156.221721153777, 44832.32751508665, 51722.448326550264, 59412.70293648504, 62382.0, 62695.0, 79917.0, 90219.09780902107, 91531.54234228787, 91816.54091729499, 92169.0, 11854.703632409259, 11969.940150299193, 11983.400829958642, 12026.458809353775, 12296.938515307365, 10708.785824283315, 12613.36933153357, 12899.871001289866, 12940.547080852126, 13140.934295328461, 11997.184131988772, 12069.456874440846, 12278.0, 12325.876741232833, 12330.951869090868, 11966.22219555726, 12260.632181034583, 12268.38658067111, 12396.81404778911, 12424.75150497003, 12104.75790484203, 12105.0, 12174.817377739519, 12209.389530523616, 12260.38698065111, 10430.16558675289, 10478.109360704426, 10604.734881628021, 10909.0, 10959.506822192861, 9621.807563848824, 9842.0, 10425.374477531372, 10452.738681533023, 10458.47707614601], "value": 7556.284445613128, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 118.0, 117.0, 118.0, 140.0, 156.0, 118.0, 117.0, 117.0, 116.0], "value": 122.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 113.0, 142.0, 115.0, 143.0, 142.0, 111.0, 137.0, 111.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 200.0, 197.0, 201.0, 199.0, 195.0, 200.0, 197.0, 199.0, 197.0], "value": 198.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 60.0, 96.0, 58.0, 57.0, 58.0, 58.0, 76.0, 59.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 88.0, 72.0, 69.0, 70.0, 86.0, 69.0, 74.0, 85.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 87.0, 91.0, 86.0, 89.0, 87.0, 105.0, 87.0], "value": 89.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 155.0, 117.0, 133.0, 97.0, 169.0, 169.0, 122.0, 97.0, 99.0], "value": 126.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 143.0, 125.0, 85.0, 87.0, 91.0, 90.0, 90.0, 87.0, 110.0], "value": 101.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 56.0, 58.0, 60.0, 59.0, 60.0, 59.0, 59.0], "value": 57.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 69.0, 75.0, 70.0, 69.0, 72.0, 70.0, 70.0, 70.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 81.0, 84.0, 84.0, 83.0, 81.0, 86.0, 83.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 152.0, 147.0, 144.0, 138.0, 155.0, 161.0, 162.0, 183.0, 162.0], "value": 155.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 169.0, 163.0, 176.0, 222.0, 215.0, 171.0, 165.0, 164.0, 182.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 66.0, 65.0, 66.0, 64.0, 69.0, 68.0, 67.0, 65.0], "value": 66.8, "unit": "score"}]}]} 09:01:29 INFO - Return code: 0 09:01:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:01:29 ERROR - # TBPL SUCCESS # 09:01:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:01:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:01:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:01:29 INFO - 2017-01-24 09:01:29.659 screenresolution[1935:19355] starting screenresolution argv=screenresolution get 09:01:29 INFO - 2017-01-24 09:01:29.664 screenresolution[1935:19355] Display 0: 1600x1200x32@60 09:01:29 INFO - 2017-01-24 09:01:29.670 screenresolution[1936:19358] starting screenresolution argv=screenresolution list 09:01:29 INFO - Available Modes on Display 0 09:01:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:01:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:01:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:01:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:01:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:01:29 INFO - Intel Iris: 09:01:29 INFO - Chipset Model: Intel Iris 09:01:29 INFO - Type: GPU 09:01:29 INFO - Bus: Built-In 09:01:29 INFO - VRAM (Dynamic, Max): 1536 MB 09:01:29 INFO - Vendor: Intel (0x8086) 09:01:29 INFO - Device ID: 0x0a2e 09:01:29 INFO - Revision ID: 0x0009 09:01:29 INFO - Displays: 09:01:29 INFO - Display: 09:01:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:01:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:01:29 INFO - Display Serial Number: 1600x1200 60 09:01:29 INFO - Main Display: Yes 09:01:29 INFO - Mirror: Off 09:01:29 INFO - Online: Yes 09:01:29 INFO - Rotation: Supported 09:01:29 INFO - Return code: 0 09:01:29 INFO - Running post-action listener: _resource_record_post_action 09:01:29 INFO - [mozharness: 2017-01-24 17:01:29.912175Z] Finished run-tests step (success) 09:01:29 INFO - Running post-run listener: _resource_record_post_run 09:01:29 INFO - Total resource usage - Wall time: 1197s; CPU: 54.0%; Read bytes: 1826816; Write bytes: 501416960; Read time: 23; Write time: 1708 09:01:29 INFO - TinderboxPrint: CPU usage
54.4% 09:01:29 INFO - TinderboxPrint: I/O read bytes / time
1,826,816 / 23 09:01:29 INFO - TinderboxPrint: I/O write bytes / time
501,416,960 / 1,708 09:01:29 INFO - TinderboxPrint: CPU idle
2,186.1 (45.6%) 09:01:29 INFO - TinderboxPrint: CPU system
966.9 (20.2%) 09:01:29 INFO - TinderboxPrint: CPU user
1,636.7 (34.2%) 09:01:29 INFO - TinderboxPrint: Swap in / out
193,716,224 / 0 09:01:29 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 180808192; Write bytes: 174510080; Read time: 16629; Write time: 307 09:01:29 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1826816; Write bytes: 309179392; Read time: 23; Write time: 1345 09:01:30 INFO - Running post-run listener: _upload_blobber_files 09:01:30 INFO - Blob upload gear active. 09:01:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:01:30 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 09:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:01:30 INFO - (blobuploader) - INFO - Open directory for files ... 09:01:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:01:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:01:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:32 INFO - (blobuploader) - INFO - Done attempting. 09:01:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:01:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:01:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:33 INFO - (blobuploader) - INFO - Done attempting. 09:01:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:01:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:01:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:01:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:01:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:01:35 INFO - (blobuploader) - INFO - Done attempting. 09:01:35 INFO - (blobuploader) - INFO - Iteration through files over. 09:01:35 INFO - Return code: 0 09:01:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:01:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:01:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/acaac34f5f6ab41b7fc79adb5340adb58ff6a670a1aab95fca79d0ca8afbaa7de27e434bffb470918ad4e0ef15cd5216af9491910c41e3b87f968230fcdd8e34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2de3aa3635ecd730be242734bcc1a2b38af77fe0113fdf9c55c8e763400e7b45e7e250e7a687d95b42105429aa6f73a6035695b825bf9326a41be26523b080e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a15f395beb1dc3704eed2dd0a0d4a659cc9c4d09ae6d89597d18bcfd6753947f50b8a452efa88d80dacf4c0a15c11632e5d8df0dc18f82f7825e21f6e02627b"} 09:01:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:01:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:01:35 INFO - Contents: 09:01:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/acaac34f5f6ab41b7fc79adb5340adb58ff6a670a1aab95fca79d0ca8afbaa7de27e434bffb470918ad4e0ef15cd5216af9491910c41e3b87f968230fcdd8e34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2de3aa3635ecd730be242734bcc1a2b38af77fe0113fdf9c55c8e763400e7b45e7e250e7a687d95b42105429aa6f73a6035695b825bf9326a41be26523b080e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a15f395beb1dc3704eed2dd0a0d4a659cc9c4d09ae6d89597d18bcfd6753947f50b8a452efa88d80dacf4c0a15c11632e5d8df0dc18f82f7825e21f6e02627b"} 09:01:35 INFO - Running post-run listener: copy_logs_to_upload_dir 09:01:35 INFO - Copying logs to upload dir... 09:01:35 INFO - mkdir: /builds/slave/test/build/upload/logs 09:01:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.246384 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-24 09:01:35.746481) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 09:01:35.750022) ========= 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.8wxStlKjjp/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.2HSEWrOTNd/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/acaac34f5f6ab41b7fc79adb5340adb58ff6a670a1aab95fca79d0ca8afbaa7de27e434bffb470918ad4e0ef15cd5216af9491910c41e3b87f968230fcdd8e34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2de3aa3635ecd730be242734bcc1a2b38af77fe0113fdf9c55c8e763400e7b45e7e250e7a687d95b42105429aa6f73a6035695b825bf9326a41be26523b080e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a15f395beb1dc3704eed2dd0a0d4a659cc9c4d09ae6d89597d18bcfd6753947f50b8a452efa88d80dacf4c0a15c11632e5d8df0dc18f82f7825e21f6e02627b"} build_url:https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011469 build_url: 'https://queue.taskcluster.net/v1/task/NY1XQKiTSta-c1EJWOoT2A/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/acaac34f5f6ab41b7fc79adb5340adb58ff6a670a1aab95fca79d0ca8afbaa7de27e434bffb470918ad4e0ef15cd5216af9491910c41e3b87f968230fcdd8e34", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f2de3aa3635ecd730be242734bcc1a2b38af77fe0113fdf9c55c8e763400e7b45e7e250e7a687d95b42105429aa6f73a6035695b825bf9326a41be26523b080e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6a15f395beb1dc3704eed2dd0a0d4a659cc9c4d09ae6d89597d18bcfd6753947f50b8a452efa88d80dacf4c0a15c11632e5d8df0dc18f82f7825e21f6e02627b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 09:01:35.784336) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 09:01:35.784633) ========= 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.8wxStlKjjp/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.2HSEWrOTNd/Listeners TMPDIR=/var/folders/k2/1p7n4dw54cbgz4k9crwktl8800000w/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.005506 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 09:01:35.833838) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 09:01:35.834147) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 09:01:35.834478) ========= ========= Total master_lag: 2.19 =========