builder: cedar_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0137 starttime: 1479228961.46 results: success (0) buildid: 20161115041412 builduid: eb509a81e1284f36b13d2de4359d9f9a revision: 798319d63092cdcd8064f40fc071ca55e8babc58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 08:56:01.456349) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 08:56:01.456884) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 08:56:01.457203) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 08:56:01.489737) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 08:56:01.490160) ========= 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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-15 08:56:01-- 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% 35.5M=0s 2016-11-15 08:56:01 (35.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.119201 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 08:56:01.631833) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 08:56:01.635207) ========= 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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.021137 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 08:56:01.684240) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-15 08:56:01.684638) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 798319d63092cdcd8064f40fc071ca55e8babc58 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 798319d63092cdcd8064f40fc071ca55e8babc58 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VdQbgWnBsd/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.o5FNNY9xT7/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-15 08:56:01,767 truncating revision to first 12 chars 2016-11-15 08:56:01,767 Setting DEBUG logging. 2016-11-15 08:56:01,767 attempt 1/10 2016-11-15 08:56:01,767 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/798319d63092?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 08:56:03,666 unpacking tar archive at: cedar-798319d63092/testing/mozharness/ program finished with exit code 0 elapsedTime=2.140020 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-15 08:56:03.850864) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 08:56:03.854269) ========= script_repo_revision: 798319d63092cdcd8064f40fc071ca55e8babc58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 08:56:03.854752) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 08:56:03.855037) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 08:56:03.874083) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-15 08:56:03.874524) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', '--add-option', '--webServer,localhost', '--branch-name', 'Cedar', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VdQbgWnBsd/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.o5FNNY9xT7/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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:56:04 INFO - MultiFileLogger online at 20161115 08:56:04 in /builds/slave/test 08:56:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 08:56:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:56:04 INFO - {'append_to_log': False, 08:56:04 INFO - 'base_work_dir': '/builds/slave/test', 08:56:04 INFO - 'blob_upload_branch': 'Cedar', 08:56:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:56:04 INFO - 'branch': 'Cedar', 08:56:04 INFO - 'buildbot_json_path': 'buildprops.json', 08:56:04 INFO - 'config_files': ('talos/mac_config.py',), 08:56:04 INFO - 'default_actions': ('clobber', 08:56:04 INFO - 'read-buildbot-config', 08:56:04 INFO - 'download-and-extract', 08:56:04 INFO - 'populate-webroot', 08:56:04 INFO - 'create-virtualenv', 08:56:04 INFO - 'install', 08:56:04 INFO - 'run-tests'), 08:56:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:56:04 INFO - 'download_minidump_stackwalk': True, 08:56:04 INFO - 'download_symbols': 'ondemand', 08:56:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:56:04 INFO - 'tooltool.py': '/tools/tooltool.py', 08:56:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:56:04 INFO - '/tools/misc-python/virtualenv.py')}, 08:56:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:56:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:56:04 INFO - 'installer_path': 'installer.exe', 08:56:04 INFO - 'log_level': 'info', 08:56:04 INFO - 'log_name': 'talos', 08:56:04 INFO - 'log_to_console': True, 08:56:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:56:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:56:04 INFO - 'opt_config_files': (), 08:56:04 INFO - 'pip_index': False, 08:56:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:56:04 INFO - 'cmd': ('bash', 08:56:04 INFO - '-c', 08:56:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:56:04 INFO - 'enabled': True, 08:56:04 INFO - 'halt_on_failure': False, 08:56:04 INFO - 'name': 'check_screen_resolution'},), 08:56:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:56:04 INFO - 'cmd': ('bash', 08:56:04 INFO - '-c', 08:56:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:56:04 INFO - 'enabled': True, 08:56:04 INFO - 'halt_on_failure': False, 08:56:04 INFO - 'name': 'check_screen_resolution'},), 08:56:04 INFO - 'run_cmd_checks_enabled': True, 08:56:04 INFO - 'sps_profile': False, 08:56:04 INFO - 'sps_profile_interval': 0, 08:56:04 INFO - 'suite': 'dromaeojs', 08:56:04 INFO - 'system_bits': '32', 08:56:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:56:04 INFO - 'title': 't-yosemite-r7-0137', 08:56:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:56:04 INFO - 'use_talos_json': True, 08:56:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:56:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:56:04 INFO - 'work_dir': 'build'} 08:56:04 INFO - [mozharness: 2016-11-15 16:56:04.077643Z] Running clobber step. 08:56:04 INFO - Running pre-action listener: _resource_record_pre_action 08:56:04 INFO - Running main action method: clobber 08:56:04 INFO - rmtree: /builds/slave/test/build 08:56:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:56:05 INFO - Running post-action listener: _resource_record_post_action 08:56:05 INFO - [mozharness: 2016-11-15 16:56:05.478282Z] Finished clobber step (success) 08:56:05 INFO - [mozharness: 2016-11-15 16:56:05.478498Z] Running read-buildbot-config step. 08:56:05 INFO - Running pre-action listener: _resource_record_pre_action 08:56:05 INFO - Running main action method: read_buildbot_config 08:56:05 INFO - Using buildbot properties: 08:56:05 INFO - { 08:56:05 INFO - "project": "", 08:56:05 INFO - "product": "firefox", 08:56:05 INFO - "script_repo_revision": "default", 08:56:05 INFO - "builddir": "cedar_yosemite_r7_test-dromaeojs", 08:56:05 INFO - "repository": "", 08:56:05 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 cedar talos dromaeojs", 08:56:05 INFO - "buildid": "20161115041412", 08:56:05 INFO - "pgo_build": "False", 08:56:05 INFO - "basedir": "/builds/slave/test", 08:56:05 INFO - "buildnumber": 3, 08:56:05 INFO - "slavename": "t-yosemite-r7-0137", 08:56:05 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:56:05 INFO - "platform": "yosemite_r7", 08:56:05 INFO - "scheduler": "tests-cedar-macosx64-talos", 08:56:05 INFO - "branch": "cedar", 08:56:05 INFO - "repo_path": "projects/cedar", 08:56:05 INFO - "revision": "798319d63092cdcd8064f40fc071ca55e8babc58", 08:56:05 INFO - "stage_platform": "macosx64", 08:56:05 INFO - "builduid": "eb509a81e1284f36b13d2de4359d9f9a", 08:56:05 INFO - "slavebuilddir": "test" 08:56:05 INFO - } 08:56:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 08:56:05 INFO - Running post-action listener: _resource_record_post_action 08:56:05 INFO - [mozharness: 2016-11-15 16:56:05.484327Z] Finished read-buildbot-config step (success) 08:56:05 INFO - [mozharness: 2016-11-15 16:56:05.484509Z] Running download-and-extract step. 08:56:05 INFO - Running pre-action listener: _resource_record_pre_action 08:56:05 INFO - Running main action method: download_and_extract 08:56:05 INFO - mkdir: /builds/slave/test/build/tests 08:56:05 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:56:05 INFO - trying https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 08:56:05 INFO - Downloading https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:56:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 08:56:06 INFO - Downloaded 1199 bytes. 08:56:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 08:56:06 INFO - Using the following test package requirements: 08:56:06 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:56:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:56:06 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 08:56:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:56:06 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 08:56:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:56:06 INFO - u'jsshell-mac.zip'], 08:56:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:56:06 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 08:56:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 08:56:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:56:06 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 08:56:06 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:56:06 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 08:56:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:56:06 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 08:56:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 08:56:06 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 08:56:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:56:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:56:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:56:06 INFO - Fetch https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:56:07 INFO - Http code: 200 08:56:07 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 08:56:07 INFO - x-amz-cf-id: S9UPTSiu08jDuBAv_FUoieDxRKazCj8liMvVvPaqhwG07dEO_3zaqg== 08:56:07 INFO - x-amz-version-id: WKVxOeVd7BxWMlu1kjUFbIrfmvI5m.F6 08:56:07 INFO - Expected file size: 16330797 08:56:07 INFO - Obtained file size: 16330797 08:56:13 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:56:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 08:56:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:56:13 INFO - Fetch https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 08:56:14 INFO - Http code: 200 08:56:14 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 08:56:14 INFO - x-amz-cf-id: _jgUmOGpkm1wFHd4XM-G1et0YvoIEGMZTnaBjgNEhBSVvVOvw8ez4w== 08:56:14 INFO - x-amz-version-id: WKVxOeVd7BxWMlu1kjUFbIrfmvI5m.F6 08:56:14 INFO - Expected file size: 16330797 08:56:14 INFO - Obtained file size: 16330797 08:56:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 08:56:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:56:21 INFO - Fetch https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 08:56:22 INFO - Http code: 200 08:56:22 INFO - via: 1.1 66ed69e8b47ad05050331602c798132f.cloudfront.net (CloudFront) 08:56:22 INFO - x-amz-cf-id: dp5Cquid_CF2tGK-ivuD2G4cRlHdYxPcHKZgAAfpjmZMBQCSppCZ3A== 08:56:22 INFO - x-amz-version-id: 5YF7n0ptudVkGwU5oybnTljVv0LpyTpH 08:56:22 INFO - Expected file size: 14409038 08:56:22 INFO - Obtained file size: 14409038 08:56:22 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:56:22 INFO - trying https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:56:22 INFO - Downloading https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 08:56:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 08:56:25 INFO - Downloaded 110971884 bytes. 08:56:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:56:25 INFO - mkdir: /builds/slave/test/properties 08:56:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:56:25 INFO - Writing to file /builds/slave/test/properties/build_url 08:56:25 INFO - Contents: 08:56:25 INFO - build_url:https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 08:56:26 INFO - Running post-action listener: _resource_record_post_action 08:56:26 INFO - Running post-action listener: set_extra_try_arguments 08:56:26 INFO - [mozharness: 2016-11-15 16:56:26.332549Z] Finished download-and-extract step (success) 08:56:26 INFO - [mozharness: 2016-11-15 16:56:26.332677Z] Running populate-webroot step. 08:56:26 INFO - Running pre-action listener: _resource_record_pre_action 08:56:26 INFO - Running main action method: populate_webroot 08:56:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:56:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:56:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:56:26 INFO - '--tppagecycles', 08:56:26 INFO - '7'], 08:56:26 INFO - 'tests': ['tsvgm']}}, 08:56:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:56:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:56:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:56:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:56:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:56:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:56:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:26 INFO - 'talos_options': ['--disable-e10s'], 08:56:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:26 INFO - 'talos_options': ['--disable-e10s'], 08:56:26 INFO - 'tests': ['damp', 'tps']}, 08:56:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:26 INFO - 'tests': ['damp', 'tps']}, 08:56:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:56:26 INFO - 'tests': ['dromaeo_dom']}, 08:56:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:56:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:56:26 INFO - 'tests': ['basic_compositor_video']}, 08:56:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:56:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:56:26 INFO - 'tests': ['a11yr', 08:56:26 INFO - 'ts_paint', 08:56:26 INFO - 'tpaint', 08:56:26 INFO - 'sessionrestore', 08:56:26 INFO - 'sessionrestore_no_auto_restore', 08:56:26 INFO - 'tabpaint']}, 08:56:26 INFO - 'other-e10s': {'tests': ['a11yr', 08:56:26 INFO - 'ts_paint', 08:56:26 INFO - 'tpaint', 08:56:26 INFO - 'sessionrestore', 08:56:26 INFO - 'sessionrestore_no_auto_restore', 08:56:26 INFO - 'tabpaint']}, 08:56:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:56:26 INFO - 'ts_paint', 08:56:26 INFO - 'tpaint', 08:56:26 INFO - 'sessionrestore', 08:56:26 INFO - 'sessionrestore_no_auto_restore', 08:56:26 INFO - 'tabpaint']}, 08:56:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:56:26 INFO - 'ts_paint', 08:56:26 INFO - 'tpaint', 08:56:26 INFO - 'sessionrestore', 08:56:26 INFO - 'sessionrestore_no_auto_restore', 08:56:26 INFO - 'tabpaint']}, 08:56:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:56:26 INFO - 'tests': ['a11yr', 08:56:26 INFO - 'ts_paint', 08:56:26 INFO - 'tpaint', 08:56:26 INFO - 'sessionrestore', 08:56:26 INFO - 'sessionrestore_no_auto_restore', 08:56:26 INFO - 'tabpaint']}, 08:56:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:56:26 INFO - 'tests': ['a11yr', 08:56:26 INFO - 'ts_paint', 08:56:26 INFO - 'tpaint', 08:56:26 INFO - 'sessionrestore', 08:56:26 INFO - 'sessionrestore_no_auto_restore', 08:56:26 INFO - 'tabpaint']}, 08:56:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:56:26 INFO - 'tests': ['tsvgx', 08:56:26 INFO - 'tsvgr_opacity', 08:56:26 INFO - 'tart', 08:56:26 INFO - 'tscrollx', 08:56:26 INFO - 'cart']}, 08:56:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:56:26 INFO - 'tsvgr_opacity', 08:56:26 INFO - 'tart', 08:56:26 INFO - 'tscrollx', 08:56:26 INFO - 'cart']}, 08:56:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:26 INFO - 'talos_options': ['--disable-e10s'], 08:56:26 INFO - 'tests': ['tp5o']}, 08:56:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:26 INFO - 'tests': ['tp5o']}, 08:56:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:26 INFO - 'talos_options': ['--disable-e10s', 08:56:26 INFO - '--xperf_path', 08:56:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:26 INFO - 'tests': ['tp5n']}, 08:56:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:56:26 INFO - 'talos_options': ['--xperf_path', 08:56:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:26 INFO - 'tests': ['tp5n']}}, 08:56:26 INFO - 'talos.zip': {'path': '', 08:56:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:56:26 INFO - Running post-action listener: _resource_record_post_action 08:56:26 INFO - [mozharness: 2016-11-15 16:56:26.351630Z] Finished populate-webroot step (success) 08:56:26 INFO - [mozharness: 2016-11-15 16:56:26.351775Z] Running create-virtualenv step. 08:56:26 INFO - Running pre-action listener: _resource_record_pre_action 08:56:26 INFO - Running main action method: create_virtualenv 08:56:26 INFO - Creating virtualenv /builds/slave/test/build/venv 08:56:26 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:56:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:56:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:56:26 INFO - Using real prefix '/tools/python27' 08:56:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:56:27 INFO - Installing distribute.............................................................................................................................................................................................done. 08:56:30 INFO - Installing pip.................done. 08:56:30 INFO - Return code: 0 08:56:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:56:30 INFO - Reading from file tmpfile_stdout 08:56:30 INFO - Output received: 08:56:30 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:56:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:56: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:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110687490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca12c9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049bd30>, '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 0x1102c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110493b20>, '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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:56:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VdQbgWnBsd/Render', 08:56:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:30 INFO - 'HOME': '/Users/cltbld', 08:56:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:30 INFO - 'LOGNAME': 'cltbld', 08:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:30 INFO - 'MOZ_NO_REMOTE': '1', 08:56:30 INFO - 'NO_EM_RESTART': '1', 08:56:30 INFO - 'PAGER': '/bin/cat', 08:56:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:30 INFO - 'PWD': '/builds/slave/test', 08:56:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:30 INFO - 'SHELL': '/bin/bash', 08:56:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o5FNNY9xT7/Listeners', 08:56:30 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 08:56:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:30 INFO - 'USER': 'cltbld', 08:56:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:30 INFO - 'XPC_FLAGS': '0x0', 08:56:30 INFO - 'XPC_SERVICE_NAME': '0', 08:56:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:30 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:56:30 INFO - Cleaning up... 08:56:30 INFO - Return code: 0 08:56:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:56: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:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110687490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca12c9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049bd30>, '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 0x1102c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110493b20>, '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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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:56:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:56:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:56:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VdQbgWnBsd/Render', 08:56:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:30 INFO - 'HOME': '/Users/cltbld', 08:56:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:30 INFO - 'LOGNAME': 'cltbld', 08:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:30 INFO - 'MOZ_NO_REMOTE': '1', 08:56:30 INFO - 'NO_EM_RESTART': '1', 08:56:30 INFO - 'PAGER': '/bin/cat', 08:56:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:30 INFO - 'PWD': '/builds/slave/test', 08:56:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:30 INFO - 'SHELL': '/bin/bash', 08:56:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o5FNNY9xT7/Listeners', 08:56:30 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 08:56:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:30 INFO - 'USER': 'cltbld', 08:56:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:30 INFO - 'XPC_FLAGS': '0x0', 08:56:30 INFO - 'XPC_SERVICE_NAME': '0', 08:56:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:30 INFO - Downloading/unpacking psutil>=3.1.1 08:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:56:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:34 INFO - Installing collected packages: psutil 08:56:34 INFO - Running setup.py install for psutil 08:56:34 INFO - building 'psutil._psutil_osx' extension 08:56:34 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:56:34 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:56:34 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:56:34 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:56:34 INFO - building 'psutil._psutil_posix' extension 08:56:34 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:56:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:56:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:56:34 INFO - ^ 08:56:34 INFO - 1 warning generated. 08:56:34 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:56:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:35 INFO - Successfully installed psutil 08:56:35 INFO - Cleaning up... 08:56:35 INFO - Return code: 0 08:56:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:35 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 0x110687490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca12c9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049bd30>, '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 0x1102c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110493b20>, '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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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:56:35 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:56:35 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:56:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VdQbgWnBsd/Render', 08:56:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:35 INFO - 'HOME': '/Users/cltbld', 08:56:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:35 INFO - 'LOGNAME': 'cltbld', 08:56:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:35 INFO - 'MOZ_NO_REMOTE': '1', 08:56:35 INFO - 'NO_EM_RESTART': '1', 08:56:35 INFO - 'PAGER': '/bin/cat', 08:56:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:35 INFO - 'PWD': '/builds/slave/test', 08:56:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:35 INFO - 'SHELL': '/bin/bash', 08:56:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o5FNNY9xT7/Listeners', 08:56:35 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 08:56:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:35 INFO - 'USER': 'cltbld', 08:56:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:35 INFO - 'XPC_FLAGS': '0x0', 08:56:35 INFO - 'XPC_SERVICE_NAME': '0', 08:56:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:56:35 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:56:35 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:56:35 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:56:35 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:56:35 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:56:35 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:56:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:56:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:56:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:56:37 INFO - Installing collected packages: mozsystemmonitor 08:56:37 INFO - Running setup.py install for mozsystemmonitor 08:56:38 INFO - Successfully installed mozsystemmonitor 08:56:38 INFO - Cleaning up... 08:56:38 INFO - Return code: 0 08:56:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:38 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 0x110687490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca12c9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049bd30>, '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 0x1102c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110493b20>, '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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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:56:38 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:56:38 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:56:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VdQbgWnBsd/Render', 08:56:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:38 INFO - 'HOME': '/Users/cltbld', 08:56:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:38 INFO - 'LOGNAME': 'cltbld', 08:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:38 INFO - 'MOZ_NO_REMOTE': '1', 08:56:38 INFO - 'NO_EM_RESTART': '1', 08:56:38 INFO - 'PAGER': '/bin/cat', 08:56:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:38 INFO - 'PWD': '/builds/slave/test', 08:56:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:38 INFO - 'SHELL': '/bin/bash', 08:56:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o5FNNY9xT7/Listeners', 08:56:38 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 08:56:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:38 INFO - 'USER': 'cltbld', 08:56:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:38 INFO - 'XPC_FLAGS': '0x0', 08:56:38 INFO - 'XPC_SERVICE_NAME': '0', 08:56:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:38 INFO - Downloading/unpacking jsonschema==2.5.1 08:56:38 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:56:38 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:56:38 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:56:38 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:56:38 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:56:38 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:56:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:56:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:56:40 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:56:40 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:56:40 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:56:40 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:56:40 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:56:40 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:56:41 INFO - Downloading functools32-3.2.3-2.tar.gz 08:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:56:41 INFO - warning: no files found matching '*.txt' 08:56:41 INFO - no previously-included directories found matching 'build' 08:56:41 INFO - no previously-included directories found matching 'dist' 08:56:41 INFO - no previously-included directories found matching '.git*' 08:56:41 INFO - Installing collected packages: jsonschema, functools32 08:56:41 INFO - Running setup.py install for functools32 08:56:41 INFO - warning: no files found matching '*.txt' 08:56:41 INFO - no previously-included directories found matching 'build' 08:56:41 INFO - no previously-included directories found matching 'dist' 08:56:41 INFO - no previously-included directories found matching '.git*' 08:56:41 INFO - Successfully installed jsonschema functools32 08:56:41 INFO - Cleaning up... 08:56:41 INFO - Return code: 0 08:56:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:56:41 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:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:41 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:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:41 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 0x110687490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca12c9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049bd30>, '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 0x1102c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110493b20>, '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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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:56:41 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:56:41 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:56:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VdQbgWnBsd/Render', 08:56:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:41 INFO - 'HOME': '/Users/cltbld', 08:56:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:41 INFO - 'LOGNAME': 'cltbld', 08:56:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:41 INFO - 'MOZ_NO_REMOTE': '1', 08:56:41 INFO - 'NO_EM_RESTART': '1', 08:56:41 INFO - 'PAGER': '/bin/cat', 08:56:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:41 INFO - 'PWD': '/builds/slave/test', 08:56:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:41 INFO - 'SHELL': '/bin/bash', 08:56:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o5FNNY9xT7/Listeners', 08:56:41 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 08:56:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:41 INFO - 'USER': 'cltbld', 08:56:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:41 INFO - 'XPC_FLAGS': '0x0', 08:56:41 INFO - 'XPC_SERVICE_NAME': '0', 08:56:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:56:41 INFO - Cleaning up... 08:56:41 INFO - Return code: 0 08:56:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:56:41 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:56:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:41 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:56:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:41 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 0x110687490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca12c9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049bd30>, '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 0x1102c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110493b20>, '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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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:56:41 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:56:41 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:56:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VdQbgWnBsd/Render', 08:56:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:42 INFO - 'HOME': '/Users/cltbld', 08:56:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:42 INFO - 'LOGNAME': 'cltbld', 08:56:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:42 INFO - 'MOZ_NO_REMOTE': '1', 08:56:42 INFO - 'NO_EM_RESTART': '1', 08:56:42 INFO - 'PAGER': '/bin/cat', 08:56:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:42 INFO - 'PWD': '/builds/slave/test', 08:56:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:42 INFO - 'SHELL': '/bin/bash', 08:56:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o5FNNY9xT7/Listeners', 08:56:42 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 08:56:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:42 INFO - 'USER': 'cltbld', 08:56:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:42 INFO - 'XPC_FLAGS': '0x0', 08:56:42 INFO - 'XPC_SERVICE_NAME': '0', 08:56:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:42 INFO - Downloading/unpacking blobuploader==1.2.4 08:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:44 INFO - Downloading blobuploader-1.2.4.tar.gz 08:56:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:56:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:56:44 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:56:44 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:56:44 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:56:44 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:56:44 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:56:44 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:56:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:56:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:46 INFO - Downloading docopt-0.6.1.tar.gz 08:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:56:46 INFO - Installing collected packages: blobuploader, requests, docopt 08:56:46 INFO - Running setup.py install for blobuploader 08:56:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:56:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:56:46 INFO - Running setup.py install for requests 08:56:46 INFO - Running setup.py install for docopt 08:56:46 INFO - Successfully installed blobuploader requests docopt 08:56:46 INFO - Cleaning up... 08:56:47 INFO - Return code: 0 08:56:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:47 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:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:47 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:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:47 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 0x110687490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca12c9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049bd30>, '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 0x1102c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110493b20>, '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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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:56:47 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:56:47 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:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VdQbgWnBsd/Render', 08:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:47 INFO - 'HOME': '/Users/cltbld', 08:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:47 INFO - 'LOGNAME': 'cltbld', 08:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:47 INFO - 'MOZ_NO_REMOTE': '1', 08:56:47 INFO - 'NO_EM_RESTART': '1', 08:56:47 INFO - 'PAGER': '/bin/cat', 08:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:47 INFO - 'PWD': '/builds/slave/test', 08:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:47 INFO - 'SHELL': '/bin/bash', 08:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o5FNNY9xT7/Listeners', 08:56:47 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 08:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:47 INFO - 'USER': 'cltbld', 08:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:47 INFO - 'XPC_FLAGS': '0x0', 08:56:47 INFO - 'XPC_SERVICE_NAME': '0', 08:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:47 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-lKrnmx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:47 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-gN9Onv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:47 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-s_UzAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:47 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-8ROJsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:47 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-h_gqQH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:47 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Z5Wejm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:47 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-4iBhkH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:48 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-bQzyaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:48 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-cKMUWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:48 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-LECgpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:48 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-xr_0E_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:48 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-TLcO2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:48 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-mDlD37-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:48 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-_VPg4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:48 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-WBjl2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:48 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-pAsWa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:49 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-92xgi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:56:49 INFO - Running setup.py install for manifestparser 08:56:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:56:49 INFO - Running setup.py install for mozcrash 08:56:49 INFO - Running setup.py install for mozdebug 08:56:49 INFO - Running setup.py install for mozdevice 08:56:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:56:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:56:49 INFO - Running setup.py install for mozfile 08:56:49 INFO - Running setup.py install for mozhttpd 08:56:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:56:50 INFO - Running setup.py install for mozinfo 08:56:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:56:50 INFO - Running setup.py install for mozInstall 08:56:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:56:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:56:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:56:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:56:50 INFO - Running setup.py install for mozleak 08:56:50 INFO - Running setup.py install for mozlog 08:56:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:56:50 INFO - Running setup.py install for moznetwork 08:56:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:56:50 INFO - Running setup.py install for mozprocess 08:56:50 INFO - Running setup.py install for mozprofile 08:56:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:56:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:56:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:56:51 INFO - Running setup.py install for mozrunner 08:56:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:56:51 INFO - Running setup.py install for mozscreenshot 08:56:51 INFO - Running setup.py install for moztest 08:56:51 INFO - Running setup.py install for mozversion 08:56:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:56:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:56:51 INFO - Cleaning up... 08:56:51 INFO - Return code: 0 08:56:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:51 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:56:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:51 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:56:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:51 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 0x110687490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca12c9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049bd30>, '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 0x1102c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110493b20>, '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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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:56:51 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:56:51 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:56:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VdQbgWnBsd/Render', 08:56:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:51 INFO - 'HOME': '/Users/cltbld', 08:56:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:51 INFO - 'LOGNAME': 'cltbld', 08:56:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:51 INFO - 'MOZ_NO_REMOTE': '1', 08:56:51 INFO - 'NO_EM_RESTART': '1', 08:56:51 INFO - 'PAGER': '/bin/cat', 08:56:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:51 INFO - 'PWD': '/builds/slave/test', 08:56:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:51 INFO - 'SHELL': '/bin/bash', 08:56:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o5FNNY9xT7/Listeners', 08:56:51 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 08:56:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:51 INFO - 'USER': 'cltbld', 08:56:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:51 INFO - 'XPC_FLAGS': '0x0', 08:56:51 INFO - 'XPC_SERVICE_NAME': '0', 08:56:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-IfsYss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:52 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:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-5JRrmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:52 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:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Z87RAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:52 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:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-XGc9Qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:52 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:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-gzriVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:52 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:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-dUvIAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:52 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:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-kW7Nr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:52 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:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-dC0r5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:52 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:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:52 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-Iovozk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:53 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:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-5Cl2Lg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:53 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:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-fhoJas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:53 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:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-HvwAlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:53 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:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-KW_FuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:53 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:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-BSI48j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:53 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:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-IxZd1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:53 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:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-EmE6ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:53 INFO - Running setup.py (path:/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/pip-AqyjMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:53 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:56:53 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:56:53 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:56:53 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:56:53 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:56:53 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:56:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56:53 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:56:53 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:56:53 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:56:53 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:56:53 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:56:53 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:56:56 INFO - Downloading blessings-1.6.tar.gz 08:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:56:56 INFO - Installing collected packages: blessings 08:56:56 INFO - Running setup.py install for blessings 08:56:56 INFO - Successfully installed blessings 08:56:56 INFO - Cleaning up... 08:56:56 INFO - Return code: 0 08:56:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:56:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:57 INFO - Reading from file tmpfile_stdout 08:56:57 INFO - Current package versions: 08:56:57 INFO - blessings == 1.6 08:56:57 INFO - blobuploader == 1.2.4 08:56:57 INFO - docopt == 0.6.1 08:56:57 INFO - functools32 == 3.2.3-2 08:56:57 INFO - jsonschema == 2.5.1 08:56:57 INFO - manifestparser == 1.1 08:56:57 INFO - mozInstall == 1.12 08:56:57 INFO - mozcrash == 1.0 08:56:57 INFO - mozdebug == 0.1 08:56:57 INFO - mozdevice == 0.48 08:56:57 INFO - mozfile == 1.2 08:56:57 INFO - mozhttpd == 0.7 08:56:57 INFO - mozinfo == 0.9 08:56:57 INFO - mozleak == 0.1 08:56:57 INFO - mozlog == 3.4 08:56:57 INFO - moznetwork == 0.27 08:56:57 INFO - mozprocess == 0.23 08:56:57 INFO - mozprofile == 0.28 08:56:57 INFO - mozrunner == 6.13 08:56:57 INFO - mozscreenshot == 0.1 08:56:57 INFO - mozsystemmonitor == 0.3 08:56:57 INFO - moztest == 0.7 08:56:57 INFO - mozversion == 1.4 08:56:57 INFO - psutil == 3.1.1 08:56:57 INFO - requests == 1.2.3 08:56:57 INFO - wsgiref == 0.1.2 08:56:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:57 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 0x110687490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca12c9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049bd30>, '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 0x1102c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110493b20>, '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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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:56:57 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:56:57 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:56:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VdQbgWnBsd/Render', 08:56:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:57 INFO - 'HOME': '/Users/cltbld', 08:56:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:57 INFO - 'LOGNAME': 'cltbld', 08:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:57 INFO - 'MOZ_NO_REMOTE': '1', 08:56:57 INFO - 'NO_EM_RESTART': '1', 08:56:57 INFO - 'PAGER': '/bin/cat', 08:56:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:57 INFO - 'PWD': '/builds/slave/test', 08:56:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:57 INFO - 'SHELL': '/bin/bash', 08:56:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o5FNNY9xT7/Listeners', 08:56:57 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 08:56:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:57 INFO - 'USER': 'cltbld', 08:56:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:57 INFO - 'XPC_FLAGS': '0x0', 08:56:57 INFO - 'XPC_SERVICE_NAME': '0', 08:56:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:58 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:56:58 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:56:58 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:56:58 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:56:58 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:56:58 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:56:58 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:56:58 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:56:58 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:56:58 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:56:58 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:56:58 INFO - Cleaning up... 08:56:58 INFO - Return code: 0 08:56:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:56:58 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:56:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:58 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:56:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:58 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 0x110687490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1105fd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca12c9abe0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11049bd30>, '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 0x1102c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110493b20>, '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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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:56:58 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:56:58 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:56:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VdQbgWnBsd/Render', 08:56:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:58 INFO - 'HOME': '/Users/cltbld', 08:56:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:58 INFO - 'LOGNAME': 'cltbld', 08:56:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:58 INFO - 'MOZ_NO_REMOTE': '1', 08:56:58 INFO - 'NO_EM_RESTART': '1', 08:56:58 INFO - 'PAGER': '/bin/cat', 08:56:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:58 INFO - 'PWD': '/builds/slave/test', 08:56:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:58 INFO - 'SHELL': '/bin/bash', 08:56:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o5FNNY9xT7/Listeners', 08:56:58 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 08:56:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:58 INFO - 'USER': 'cltbld', 08:56:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:58 INFO - 'XPC_FLAGS': '0x0', 08:56:58 INFO - 'XPC_SERVICE_NAME': '0', 08:56:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:56:58 INFO - Cleaning up... 08:56:58 INFO - Return code: 0 08:56:58 INFO - Running post-action listener: _resource_record_post_action 08:56:58 INFO - Running post-action listener: _start_resource_monitoring 08:56:58 INFO - Starting resource monitoring. 08:56:58 INFO - [mozharness: 2016-11-15 16:56:58.884021Z] Finished create-virtualenv step (success) 08:56:58 INFO - [mozharness: 2016-11-15 16:56:58.885123Z] Running install step. 08:56:58 INFO - Running pre-action listener: _resource_record_pre_action 08:56:58 INFO - Running main action method: install 08:56:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:59 INFO - Reading from file tmpfile_stdout 08:56:59 INFO - Detecting whether we're running mozinstall >=1.0... 08:56:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:56:59 INFO - Reading from file tmpfile_stdout 08:56:59 INFO - Output received: 08:56:59 INFO - Usage: mozinstall [options] installer 08:56:59 INFO - Options: 08:56:59 INFO - -h, --help show this help message and exit 08:56:59 INFO - -d DEST, --destination=DEST 08:56:59 INFO - Directory to install application into. [default: 08:56:59 INFO - "/builds/slave/test"] 08:56:59 INFO - --app=APP Application being installed. [default: firefox] 08:56:59 INFO - mkdir: /builds/slave/test/build/application 08:56:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:56:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:57:33 INFO - Reading from file tmpfile_stdout 08:57:33 INFO - Output received: 08:57:33 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:57:33 INFO - Running post-action listener: _resource_record_post_action 08:57:33 INFO - [mozharness: 2016-11-15 16:57:33.769561Z] Finished install step (success) 08:57:33 INFO - [mozharness: 2016-11-15 16:57:33.769684Z] Running run-tests step. 08:57:33 INFO - Running pre-action listener: _resource_record_pre_action 08:57:33 INFO - Running main action method: run_tests 08:57:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:57:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:57:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:57:33 INFO - 2016-11-15 08:57:33.784 screenresolution[2168:22685] starting screenresolution argv=screenresolution get 08:57:33 INFO - 2016-11-15 08:57:33.787 screenresolution[2168:22685] Display 0: 1600x1200x32@60 08:57:33 INFO - 2016-11-15 08:57:33.793 screenresolution[2169:22687] starting screenresolution argv=screenresolution list 08:57:33 INFO - Available Modes on Display 0 08:57:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:57:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:57:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:57:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:57:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:57:34 INFO - Intel Iris: 08:57:34 INFO - Chipset Model: Intel Iris 08:57:34 INFO - Type: GPU 08:57:34 INFO - Bus: Built-In 08:57:34 INFO - VRAM (Dynamic, Max): 1536 MB 08:57:34 INFO - Vendor: Intel (0x8086) 08:57:34 INFO - Device ID: 0x0a2e 08:57:34 INFO - Revision ID: 0x0009 08:57:34 INFO - Displays: 08:57:34 INFO - Display: 08:57:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:57:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:57:34 INFO - Display Serial Number: 1600x1200 60 08:57:34 INFO - Main Display: Yes 08:57:34 INFO - Mirror: Off 08:57:34 INFO - Online: Yes 08:57:34 INFO - Rotation: Supported 08:57:34 INFO - Return code: 0 08:57:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:57:34 INFO - Python 2.7.3 08:57:34 INFO - Return code: 0 08:57:34 INFO - grabbing minidump binary from tooltool 08:57:34 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:57:34 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 0x11049bd30>, '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 0x1102c1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110493b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:57:34 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:57:34 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:57:34 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:57:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:57:34 INFO - Return code: 0 08:57:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:57:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:57:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:57:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:57:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:57:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0137 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:57:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VdQbgWnBsd/Render', 08:57:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:34 INFO - 'HOME': '/Users/cltbld', 08:57:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:34 INFO - 'LOGNAME': 'cltbld', 08:57:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:57:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:57:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:34 INFO - 'MOZ_NO_REMOTE': '1', 08:57:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:57:34 INFO - 'NO_EM_RESTART': '1', 08:57:34 INFO - 'PAGER': '/bin/cat', 08:57:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:34 INFO - 'PWD': '/builds/slave/test', 08:57:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:57:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:34 INFO - 'SHELL': '/bin/bash', 08:57:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.o5FNNY9xT7/Listeners', 08:57:34 INFO - 'TMPDIR': '/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/', 08:57:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:34 INFO - 'USER': 'cltbld', 08:57:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:34 INFO - 'XPC_FLAGS': '0x0', 08:57:34 INFO - 'XPC_SERVICE_NAME': '0', 08:57:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0137', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:57:34 INFO - mozversion application_buildid: 20161115041412 08:57:34 INFO - mozversion application_changeset: 798319d63092cdcd8064f40fc071ca55e8babc58 08:57:34 INFO - mozversion application_display_name: Nightly 08:57:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:57:34 INFO - mozversion application_name: Firefox 08:57:34 INFO - mozversion application_remotingname: firefox 08:57:34 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 08:57:34 INFO - mozversion application_vendor: Mozilla 08:57:34 INFO - mozversion application_version: 53.0a1 08:57:34 INFO - mozversion platform_buildid: 20161115041412 08:57:34 INFO - mozversion platform_changeset: 798319d63092cdcd8064f40fc071ca55e8babc58 08:57:34 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 08:57:34 INFO - mozversion platform_version: 53.0a1 08:57:34 INFO - using testdate: 1479229054 08:57:34 INFO - actual date: 1479229054 08:57:34 INFO - starting webserver on 'localhost:56087' 08:57:34 INFO - SUITE-START | Running 2 tests 08:57:34 INFO - TEST-START | dromaeo_css 08:57:34 INFO - operating with platform_type : mac_ 08:57:34 INFO - Initialising browser for dromaeo_css test... 08:57:34 INFO - TEST-INFO | started process 2179 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpqOfNXv/profile http://localhost:56087/getInfo.html) 08:57:36 INFO - PROCESS | 2179 | __metrics Screen width/height:1600/1200 08:57:36 INFO - PROCESS | 2179 | colorDepth:24 08:57:36 INFO - PROCESS | 2179 | Browser inner width/height: 1024/689 08:57:36 INFO - PROCESS | 2179 | __metrics 08:57:36 INFO - PROCESS | 2179 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:57:36 INFO - PROCESS | 2179 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:57:37 INFO - TEST-INFO | 2179: exit 0 08:57:37 INFO - Browser initialized. 08:57:37 INFO - Running cycle 1/1 for dromaeo_css test... 08:57:37 INFO - TEST-INFO | started process 2181 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmpqOfNXv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:49 INFO - PROCESS | 2181 | RSS: Main: 229859328 08:57:49 INFO - PROCESS | 2181 | 08:58:41 INFO - PROCESS | 2181 | 1479229121701 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:00:55 INFO - PROCESS | 2181 | Cycle 1(1): loaded http://localhost:56087/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56087/tests/dromaeo/cssquery-ext.html) 09:00:57 INFO - PROCESS | 2181 | RSS: Main: 406233088 09:00:57 INFO - PROCESS | 2181 | 09:04:00 INFO - PROCESS | 2181 | Cycle 1(1): loaded http://localhost:56087/tests/dromaeo/cssquery-ext.html (next: http://localhost:56087/tests/dromaeo/cssquery-jquery.html) 09:04:00 INFO - PROCESS | 2181 | RSS: Main: 376037376 09:04:00 INFO - PROCESS | 2181 | 09:07:03 INFO - PROCESS | 2181 | Cycle 1(1): loaded http://localhost:56087/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56087/tests/dromaeo/cssquery-mootools.html) 09:07:03 INFO - PROCESS | 2181 | RSS: Main: 354865152 09:07:03 INFO - PROCESS | 2181 | 09:10:06 INFO - PROCESS | 2181 | Cycle 1(1): loaded http://localhost:56087/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56087/tests/dromaeo/cssquery-prototype.html) 09:10:06 INFO - PROCESS | 2181 | RSS: Main: 341196800 09:10:06 INFO - PROCESS | 2181 | 09:13:10 INFO - PROCESS | 2181 | Cycle 1(1): loaded http://localhost:56087/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56087/tests/dromaeo/cssquery-yui.html) 09:13:10 INFO - PROCESS | 2181 | RSS: Main: 334045184 09:13:10 INFO - PROCESS | 2181 | 09:16:14 INFO - PROCESS | 2181 | Cycle 1(1): loaded http://localhost:56087/tests/dromaeo/cssquery-yui.html (next: http://localhost:56087/tests/dromaeo/cssquery-dojo.html) 09:16:14 INFO - PROCESS | 2181 | RSS: Main: 481087488 09:16:14 INFO - PROCESS | 2181 | 09:16:14 INFO - PROCESS | 2181 | __start_tp_report 09:16:14 INFO - PROCESS | 2181 | _x_x_mozilla_page_load 09:16:14 INFO - PROCESS | 2181 | _x_x_mozilla_page_load_details 09:16:14 INFO - PROCESS | 2181 | |i|pagename|runs| 09:16:14 INFO - PROCESS | 2181 | |0;dojo.html;3248.7076163145325;3257.7719559630827;3264.7551433642475;3272.8690852365908;3302.6367099619038;5613.522850557697;5627.7186140693;5726.3987281335485;5727.541796656268;5751.7986870459545;5715.2855893013375;5741.483266506014;5743.282089738783;5757.68332741699;5781.566382521317;5147.7426128693605;5186.844394668166;5193.350831146106;5217.373915130171;5230.320058392404;5256.106461901486;5270.367555893298;5278.181881808307;5283.709395983219;5293.3647962244395;5192.1173400522;5217.791288348461;5227.5295223429885;5256.8160114396005;5269.552088072518;5271.182966640177;5274.103402421579;5288.8413347599635;5308.124159513675;5318.282031925679;5045.924311135299;5115.411727651331;5142.254373115915;5202.505761952646;5219.947800521984;5611.887762244733;5709.628874123168;5732.3407808101765;5764.711764411804;5771.682557459338;6119.541034422392;6136.785212517585;6138.478229350466;6140.84647883802;6144.109104179914;6086.573939824214;6094.664793436359;6132.6013809102715;6135.938640613582;6138.9693051534905;5720.3421606515785;5777.19119323295;5789.392113828029;5799.739011744482;5807.041838096667;6072.848178795565;6131.204789224245;6140.916290666746;6152.64641778808;6157.983932651152;6004.459598636144;6097.542684298695;6098;6113.449789518876;6127.387261273837;6149.723262453201;6160.414760597736;6163.7842675506145;6168.352323006109;6173.69131543421;6107.492261292593;6170.81487555374;6174.876502469925;6194.876102477925;6212.192414986023;6193.504519638418;6200.720967556471;6202.596831205957;6203.131561581382;6208.689565521706;4839.637027222972;4898.583620392306;4909.165441874889;4915.459299477055;4943.505649435027;4355.5208927018;4360.869173924787;4387.846425375161;4398.890027749332;4421.513633500313;5806.593538452352;5814.534837213013;5835.328937172195;5836.620619659709;5866.1494083357675;6160.291566469913;6170.598911070766;6177.2587289525545;6181.84545386369;6188.350223226586;5646.2942132233475;5690.089585666274;5698.00284950132;5788.942110578924;5790.594658373958;5246.921296180561;5326.414094449608;5400.000999815047;5421.566274698093;5452.945470545244;6313.96843015782;6317.4630156437215;6325.525585581007;6333.936660633335;6347.8095657128515;6033.095035744674;6126.731429653803;6154.815355539341;6167.229096362955;6194.752209911733;6151.32335443092;6180.412860778219;6186.907196391968;6193.752249909953;6218.160548325918;6147.924113280247;6179.320274769681;6187.752489900534;6191.318954915046;6204.348543402878;6079.3008803988105;6142.416470435302;6162.075688646739;6165.753369865155;6179.567430279837;5947.553933455095;6016.398360163948;6124.693765311806;6134.141220229082;6141.723622437091;5864.06175011996;6046.848828779316;6074.574779765374;6083.178770866053;6130.031268545553;5916.053431450947;5983.850403739942;6000.87998240024;6004.5796794225735;6043.969780151071;6112.083187521907;6113.847153821012;6114.969425153024;6137.815865524041;6140.723667434887;5698.914516282176;5711.971440142773;5728.627639203439;5809.070548712186;5816.156657284585 09:16:14 INFO - PROCESS | 2181 | |1;ext.html;466.67566041601077;471.44605089020416;471.84900831733836;472.29863652476087;515.1628603519279;29962.550561741566;31432.05703828883;31471.370572588563;31472.898448554304;39399.409008864815;39457.802710986405;41815.58184418155;41958.58041419585;41972.37041444381;42074.57925420745;7770.611469426534;8882.511461869595;9213.815723685522;9403.952980235123;9404.012578679243;9287.442753434781;9389.108034736722;9408.81182376352;9410.5765240564;9418.10527999839;9375.203107735852;9425.952870235638;9437.716868493957;9442.150206481416;9448.905510944905;9336;9379.343445958786;9402.90597094034;9407.388519746195;9416.858747118798;9301.255899528089;9347.439153650803;9369.812603747954;9371.297152713505;9380.390274632195;39426.60573394258;39802.40296395557;39828.402573961415;39865.60134398648;39867.80066099651;3275.7870738401925;3301.983490082558;3367.6800703933086;3702.148505843644;3915.451836742858;29344.706552934626;29660.406791864043;29895.252618684488;30482.93309734171;30783.538246926313;2890.4797136515417;3195.6644552321904;3203.615566132056;3317.6848199421015;3341.448660970961;475707;476683;480611;482777;484245;60369.698151508965;60906.08640870391;60993.695031524556;61053.38946610477;61143.388566114656;62739;62772.372276277565;62833.37166628367;62862.685686572186;62934.74130517364;14910.850891491164;14918.254087295592;14929.552113436614;15305.540833775005;15570.532884013497;11751.764964700658;11821.408929553489;11838.94080529609;11844.052475801915;11850.111241656738;15653.530394088195;18194.272229110687;18198.727019094724;18277.725834112498;18365.449036528924;6318.684065796691;7308.707651693979;7369.494371913575;7604.391648668204;7610.657520411595;836.4887272007302;885.4687187687337;917.0783362720423;1032.4528000159928;1039.6880935719255;28627.427451450854;28905.855470722512;28909.42181156365;29477.968271110407;29563.704362956527;848.6308455821737;1016.9898301017043;1039.8856125826153;1046.6080113449095;1072.2172813845937;12013.519459221534;14997.95014348985;15067.300276167536;15324.616884577974;15390.461333853485;647411;652488;653502;655594;655716;56095;56700.716496417255;56746.71626641923;56812.715936420056;57118.42881571131;1106.8616422947132;1251.4305990774176;1310.2531557012412;1340.9664758381118;1366.214426704629;25437.87281063583;28775;29802.403951921275;30077.94727184538;31075.055982085516;43505.78247108744;54965.72517137389;55797.88404231974;55886.72056639854;55977.44022559722;602564;608647;609094;609953;610270.9486452717;25927.96288148453;26411.339716507242;27326.590101148897;27354.863225683745;40677.593224068565;44671.55328446804;45090.323645146;45691.857703557675;45767.855803605176;46578;37416.62583374132;37464.438033428974;37745;38654.840354789405;39251.803740981115;37375.878723638336;38275.617243827204;38550;38798.4180237291;39102;35968.460473092404;36247.275054498234;36941;37189;37225.44161837629;32236.83881580577;33019.83490082534;33407.49888751622;33483.16292092717;33695.663043369255;24118.51762964766;24385;24571.877140614182;24768;25077.498450031264 09:16:14 INFO - PROCESS | 2181 | |2;jquery.html;339.24778518949626;356.789494198423;359.8344761409753;368.2101891442855;389.6707282346418;14778.408863645454;14864.925675371622;16882.662346753074;19000.524986875334;20253.493662658406;19519.70720439191;19681.901590492027;19756.506087347825;19941.60116797663;20134.39596812094;4832.420109586846;5639.8590035249035;5834.21238132853;5903.852403689899;5910.67491287979;4757.619390448755;5793.942060579382;5854.941450585482;5925.5555833312455;5936;5931.644101353911;5937.317208521033;5937.821865344046;5944.7027648617395;5959;5954.612950158225;5954.9404505955035;7402.11174659039;7748.302652761278;7835.6473958671995;7271.163816161156;7524.05949256343;7526.36025937796;7621.628106940749;7646.929429879766;25869.09458168955;26824.865875670694;26971.46057078867;27072.78172482243;27578.862105689543;2175.7171567696255;2526.381036646015;2584.185981415867;2630.5659566171557;3116.2209447638093;16154;16252.75620865688;16347.427840025543;16779.412720554843;17034.65930681392;1730.9653806923916;1946.776120746118;1998.99000504998;2014.687723402875;2105.788921632295;122202;124317.37841310736;129550.3522482391;133032;134676.6532334674;20153.899230503754;20463.656266557417;20489.609766473102;20769.688454673193;20772.57252553342;27784.86107569449;29473;29475.705242947297;32249.677503225135;34201.97394078182;10095.798084038279;10417.218708596885;10531.84202236967;10553.736156596147;10675.957352154599;8644.481331120027;8650.437721548205;8670.609822558;8781.91218087811;8814.603342849587;7321.538737089325;8136.524911298762;8531.53076580794;8535.530545819915;8684.522351270614;3458.8097654629237;3625.3836847735947;3644.8836245010134;3644.908877278089;3668.3030224257304;703.7290643102442;851.5614458553849;860.2687715441824;873.3624454148508;922.1746536849616;19264.518387040436;19875.701864472045;19998.300059497848;20075.498112547302;20119.49701257451;904.9366993782279;912.3112050402036;917.8990311065777;924.8335299646128;992.717075633441;9986.400815951067;10362.274640775224;10504.474776261157;10528.368297901998;10590.523426445829;496204;504769.61843052466;504943;568348;576071;133466;136470;146494.2675286638;148418.25790870975;149574;376.4165543407707;411.5904674848485;434.0970780775978;434.51768536923987;435.42958724071565;10162.593496260066;11134.3876086816;11304.604338848101;17445.738313925554;18695.81304186995;53037;54746.452535474134;57616.423835762784;57947;59100;73538.63230683812;75039.62321695428;76492;79374;80822;7287.688216121149;7895.921040789519;7896;8088.555129467935;8238.629261683358;9120.361574689709;12294.569690060805;12513.874861251272;12667.493300267886;12799.616011519669;10489.685309440729;10544.525496352837;10669.35983840972;10777.784444310913;10952.726181845517;10278.098551767947;10323.225758068025;10424.583016679248;10555.683329500127;10917.23579349438;9195.448273103635;10543.57825686964;10659.840102398626;10923.56305747793;11020.614278500214;7795.103563090317;7945.364370850433;8066.112727600077;8092.6762929482165;8263.545504997282;7988.281054705104;9561.235101191749;10364.326318789255;10388.480575971322;11082.113430925669 09:16:14 INFO - PROCESS | 2181 | |3;mootools.html;1467.2003757951918;1486.9851301486985;1648.6372997940448;1787.7407775872507;1848.2791711232621;7970.84058318834;8413.074561798205;8422.620982055807;8427.367947403938;8429.957850210749;7017.824554386143;7364.079490063742;7623.542587444757;7629.2752188542;8056.677732890677;2247.5954328220914;2283.1324096843177;2284.565932472833;2286;2286.6227072533097;2278.9658155127686;2321.292005938188;2321.3152120124605;2327.94180145496;2334;2249.2127755285683;2255.9887200563976;2277.4534111813127;2277.464795772992;2277.943051423719;2235.474663454095;2249.730032396123;2250.8424410291286;2253.211376018397;2265.365697604665;2220.9444763881033;2300.240920496249;2301.505176387068;2303.389601755536;2309.445733024062;8294.58527073644;8309.626066827008;8380.24577787996;8407.327413806881;8412.621432035512;4976;5140.074786538422;5143.665661731976;5145.382554093495;5146.974265128651;3163.6710595779477;3222.629397619257;3295.20914980403;3402.4726167443837;3405.3019131078318;946.7869729310919;995.5370752600076;999.5102399824107;1015.7206768138747;1084.2139448899563;10881.891181088246;10888.78222435547;10902.5093870776;10943.96032376923;10944.069754070913;4287.399764033038;4570.200214962369;4621.214393553104;4630.050839577946;4634.096351211549;9397.57710903011;9409;9419.529023548932;9420.811583768285;9437.811243775086;5047.646664733434;5156.226566015128;5159.664621799571;5166.380034395821;5168.095583272912;3940.330143875548;4371;4666.743329116931;4712.670113092119;4719.362886010414;3627.8004709741217;3696.5933747287777;3722.962770372316;3766.246750649881;3790.905227369283;1164.598213616301;1217.3669691760235;1219.9878001220052;1222.9938850305869;1232.7056590579855;723.2405973727565;826.4917075998218;870.3472395703222;878.4158534574436;892.7098692924825;5332.33345831771;5411.83764487066;5682.119271512922;5700.857478562986;5769.538436925036;763.4503157726429;807.5477732469835;920.798358142617;936.6347124621403;963.6990063414474;3759.8496060157286;3760.304343696425;3789.886303410902;3863.0535518798074;3885.3487267911023;9666;9999.100080992746;10033.498325083716;10117.848232276521;10143.391396516232;10077.54651040705;10080.69757907264;10093;10111;10119.494025298705;7354.338109570164;7725.459217854808;7746.30283274508;7908.130105688369;7909.881351779728;5631.8592035199445;5783.074708046693;5805.245318108618;5827.24245848037;5871.706414679335;7230.349268565854;9130.497822619554;9175.678851240174;9231.76920576964;9362.221177976162;7411.554746824533;9122.90877091247;9449.622015119317;9502.809943801223;9528.333016689043;7108.893366599402;7294.562326260441;7307.2327405621645;7322.5972571506945;7344.632768361667;7651.579163145858;7829.021372328459;7874.763757087297;7894.092179399443;7902.367810575025;7053.0830991970715;7106.502544821813;7148.177959534512;7159.03353047332;7312.378447831994;6635.2037755469655;6981.860362792817;7000.439964802906;7040.718371265297;7058.435325174077;6583.769568065095;6634.303398143125;6651.401373876374;6729.7644582441335;6751.358620931003;4135.875923722293;4233.894152646209;4775.832845850378;4861.052094841472;4992.450830408725;4385;4723.078999595046;4875.561199491921;4907.6140408684705;4948.62885283598 09:16:14 INFO - PROCESS | 2181 | |4;prototype.html;294.646424290851;301.7766852529129;305.75539568345323;311.91422358851327;313.2888343460344;4531.841385551506;4912.803487860486;5125.974370128149;5154.5103215194495;5183.559397451217;5044.243363495469;5095.108356037688;5106.876487172825;5120.8990067135555;5140.66585671932;3102.90691279262;3678.44823276508;3821.636944490269;3834.4056671215867;3893.1118407572303;3030.106183635228;3241.6272128705145;3890.319194141028;3921.9803900980455;3929.7207619580577;3845.365514690087;3855.8407291916615;3859.864904728335;3873.612638736132;3903.394973779069;3159.9684003160132;3202.679732026802;3624;3686.6497682720233;3781.0169355967646;3396.915077123067;3421.6920477157178;3426.794392336443;3428.434308339121;3439.2287971694595;4018.738781979191;4643.419572553431;4692.850251688358;4869.318295438641;4971.900561988776;4161.9583804161875;4176.081262122359;4338.848140315074;4449.288113901793;4450.9332360014305;4971.502849715036;5243.501867322599;5311.893762124774;5333.679979201261;5348.432752278889;3092.9431927768005;3492.266624008961;3676.114250313491;3676.3198808220295;3691.6123807000417;4530.3431002504785;5241.798444653255;5486.506214440719;5536.833894983157;5670.801521946753;3198.344339410415;3743.419769935664;3828;3829.8659546916283;3838.4626152338697;3262.3964566555264;3866.497355343787;3871.5160604924386;3882.3400021995762;3896.337622604164;3734.290484807878;4448.132614140211;4449.399331090326;4469.642428605704;4476.657002899117;4998.650094493423;5373.140297552451;5376.865578360494;5385.6230063895155;5429.864253393696;1066.7653116314398;1081.8478320588547;1234.327291626066;1241.2614494375832;1241.4475558376437;708.7094291340526;762.5767698927149;783.8001309665999;822.2394285286086;831.4429332347341;4790.8323208688225;4946.3817022872145;4947.876303092379;4952.430470495867;4958.834578953696;4550.88622784433;5097.6941383517105;5386.757595908193;5443.945560544423;5563.666180029211;4182.121754431603;4863.003084367696;5042.546170844642;5046.217836235316;5053;2650.966123211949;2732.9180124595896;2745.697973222944;2746.4781691478556;2753.917382478489;4923.8276660316715;4931.408231012229;5148.742562871841;5309.230161626542;5489.365104749742;4648.604868586141;5183.611229157828;5409.215663728737;5464.398916119224;5481.725913704299;4458.509563947963;5054.826424637441;5178.61160412963;5467.118345974323;5520.91718624221;4352.4341835562445;4536.459582633735;5233.319668443078;5269.815556455505;5298.841034768963;3939.9362172213914;4798.2082956311815;4829.517048295143;5181.5077567631015;5201.349831271091;5183.688978661293;5395.3525576931015;5429.800930623104;5440.0623663223;5457.025920873054;2911.5341545352644;3019.452143731151;3588.6411358863907;3619.936636117388;3674.3018826422895;4169.60388763067;4216.018471318475;4644.907101857876;4663.300504924288;5237.685738855681;4149.787965215249;4608.631309495299;5033.320501732365;5068.66841253013;5070.112730272114;4001.2597669431248;4472.39622650938;4482.731036137842;4977.626677999237;5016.971520838292;4236;4765.666403351732;4880.438749543706;4933.432655244549;4970.21072413938;4603.516630753723;5065.39215294167;5078.568321692697;5121.897562048813;5256.6320357574605;3980.3034468968394;4567.63458923292;5188.58491320701;5193.506616871391;5324.961632481783 09:16:14 INFO - PROCESS | 2181 | |5;yui.html;681.3084719010204;686.3856848120932;706.8162277807775;708.9397401220896;758.7041053988944;13711.314434278283;13755.105918115341;14127.293635318232;14401.991860569764;14413.06315089521;12627.55803546876;13440.395182216824;13763.862361376383;13790.517331893385;13806.102603330777;744.1219361153836;818.9549574773386;821.3470291118546;822.8765685147246;823.3742355809597;643;664.3987191591593;665.2947875252224;801.266840840633;813.975580732576;854.0946596607616;864.0883867519764;865.5845194306737;865.7359505350865;866.2982983783156;826.9049059358191;860.9311255099577;861.5261606116611;862.9784255393603;863.9913600863973;499.6053118036783;507.49504243278176;615.7444660465901;617.3548641669466;637.9138816259792;13739.313034348343;14239.288035598178;14271.215083170422;14274.214918179496;14277.14337139775;13022.283774392405;13153.736925261537;13311.400986955514;13405.530806421826;13558.322083895864;10591.57633694659;11844.111691623162;11935.701607459796;11992.820107698391;12148.817767733492;4233.322668373076;4255.510616279105;4261.382099595541;4406.1848558016545;4442.689011769177;91832.08167918301;91853.62219566645;93044.53477732636;93641;95170.52414737952;10481.71585817744;10524.26330156897;10773.569057237779;10801.24391292602;10854.511546980404;19315.8068419314;20083.698744518842;20239.392818215478;20282.59434811325;20328.288509902082;7505.174430812606;7732.149463559004;7759.650815713307;7778.455508114378;7789.571573563395;4141.565135660712;4164.43780089684;4172;4249.043965107888;4362.411074504901;3282.638909719929;3394.762366634361;3394.932101357959;3399.5750531183603;3424.366492198951;637.8979363301942;648.870225954811;675.4056430341268;678.504691575143;697.0694123345289;548.700957977903;573.4666759913321;579.4495229531962;658.121407920422;683.45323741007;8721;9033.277337812959;9073.54632268384;9091.545422728837;9317.021712720067;629.1286568103119;633.5628416392674;651.6513665189101;652.5595223224304;657.6087228099274;4253.80857861397;4486.64106871456;4488.685791994529;4490.57339552742;4498.235299999008;113754.86245137609;116432;116717;118201;118335.40832295956;94505.5274723622;95859;96293.51853240689;101959;102652.48673756733;56139.438605613424;56400.153997689245;58492.7075364629;76450;77537;9173.724788256097;9226.492542910204;9594.376365536218;9608.231341492525;9699;51092;52897.471025289255;53425.73287133539;55167.75906288896;57181.714091429276;73768;74659;76101.61949190218;77135.22864771505;77686.89252430065;12154.270743755404;12257.754844903231;12360;12549.811752823533;12764.489420423079;13506.932465338003;14212.573622791333;14314.713705725619;14375.928120359331;14502.709945800814;11831.994280485911;12632.368381581067;13043.217406955613;13043.28261945602;13071.607851764082;10859.239853210516;11897.286162830258;12820.61538153857;13028.28344441027;13095;12365.938170309091;12737.172083814523;12927.095103342675;13004.934975325063;13114.082014258911;10360.067593916583;10514.369137851754;10725.946370268099;10787.190960677824;11173.608923687632;9557.713268601676;10413;10499.790004200026;11076.556937722724;11118 09:16:14 INFO - PROCESS | 2181 | __end_tp_report 09:16:14 INFO - PROCESS | 2181 | __start_cc_report 09:16:14 INFO - PROCESS | 2181 | _x_x_mozilla_cycle_collect,1815 09:16:14 INFO - PROCESS | 2181 | __end_cc_report 09:16:14 INFO - PROCESS | 2181 | __startTimestamp1479230174517__endTimestamp 09:16:14 INFO - PROCESS | 2181 | 09:16:14 INFO - PROCESS | 2181 | ------- Summary: start ------- 09:16:14 INFO - PROCESS | 2181 | Number of tests: 6 09:16:14 INFO - PROCESS | 2181 | 09:16:14 INFO - PROCESS | 2181 | [#0] dojo.html Cycles:165 Average:5718.10 Median:5947.55 stddev:628.84 (10.6%) stddev-sans-first:600.19 09:16:14 INFO - PROCESS | 2181 | Values: 3248.7 3257.8 3264.8 3272.9 3302.6 5613.5 5627.7 5726.4 5727.5 5751.8 5715.3 5741.5 5743.3 5757.7 5781.6 5147.7 5186.8 5193.4 5217.4 5230.3 5256.1 5270.4 5278.2 5283.7 5293.4 5192.1 5217.8 5227.5 5256.8 5269.6 5271.2 5274.1 5288.8 5308.1 5318.3 5045.9 5115.4 5142.3 5202.5 5219.9 5611.9 5709.6 5732.3 5764.7 5771.7 6119.5 6136.8 6138.5 6140.8 6144.1 6086.6 6094.7 6132.6 6135.9 6139.0 5720.3 5777.2 5789.4 5799.7 5807.0 6072.8 6131.2 6140.9 6152.6 6158.0 6004.5 6097.5 6098.0 6113.4 6127.4 6149.7 6160.4 6163.8 6168.4 6173.7 6107.5 6170.8 6174.9 6194.9 6212.2 6193.5 6200.7 6202.6 6203.1 6208.7 4839.6 4898.6 4909.2 4915.5 4943.5 4355.5 4360.9 4387.8 4398.9 4421.5 5806.6 5814.5 5835.3 5836.6 5866.1 6160.3 6170.6 6177.3 6181.8 6188.4 5646.3 5690.1 5698.0 5788.9 5790.6 5246.9 5326.4 5400.0 5421.6 5452.9 6314.0 6317.5 6325.5 6333.9 6347.8 6033.1 6126.7 6154.8 6167.2 6194.8 6151.3 6180.4 6186.9 6193.8 6218.2 6147.9 6179.3 6187.8 6191.3 6204.3 6079.3 6142.4 6162.1 6165.8 6179.6 5947.6 6016.4 6124.7 6134.1 6141.7 5864.1 6046.8 6074.6 6083.2 6130.0 5916.1 5983.9 6000.9 6004.6 6044.0 6112.1 6113.8 6115.0 6137.8 6140.7 5698.9 5712.0 5728.6 5809.1 5816.2 09:16:14 INFO - PROCESS | 2181 | 09:16:14 INFO - PROCESS | 2181 | [#1] ext.html Cycles:180 Average:70730.35 Median:39442.20 stddev:156563.78 (396.9%) stddev-sans-first:156914.10 09:16:14 INFO - PROCESS | 2181 | Values: 466.7 471.4 471.8 472.3 515.2 29962.6 31432.1 31471.4 31472.9 39399.4 39457.8 41815.6 41958.6 41972.4 42074.6 7770.6 8882.5 9213.8 9404.0 9404.0 9287.4 9389.1 9408.8 9410.6 9418.1 9375.2 9426.0 9437.7 9442.2 9448.9 9336.0 9379.3 9402.9 9407.4 9416.9 9301.3 9347.4 9369.8 9371.3 9380.4 39426.6 39802.4 39828.4 39865.6 39867.8 3275.8 3302.0 3367.7 3702.1 3915.5 29344.7 29660.4 29895.3 30482.9 30783.5 2890.5 3195.7 3203.6 3317.7 3341.4 475707.0 476683.0 480611.0 482777.0 484245.0 60369.7 60906.1 60993.7 61053.4 61143.4 62739.0 62772.4 62833.4 62862.7 62934.7 14910.9 14918.3 14929.6 15305.5 15570.5 11751.8 11821.4 11838.9 11844.1 11850.1 15653.5 18194.3 18198.7 18277.7 18365.4 6318.7 7308.7 7369.5 7604.4 7610.7 836.5 885.5 917.1 1032.5 1039.7 28627.4 28905.9 28909.4 29478.0 29563.7 848.6 1017.0 1039.9 1046.6 1072.2 12013.5 14998.0 15067.3 15324.6 15390.5 647411.0 652488.0 653502.0 655594.0 655716.0 56095.0 56700.7 56746.7 56812.7 57118.4 1106.9 1251.4 1310.3 1341.0 1366.2 25437.9 28775.0 29802.4 30077.9 31075.1 43505.8 54965.7 55797.9 55886.7 55977.4 602564.0 608647.0 609094.0 609953.0 610270.9 25928.0 26411.3 27326.6 27354.9 40677.6 44671.6 45090.3 45691.9 45767.9 46578.0 37416.6 37464.4 37745.0 38654.8 39251.8 37375.9 38275.6 38550.0 38798.4 39102.0 35968.5 36247.3 36941.0 37189.0 37225.4 32236.8 33019.8 33407.5 33483.2 33695.7 24118.5 24385.0 24571.9 24768.0 25077.5 09:16:14 INFO - PROCESS | 2181 | 09:16:14 INFO - PROCESS | 2181 | [#2] jquery.html Cycles:180 Average:34720.73 Median:18830.39 stddev:89990.26 (477.9%) stddev-sans-first:90205.68 09:16:14 INFO - PROCESS | 2181 | Values: 339.2 356.8 359.8 368.2 389.7 14778.4 14864.9 16882.7 19000.5 20253.5 19519.7 19681.9 19756.5 19941.6 20134.4 4832.4 5639.9 5834.2 5903.9 5910.7 4757.6 5793.9 5854.9 5925.6 5936.0 5931.6 5937.3 5937.8 5944.7 5959.0 5954.6 5954.9 7402.1 7748.3 7835.6 7271.2 7524.1 7526.4 7621.6 7646.9 25869.1 26824.9 26971.5 27072.8 27578.9 2175.7 2526.4 2584.2 2630.6 3116.2 16154.0 16252.8 16347.4 16779.4 17034.7 1731.0 1946.8 1999.0 2014.7 2105.8 122202.0 124317.4 129550.4 133032.0 134676.7 20153.9 20463.7 20489.6 20769.7 20772.6 27784.9 29473.0 29475.7 32249.7 34202.0 10095.8 10417.2 10531.8 10553.7 10676.0 8644.5 8650.4 8670.6 8781.9 8814.6 7321.5 8136.5 8531.5 8535.5 8684.5 3458.8 3625.4 3644.9 3644.9 3668.3 703.7 851.6 860.3 873.4 922.2 19264.5 19875.7 19998.3 20075.5 20119.5 904.9 912.3 917.9 924.8 992.7 9986.4 10362.3 10504.5 10528.4 10590.5 496204.0 504769.6 504943.0 568348.0 576071.0 133466.0 136470.0 146494.3 148418.3 149574.0 376.4 411.6 434.1 434.5 435.4 10162.6 11134.4 11304.6 17445.7 18695.8 53037.0 54746.5 57616.4 57947.0 59100.0 73538.6 75039.6 76492.0 79374.0 80822.0 7287.7 7895.9 7896.0 8088.6 8238.6 9120.4 12294.6 12513.9 12667.5 12799.6 10489.7 10544.5 10669.4 10777.8 10952.7 10278.1 10323.2 10424.6 10555.7 10917.2 9195.4 10543.6 10659.8 10923.6 11020.6 7795.1 7945.4 8066.1 8092.7 8263.5 7988.3 9561.2 10364.3 10388.5 11082.1 09:16:14 INFO - PROCESS | 2181 | 09:16:14 INFO - PROCESS | 2181 | [#3] mootools.html Cycles:180 Average:5386.36 Median:5151.60 stddev:2960.26 (57.5%) stddev-sans-first:2953.91 09:16:14 INFO - PROCESS | 2181 | Values: 1467.2 1487.0 1648.6 1787.7 1848.3 7970.8 8413.1 8422.6 8427.4 8430.0 7017.8 7364.1 7623.5 7629.3 8056.7 2247.6 2283.1 2284.6 2286.0 2286.6 2279.0 2321.3 2321.3 2327.9 2334.0 2249.2 2256.0 2277.5 2277.5 2277.9 2235.5 2249.7 2250.8 2253.2 2265.4 2220.9 2300.2 2301.5 2303.4 2309.4 8294.6 8309.6 8380.2 8407.3 8412.6 4976.0 5140.1 5143.7 5145.4 5147.0 3163.7 3222.6 3295.2 3402.5 3405.3 946.8 995.5 999.5 1015.7 1084.2 10881.9 10888.8 10902.5 10944.0 10944.1 4287.4 4570.2 4621.2 4630.1 4634.1 9397.6 9409.0 9419.5 9420.8 9437.8 5047.6 5156.2 5159.7 5166.4 5168.1 3940.3 4371.0 4666.7 4712.7 4719.4 3627.8 3696.6 3723.0 3766.2 3790.9 1164.6 1217.4 1220.0 1223.0 1232.7 723.2 826.5 870.3 878.4 892.7 5332.3 5411.8 5682.1 5700.9 5769.5 763.5 807.5 920.8 936.6 963.7 3759.8 3760.3 3789.9 3863.1 3885.3 9666.0 9999.1 10033.5 10117.8 10143.4 10077.5 10080.7 10093.0 10111.0 10119.5 7354.3 7725.5 7746.3 7908.1 7909.9 5631.9 5783.1 5805.2 5827.2 5871.7 7230.3 9130.5 9175.7 9231.8 9362.2 7411.6 9122.9 9449.6 9502.8 9528.3 7108.9 7294.6 7307.2 7322.6 7344.6 7651.6 7829.0 7874.8 7894.1 7902.4 7053.1 7106.5 7148.2 7159.0 7312.4 6635.2 6981.9 7000.4 7040.7 7058.4 6583.8 6634.3 6651.4 6729.8 6751.4 4135.9 4233.9 4775.8 4861.1 4992.5 4385.0 4723.1 4875.6 4907.6 4948.6 09:16:14 INFO - PROCESS | 2181 | 09:16:14 INFO - PROCESS | 2181 | [#4] prototype.html Cycles:180 Average:4188.18 Median:4644.16 stddev:1281.41 (27.6%) stddev-sans-first:1251.23 09:16:14 INFO - PROCESS | 2181 | Values: 294.6 301.8 305.8 311.9 313.3 4531.8 4912.8 5126.0 5154.5 5183.6 5044.2 5095.1 5106.9 5120.9 5140.7 3102.9 3678.4 3821.6 3834.4 3893.1 3030.1 3241.6 3890.3 3922.0 3929.7 3845.4 3855.8 3859.9 3873.6 3903.4 3160.0 3202.7 3624.0 3686.6 3781.0 3396.9 3421.7 3426.8 3428.4 3439.2 4018.7 4643.4 4692.9 4869.3 4971.9 4162.0 4176.1 4338.8 4449.3 4450.9 4971.5 5243.5 5311.9 5333.7 5348.4 3092.9 3492.3 3676.1 3676.3 3691.6 4530.3 5241.8 5486.5 5536.8 5670.8 3198.3 3743.4 3828.0 3829.9 3838.5 3262.4 3866.5 3871.5 3882.3 3896.3 3734.3 4448.1 4449.4 4469.6 4476.7 4998.7 5373.1 5376.9 5385.6 5429.9 1066.8 1081.8 1234.3 1241.3 1241.4 708.7 762.6 783.8 822.2 831.4 4790.8 4946.4 4947.9 4952.4 4958.8 4550.9 5097.7 5386.8 5443.9 5563.7 4182.1 4863.0 5042.5 5046.2 5053.0 2651.0 2732.9 2745.7 2746.5 2753.9 4923.8 4931.4 5148.7 5309.2 5489.4 4648.6 5183.6 5409.2 5464.4 5481.7 4458.5 5054.8 5178.6 5467.1 5520.9 4352.4 4536.5 5233.3 5269.8 5298.8 3939.9 4798.2 4829.5 5181.5 5201.3 5183.7 5395.4 5429.8 5440.1 5457.0 2911.5 3019.5 3588.6 3619.9 3674.3 4169.6 4216.0 4644.9 4663.3 5237.7 4149.8 4608.6 5033.3 5068.7 5070.1 4001.3 4472.4 4482.7 4977.6 5017.0 4236.0 4765.7 4880.4 4933.4 4970.2 4603.5 5065.4 5078.6 5121.9 5256.6 3980.3 4567.6 5188.6 5193.5 5325.0 09:16:14 INFO - PROCESS | 2181 | 09:16:14 INFO - PROCESS | 2181 | [#5] yui.html Cycles:180 Average:20419.52 Median:4424.44 stddev:30230.08 (683.3%) stddev-sans-first:30278.55 09:16:14 INFO - PROCESS | 2181 | Values: 681.3 686.4 706.8 708.9 758.7 13711.3 13755.1 14127.3 14402.0 14413.1 12627.6 13440.4 13763.9 13790.5 13806.1 744.1 819.0 821.3 822.9 823.4 643.0 664.4 665.3 801.3 814.0 854.1 864.1 865.6 865.7 866.3 826.9 860.9 861.5 863.0 864.0 499.6 507.5 615.7 617.4 637.9 13739.3 14239.3 14271.2 14274.2 14277.1 13022.3 13153.7 13311.4 13405.5 13558.3 10591.6 11844.1 11935.7 11992.8 12148.8 4233.3 4255.5 4261.4 4406.2 4442.7 91832.1 91853.6 93044.5 93641.0 95170.5 10481.7 10524.3 10773.6 10801.2 10854.5 19315.8 20083.7 20239.4 20282.6 20328.3 7505.2 7732.1 7759.7 7778.5 7789.6 4141.6 4164.4 4172.0 4249.0 4362.4 3282.6 3394.8 3394.9 3399.6 3424.4 637.9 648.9 675.4 678.5 697.1 548.7 573.5 579.4 658.1 683.5 8721.0 9033.3 9073.5 9091.5 9317.0 629.1 633.6 651.7 652.6 657.6 4253.8 4486.6 4488.7 4490.6 4498.2 113754.9 116432.0 116717.0 118201.0 118335.4 94505.5 95859.0 96293.5 101959.0 102652.5 56139.4 56400.2 58492.7 76450.0 77537.0 9173.7 9226.5 9594.4 9608.2 9699.0 51092.0 52897.5 53425.7 55167.8 57181.7 73768.0 74659.0 76101.6 77135.2 77686.9 12154.3 12257.8 12360.0 12549.8 12764.5 13506.9 14212.6 14314.7 14375.9 14502.7 11832.0 12632.4 13043.2 13043.3 13071.6 10859.2 11897.3 12820.6 13028.3 13095.0 12365.9 12737.2 12927.1 13004.9 13114.1 10360.1 10514.4 10725.9 10787.2 11173.6 9557.7 10413.0 10499.8 11076.6 11118.0 09:16:14 INFO - PROCESS | 2181 | -------- Summary: end -------- 09:16:14 INFO - PROCESS | 2181 | 09:16:15 INFO - TEST-INFO | 2181: exit 0 09:16:15 INFO - TEST-OK | dromaeo_css | took 1120827ms 09:16:15 INFO - TEST-START | kraken 09:16:15 INFO - operating with platform_type : mac_ 09:16:15 INFO - Initialising browser for kraken test... 09:16:15 INFO - TEST-INFO | started process 2185 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmplgV24k/profile http://localhost:56087/getInfo.html) 09:16:17 INFO - PROCESS | 2185 | __metrics Screen width/height:1600/1200 09:16:17 INFO - PROCESS | 2185 | colorDepth:24 09:16:17 INFO - PROCESS | 2185 | Browser inner width/height: 1024/689 09:16:17 INFO - PROCESS | 2185 | __metrics 09:16:17 INFO - PROCESS | 2185 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:16:17 INFO - PROCESS | 2185 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:16:18 INFO - TEST-INFO | 2185: exit 0 09:16:18 INFO - Browser initialized. 09:16:18 INFO - Running cycle 1/1 for kraken test... 09:16:18 INFO - TEST-INFO | started process 2186 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/T/tmplgV24k/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:30 INFO - PROCESS | 2186 | RSS: Main: 239001600 09:16:30 INFO - PROCESS | 2186 | 09:16:33 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56087/tests/kraken/driver.html?testName=audio-beat-detection) 09:16:34 INFO - PROCESS | 2186 | RSS: Main: 288874496 09:16:34 INFO - PROCESS | 2186 | 09:16:37 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56087/tests/kraken/driver.html?testName=audio-dft) 09:16:37 INFO - PROCESS | 2186 | RSS: Main: 289263616 09:16:37 INFO - PROCESS | 2186 | 09:16:41 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56087/tests/kraken/driver.html?testName=audio-fft) 09:16:41 INFO - PROCESS | 2186 | RSS: Main: 379760640 09:16:41 INFO - PROCESS | 2186 | 09:16:43 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56087/tests/kraken/driver.html?testName=audio-oscillator) 09:16:44 INFO - PROCESS | 2186 | RSS: Main: 280621056 09:16:44 INFO - PROCESS | 2186 | 09:16:46 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56087/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:16:47 INFO - PROCESS | 2186 | RSS: Main: 286568448 09:16:47 INFO - PROCESS | 2186 | 09:16:49 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56087/tests/kraken/driver.html?testName=imaging-darkroom) 09:16:50 INFO - PROCESS | 2186 | RSS: Main: 328151040 09:16:50 INFO - PROCESS | 2186 | 09:16:53 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56087/tests/kraken/driver.html?testName=imaging-desaturate) 09:16:54 INFO - PROCESS | 2186 | RSS: Main: 329830400 09:16:54 INFO - PROCESS | 2186 | 09:16:56 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56087/tests/kraken/driver.html?testName=json-parse-financial) 09:16:57 INFO - PROCESS | 2186 | RSS: Main: 326836224 09:16:57 INFO - PROCESS | 2186 | 09:16:59 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56087/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:16:59 INFO - PROCESS | 2186 | RSS: Main: 303980544 09:16:59 INFO - PROCESS | 2186 | 09:17:01 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56087/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:17:02 INFO - PROCESS | 2186 | RSS: Main: 310005760 09:17:02 INFO - PROCESS | 2186 | 09:17:04 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56087/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:17:05 INFO - PROCESS | 2186 | RSS: Main: 311115776 09:17:05 INFO - PROCESS | 2186 | 09:17:08 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:17:09 INFO - PROCESS | 2186 | RSS: Main: 331079680 09:17:09 INFO - PROCESS | 2186 | 09:17:12 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:17:12 INFO - PROCESS | 2186 | RSS: Main: 323428352 09:17:12 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | Cycle 1(1): loaded http://localhost:56087/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56087/tests/kraken/driver.html?testName=ai-astar) 09:17:14 INFO - PROCESS | 2186 | RSS: Main: 367407104 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | __start_tp_report 09:17:14 INFO - PROCESS | 2186 | _x_x_mozilla_page_load 09:17:14 INFO - PROCESS | 2186 | _x_x_mozilla_page_load_details 09:17:14 INFO - PROCESS | 2186 | |i|pagename|runs| 09:17:14 INFO - PROCESS | 2186 | |0;ai-astar;115;114;115;114;115;114;114;115;113;113 09:17:14 INFO - PROCESS | 2186 | |1;audio-beat-detection;142;113;111;148;113;115;135;133;146;111 09:17:14 INFO - PROCESS | 2186 | |2;audio-dft;185;184;184;185;186;183;184;182;182;184 09:17:14 INFO - PROCESS | 2186 | |3;audio-fft;81;60;60;89;60;60;59;61;71;61 09:17:14 INFO - PROCESS | 2186 | |4;audio-oscillator;88;72;92;70;68;70;90;66;69;96 09:17:14 INFO - PROCESS | 2186 | |5;imaging-gaussian-blur;91;88;91;89;91;88;91;88;91;88 09:17:14 INFO - PROCESS | 2186 | |6;imaging-darkroom;99;99;99;99;98;99;97;99;97;97 09:17:14 INFO - PROCESS | 2186 | |7;imaging-desaturate;85;86;85;85;86;85;85;86;85;85 09:17:14 INFO - PROCESS | 2186 | |8;json-parse-financial;58;56;56;56;57;58;55;54;54;55 09:17:14 INFO - PROCESS | 2186 | |9;json-stringify-tinderbox;67;77;76;74;74;71;72;72;72;71 09:17:14 INFO - PROCESS | 2186 | |10;stanford-crypto-aes;89;101;106;104;106;76;96;105;105;91 09:17:14 INFO - PROCESS | 2186 | |11;stanford-crypto-ccm;163;157;151;148;147;147;167;168;198;175 09:17:14 INFO - PROCESS | 2186 | |12;stanford-crypto-pbkdf2;175;187;162;172;201;235;189;176;174;175 09:17:14 INFO - PROCESS | 2186 | |13;stanford-crypto-sha256-iterative;68;69;69;69;67;66;69;68;68;68 09:17:14 INFO - PROCESS | 2186 | __end_tp_report 09:17:14 INFO - PROCESS | 2186 | __start_cc_report 09:17:14 INFO - PROCESS | 2186 | _x_x_mozilla_cycle_collect,2054 09:17:14 INFO - PROCESS | 2186 | __end_cc_report 09:17:14 INFO - PROCESS | 2186 | __startTimestamp1479230234895__endTimestamp 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | ------- Summary: start ------- 09:17:14 INFO - PROCESS | 2186 | Number of tests: 14 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 09:17:14 INFO - PROCESS | 2186 | Values: 115.0 114.0 115.0 114.0 115.0 114.0 114.0 115.0 113.0 113.0 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#1] audio-beat-detection Cycles:10 Average:126.70 Median:134.00 stddev:15.54 (11.6%) stddev-sans-first:15.47 09:17:14 INFO - PROCESS | 2186 | Values: 142.0 113.0 111.0 148.0 113.0 115.0 135.0 133.0 146.0 111.0 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.29 (0.7%) stddev-sans-first:1.30 09:17:14 INFO - PROCESS | 2186 | Values: 185.0 184.0 184.0 185.0 186.0 183.0 184.0 182.0 182.0 184.0 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#3] audio-fft Cycles:10 Average:66.20 Median:61.00 stddev:10.65 (17.5%) stddev-sans-first:9.86 09:17:14 INFO - PROCESS | 2186 | Values: 81.0 60.0 60.0 89.0 60.0 60.0 59.0 61.0 71.0 61.0 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#4] audio-oscillator Cycles:10 Average:78.10 Median:80.00 stddev:11.80 (14.7%) stddev-sans-first:11.96 09:17:14 INFO - PROCESS | 2186 | Values: 88.0 72.0 92.0 70.0 68.0 70.0 90.0 66.0 69.0 96.0 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#5] imaging-gaussian-blur Cycles:10 Average:89.60 Median:91.00 stddev:1.51 (1.7%) stddev-sans-first:1.51 09:17:14 INFO - PROCESS | 2186 | Values: 91.0 88.0 91.0 89.0 91.0 88.0 91.0 88.0 91.0 88.0 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#6] imaging-darkroom Cycles:10 Average:98.30 Median:99.00 stddev:0.95 (1.0%) stddev-sans-first:0.97 09:17:14 INFO - PROCESS | 2186 | Values: 99.0 99.0 99.0 99.0 98.0 99.0 97.0 99.0 97.0 97.0 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 09:17:14 INFO - PROCESS | 2186 | Values: 85.0 86.0 85.0 85.0 86.0 85.0 85.0 86.0 85.0 85.0 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:1.45 (2.6%) stddev-sans-first:1.32 09:17:14 INFO - PROCESS | 2186 | Values: 58.0 56.0 56.0 56.0 57.0 58.0 55.0 54.0 54.0 55.0 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#9] json-stringify-tinderbox Cycles:10 Average:72.60 Median:73.00 stddev:2.84 (3.9%) stddev-sans-first:2.17 09:17:14 INFO - PROCESS | 2186 | Values: 67.0 77.0 76.0 74.0 74.0 71.0 72.0 72.0 72.0 71.0 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#10] stanford-crypto-aes Cycles:10 Average:97.90 Median:91.00 stddev:9.94 (10.9%) stddev-sans-first:10.01 09:17:14 INFO - PROCESS | 2186 | Values: 89.0 101.0 106.0 104.0 106.0 76.0 96.0 105.0 105.0 91.0 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#11] stanford-crypto-ccm Cycles:10 Average:162.10 Median:165.00 stddev:16.05 (9.7%) stddev-sans-first:17.02 09:17:14 INFO - PROCESS | 2186 | Values: 163.0 157.0 151.0 148.0 147.0 147.0 167.0 168.0 198.0 175.0 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.60 Median:181.50 stddev:20.75 (11.4%) stddev-sans-first:21.71 09:17:14 INFO - PROCESS | 2186 | Values: 175.0 187.0 162.0 172.0 201.0 235.0 189.0 176.0 174.0 175.0 09:17:14 INFO - PROCESS | 2186 | 09:17:14 INFO - PROCESS | 2186 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.10 Median:68.50 stddev:0.99 (1.5%) stddev-sans-first:1.05 09:17:14 INFO - PROCESS | 2186 | Values: 68.0 69.0 69.0 69.0 67.0 66.0 69.0 68.0 68.0 68.0 09:17:14 INFO - PROCESS | 2186 | -------- Summary: end -------- 09:17:14 INFO - PROCESS | 2186 | 09:17:15 INFO - TEST-INFO | 2186: exit 0 09:17:15 INFO - TEST-OK | kraken | took 60576ms 09:17:15 INFO - SUITE-END | took 1181s 09:17:16 INFO - Completed test suite (00:19:41) 09:17:16 INFO - javascript benchmark 09:17:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3248.7076163145325, 3257.7719559630827, 3264.7551433642475, 3272.8690852365908, 3302.6367099619038, 5613.522850557697, 5627.7186140693, 5726.3987281335485, 5727.541796656268, 5751.7986870459545, 5715.2855893013375, 5741.483266506014, 5743.282089738783, 5757.68332741699, 5781.566382521317, 5147.7426128693605, 5186.844394668166, 5193.350831146106, 5217.373915130171, 5230.320058392404, 5256.106461901486, 5270.367555893298, 5278.181881808307, 5283.709395983219, 5293.3647962244395, 5192.1173400522, 5217.791288348461, 5227.5295223429885, 5256.8160114396005, 5269.552088072518, 5271.182966640177, 5274.103402421579, 5288.8413347599635, 5308.124159513675, 5318.282031925679, 5045.924311135299, 5115.411727651331, 5142.254373115915, 5202.505761952646, 5219.947800521984, 5611.887762244733, 5709.628874123168, 5732.3407808101765, 5764.711764411804, 5771.682557459338, 6119.541034422392, 6136.785212517585, 6138.478229350466, 6140.84647883802, 6144.109104179914, 6086.573939824214, 6094.664793436359, 6132.6013809102715, 6135.938640613582, 6138.9693051534905, 5720.3421606515785, 5777.19119323295, 5789.392113828029, 5799.739011744482, 5807.041838096667, 6072.848178795565, 6131.204789224245, 6140.916290666746, 6152.64641778808, 6157.983932651152, 6004.459598636144, 6097.542684298695, 6098.0, 6113.449789518876, 6127.387261273837, 6149.723262453201, 6160.414760597736, 6163.7842675506145, 6168.352323006109, 6173.69131543421, 6107.492261292593, 6170.81487555374, 6174.876502469925, 6194.876102477925, 6212.192414986023, 6193.504519638418, 6200.720967556471, 6202.596831205957, 6203.131561581382, 6208.689565521706, 4839.637027222972, 4898.583620392306, 4909.165441874889, 4915.459299477055, 4943.505649435027, 4355.5208927018, 4360.869173924787, 4387.846425375161, 4398.890027749332, 4421.513633500313, 5806.593538452352, 5814.534837213013, 5835.328937172195, 5836.620619659709, 5866.1494083357675, 6160.291566469913, 6170.598911070766, 6177.2587289525545, 6181.84545386369, 6188.350223226586, 5646.2942132233475, 5690.089585666274, 5698.00284950132, 5788.942110578924, 5790.594658373958, 5246.921296180561, 5326.414094449608, 5400.000999815047, 5421.566274698093, 5452.945470545244, 6313.96843015782, 6317.4630156437215, 6325.525585581007, 6333.936660633335, 6347.8095657128515, 6033.095035744674, 6126.731429653803, 6154.815355539341, 6167.229096362955, 6194.752209911733, 6151.32335443092, 6180.412860778219, 6186.907196391968, 6193.752249909953, 6218.160548325918, 6147.924113280247, 6179.320274769681, 6187.752489900534, 6191.318954915046, 6204.348543402878, 6079.3008803988105, 6142.416470435302, 6162.075688646739, 6165.753369865155, 6179.567430279837, 5947.553933455095, 6016.398360163948, 6124.693765311806, 6134.141220229082, 6141.723622437091, 5864.06175011996, 6046.848828779316, 6074.574779765374, 6083.178770866053, 6130.031268545553, 5916.053431450947, 5983.850403739942, 6000.87998240024, 6004.5796794225735, 6043.969780151071, 6112.083187521907, 6113.847153821012, 6114.969425153024, 6137.815865524041, 6140.723667434887, 5698.914516282176, 5711.971440142773, 5728.627639203439, 5809.070548712186, 5816.156657284585], "value": 5676.379781215092, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.67566041601077, 471.44605089020416, 471.84900831733836, 472.29863652476087, 515.1628603519279, 29962.550561741566, 31432.05703828883, 31471.370572588563, 31472.898448554304, 39399.409008864815, 39457.802710986405, 41815.58184418155, 41958.58041419585, 41972.37041444381, 42074.57925420745, 7770.611469426534, 8882.511461869595, 9213.815723685522, 9403.952980235123, 9404.012578679243, 9287.442753434781, 9389.108034736722, 9408.81182376352, 9410.5765240564, 9418.10527999839, 9375.203107735852, 9425.952870235638, 9437.716868493957, 9442.150206481416, 9448.905510944905, 9336.0, 9379.343445958786, 9402.90597094034, 9407.388519746195, 9416.858747118798, 9301.255899528089, 9347.439153650803, 9369.812603747954, 9371.297152713505, 9380.390274632195, 39426.60573394258, 39802.40296395557, 39828.402573961415, 39865.60134398648, 39867.80066099651, 3275.7870738401925, 3301.983490082558, 3367.6800703933086, 3702.148505843644, 3915.451836742858, 29344.706552934626, 29660.406791864043, 29895.252618684488, 30482.93309734171, 30783.538246926313, 2890.4797136515417, 3195.6644552321904, 3203.615566132056, 3317.6848199421015, 3341.448660970961, 475707.0, 476683.0, 480611.0, 482777.0, 484245.0, 60369.698151508965, 60906.08640870391, 60993.695031524556, 61053.38946610477, 61143.388566114656, 62739.0, 62772.372276277565, 62833.37166628367, 62862.685686572186, 62934.74130517364, 14910.850891491164, 14918.254087295592, 14929.552113436614, 15305.540833775005, 15570.532884013497, 11751.764964700658, 11821.408929553489, 11838.94080529609, 11844.052475801915, 11850.111241656738, 15653.530394088195, 18194.272229110687, 18198.727019094724, 18277.725834112498, 18365.449036528924, 6318.684065796691, 7308.707651693979, 7369.494371913575, 7604.391648668204, 7610.657520411595, 836.4887272007302, 885.4687187687337, 917.0783362720423, 1032.4528000159928, 1039.6880935719255, 28627.427451450854, 28905.855470722512, 28909.42181156365, 29477.968271110407, 29563.704362956527, 848.6308455821737, 1016.9898301017043, 1039.8856125826153, 1046.6080113449095, 1072.2172813845937, 12013.519459221534, 14997.95014348985, 15067.300276167536, 15324.616884577974, 15390.461333853485, 647411.0, 652488.0, 653502.0, 655594.0, 655716.0, 56095.0, 56700.716496417255, 56746.71626641923, 56812.715936420056, 57118.42881571131, 1106.8616422947132, 1251.4305990774176, 1310.2531557012412, 1340.9664758381118, 1366.214426704629, 25437.87281063583, 28775.0, 29802.403951921275, 30077.94727184538, 31075.055982085516, 43505.78247108744, 54965.72517137389, 55797.88404231974, 55886.72056639854, 55977.44022559722, 602564.0, 608647.0, 609094.0, 609953.0, 610270.9486452717, 25927.96288148453, 26411.339716507242, 27326.590101148897, 27354.863225683745, 40677.593224068565, 44671.55328446804, 45090.323645146, 45691.857703557675, 45767.855803605176, 46578.0, 37416.62583374132, 37464.438033428974, 37745.0, 38654.840354789405, 39251.803740981115, 37375.878723638336, 38275.617243827204, 38550.0, 38798.4180237291, 39102.0, 35968.460473092404, 36247.275054498234, 36941.0, 37189.0, 37225.44161837629, 32236.83881580577, 33019.83490082534, 33407.49888751622, 33483.16292092717, 33695.663043369255, 24118.51762964766, 24385.0, 24571.877140614182, 24768.0, 25077.498450031264], "value": 19485.585319303238, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.24778518949626, 356.789494198423, 359.8344761409753, 368.2101891442855, 389.6707282346418, 14778.408863645454, 14864.925675371622, 16882.662346753074, 19000.524986875334, 20253.493662658406, 19519.70720439191, 19681.901590492027, 19756.506087347825, 19941.60116797663, 20134.39596812094, 4832.420109586846, 5639.8590035249035, 5834.21238132853, 5903.852403689899, 5910.67491287979, 4757.619390448755, 5793.942060579382, 5854.941450585482, 5925.5555833312455, 5936.0, 5931.644101353911, 5937.317208521033, 5937.821865344046, 5944.7027648617395, 5959.0, 5954.612950158225, 5954.9404505955035, 7402.11174659039, 7748.302652761278, 7835.6473958671995, 7271.163816161156, 7524.05949256343, 7526.36025937796, 7621.628106940749, 7646.929429879766, 25869.09458168955, 26824.865875670694, 26971.46057078867, 27072.78172482243, 27578.862105689543, 2175.7171567696255, 2526.381036646015, 2584.185981415867, 2630.5659566171557, 3116.2209447638093, 16154.0, 16252.75620865688, 16347.427840025543, 16779.412720554843, 17034.65930681392, 1730.9653806923916, 1946.776120746118, 1998.99000504998, 2014.687723402875, 2105.788921632295, 122202.0, 124317.37841310736, 129550.3522482391, 133032.0, 134676.6532334674, 20153.899230503754, 20463.656266557417, 20489.609766473102, 20769.688454673193, 20772.57252553342, 27784.86107569449, 29473.0, 29475.705242947297, 32249.677503225135, 34201.97394078182, 10095.798084038279, 10417.218708596885, 10531.84202236967, 10553.736156596147, 10675.957352154599, 8644.481331120027, 8650.437721548205, 8670.609822558, 8781.91218087811, 8814.603342849587, 7321.538737089325, 8136.524911298762, 8531.53076580794, 8535.530545819915, 8684.522351270614, 3458.8097654629237, 3625.3836847735947, 3644.8836245010134, 3644.908877278089, 3668.3030224257304, 703.7290643102442, 851.5614458553849, 860.2687715441824, 873.3624454148508, 922.1746536849616, 19264.518387040436, 19875.701864472045, 19998.300059497848, 20075.498112547302, 20119.49701257451, 904.9366993782279, 912.3112050402036, 917.8990311065777, 924.8335299646128, 992.717075633441, 9986.400815951067, 10362.274640775224, 10504.474776261157, 10528.368297901998, 10590.523426445829, 496204.0, 504769.61843052466, 504943.0, 568348.0, 576071.0, 133466.0, 136470.0, 146494.2675286638, 148418.25790870975, 149574.0, 376.4165543407707, 411.5904674848485, 434.0970780775978, 434.51768536923987, 435.42958724071565, 10162.593496260066, 11134.3876086816, 11304.604338848101, 17445.738313925554, 18695.81304186995, 53037.0, 54746.452535474134, 57616.423835762784, 57947.0, 59100.0, 73538.63230683812, 75039.62321695428, 76492.0, 79374.0, 80822.0, 7287.688216121149, 7895.921040789519, 7896.0, 8088.555129467935, 8238.629261683358, 9120.361574689709, 12294.569690060805, 12513.874861251272, 12667.493300267886, 12799.616011519669, 10489.685309440729, 10544.525496352837, 10669.35983840972, 10777.784444310913, 10952.726181845517, 10278.098551767947, 10323.225758068025, 10424.583016679248, 10555.683329500127, 10917.23579349438, 9195.448273103635, 10543.57825686964, 10659.840102398626, 10923.56305747793, 11020.614278500214, 7795.103563090317, 7945.364370850433, 8066.112727600077, 8092.6762929482165, 8263.545504997282, 7988.281054705104, 9561.235101191749, 10364.326318789255, 10388.480575971322, 11082.113430925669], "value": 10138.15292774222, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1467.2003757951918, 1486.9851301486985, 1648.6372997940448, 1787.7407775872507, 1848.2791711232621, 7970.84058318834, 8413.074561798205, 8422.620982055807, 8427.367947403938, 8429.957850210749, 7017.824554386143, 7364.079490063742, 7623.542587444757, 7629.2752188542, 8056.677732890677, 2247.5954328220914, 2283.1324096843177, 2284.565932472833, 2286.0, 2286.6227072533097, 2278.9658155127686, 2321.292005938188, 2321.3152120124605, 2327.94180145496, 2334.0, 2249.2127755285683, 2255.9887200563976, 2277.4534111813127, 2277.464795772992, 2277.943051423719, 2235.474663454095, 2249.730032396123, 2250.8424410291286, 2253.211376018397, 2265.365697604665, 2220.9444763881033, 2300.240920496249, 2301.505176387068, 2303.389601755536, 2309.445733024062, 8294.58527073644, 8309.626066827008, 8380.24577787996, 8407.327413806881, 8412.621432035512, 4976.0, 5140.074786538422, 5143.665661731976, 5145.382554093495, 5146.974265128651, 3163.6710595779477, 3222.629397619257, 3295.20914980403, 3402.4726167443837, 3405.3019131078318, 946.7869729310919, 995.5370752600076, 999.5102399824107, 1015.7206768138747, 1084.2139448899563, 10881.891181088246, 10888.78222435547, 10902.5093870776, 10943.96032376923, 10944.069754070913, 4287.399764033038, 4570.200214962369, 4621.214393553104, 4630.050839577946, 4634.096351211549, 9397.57710903011, 9409.0, 9419.529023548932, 9420.811583768285, 9437.811243775086, 5047.646664733434, 5156.226566015128, 5159.664621799571, 5166.380034395821, 5168.095583272912, 3940.330143875548, 4371.0, 4666.743329116931, 4712.670113092119, 4719.362886010414, 3627.8004709741217, 3696.5933747287777, 3722.962770372316, 3766.246750649881, 3790.905227369283, 1164.598213616301, 1217.3669691760235, 1219.9878001220052, 1222.9938850305869, 1232.7056590579855, 723.2405973727565, 826.4917075998218, 870.3472395703222, 878.4158534574436, 892.7098692924825, 5332.33345831771, 5411.83764487066, 5682.119271512922, 5700.857478562986, 5769.538436925036, 763.4503157726429, 807.5477732469835, 920.798358142617, 936.6347124621403, 963.6990063414474, 3759.8496060157286, 3760.304343696425, 3789.886303410902, 3863.0535518798074, 3885.3487267911023, 9666.0, 9999.100080992746, 10033.498325083716, 10117.848232276521, 10143.391396516232, 10077.54651040705, 10080.69757907264, 10093.0, 10111.0, 10119.494025298705, 7354.338109570164, 7725.459217854808, 7746.30283274508, 7908.130105688369, 7909.881351779728, 5631.8592035199445, 5783.074708046693, 5805.245318108618, 5827.24245848037, 5871.706414679335, 7230.349268565854, 9130.497822619554, 9175.678851240174, 9231.76920576964, 9362.221177976162, 7411.554746824533, 9122.90877091247, 9449.622015119317, 9502.809943801223, 9528.333016689043, 7108.893366599402, 7294.562326260441, 7307.2327405621645, 7322.5972571506945, 7344.632768361667, 7651.579163145858, 7829.021372328459, 7874.763757087297, 7894.092179399443, 7902.367810575025, 7053.0830991970715, 7106.502544821813, 7148.177959534512, 7159.03353047332, 7312.378447831994, 6635.2037755469655, 6981.860362792817, 7000.439964802906, 7040.718371265297, 7058.435325174077, 6583.769568065095, 6634.303398143125, 6651.401373876374, 6729.7644582441335, 6751.358620931003, 4135.875923722293, 4233.894152646209, 4775.832845850378, 4861.052094841472, 4992.450830408725, 4385.0, 4723.078999595046, 4875.561199491921, 4907.6140408684705, 4948.62885283598], "value": 4356.958812670086, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.646424290851, 301.7766852529129, 305.75539568345323, 311.91422358851327, 313.2888343460344, 4531.841385551506, 4912.803487860486, 5125.974370128149, 5154.5103215194495, 5183.559397451217, 5044.243363495469, 5095.108356037688, 5106.876487172825, 5120.8990067135555, 5140.66585671932, 3102.90691279262, 3678.44823276508, 3821.636944490269, 3834.4056671215867, 3893.1118407572303, 3030.106183635228, 3241.6272128705145, 3890.319194141028, 3921.9803900980455, 3929.7207619580577, 3845.365514690087, 3855.8407291916615, 3859.864904728335, 3873.612638736132, 3903.394973779069, 3159.9684003160132, 3202.679732026802, 3624.0, 3686.6497682720233, 3781.0169355967646, 3396.915077123067, 3421.6920477157178, 3426.794392336443, 3428.434308339121, 3439.2287971694595, 4018.738781979191, 4643.419572553431, 4692.850251688358, 4869.318295438641, 4971.900561988776, 4161.9583804161875, 4176.081262122359, 4338.848140315074, 4449.288113901793, 4450.9332360014305, 4971.502849715036, 5243.501867322599, 5311.893762124774, 5333.679979201261, 5348.432752278889, 3092.9431927768005, 3492.266624008961, 3676.114250313491, 3676.3198808220295, 3691.6123807000417, 4530.3431002504785, 5241.798444653255, 5486.506214440719, 5536.833894983157, 5670.801521946753, 3198.344339410415, 3743.419769935664, 3828.0, 3829.8659546916283, 3838.4626152338697, 3262.3964566555264, 3866.497355343787, 3871.5160604924386, 3882.3400021995762, 3896.337622604164, 3734.290484807878, 4448.132614140211, 4449.399331090326, 4469.642428605704, 4476.657002899117, 4998.650094493423, 5373.140297552451, 5376.865578360494, 5385.6230063895155, 5429.864253393696, 1066.7653116314398, 1081.8478320588547, 1234.327291626066, 1241.2614494375832, 1241.4475558376437, 708.7094291340526, 762.5767698927149, 783.8001309665999, 822.2394285286086, 831.4429332347341, 4790.8323208688225, 4946.3817022872145, 4947.876303092379, 4952.430470495867, 4958.834578953696, 4550.88622784433, 5097.6941383517105, 5386.757595908193, 5443.945560544423, 5563.666180029211, 4182.121754431603, 4863.003084367696, 5042.546170844642, 5046.217836235316, 5053.0, 2650.966123211949, 2732.9180124595896, 2745.697973222944, 2746.4781691478556, 2753.917382478489, 4923.8276660316715, 4931.408231012229, 5148.742562871841, 5309.230161626542, 5489.365104749742, 4648.604868586141, 5183.611229157828, 5409.215663728737, 5464.398916119224, 5481.725913704299, 4458.509563947963, 5054.826424637441, 5178.61160412963, 5467.118345974323, 5520.91718624221, 4352.4341835562445, 4536.459582633735, 5233.319668443078, 5269.815556455505, 5298.841034768963, 3939.9362172213914, 4798.2082956311815, 4829.517048295143, 5181.5077567631015, 5201.349831271091, 5183.688978661293, 5395.3525576931015, 5429.800930623104, 5440.0623663223, 5457.025920873054, 2911.5341545352644, 3019.452143731151, 3588.6411358863907, 3619.936636117388, 3674.3018826422895, 4169.60388763067, 4216.018471318475, 4644.907101857876, 4663.300504924288, 5237.685738855681, 4149.787965215249, 4608.631309495299, 5033.320501732365, 5068.66841253013, 5070.112730272114, 4001.2597669431248, 4472.39622650938, 4482.731036137842, 4977.626677999237, 5016.971520838292, 4236.0, 4765.666403351732, 4880.438749543706, 4933.432655244549, 4970.21072413938, 4603.516630753723, 5065.39215294167, 5078.568321692697, 5121.897562048813, 5256.6320357574605, 3980.3034468968394, 4567.63458923292, 5188.58491320701, 5193.506616871391, 5324.961632481783], "value": 3783.3597231761096, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [681.3084719010204, 686.3856848120932, 706.8162277807775, 708.9397401220896, 758.7041053988944, 13711.314434278283, 13755.105918115341, 14127.293635318232, 14401.991860569764, 14413.06315089521, 12627.55803546876, 13440.395182216824, 13763.862361376383, 13790.517331893385, 13806.102603330777, 744.1219361153836, 818.9549574773386, 821.3470291118546, 822.8765685147246, 823.3742355809597, 643.0, 664.3987191591593, 665.2947875252224, 801.266840840633, 813.975580732576, 854.0946596607616, 864.0883867519764, 865.5845194306737, 865.7359505350865, 866.2982983783156, 826.9049059358191, 860.9311255099577, 861.5261606116611, 862.9784255393603, 863.9913600863973, 499.6053118036783, 507.49504243278176, 615.7444660465901, 617.3548641669466, 637.9138816259792, 13739.313034348343, 14239.288035598178, 14271.215083170422, 14274.214918179496, 14277.14337139775, 13022.283774392405, 13153.736925261537, 13311.400986955514, 13405.530806421826, 13558.322083895864, 10591.57633694659, 11844.111691623162, 11935.701607459796, 11992.820107698391, 12148.817767733492, 4233.322668373076, 4255.510616279105, 4261.382099595541, 4406.1848558016545, 4442.689011769177, 91832.08167918301, 91853.62219566645, 93044.53477732636, 93641.0, 95170.52414737952, 10481.71585817744, 10524.26330156897, 10773.569057237779, 10801.24391292602, 10854.511546980404, 19315.8068419314, 20083.698744518842, 20239.392818215478, 20282.59434811325, 20328.288509902082, 7505.174430812606, 7732.149463559004, 7759.650815713307, 7778.455508114378, 7789.571573563395, 4141.565135660712, 4164.43780089684, 4172.0, 4249.043965107888, 4362.411074504901, 3282.638909719929, 3394.762366634361, 3394.932101357959, 3399.5750531183603, 3424.366492198951, 637.8979363301942, 648.870225954811, 675.4056430341268, 678.504691575143, 697.0694123345289, 548.700957977903, 573.4666759913321, 579.4495229531962, 658.121407920422, 683.45323741007, 8721.0, 9033.277337812959, 9073.54632268384, 9091.545422728837, 9317.021712720067, 629.1286568103119, 633.5628416392674, 651.6513665189101, 652.5595223224304, 657.6087228099274, 4253.80857861397, 4486.64106871456, 4488.685791994529, 4490.57339552742, 4498.235299999008, 113754.86245137609, 116432.0, 116717.0, 118201.0, 118335.40832295956, 94505.5274723622, 95859.0, 96293.51853240689, 101959.0, 102652.48673756733, 56139.438605613424, 56400.153997689245, 58492.7075364629, 76450.0, 77537.0, 9173.724788256097, 9226.492542910204, 9594.376365536218, 9608.231341492525, 9699.0, 51092.0, 52897.471025289255, 53425.73287133539, 55167.75906288896, 57181.714091429276, 73768.0, 74659.0, 76101.61949190218, 77135.22864771505, 77686.89252430065, 12154.270743755404, 12257.754844903231, 12360.0, 12549.811752823533, 12764.489420423079, 13506.932465338003, 14212.573622791333, 14314.713705725619, 14375.928120359331, 14502.709945800814, 11831.994280485911, 12632.368381581067, 13043.217406955613, 13043.28261945602, 13071.607851764082, 10859.239853210516, 11897.286162830258, 12820.61538153857, 13028.28344441027, 13095.0, 12365.938170309091, 12737.172083814523, 12927.095103342675, 13004.934975325063, 13114.082014258911, 10360.067593916583, 10514.369137851754, 10725.946370268099, 10787.190960677824, 11173.608923687632, 9557.713268601676, 10413.0, 10499.790004200026, 11076.556937722724, 11118.0], "value": 7229.855861535547, "unit": "score"}], "name": "dromaeo_css", "value": 7150.411472362565, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 114.0, 115.0, 114.0, 114.0, 115.0, 113.0, 113.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 113.0, 111.0, 148.0, 113.0, 115.0, 135.0, 133.0, 146.0, 111.0], "value": 126.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 185.0, 186.0, 183.0, 184.0, 182.0, 182.0, 184.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 60.0, 89.0, 60.0, 60.0, 59.0, 61.0, 71.0, 61.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 92.0, 70.0, 68.0, 70.0, 90.0, 66.0, 69.0, 96.0], "value": 78.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 88.0, 91.0, 89.0, 91.0, 88.0, 91.0, 88.0, 91.0, 88.0], "value": 89.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 99.0, 99.0, 98.0, 99.0, 97.0, 99.0, 97.0, 97.0], "value": 98.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 85.0, 85.0, 86.0, 85.0, 85.0, 86.0, 85.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 56.0, 57.0, 58.0, 55.0, 54.0, 54.0, 55.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 77.0, 76.0, 74.0, 74.0, 71.0, 72.0, 72.0, 72.0, 71.0], "value": 72.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 101.0, 106.0, 104.0, 106.0, 76.0, 96.0, 105.0, 105.0, 91.0], "value": 97.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 157.0, 151.0, 148.0, 147.0, 147.0, 167.0, 168.0, 198.0, 175.0], "value": 162.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 187.0, 162.0, 172.0, 201.0, 235.0, 189.0, 176.0, 174.0, 175.0], "value": 184.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 69.0, 69.0, 67.0, 66.0, 69.0, 68.0, 68.0, 68.0], "value": 68.1, "unit": "score"}], "name": "kraken", "value": 1483.4999999999998, "alertThreshold": 2.0}]} 09:17:16 INFO - Return code: 0 09:17:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:17:16 INFO - # TBPL SUCCESS # 09:17:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:17:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:17:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:17:16 INFO - 2016-11-15 09:17:16.224 screenresolution[2190:24904] starting screenresolution argv=screenresolution get 09:17:16 INFO - 2016-11-15 09:17:16.227 screenresolution[2190:24904] Display 0: 1600x1200x32@60 09:17:16 INFO - 2016-11-15 09:17:16.233 screenresolution[2191:24907] starting screenresolution argv=screenresolution list 09:17:16 INFO - Available Modes on Display 0 09:17:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:17:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:17:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:17:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:17:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:17:16 INFO - Intel Iris: 09:17:16 INFO - Chipset Model: Intel Iris 09:17:16 INFO - Type: GPU 09:17:16 INFO - Bus: Built-In 09:17:16 INFO - VRAM (Dynamic, Max): 1536 MB 09:17:16 INFO - Vendor: Intel (0x8086) 09:17:16 INFO - Device ID: 0x0a2e 09:17:16 INFO - Revision ID: 0x0009 09:17:16 INFO - Displays: 09:17:16 INFO - Display: 09:17:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:17:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:17:16 INFO - Display Serial Number: 1600x1200 60 09:17:16 INFO - Main Display: Yes 09:17:16 INFO - Mirror: Off 09:17:16 INFO - Online: Yes 09:17:16 INFO - Rotation: Supported 09:17:16 INFO - Return code: 0 09:17:16 INFO - Running post-action listener: _resource_record_post_action 09:17:16 INFO - [mozharness: 2016-11-15 17:17:16.468375Z] Finished run-tests step (success) 09:17:16 INFO - Running post-run listener: _resource_record_post_run 09:17:16 INFO - Total resource usage - Wall time: 1217s; CPU: 54.0%; Read bytes: 36864; Write bytes: 698111488; Read time: 1; Write time: 1862 09:17:16 INFO - TinderboxPrint: CPU usage
53.9% 09:17:16 INFO - TinderboxPrint: I/O read bytes / time
36,864 / 1 09:17:16 INFO - TinderboxPrint: I/O write bytes / time
698,111,488 / 1,862 09:17:16 INFO - TinderboxPrint: CPU idle
2,242.9 (46.1%) 09:17:16 INFO - TinderboxPrint: CPU system
983.1 (20.2%) 09:17:16 INFO - TinderboxPrint: CPU user
1,643.7 (33.8%) 09:17:16 INFO - TinderboxPrint: Swap in / out
398,041,088 / 0 09:17:16 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 381237760; Write bytes: 375535104; Read time: 29139; Write time: 683 09:17:16 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 36864; Write bytes: 296820736; Read time: 1; Write time: 1123 09:17:16 INFO - Running post-run listener: _upload_blobber_files 09:17:16 INFO - Blob upload gear active. 09:17:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:17:16 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:17:16 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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:17:16 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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:17:17 INFO - (blobuploader) - INFO - Open directory for files ... 09:17:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:17:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:17:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:18 INFO - (blobuploader) - INFO - Done attempting. 09:17:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:17:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:19 INFO - (blobuploader) - INFO - Done attempting. 09:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:17:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:22 INFO - (blobuploader) - INFO - Done attempting. 09:17:22 INFO - (blobuploader) - INFO - Iteration through files over. 09:17:22 INFO - Return code: 0 09:17:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:17:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:17:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/f434997c33d44c7eab041182dd55f48727a6de18530a62dbba52d0644b39e4e43cd65843e19e7676c57eba7b2f6553b4dd7729508faae80e99bac3d63be9918c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/1875c7e8ab3f36c7bc86e03ad544a8ace5476919ede0139d111655515baedc68f6e4c120a34d1afdb947390685e8b9da56708fdd8955079de192596bc11d8f82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/291f89a5b8ce9031ec16171e2ef52f51b4d6b10d1fb1a1e8d9879782a46147c2cc80c97ce13fc769886c96be726ed0503ec429328c9560362d41479b515c4f75"} 09:17:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:17:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:17:22 INFO - Contents: 09:17:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/f434997c33d44c7eab041182dd55f48727a6de18530a62dbba52d0644b39e4e43cd65843e19e7676c57eba7b2f6553b4dd7729508faae80e99bac3d63be9918c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/1875c7e8ab3f36c7bc86e03ad544a8ace5476919ede0139d111655515baedc68f6e4c120a34d1afdb947390685e8b9da56708fdd8955079de192596bc11d8f82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/291f89a5b8ce9031ec16171e2ef52f51b4d6b10d1fb1a1e8d9879782a46147c2cc80c97ce13fc769886c96be726ed0503ec429328c9560362d41479b515c4f75"} 09:17:22 INFO - Running post-run listener: copy_logs_to_upload_dir 09:17:22 INFO - Copying logs to upload dir... 09:17:22 INFO - mkdir: /builds/slave/test/build/upload/logs 09:17:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1278.323357 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2016-11-15 09:17:22.391741) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 09:17:22.399806) ========= 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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/f434997c33d44c7eab041182dd55f48727a6de18530a62dbba52d0644b39e4e43cd65843e19e7676c57eba7b2f6553b4dd7729508faae80e99bac3d63be9918c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/1875c7e8ab3f36c7bc86e03ad544a8ace5476919ede0139d111655515baedc68f6e4c120a34d1afdb947390685e8b9da56708fdd8955079de192596bc11d8f82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/291f89a5b8ce9031ec16171e2ef52f51b4d6b10d1fb1a1e8d9879782a46147c2cc80c97ce13fc769886c96be726ed0503ec429328c9560362d41479b515c4f75"} build_url:https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011413 build_url: 'https://queue.taskcluster.net/v1/task/OSj1zvHERkeO_jktxNS0ig/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/f434997c33d44c7eab041182dd55f48727a6de18530a62dbba52d0644b39e4e43cd65843e19e7676c57eba7b2f6553b4dd7729508faae80e99bac3d63be9918c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/1875c7e8ab3f36c7bc86e03ad544a8ace5476919ede0139d111655515baedc68f6e4c120a34d1afdb947390685e8b9da56708fdd8955079de192596bc11d8f82", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/291f89a5b8ce9031ec16171e2ef52f51b4d6b10d1fb1a1e8d9879782a46147c2cc80c97ce13fc769886c96be726ed0503ec429328c9560362d41479b515c4f75"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 09:17:22.437540) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 09:17:22.438045) ========= 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.VdQbgWnBsd/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.o5FNNY9xT7/Listeners TMPDIR=/var/folders/46/l2pgwt217d93gf4d7qtgkmq000000w/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.005495 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 09:17:22.490091) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 09:17:22.493668) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 09:17:22.494102) ========= ========= Total master_lag: 0.34 =========