builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-067 starttime: 1476325642.99 results: success (0) buildid: 20161012163004 builduid: 816ade9cf30949d3901e9f09bbea6cd2 revision: 22be4ae74653b25186665f22e52a50e7027fd36b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 19:27:22.990421) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 19:27:22.991071) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 19:27:22.991499) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 19:27:23.010677) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 19:27:23.011152) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-12 19:27:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (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% 66.8M=0s 2016-10-12 19:27:23 (66.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.153281 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 19:27:23.181480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 19:27:23.184825) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019791 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 19:27:23.234330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 19:27:23.237696) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 22be4ae74653b25186665f22e52a50e7027fd36b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 22be4ae74653b25186665f22e52a50e7027fd36b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-12 19:27:23,838 truncating revision to first 12 chars 2016-10-12 19:27:23,838 Setting DEBUG logging. 2016-10-12 19:27:23,838 attempt 1/10 2016-10-12 19:27:23,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/22be4ae74653?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 19:27:24,496 unpacking tar archive at: mozilla-central-22be4ae74653/testing/mozharness/ program finished with exit code 0 elapsedTime=1.003091 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 19:27:24.253895) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 19:27:24.254209) ========= script_repo_revision: 22be4ae74653b25186665f22e52a50e7027fd36b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 19:27:24.254578) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 19:27:24.257189) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 19:27:24.268092) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-12 19:27:24.268438) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:27:24 INFO - MultiFileLogger online at 20161012 19:27:24 in /builds/slave/test 19:27:24 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:27:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:27:24 INFO - {'append_to_log': False, 19:27:24 INFO - 'base_work_dir': '/builds/slave/test', 19:27:24 INFO - 'blob_upload_branch': 'Firefox', 19:27:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:27:24 INFO - 'branch': 'Firefox', 19:27:24 INFO - 'buildbot_json_path': 'buildprops.json', 19:27:24 INFO - 'config_files': ('talos/linux_config.py',), 19:27:24 INFO - 'default_actions': ('clobber', 19:27:24 INFO - 'read-buildbot-config', 19:27:24 INFO - 'download-and-extract', 19:27:24 INFO - 'populate-webroot', 19:27:24 INFO - 'create-virtualenv', 19:27:24 INFO - 'install', 19:27:24 INFO - 'run-tests'), 19:27:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:27:24 INFO - 'download_minidump_stackwalk': True, 19:27:24 INFO - 'download_symbols': 'ondemand', 19:27:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:27:24 INFO - 'tooltool.py': '/tools/tooltool.py', 19:27:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:27:24 INFO - '/tools/misc-python/virtualenv.py')}, 19:27:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:27:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:27:24 INFO - 'installer_path': 'installer.exe', 19:27:24 INFO - 'log_level': 'info', 19:27:24 INFO - 'log_name': 'talos', 19:27:24 INFO - 'log_to_console': True, 19:27:24 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:27:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:27:24 INFO - 'opt_config_files': (), 19:27:24 INFO - 'pip_index': False, 19:27:24 INFO - 'sps_profile': False, 19:27:24 INFO - 'sps_profile_interval': 0, 19:27:24 INFO - 'suite': 'dromaeojs', 19:27:24 INFO - 'system_bits': '32', 19:27:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:27:24 INFO - 'title': 'talos-linux64-ix-067', 19:27:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:27:24 INFO - 'use_talos_json': True, 19:27:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:27:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:27:24 INFO - 'work_dir': 'build'} 19:27:24 INFO - [mozharness: 2016-10-13 02:27:24.978976Z] Running clobber step. 19:27:24 INFO - Running pre-action listener: _resource_record_pre_action 19:27:24 INFO - Running main action method: clobber 19:27:24 INFO - rmtree: /builds/slave/test/build 19:27:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:27:25 INFO - Running post-action listener: _resource_record_post_action 19:27:25 INFO - [mozharness: 2016-10-13 02:27:25.439084Z] Finished clobber step (success) 19:27:25 INFO - [mozharness: 2016-10-13 02:27:25.439185Z] Running read-buildbot-config step. 19:27:25 INFO - Running pre-action listener: _resource_record_pre_action 19:27:25 INFO - Running main action method: read_buildbot_config 19:27:25 INFO - Using buildbot properties: 19:27:25 INFO - { 19:27:25 INFO - "project": "", 19:27:25 INFO - "product": "firefox", 19:27:25 INFO - "script_repo_revision": "production", 19:27:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 19:27:25 INFO - "repository": "", 19:27:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 19:27:25 INFO - "buildid": "20161012163004", 19:27:25 INFO - "pgo_build": "True", 19:27:25 INFO - "basedir": "/builds/slave/test", 19:27:25 INFO - "buildnumber": 5, 19:27:25 INFO - "slavename": "talos-linux64-ix-067", 19:27:25 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:27:25 INFO - "platform": "ubuntu64_hw", 19:27:25 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 19:27:25 INFO - "branch": "mozilla-central", 19:27:25 INFO - "repo_path": "mozilla-central", 19:27:25 INFO - "revision": "22be4ae74653b25186665f22e52a50e7027fd36b", 19:27:25 INFO - "stage_platform": "linux64-pgo", 19:27:25 INFO - "builduid": "816ade9cf30949d3901e9f09bbea6cd2", 19:27:25 INFO - "slavebuilddir": "test" 19:27:25 INFO - } 19:27:25 INFO - Found installer url https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 19:27:25 INFO - Running post-action listener: _resource_record_post_action 19:27:25 INFO - [mozharness: 2016-10-13 02:27:25.441607Z] Finished read-buildbot-config step (success) 19:27:25 INFO - [mozharness: 2016-10-13 02:27:25.441695Z] Running download-and-extract step. 19:27:25 INFO - Running pre-action listener: _resource_record_pre_action 19:27:25 INFO - Running main action method: download_and_extract 19:27:25 INFO - mkdir: /builds/slave/test/build/tests 19:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:25 INFO - trying https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:27:25 INFO - Downloading https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:27:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 19:27:26 INFO - Downloaded 1361 bytes. 19:27:26 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 19:27:26 INFO - Using the following test package requirements: 19:27:26 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:27:26 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:27:26 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 19:27:26 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:26 INFO - u'jsshell-linux-x86_64.zip'], 19:27:26 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:27:26 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 19:27:26 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:27:26 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:27:26 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:27:26 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 19:27:26 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:27:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:27:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:27:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:27:26 INFO - Fetch https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:27:26 INFO - Http code: 200 19:27:26 INFO - via: 1.1 c0740de9f16cf32ffedfd2f9806b8483.cloudfront.net (CloudFront) 19:27:26 INFO - x-amz-cf-id: _1PiYLNvZIGK0vRow8J6mH4OvuctFHtJJUpTZRc3HT7a6DwoyrHuJw== 19:27:26 INFO - x-amz-version-id: SZsDTOVqdeyH9vyjLXAu.EiLuic36Y2d 19:27:26 INFO - Expected file size: 22117297 19:27:26 INFO - Obtained file size: 22117297 19:27:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:27:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 19:27:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 19:27:31 INFO - Fetch https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 19:27:31 INFO - Http code: 200 19:27:31 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 19:27:31 INFO - x-amz-cf-id: zGvp1WJKrxtzlsVnKdFiAGYjOvMss2J2MhUWy_reTfZzzxuaRnlVfg== 19:27:31 INFO - x-amz-version-id: SZsDTOVqdeyH9vyjLXAu.EiLuic36Y2d 19:27:31 INFO - Expected file size: 22117297 19:27:31 INFO - Obtained file size: 22117297 19:27:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 19:27:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 19:27:36 INFO - Fetch https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 19:27:36 INFO - Http code: 200 19:27:36 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 19:27:36 INFO - x-amz-cf-id: K8MOJTABeZIJHO_Fwqzdbj7ZkcDzosLs_-Z-7M0E-tubSJBacGydWA== 19:27:36 INFO - x-amz-version-id: 3ZxJbWb0wm.AePVn_W7xK6S1.VlRIT90 19:27:37 INFO - Expected file size: 14409006 19:27:37 INFO - Obtained file size: 14409006 19:27:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:37 INFO - trying https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:27:37 INFO - Downloading https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:27:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 19:27:38 INFO - Downloaded 59787801 bytes. 19:27:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:27:38 INFO - mkdir: /builds/slave/test/properties 19:27:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:27:38 INFO - Writing to file /builds/slave/test/properties/build_url 19:27:38 INFO - Contents: 19:27:38 INFO - build_url:https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 19:27:39 INFO - Running post-action listener: _resource_record_post_action 19:27:39 INFO - Running post-action listener: set_extra_try_arguments 19:27:39 INFO - [mozharness: 2016-10-13 02:27:39.162741Z] Finished download-and-extract step (success) 19:27:39 INFO - [mozharness: 2016-10-13 02:27:39.162968Z] Running populate-webroot step. 19:27:39 INFO - Running pre-action listener: _resource_record_pre_action 19:27:39 INFO - Running main action method: populate_webroot 19:27:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:27:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:27:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:27:39 INFO - '--tppagecycles', 19:27:39 INFO - '7'], 19:27:39 INFO - 'tests': ['tsvgm']}}, 19:27:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:27:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:27:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:27:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:27:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:27:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:27:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:39 INFO - 'talos_options': ['--disable-e10s'], 19:27:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:27:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:39 INFO - 'talos_options': ['--disable-e10s'], 19:27:39 INFO - 'tests': ['damp', 'tps']}, 19:27:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:39 INFO - 'tests': ['damp', 'tps']}, 19:27:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:27:39 INFO - 'tests': ['dromaeo_dom']}, 19:27:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:27:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:27:39 INFO - 'tests': ['basic_compositor_video']}, 19:27:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:27:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:27:39 INFO - 'tests': ['a11yr', 19:27:39 INFO - 'ts_paint', 19:27:39 INFO - 'tpaint', 19:27:39 INFO - 'sessionrestore', 19:27:39 INFO - 'sessionrestore_no_auto_restore', 19:27:39 INFO - 'tabpaint']}, 19:27:39 INFO - 'other-e10s': {'tests': ['a11yr', 19:27:39 INFO - 'ts_paint', 19:27:39 INFO - 'tpaint', 19:27:39 INFO - 'sessionrestore', 19:27:39 INFO - 'sessionrestore_no_auto_restore', 19:27:39 INFO - 'tabpaint']}, 19:27:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:27:39 INFO - 'ts_paint', 19:27:39 INFO - 'tpaint', 19:27:39 INFO - 'sessionrestore', 19:27:39 INFO - 'sessionrestore_no_auto_restore', 19:27:39 INFO - 'tabpaint']}, 19:27:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:27:39 INFO - 'ts_paint', 19:27:39 INFO - 'tpaint', 19:27:39 INFO - 'sessionrestore', 19:27:39 INFO - 'sessionrestore_no_auto_restore', 19:27:39 INFO - 'tabpaint']}, 19:27:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:27:39 INFO - 'tests': ['a11yr', 19:27:39 INFO - 'ts_paint', 19:27:39 INFO - 'tpaint', 19:27:39 INFO - 'sessionrestore', 19:27:39 INFO - 'sessionrestore_no_auto_restore', 19:27:39 INFO - 'tabpaint']}, 19:27:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:27:39 INFO - 'tests': ['a11yr', 19:27:39 INFO - 'ts_paint', 19:27:39 INFO - 'tpaint', 19:27:39 INFO - 'sessionrestore', 19:27:39 INFO - 'sessionrestore_no_auto_restore', 19:27:39 INFO - 'tabpaint']}, 19:27:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:27:39 INFO - 'tests': ['tsvgx', 19:27:39 INFO - 'tsvgr_opacity', 19:27:39 INFO - 'tart', 19:27:39 INFO - 'tscrollx', 19:27:39 INFO - 'cart']}, 19:27:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:27:39 INFO - 'tsvgr_opacity', 19:27:39 INFO - 'tart', 19:27:39 INFO - 'tscrollx', 19:27:39 INFO - 'cart']}, 19:27:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:39 INFO - 'talos_options': ['--disable-e10s'], 19:27:39 INFO - 'tests': ['tp5o']}, 19:27:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:39 INFO - 'tests': ['tp5o']}, 19:27:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:39 INFO - 'talos_options': ['--disable-e10s', 19:27:39 INFO - '--xperf_path', 19:27:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:39 INFO - 'tests': ['tp5n']}, 19:27:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:27:39 INFO - 'talos_options': ['--xperf_path', 19:27:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:27:39 INFO - 'tests': ['tp5n']}}, 19:27:39 INFO - 'talos.zip': {'path': '', 19:27:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:27:39 INFO - Running post-action listener: _resource_record_post_action 19:27:39 INFO - [mozharness: 2016-10-13 02:27:39.183100Z] Finished populate-webroot step (success) 19:27:39 INFO - [mozharness: 2016-10-13 02:27:39.183188Z] Running create-virtualenv step. 19:27:39 INFO - Running pre-action listener: _resource_record_pre_action 19:27:39 INFO - Running main action method: create_virtualenv 19:27:39 INFO - Creating virtualenv /builds/slave/test/build/venv 19:27:39 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 19:27:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:27:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:27:39 INFO - Using real prefix '/usr' 19:27:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:27:39 INFO - Installing distribute.............................................................................................................................................................................................done. 19:27:41 INFO - Installing pip.................done. 19:27:41 INFO - Return code: 0 19:27:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:27:41 INFO - Reading from file tmpfile_stdout 19:27:41 INFO - Output received: 19:27:41 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:27:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:42 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 0x7f8a69ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d790>, '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 0x212e690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:27:42 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 19:27:42 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 19:27:42 INFO - Using env: {'DISPLAY': ':0', 19:27:42 INFO - 'HOME': '/home/cltbld', 19:27:42 INFO - 'LANG': 'en_US.UTF-8', 19:27:42 INFO - 'LANGUAGE': 'en_US:en', 19:27:42 INFO - 'LOGNAME': 'cltbld', 19:27:42 INFO - 'MAIL': '/var/mail/cltbld', 19:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:42 INFO - 'MOZ_NO_REMOTE': '1', 19:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:42 INFO - 'NO_EM_RESTART': '1', 19:27:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:42 INFO - 'PWD': '/builds/slave/test', 19:27:42 INFO - 'SHELL': '/bin/bash', 19:27:42 INFO - 'SHLVL': '1', 19:27:42 INFO - 'TERM': 'linux', 19:27:42 INFO - 'TMOUT': '86400', 19:27:42 INFO - 'USER': 'cltbld', 19:27:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 19:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:42 INFO - '_': '/tools/buildbot/bin/python'} 19:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:42 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 19:27:42 INFO - Cleaning up... 19:27:42 INFO - Return code: 0 19:27:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:27:42 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')]} 19:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:42 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')]} 19:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:42 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 0x7f8a69ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d790>, '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 0x212e690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:27:42 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 19:27:42 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 19:27:42 INFO - Using env: {'DISPLAY': ':0', 19:27:42 INFO - 'HOME': '/home/cltbld', 19:27:42 INFO - 'LANG': 'en_US.UTF-8', 19:27:42 INFO - 'LANGUAGE': 'en_US:en', 19:27:42 INFO - 'LOGNAME': 'cltbld', 19:27:42 INFO - 'MAIL': '/var/mail/cltbld', 19:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:42 INFO - 'MOZ_NO_REMOTE': '1', 19:27:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:42 INFO - 'NO_EM_RESTART': '1', 19:27:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:42 INFO - 'PWD': '/builds/slave/test', 19:27:42 INFO - 'SHELL': '/bin/bash', 19:27:42 INFO - 'SHLVL': '1', 19:27:42 INFO - 'TERM': 'linux', 19:27:42 INFO - 'TMOUT': '86400', 19:27:42 INFO - 'USER': 'cltbld', 19:27:42 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 19:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:42 INFO - '_': '/tools/buildbot/bin/python'} 19:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:42 INFO - Downloading/unpacking psutil>=3.1.1 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:27:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:44 INFO - Installing collected packages: psutil 19:27:44 INFO - Running setup.py install for psutil 19:27:44 INFO - building 'psutil._psutil_linux' extension 19:27:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:27:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:27:44 INFO - building 'psutil._psutil_posix' extension 19:27:44 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:27:44 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:27:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:27:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:27:44 INFO - Successfully installed psutil 19:27:44 INFO - Cleaning up... 19:27:45 INFO - Return code: 0 19:27:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:45 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 0x7f8a69ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d790>, '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 0x212e690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:27:45 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 19:27:45 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 19:27:45 INFO - Using env: {'DISPLAY': ':0', 19:27:45 INFO - 'HOME': '/home/cltbld', 19:27:45 INFO - 'LANG': 'en_US.UTF-8', 19:27:45 INFO - 'LANGUAGE': 'en_US:en', 19:27:45 INFO - 'LOGNAME': 'cltbld', 19:27:45 INFO - 'MAIL': '/var/mail/cltbld', 19:27:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:45 INFO - 'MOZ_NO_REMOTE': '1', 19:27:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:45 INFO - 'NO_EM_RESTART': '1', 19:27:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:45 INFO - 'PWD': '/builds/slave/test', 19:27:45 INFO - 'SHELL': '/bin/bash', 19:27:45 INFO - 'SHLVL': '1', 19:27:45 INFO - 'TERM': 'linux', 19:27:45 INFO - 'TMOUT': '86400', 19:27:45 INFO - 'USER': 'cltbld', 19:27:45 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 19:27:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:45 INFO - '_': '/tools/buildbot/bin/python'} 19:27:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27: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 19:27:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:27:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:27:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:27:47 INFO - Installing collected packages: mozsystemmonitor 19:27:47 INFO - Running setup.py install for mozsystemmonitor 19:27:47 INFO - Successfully installed mozsystemmonitor 19:27:47 INFO - Cleaning up... 19:27:47 INFO - Return code: 0 19:27:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:27: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')]} 19:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27: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')]} 19:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:47 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 0x7f8a69ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d790>, '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 0x212e690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:27:47 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 19:27:47 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 19:27:47 INFO - Using env: {'DISPLAY': ':0', 19:27:47 INFO - 'HOME': '/home/cltbld', 19:27:47 INFO - 'LANG': 'en_US.UTF-8', 19:27:47 INFO - 'LANGUAGE': 'en_US:en', 19:27:47 INFO - 'LOGNAME': 'cltbld', 19:27:47 INFO - 'MAIL': '/var/mail/cltbld', 19:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:47 INFO - 'MOZ_NO_REMOTE': '1', 19:27:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:47 INFO - 'NO_EM_RESTART': '1', 19:27:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:47 INFO - 'PWD': '/builds/slave/test', 19:27:47 INFO - 'SHELL': '/bin/bash', 19:27:47 INFO - 'SHLVL': '1', 19:27:47 INFO - 'TERM': 'linux', 19:27:47 INFO - 'TMOUT': '86400', 19:27:47 INFO - 'USER': 'cltbld', 19:27:47 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 19:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:47 INFO - '_': '/tools/buildbot/bin/python'} 19:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:47 INFO - Downloading/unpacking jsonschema==2.5.1 19:27:47 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 19:27:47 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 19:27:47 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 19:27:47 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 19:27:47 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 19:27:47 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 19:27:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:27:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 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 19:27:49 INFO - Downloading functools32-3.2.3-2.tar.gz 19:27:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:27:49 INFO - warning: no files found matching '*.txt' 19:27:49 INFO - no previously-included directories found matching 'build' 19:27:49 INFO - no previously-included directories found matching 'dist' 19:27:49 INFO - no previously-included directories found matching '.git*' 19:27:49 INFO - Installing collected packages: jsonschema, functools32 19:27:49 INFO - Running setup.py install for functools32 19:27:49 INFO - warning: no files found matching '*.txt' 19:27:49 INFO - no previously-included directories found matching 'build' 19:27:49 INFO - no previously-included directories found matching 'dist' 19:27:49 INFO - no previously-included directories found matching '.git*' 19:27:49 INFO - Successfully installed jsonschema functools32 19:27:49 INFO - Cleaning up... 19:27:49 INFO - Return code: 0 19:27:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:27:49 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')]} 19:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:49 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')]} 19:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:49 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 0x7f8a69ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d790>, '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 0x212e690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:27:49 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 19:27:49 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 19:27:49 INFO - Using env: {'DISPLAY': ':0', 19:27:49 INFO - 'HOME': '/home/cltbld', 19:27:49 INFO - 'LANG': 'en_US.UTF-8', 19:27:49 INFO - 'LANGUAGE': 'en_US:en', 19:27:49 INFO - 'LOGNAME': 'cltbld', 19:27:49 INFO - 'MAIL': '/var/mail/cltbld', 19:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:49 INFO - 'MOZ_NO_REMOTE': '1', 19:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:49 INFO - 'NO_EM_RESTART': '1', 19:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:49 INFO - 'PWD': '/builds/slave/test', 19:27:49 INFO - 'SHELL': '/bin/bash', 19:27:49 INFO - 'SHLVL': '1', 19:27:49 INFO - 'TERM': 'linux', 19:27:49 INFO - 'TMOUT': '86400', 19:27:49 INFO - 'USER': 'cltbld', 19:27:49 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 19:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:49 INFO - '_': '/tools/buildbot/bin/python'} 19:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:27:50 INFO - Cleaning up... 19:27:50 INFO - Return code: 0 19:27:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:27:50 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')]} 19:27:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:50 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')]} 19:27:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:50 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 0x7f8a69ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d790>, '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 0x212e690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:27:50 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 19:27:50 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 19:27:50 INFO - Using env: {'DISPLAY': ':0', 19:27:50 INFO - 'HOME': '/home/cltbld', 19:27:50 INFO - 'LANG': 'en_US.UTF-8', 19:27:50 INFO - 'LANGUAGE': 'en_US:en', 19:27:50 INFO - 'LOGNAME': 'cltbld', 19:27:50 INFO - 'MAIL': '/var/mail/cltbld', 19:27:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:50 INFO - 'MOZ_NO_REMOTE': '1', 19:27:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:50 INFO - 'NO_EM_RESTART': '1', 19:27:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:50 INFO - 'PWD': '/builds/slave/test', 19:27:50 INFO - 'SHELL': '/bin/bash', 19:27:50 INFO - 'SHLVL': '1', 19:27:50 INFO - 'TERM': 'linux', 19:27:50 INFO - 'TMOUT': '86400', 19:27:50 INFO - 'USER': 'cltbld', 19:27:50 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 19:27:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:50 INFO - '_': '/tools/buildbot/bin/python'} 19:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:50 INFO - Downloading/unpacking blobuploader==1.2.4 19:27:50 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 19:27:50 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 19:27:50 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 19:27:50 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 19:27:50 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 19:27:50 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 19:27:52 INFO - Downloading blobuploader-1.2.4.tar.gz 19:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:27:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:27:52 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 19:27:52 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 19:27:52 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 19:27:52 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 19:27:52 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 19:27:52 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 19:27:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:27:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:27:52 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 19:27:52 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 19:27:52 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 19:27:52 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 19:27:52 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 19:27:52 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 19:27:53 INFO - Downloading docopt-0.6.1.tar.gz 19:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:27:53 INFO - Installing collected packages: blobuploader, requests, docopt 19:27:53 INFO - Running setup.py install for blobuploader 19:27:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:27:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:27:53 INFO - Running setup.py install for requests 19:27:53 INFO - Running setup.py install for docopt 19:27:53 INFO - Successfully installed blobuploader requests docopt 19:27:53 INFO - Cleaning up... 19:27:53 INFO - Return code: 0 19:27:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:53 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')]} 19:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:53 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')]} 19:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:53 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 0x7f8a69ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d790>, '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 0x212e690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:27:53 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 19:27:53 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 19:27:53 INFO - Using env: {'DISPLAY': ':0', 19:27:53 INFO - 'HOME': '/home/cltbld', 19:27:53 INFO - 'LANG': 'en_US.UTF-8', 19:27:53 INFO - 'LANGUAGE': 'en_US:en', 19:27:53 INFO - 'LOGNAME': 'cltbld', 19:27:53 INFO - 'MAIL': '/var/mail/cltbld', 19:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:53 INFO - 'MOZ_NO_REMOTE': '1', 19:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:53 INFO - 'NO_EM_RESTART': '1', 19:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:53 INFO - 'PWD': '/builds/slave/test', 19:27:53 INFO - 'SHELL': '/bin/bash', 19:27:53 INFO - 'SHLVL': '1', 19:27:53 INFO - 'TERM': 'linux', 19:27:53 INFO - 'TMOUT': '86400', 19:27:53 INFO - 'USER': 'cltbld', 19:27:53 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 19:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:53 INFO - '_': '/tools/buildbot/bin/python'} 19:27:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:53 INFO - Running setup.py (path:/tmp/pip-UIUpp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:53 INFO - Running setup.py (path:/tmp/pip-gt5_pU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:54 INFO - Running setup.py (path:/tmp/pip-yM7hci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:54 INFO - Running setup.py (path:/tmp/pip-HVwWsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:54 INFO - Running setup.py (path:/tmp/pip-bBNI2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:54 INFO - Running setup.py (path:/tmp/pip-hGWouj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:54 INFO - Running setup.py (path:/tmp/pip-v7BAiJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:54 INFO - Running setup.py (path:/tmp/pip-n60a88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:54 INFO - Running setup.py (path:/tmp/pip-UOGLY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:54 INFO - Running setup.py (path:/tmp/pip-hcJTDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:54 INFO - Running setup.py (path:/tmp/pip-06xISJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:54 INFO - Running setup.py (path:/tmp/pip-oHESN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:54 INFO - Running setup.py (path:/tmp/pip-5EZAWP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:54 INFO - Running setup.py (path:/tmp/pip-zpQRrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:54 INFO - Running setup.py (path:/tmp/pip-fNx4l5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:54 INFO - Running setup.py (path:/tmp/pip-oOdlIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:55 INFO - Running setup.py (path:/tmp/pip-Ag8KLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:27:55 INFO - Running setup.py install for manifestparser 19:27:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:27:55 INFO - Running setup.py install for mozcrash 19:27:55 INFO - Running setup.py install for mozdebug 19:27:55 INFO - Running setup.py install for mozdevice 19:27:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:27:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:27:55 INFO - Running setup.py install for mozfile 19:27:55 INFO - Running setup.py install for mozhttpd 19:27:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:27:55 INFO - Running setup.py install for mozinfo 19:27:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:27:55 INFO - Running setup.py install for mozInstall 19:27:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:27:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:27:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:27:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:27:55 INFO - Running setup.py install for mozleak 19:27:56 INFO - Running setup.py install for mozlog 19:27:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:27:56 INFO - Running setup.py install for moznetwork 19:27:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:27:56 INFO - Running setup.py install for mozprocess 19:27:56 INFO - Running setup.py install for mozprofile 19:27:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:27:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:27:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:27:56 INFO - Running setup.py install for mozrunner 19:27:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:27:56 INFO - Running setup.py install for mozscreenshot 19:27:56 INFO - Running setup.py install for moztest 19:27:56 INFO - Running setup.py install for mozversion 19:27:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:27:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:27:56 INFO - Cleaning up... 19:27:56 INFO - Return code: 0 19:27:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:27:56 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 0x7f8a69ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d790>, '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 0x212e690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:27:56 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 19:27:56 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 19:27:56 INFO - Using env: {'DISPLAY': ':0', 19:27:56 INFO - 'HOME': '/home/cltbld', 19:27:56 INFO - 'LANG': 'en_US.UTF-8', 19:27:56 INFO - 'LANGUAGE': 'en_US:en', 19:27:56 INFO - 'LOGNAME': 'cltbld', 19:27:56 INFO - 'MAIL': '/var/mail/cltbld', 19:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:27:56 INFO - 'MOZ_NO_REMOTE': '1', 19:27:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:27:56 INFO - 'NO_EM_RESTART': '1', 19:27:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:27:56 INFO - 'PWD': '/builds/slave/test', 19:27:56 INFO - 'SHELL': '/bin/bash', 19:27:56 INFO - 'SHLVL': '1', 19:27:56 INFO - 'TERM': 'linux', 19:27:56 INFO - 'TMOUT': '86400', 19:27:56 INFO - 'USER': 'cltbld', 19:27:56 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 19:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:27:56 INFO - '_': '/tools/buildbot/bin/python'} 19:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:27:57 INFO - Running setup.py (path:/tmp/pip-QmVOvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:27:57 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)) 19:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:27:57 INFO - Running setup.py (path:/tmp/pip-UrYFUY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:27:57 INFO - Running setup.py (path:/tmp/pip-2W22cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:27:57 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)) 19:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:27:57 INFO - Running setup.py (path:/tmp/pip-JANKCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:27:57 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)) 19:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:27:57 INFO - Running setup.py (path:/tmp/pip-HIFolD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:27:57 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)) 19:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:27:57 INFO - Running setup.py (path:/tmp/pip-D7r7po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:27:57 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)) 19:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:27:57 INFO - Running setup.py (path:/tmp/pip-9so_wT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:27:57 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)) 19:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:27:57 INFO - Running setup.py (path:/tmp/pip-0g_dyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:27:57 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)) 19:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:27:57 INFO - Running setup.py (path:/tmp/pip-oODkjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:27:57 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)) 19:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:27:57 INFO - Running setup.py (path:/tmp/pip-ferW0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:27:57 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)) 19:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:27:57 INFO - Running setup.py (path:/tmp/pip-cfpg5b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:27:57 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)) 19:27:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:27:57 INFO - Running setup.py (path:/tmp/pip-sKNXeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:27:58 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)) 19:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:27:58 INFO - Running setup.py (path:/tmp/pip-FkFW0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:27:58 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)) 19:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:27:58 INFO - Running setup.py (path:/tmp/pip-jl52Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:58 INFO - Running setup.py (path:/tmp/pip-HWofW3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:27:58 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)) 19:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:27:58 INFO - Running setup.py (path:/tmp/pip-0Z8Z1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:27:58 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)) 19:27:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:27:58 INFO - Running setup.py (path:/tmp/pip-Lm4T44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:27:58 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)) 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:27:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:27:58 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)) 19:27:58 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)) 19:27:58 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)) 19:27:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:27:58 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 19:27:58 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 19:27:58 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 19:27:58 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 19:27:58 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 19:27:58 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 19:28:00 INFO - Downloading blessings-1.6.tar.gz 19:28:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:28:00 INFO - Installing collected packages: blessings 19:28:00 INFO - Running setup.py install for blessings 19:28:00 INFO - Successfully installed blessings 19:28:00 INFO - Cleaning up... 19:28:00 INFO - Return code: 0 19:28:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:28:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:28:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:28:00 INFO - Reading from file tmpfile_stdout 19:28:00 INFO - Current package versions: 19:28:00 INFO - argparse == 1.2.1 19:28:00 INFO - blessings == 1.6 19:28:00 INFO - blobuploader == 1.2.4 19:28:00 INFO - docopt == 0.6.1 19:28:00 INFO - functools32 == 3.2.3-2 19:28:00 INFO - jsonschema == 2.5.1 19:28:00 INFO - manifestparser == 1.1 19:28:00 INFO - mozInstall == 1.12 19:28:00 INFO - mozcrash == 0.17 19:28:00 INFO - mozdebug == 0.1 19:28:00 INFO - mozdevice == 0.48 19:28:00 INFO - mozfile == 1.2 19:28:00 INFO - mozhttpd == 0.7 19:28:00 INFO - mozinfo == 0.9 19:28:00 INFO - mozleak == 0.1 19:28:00 INFO - mozlog == 3.4 19:28:00 INFO - moznetwork == 0.27 19:28:00 INFO - mozprocess == 0.23 19:28:00 INFO - mozprofile == 0.28 19:28:00 INFO - mozrunner == 6.12 19:28:00 INFO - mozscreenshot == 0.1 19:28:00 INFO - mozsystemmonitor == 0.3 19:28:00 INFO - moztest == 0.7 19:28:00 INFO - mozversion == 1.4 19:28:00 INFO - psutil == 3.1.1 19:28:00 INFO - requests == 1.2.3 19:28:00 INFO - wsgiref == 0.1.2 19:28:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:28:00 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')]} 19:28:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:00 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')]} 19:28:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:00 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 0x7f8a69ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d790>, '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 0x212e690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:28:00 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 19:28:00 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 19:28:00 INFO - Using env: {'DISPLAY': ':0', 19:28:00 INFO - 'HOME': '/home/cltbld', 19:28:00 INFO - 'LANG': 'en_US.UTF-8', 19:28:00 INFO - 'LANGUAGE': 'en_US:en', 19:28:00 INFO - 'LOGNAME': 'cltbld', 19:28:00 INFO - 'MAIL': '/var/mail/cltbld', 19:28:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:00 INFO - 'MOZ_NO_REMOTE': '1', 19:28:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:00 INFO - 'NO_EM_RESTART': '1', 19:28:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:00 INFO - 'PWD': '/builds/slave/test', 19:28:00 INFO - 'SHELL': '/bin/bash', 19:28:00 INFO - 'SHLVL': '1', 19:28:00 INFO - 'TERM': 'linux', 19:28:00 INFO - 'TMOUT': '86400', 19:28:00 INFO - 'USER': 'cltbld', 19:28:00 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 19:28:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:00 INFO - '_': '/tools/buildbot/bin/python'} 19:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:01 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)) 19:28:01 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)) 19:28:01 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)) 19:28:01 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)) 19:28:01 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)) 19:28:01 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)) 19:28:01 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)) 19:28:01 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)) 19:28:01 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)) 19:28:01 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)) 19:28:01 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)) 19:28:01 INFO - Cleaning up... 19:28:01 INFO - Return code: 0 19:28:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:28:01 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')]} 19:28:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:28:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:01 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')]} 19:28:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:28:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:28:01 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 0x7f8a69ca4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fd28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x209e7b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x212d790>, '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 0x212e690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212eb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:28:01 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 19:28:01 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 19:28:01 INFO - Using env: {'DISPLAY': ':0', 19:28:01 INFO - 'HOME': '/home/cltbld', 19:28:01 INFO - 'LANG': 'en_US.UTF-8', 19:28:01 INFO - 'LANGUAGE': 'en_US:en', 19:28:01 INFO - 'LOGNAME': 'cltbld', 19:28:01 INFO - 'MAIL': '/var/mail/cltbld', 19:28:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:01 INFO - 'MOZ_NO_REMOTE': '1', 19:28:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:01 INFO - 'NO_EM_RESTART': '1', 19:28:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:01 INFO - 'PWD': '/builds/slave/test', 19:28:01 INFO - 'SHELL': '/bin/bash', 19:28:01 INFO - 'SHLVL': '1', 19:28:01 INFO - 'TERM': 'linux', 19:28:01 INFO - 'TMOUT': '86400', 19:28:01 INFO - 'USER': 'cltbld', 19:28:01 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 19:28:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:01 INFO - '_': '/tools/buildbot/bin/python'} 19:28:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:28:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:28:01 INFO - Cleaning up... 19:28:01 INFO - Return code: 0 19:28:01 INFO - Running post-action listener: _resource_record_post_action 19:28:01 INFO - Running post-action listener: _start_resource_monitoring 19:28:01 INFO - Starting resource monitoring. 19:28:01 INFO - [mozharness: 2016-10-13 02:28:01.303378Z] Finished create-virtualenv step (success) 19:28:01 INFO - [mozharness: 2016-10-13 02:28:01.303894Z] Running install step. 19:28:01 INFO - Running pre-action listener: _resource_record_pre_action 19:28:01 INFO - Running main action method: install 19:28:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:28:01 INFO - Reading from file tmpfile_stdout 19:28:01 INFO - Detecting whether we're running mozinstall >=1.0... 19:28:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:28:01 INFO - Reading from file tmpfile_stdout 19:28:01 INFO - Output received: 19:28:01 INFO - Usage: mozinstall [options] installer 19:28:01 INFO - Options: 19:28:01 INFO - -h, --help show this help message and exit 19:28:01 INFO - -d DEST, --destination=DEST 19:28:01 INFO - Directory to install application into. [default: 19:28:01 INFO - "/builds/slave/test"] 19:28:01 INFO - --app=APP Application being installed. [default: firefox] 19:28:01 INFO - mkdir: /builds/slave/test/build/application 19:28:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:28:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 19:28:18 INFO - Reading from file tmpfile_stdout 19:28:18 INFO - Output received: 19:28:18 INFO - /builds/slave/test/build/application/firefox/firefox 19:28:18 INFO - Running post-action listener: _resource_record_post_action 19:28:18 INFO - [mozharness: 2016-10-13 02:28:18.650585Z] Finished install step (success) 19:28:18 INFO - [mozharness: 2016-10-13 02:28:18.650830Z] Running run-tests step. 19:28:18 INFO - Running pre-action listener: _resource_record_pre_action 19:28:18 INFO - Running main action method: run_tests 19:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:28:18 INFO - Python 2.7.3 19:28:18 INFO - Return code: 0 19:28:18 INFO - grabbing minidump binary from tooltool 19:28:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:28:18 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/linux64/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 0x212d790>, '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 0x212e690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x212eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:28:18 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:28:18 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/linux64/releng.manifest -o -c /builds/tooltool_cache 19:28:18 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/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:28:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:28:18 INFO - Return code: 0 19:28:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:28:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:28:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:28:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:28:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:28:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 19:28:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-067 --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 19:28:18 INFO - Using env: {'DISPLAY': ':0', 19:28:18 INFO - 'HOME': '/home/cltbld', 19:28:18 INFO - 'LANG': 'en_US.UTF-8', 19:28:18 INFO - 'LANGUAGE': 'en_US:en', 19:28:18 INFO - 'LOGNAME': 'cltbld', 19:28:18 INFO - 'MAIL': '/var/mail/cltbld', 19:28:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:28:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:28:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:28:18 INFO - 'MOZ_NO_REMOTE': '1', 19:28:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:28:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:28:18 INFO - 'NO_EM_RESTART': '1', 19:28:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:28:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:28:18 INFO - 'PWD': '/builds/slave/test', 19:28:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:28:18 INFO - 'SHELL': '/bin/bash', 19:28:18 INFO - 'SHLVL': '1', 19:28:18 INFO - 'TERM': 'linux', 19:28:18 INFO - 'TMOUT': '86400', 19:28:18 INFO - 'USER': 'cltbld', 19:28:18 INFO - 'XDG_SESSION_COOKIE': 'e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220', 19:28:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:28:18 INFO - '_': '/tools/buildbot/bin/python'} 19:28:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-067', '--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 19:28:18 INFO - mozversion application_buildid: 20161012163004 19:28:18 INFO - mozversion application_changeset: 22be4ae74653b25186665f22e52a50e7027fd36b 19:28:18 INFO - mozversion application_display_name: Nightly 19:28:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:28:18 INFO - mozversion application_name: Firefox 19:28:18 INFO - mozversion application_remotingname: firefox 19:28:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:28:18 INFO - mozversion application_vendor: Mozilla 19:28:18 INFO - mozversion application_version: 52.0a1 19:28:18 INFO - mozversion platform_buildid: 20161012163004 19:28:18 INFO - mozversion platform_changeset: 22be4ae74653b25186665f22e52a50e7027fd36b 19:28:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:28:18 INFO - mozversion platform_version: 52.0a1 19:28:18 INFO - using testdate: 1476325698 19:28:18 INFO - actual date: 1476325698 19:28:18 INFO - starting webserver on 'localhost:42303' 19:28:18 INFO - SUITE-START | Running 2 tests 19:28:18 INFO - TEST-START | dromaeo_css 19:28:18 INFO - operating with platform_type : linux_ 19:28:18 INFO - Initialising browser for dromaeo_css test... 19:28:18 INFO - TEST-INFO | started process 15906 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp34zJcc/profile http://localhost:42303/getInfo.html) 19:28:22 INFO - PROCESS | 15906 | __metrics Screen width/height:1600/1200 19:28:22 INFO - PROCESS | 15906 | colorDepth:24 19:28:22 INFO - PROCESS | 15906 | Browser inner width/height: 1024/697 19:28:22 INFO - PROCESS | 15906 | __metrics 19:28:23 INFO - PROCESS | 15906 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:28:23 INFO - PROCESS | 15906 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:28:23 INFO - PROCESS | 15906 | console.error: PushService: 19:28:23 INFO - PROCESS | 15906 | stateChangeProcessEnqueue: Error transitioning state 19:28:23 INFO - PROCESS | 15906 | UnknownError 19:28:24 INFO - TEST-INFO | 15906: exit 0 19:28:24 INFO - Browser initialized. 19:28:24 INFO - Running cycle 1/1 for dromaeo_css test... 19:28:24 INFO - TEST-INFO | started process 15989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp34zJcc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:28:36 INFO - PROCESS | 15989 | RSS: Main: 173293568 19:28:36 INFO - PROCESS | 15989 | 19:29:27 INFO - PROCESS | 15989 | 1476325767969 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] 19:31:38 INFO - PROCESS | 15989 | Cycle 1(1): loaded http://localhost:42303/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42303/tests/dromaeo/cssquery-ext.html) 19:31:39 INFO - PROCESS | 15989 | RSS: Main: 318750720 19:31:39 INFO - PROCESS | 15989 | 19:34:42 INFO - PROCESS | 15989 | Cycle 1(1): loaded http://localhost:42303/tests/dromaeo/cssquery-ext.html (next: http://localhost:42303/tests/dromaeo/cssquery-jquery.html) 19:34:42 INFO - PROCESS | 15989 | RSS: Main: 276398080 19:34:42 INFO - PROCESS | 15989 | 19:37:44 INFO - PROCESS | 15989 | Cycle 1(1): loaded http://localhost:42303/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42303/tests/dromaeo/cssquery-mootools.html) 19:37:45 INFO - PROCESS | 15989 | RSS: Main: 239636480 19:37:45 INFO - PROCESS | 15989 | 19:40:47 INFO - PROCESS | 15989 | Cycle 1(1): loaded http://localhost:42303/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42303/tests/dromaeo/cssquery-prototype.html) 19:40:48 INFO - PROCESS | 15989 | RSS: Main: 232534016 19:40:48 INFO - PROCESS | 15989 | 19:43:50 INFO - PROCESS | 15989 | Cycle 1(1): loaded http://localhost:42303/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42303/tests/dromaeo/cssquery-yui.html) 19:43:51 INFO - PROCESS | 15989 | RSS: Main: 215580672 19:43:51 INFO - PROCESS | 15989 | 19:46:54 INFO - PROCESS | 15989 | Cycle 1(1): loaded http://localhost:42303/tests/dromaeo/cssquery-yui.html (next: http://localhost:42303/tests/dromaeo/cssquery-dojo.html) 19:46:55 INFO - PROCESS | 15989 | RSS: Main: 307687424 19:46:55 INFO - PROCESS | 15989 | 19:46:55 INFO - PROCESS | 15989 | __start_tp_report 19:46:55 INFO - PROCESS | 15989 | _x_x_mozilla_page_load 19:46:55 INFO - PROCESS | 15989 | _x_x_mozilla_page_load_details 19:46:55 INFO - PROCESS | 15989 | |i|pagename|runs| 19:46:55 INFO - PROCESS | 15989 | |0;dojo.html;3011.367612801312;3041.4221297953372;3054.7708921830863;3068.493698539741;3103.7516998640112;5093.337866077405;5183.663061900974;5207.5052869977335;5283.630145889784;5306.7346632668405;5234.50272224139;5244.79020839166;5318.840434786953;5320.122179840331;5431.891362172754;4776.307435421862;4840.056189043138;4869.65912386134;4875.780589873464;4897.3878265216845;4830.541098595628;4854.951450485485;4858.902821943577;4859.343988561552;4891.5353041461185;4917.803287868481;4938.407391113054;4945.67853089548;4986.551210391064;4995.075910956467;4708;4741.407324084489;4742.383490146259;4886.315915771759;4950.381202349707;4676.251799712029;4716.103940251342;4731.763411829429;4750.334953106568;4795.376601041842;5121.539061484485;5141.922871156936;5166.767495462713;5181.53366197044;5224.843254702365;5527.281453411071;5534.446555344473;5536.4186760389985;5537.1140617501405;5548.056830338812;5473.2063850741415;5531.25328080708;5626;5679.4036626154075;5686.5735069869515;5297.655652382583;5307.52232299095;5315.1761476971515;5316.4683531646915;5364.785408583652;5761.9135712964335;5769.88460230793;5781.855453613609;5782.6819524925695;5786.797462088891;5350.117230656898;5450.400455949843;5456;5579.9163012554845;5640.717964101778;5548.750306236229;5588.050031494575;5593.888122237532;5609.747561359749;5626.718664066862;5549.5837812163445;5555.694436805934;5558.805441809517;5563.13771365439;5652.660840349592;5439.809606663748;5605.299337582802;5613.326400831845;5614.522765564891;5618.129189975561;4243.724157929724;4364.214441400578;4364.956350436519;4365.694401391936;4367.061081867414;3918.4710064140977;3926.254011737818;3946.7631942083567;3949.624785645359;3950.9529974556767;5240.737963101829;5244.134717771602;5293.708846013429;5362.624616276901;5371.677699338053;5559.577240480675;5610.326760788732;5612.130119831432;5613.410591887875;5621.213030175779;5264.78940842362;5292.126799078109;5297.54970827484;5308.362996440452;5338.599605029638;4811.254255590389;4828.589569886529;4837.564619184291;4843.491433399513;4866.124097662455;5764.682942438122;5764.769409223752;5768.884622307531;5772.480476757028;5821.446962538552;5547.694876781816;5588.524975377139;5598.468145526169;5598.720063996865;5603.243562119224;5593.049181639212;5645.887082258414;5739.053056245672;5744.253247077853;5791.971040144772;5553.611247212656;5556.499915007668;5558.3607885092115;5596.300462442195;5607.495325420732;5614.803481878114;5627.071533196977;5629.831105066854;5659.179418984142;5671.943280567141;5352.5985551084605;5413.945860541344;5456.508914197582;5512.090505066619;5515.972420137874;5478.205660179331;5506.091494903296;5515.751791169327;5567.77728890856;5579.414161512983;5440.102383106743;5500.147477141049;5501.669899806025;5505.284313039279;5525.806596769094;5347.973260133675;5406.945930540644;5416.972915135557;5527.565568828004;5559.555235581225;5314.8937021260135;5336.546393556591;5387.434319396407;5390.541803946709;5391.245225668331 19:46:55 INFO - PROCESS | 15989 | |1;ext.html;555.7471350535507;596.8985272503674;599.7421108923161;607.1045208317735;612.6048698589409;31404.84297578512;34977.82511087447;34993.65006349936;35006.824965875196;35145;34814.82592587033;42541;43918;43926.12147757043;48500.272495912504;8796.736097917057;8896.154865287788;8934.865977010317;8938.776530586754;8943.910560894374;8715.084916083782;8832.602532886003;8848.5575721214;8864.113588641148;8864.290856731446;8881.200691937724;8922.821543569156;8926.821463570725;8930.508822014786;8936.195742383185;8867.77830554238;8895.421797583136;8897.644094236222;8909.376343655947;8935.64257429702;8771.78070548235;8819.559022048872;8841.778955526099;8845.557722113868;8850.291976641853;43349.349759753626;43581.12837743259;43611.63883611614;43621.563784362064;43628.127437451076;3490.0925759302763;3669.5779985301765;3707.6292370762976;3800.7529510582;3874.9987583315983;31785.728570857136;32184.195395115075;32195.19512012195;33432.66567334344;33751;4233.308040607225;4245.405643209953;4302.397664326965;4351.216780979423;4487.371767952489;310322;310860.56557737663;311018;312980.99999999773;314227;57554;57596;57719.134212986835;57931.71034144802;58016;59936.70031649901;59980.70009650011;60000.69999649974;60024;60208;14502.492412765714;14692.191929443983;14715.19066451334;14725.705485890223;14733;11132.165087618461;11175.888241117647;11191.496382662799;11194.832077518844;11210.327380357205;15543.689126217412;17840.46478605644;17884.463466096036;17886.373976910745;17980.280788768563;6283.37166283368;6298.307186209513;6380.457661098766;6445.323241059715;6538.509611779041;912.4160537256162;1013.8428543575758;1015.9136473399844;1065.3394895165047;1078.250615822012;29708.257293567833;31344.686553134634;31600.683993159775;31623.20941976469;32253.452120266753;907.7594437474074;1052.652624633869;1107.7286064914147;1122.5341483284508;1123.8201887698092;15693;16619;16707.749383759252;16771.413000544922;16771.832281677027;469096;471204;471690;472999;474123;56745.14882276769;57202.427975720544;57348.71325643345;57444.71277643585;57561;1182.8284898689642;1208.5407545132969;1281.2568710148091;1303.9152455090577;1346.4277681985118;29492.262693432836;32596.83701581572;32741.83629081839;32996.83501582477;33185.170370740925;47826;48297.27554086621;48420.5157948416;48420.5157948416;48422;338712;340182;340433;341781;341913;28627.284317891386;29545.40909181761;29619.407611848073;29636.259093522833;39968.80015599904;46725.53274467348;46737;46803;47157.52842471531;48540;38718.772965649274;38920.22159556737;38970.805145975224;40145.79927100346;41142.79428602838;38906;38915.41626875543;39188;39866.20267594574;40448.59551404566;39739;40010.59989400069;40457.59542404656;40849.795751021054;41002.84957256435;31783;35494.822525887204;35706;36462.27075458529;36634.26731465409;27290.181294561196;27444;27759.722402775715;27933.441331173668;27978.440431190855 19:46:55 INFO - PROCESS | 15989 | |2;jquery.html;347.43194876377146;352.8817846021583;369.10492056762354;379.5843551311313;390.50600989747954;14232.644183895407;18095.547611309707;18988.335408260715;20101.798982010176;20333.898330508364;17707.203175857085;17853.91073044633;18300.72548911764;18313.725294120566;18491.982940938244;5424.349078110622;5692.402297758737;5701.116326969326;5710.257666503348;5716.1711551824965;4143.564925682806;4346.521882592912;4367.737935723851;5616.887662246752;5714.25714657094;6250.374962503759;6279.68601569922;6364.2681091674585;6371.394717501853;6378.617282963014;5441.455854414547;5676.375598684142;5703.800366987177;6377.521685873555;6382.712777924981;5618.7190640468225;5648.491635752802;5657.377688454267;5657.462541058593;5662.405447428043;13443.731125377437;16942.3223071077;20305.88317642529;21866.344009679575;22077.558448831092;2096.1510588211645;2300.9654855177187;2389.569877422063;2651.180032126529;2864.3412015236404;9540.952295238549;9747.268954828345;9868.45723485208;10371;10400.687979360631;1849.2880241107136;1859.8326150646508;1897.5351038995395;1933.835623971964;1944.6888497840278;81357;81363.18636813674;81656.59171704162;83128.75306870401;86420.99999999937;10441.947790261;10496.632617858339;10701.304415212986;10721.731956701145;10757.83863242052;15152.545423637308;15153.393864245307;15163.848361516244;15165.848341516665;15192.772108418383;7380.225076366904;7482.289182527651;7484.663190156456;7521.4734968551675;7591.932407184963;6957.095577574883;7055.118110236221;7075.929240707527;7130.290749244104;7316.780496585111;4455.376247325377;4567.332923482905;4609.193391156534;4686.203345431285;4740.6444516660695;1862.841658459019;1873.9063046847602;1876.0041112430708;1938.9709154362695;1960.1767257751778;838.773531146587;961.6297725375781;994.5773046455372;1008.4432404642874;1041.9788607165021;17929.7310540342;18617.534561635795;19100.61798764017;19414.2234310626;19523.707144392847;958.4297343080856;964.7781010367655;965.8406362950035;993.3890657245742;1004.1866088468364;10056.547455364525;10479.109275711497;10770.407627580558;10775.78448431027;10777.892221077846;431103;460118.9881011872;473743;473758;474662;85144;88526;89598.30803533619;90183;93511.06488935159;1000.1798525209404;1015.294370412571;1044.681372181492;1052.552665117322;1062.134360496193;16155.919220403823;16853;17474.563135921704;17646.558836029202;17832.3758668446;39063.609363906;39591.80204098961;40279.19441611093;40521.1895762089;40915;52425.7378713104;55101.72449137729;56168.438315616324;56585.15122273087;57087.42912570821;5469.863253418696;7942.927704759783;8280.544570048705;8300.916990830256;8489.4481858679;9226.907730922605;12080.335581542748;12251.87748122543;12692.238465692088;12703.55537556218;5858.414158584107;6537.901931471127;10725.30285531438;11237.943810280896;11350.205485615928;10397.16822654201;10636.787264254826;10937.851525589698;10994.890051099386;11195.328280303207;10891.67324980252;10961.56153753841;11136.777264454504;11138;11813.940930295294;7956.323712484504;8155.918440815516;8191.959040204761;8240.83518329642;8397.118302578141;9759.56081976327;10782.946085269523;11085.722856928642;11161.386123762946;11196.440177991231 19:46:55 INFO - PROCESS | 15989 | |3;mootools.html;1302.4139137388179;1429.099667209658;1478.2904205981126;1577.4636623548;1782.224732241475;7745.457817952739;8609.311255099585;8882.067382924797;8893.199612034916;9136.497492637902;8972.8654070189;9057.637694492212;9058.637654493812;9060.275177985763;9064.22954048905;2215.8781267030386;2234.709487766588;2248.9662655060188;2260.547890421914;2261.6607508873717;2201.2955854126685;2224.7552769195377;2292.610256256432;2294.7705229477087;2299.908003679851;2250.1561914282142;2260.8078313343385;2262.9773702263014;2267.30847091637;2277.840551161419;2166.566686662674;2176.662617294314;2192.3642143778284;2192.6710993351044;2192.9890350548303;2220.9555808883892;2230.342049095521;2230.5984922713906;2235.4634887627017;2238.4851484158735;8700.608472618747;8814.647414103429;8882.689105881327;8901.109889011112;8923.776905577348;5164.741762911839;5386.703731294777;5391.272178255964;5401.297831281948;5404.567634589223;3409.4203985322556;3443.0359499340225;3453.4474484082675;3473.7221022318154;3501.7023552998025;1103.194667892443;1119.7872404243167;1125.3416751200557;1146.5528443906883;1147.9483423245974;12252.081093917903;12256.019518438503;12292.815607765891;12318.99999999991;12328.075394345371;4264.786760661955;4468.061707041557;4476.261416866246;4554.521775213621;4558.8632341029825;9720.659776907774;9748.512574371394;9757.414555126716;9764.072413120743;9765.755856103513;5220.112580861187;5238.711870847063;5242.397124330674;5251.737413129405;5259.132243179909;4043.130726893732;4239.215745087169;4406.030673251879;4892.633052521004;4894.926576101361;3690.944635830465;3727.5340582427198;3800.4489349044234;3803.410471376941;3803.8858834235016;1148.1675785055768;1169.2283093158474;1177.776222517719;1182.3319824299244;1182.798924182891;917.3899356927568;926.8321914387919;930.8184903943666;934.1265916368218;951.8191543606692;5572.860678482989;5611.102223644198;5752.884942301131;5772.7690892363835;5788.218590490314;926.6478738079621;986.2405947420447;986.4475893499663;991.5092029445326;994.6568433890296;3542.557180352456;3815.523059617548;3877.4765406670303;3903.0437542802197;3993.241284156059;10691.625793097204;11083.50124244411;11092.833607495893;11111.388873611868;11136.61021864247;10307.742306442398;10720.195985301134;10989.450527473595;11024.393658348707;11038.44807759625;7911.406644501685;8079.151689072681;8081.272685458337;8096.716614918568;8105.2705256526015;5662.178984047372;5717.771289148387;5776.393478684678;5802.216700745345;5950.285965684146;10067.949660251652;10196.59213631476;10202.38785672862;10210.642627508001;10359.119474844723;9146.222571081533;9745.658901938397;10136.594536218468;10139.340942838691;10395.116415104801;7088;7331.74338898136;7506.887396688945;7591.8861217080685;7714;8439.831203375776;8540.914590854012;8615.3107751381;8621.051684314594;8701.52141632191;7694.846103077795;7746.961265193638;7889.64496597643;7898.723544675909;7923.1680673530755;7690.538567685957;7818.022747156606;7870.842583148419;7904.604769761604;8010.078840933367;6862.862742745017;7006.5095443320515;7069.681864316221;7075.433965282868;7085.82285442868;4839.540243676845;4926.8768280793265;4930.309756634002;5002.049610573979;5014.122528557561;4818.325434439112;4916.410030796327;4954.702717836942;4962.354893863775;4964.156093464047 19:46:55 INFO - PROCESS | 15989 | |4;prototype.html;303.43258107339267;311.7163381322996;318.74500399680255;322.44861287198887;324.7791501778792;4967.230079337699;5087.414947281064;5115.360579927509;5135.922961155586;5182.611304152189;4938.98721779715;5061.266116413118;5085.389753229609;5112;5128.512791284831;4076.653484453825;4083.081306705997;4083.9795801020955;4086.5504794472586;4086.795660216992;3971.4042893565907;4078.8980275493054;4082.326416141348;4085.9795701021453;4094.7338423002557;4027.879163625081;4046.9392959105635;4053.27041132596;4059;4060.878173654795;4022.2045678253626;4033.4958130233867;4039.35370340747;4048.089179934506;4050.3721923101966;3398.8470518826466;3532.434810430319;3602.3335682898487;3606.134527713356;3613.313470440608;4957.851264462072;5005.874853128701;5007.549320561167;5029.7736601853;5037.345145131146;4506.188886000518;4524.3213517972235;4528.796204170821;4535.319702044687;4576.748278844662;5117.48825117489;5288.8413347599635;5292.523672869422;5298.781280305513;5299.906536917934;3804.5814960354337;3866.3427217373114;3869.187470631171;3869.7484663497066;3876.341022026234;5473.877855039707;5481.75332110056;5485.177223416479;5497.862553436156;5509.531689806371;3802.4486449465226;3870.8645197417954;3872.8063596820048;3877.2439374321734;3894.415837624322;3912.6478616924614;3927.3127202739406;3944.8224829882724;3963;3968.0873399118364;4500.234960056799;4502.279635258343;4512.706674066175;4516.458025036951;4530.909381812346;5332.866678333073;5335.199720042025;5338.332708411449;5339.839804805862;5347.689815995028;1312.6587087357166;1359.198073136854;1373.7870630052357;1375.18863870317;1384.5154196031308;857.8970523537215;877.6050777150308;885.840548701227;886.8492356299315;892.3173772064376;4569.281277639799;4569.885752856205;4586.793594288265;4588.357629931812;4609.7695115244105;4780.880477988078;4813.253945638432;4819.566239038503;4820.758962051884;4824.903501929942;4556.650861616709;4567.954320456753;4573.451185857652;4578.221702310615;4583.931241031387;2703.5133675938127;2873.6407949006375;2879.3953269813155;2901.9251235366814;2907.6334122962176;5679.716014199274;5688;5688.40271771458;5696.231008813757;5698.458646428583;5431.891362172813;5565.499105080562;5593.804216852472;5603.215549823028;5625.634333768292;5591.8881622368135;5616.747246373923;5639.2668953035845;5640.520555752725;5664.660120392789;5457.263269458573;5489.709918169307;5506.284183056177;5524.66851988882;5534.08687566547;5297.8145764898045;5342.9465705342445;5419.376771671308;5465.37148227943;5485.204645326326;5695.401982791913;5708.514776244066;5710.915515836773;5712;5719.456651618089;3722.10669439338;3814.1418180909072;3888.3778595424596;3925.4504369387737;3934.5475270344277;5120.462351453193;5499.50504454601;5548.781706610076;5554.250176226158;5555.416681248573;5403.540699040625;5406.243125962447;5417.83746487606;5425.13197888336;5439.836804895859;5157.355330583677;5390.595705322038;5397.865053373697;5429.484199001088;5434.184872269191;5357.383900851452;5374.543163830962;5434.510894019557;5441.891162176814;5443.374011988513;5450.373207081077;5492.286002819608;5492.368377636463;5493.09363954943;5494.500002498774;5152.252923326172;5297.682139071668;5331.107456852761;5335.718533102036;5347.438518955453 19:46:55 INFO - PROCESS | 15989 | |5;yui.html;743.1824992508242;744.1925510820763;750.470918002808;774.3418094619574;797.952122872628;15639.687206255881;16894.831051689478;16971.91514042428;17020.404285849996;17033.7444938326;15081.321340539675;15304.23478826057;15305.540833774976;15306.387744490235;15313.540593782205;661.5071771530216;673.7170388436843;786.952782833029;790.9762707118796;813.7029984055806;772.6098320348216;813.780279324585;822.7901885019312;822.9629666665014;823.086374124721;879.0242830458218;883.152173913041;884.2042162054138;884.4251236696167;884.95575221239;693.5076095971866;710.1229980973494;880.3617377401397;882.6734108379876;883.0948278015022;608.0362625239002;618.0698049435571;618.245740196959;620.7330847735471;625.4527288622455;13786.103903246258;13788.793168102486;13812.171269723749;13816.171029738249;13828.308584570732;13926.234057126854;14209.573712788633;14617.196054217015;14665.193414362206;14797.482088126864;12442.253464792142;12574.874251257463;12667.176633518791;12758;12793.296368699717;4238.936415953764;4298.763568003758;4303.751911945532;4312.611864932172;4321.913561728779;79798.60100699459;79922.6003869977;79995.80006299968;80147;80150.19849801486;10722.641018975813;10785.62250321235;11181.105511559055;11280.379579123228;11650.6504804856;21244.89377553133;21248.575028499654;21262.78737212639;21272.680909786366;21282.467938301357;8303.04514980773;8320.70877519284;8552;8560.700375486953;8564.3148548116;4567.337736028324;4617.12274667812;4706.1999460091865;4910;4988.152014157602;3316.6351701312838;3361.83190840457;3403.4894765784834;3414.504896790001;3430.2281986552825;576.4322142689448;585.718854949618;595.4164918380012;606.3936063936064;628.8302158417293;540.151961420566;578.467809615155;638.2436812377348;640.6508452893185;656.5929123943185;8740.06186504623;9244.722658320261;9292.210162136158;9323.906760932305;9583.472908990072;654.8166513376262;671.385682100882;679.3681875855502;684.5139950635005;688.9345512176435;4305.815900627353;4383.180979893308;4665.300204969214;4725.4565724941385;4787.952120478821;112583;113655.43172284086;115461;117315.41342293234;120970;72678.63660681662;89435.10564894398;100816.49591751995;101436;103578;87981;89967;90304.99999999869;91257.54371228101;92394.07605923989;8558.700445484626;8582.699605513777;8629.913700862911;8737.475751454933;8979.82040359176;51096;51249.23126153185;51403.0605868203;52740;53358.733206333716;66038.67922641616;68773;75380.62309688417;75828.24171758212;78483.60758196173;10518.263721539724;11010.284331518425;11218.663440096483;11219.326840389604;11420.371879546705;11795.646130616095;11796.587119450778;12188.390580471118;12578.433970471167;13025.674358141123;11326.32042077478;11370.31778093317;11721.882781172078;11791.646250612495;11879.76240475203;11183.273087249303;11488.655340339803;11760.411979400824;11880.168388212742;11916.940415297868;10356.792864142826;10517.15862730995;10802.081823044815;10854.891451085705;11141.888581114084;8820.91179088201;8952.820943581222;9304.95347523258;9794.412335259907;9822.557984890555;7831.608419579112;7910.169432209766;8710.116287152883;9018.86471702938;9472.621095156117 19:46:55 INFO - PROCESS | 15989 | __end_tp_report 19:46:55 INFO - PROCESS | 15989 | __start_cc_report 19:46:55 INFO - PROCESS | 15989 | _x_x_mozilla_cycle_collect,1279 19:46:55 INFO - PROCESS | 15989 | __end_cc_report 19:46:55 INFO - PROCESS | 15989 | __startTimestamp1476326815020__endTimestamp 19:46:55 INFO - PROCESS | 15989 | 19:46:55 INFO - PROCESS | 15989 | ------- Summary: start ------- 19:46:55 INFO - PROCESS | 15989 | Number of tests: 6 19:46:55 INFO - PROCESS | 15989 | 19:46:55 INFO - PROCESS | 15989 | [#0] dojo.html Cycles:165 Average:5222.08 Median:5406.95 stddev:567.23 (10.5%) stddev-sans-first:541.81 19:46:55 INFO - PROCESS | 15989 | Values: 3011.4 3041.4 3054.8 3068.5 3103.8 5093.3 5183.7 5207.5 5283.6 5306.7 5234.5 5244.8 5318.8 5320.1 5431.9 4776.3 4840.1 4869.7 4875.8 4897.4 4830.5 4855.0 4858.9 4859.3 4891.5 4917.8 4938.4 4945.7 4986.6 4995.1 4708.0 4741.4 4742.4 4886.3 4950.4 4676.3 4716.1 4731.8 4750.3 4795.4 5121.5 5141.9 5166.8 5181.5 5224.8 5527.3 5534.4 5536.4 5537.1 5548.1 5473.2 5531.3 5626.0 5679.4 5686.6 5297.7 5307.5 5315.2 5316.5 5364.8 5761.9 5769.9 5781.9 5782.7 5786.8 5350.1 5450.4 5456.0 5579.9 5640.7 5548.8 5588.1 5593.9 5609.7 5626.7 5549.6 5555.7 5558.8 5563.1 5652.7 5439.8 5605.3 5613.3 5614.5 5618.1 4243.7 4364.2 4365.0 4365.7 4367.1 3918.5 3926.3 3946.8 3949.6 3951.0 5240.7 5244.1 5293.7 5362.6 5371.7 5559.6 5610.3 5612.1 5613.4 5621.2 5264.8 5292.1 5297.5 5308.4 5338.6 4811.3 4828.6 4837.6 4843.5 4866.1 5764.7 5764.8 5768.9 5772.5 5821.4 5547.7 5588.5 5598.5 5598.7 5603.2 5593.0 5645.9 5739.1 5744.3 5792.0 5553.6 5556.5 5558.4 5596.3 5607.5 5614.8 5627.1 5629.8 5659.2 5671.9 5352.6 5413.9 5456.5 5512.1 5516.0 5478.2 5506.1 5515.8 5567.8 5579.4 5440.1 5500.1 5501.7 5505.3 5525.8 5348.0 5406.9 5417.0 5527.6 5559.6 5314.9 5336.5 5387.4 5390.5 5391.2 19:46:55 INFO - PROCESS | 15989 | 19:46:55 INFO - PROCESS | 15989 | [#1] ext.html Cycles:180 Average:54110.45 Median:39917.50 stddev:100619.95 (252.1%) stddev-sans-first:100821.87 19:46:55 INFO - PROCESS | 15989 | Values: 555.7 596.9 599.7 607.1 612.6 31404.8 34977.8 34993.7 35006.8 35145.0 34814.8 42541.0 43918.0 43926.1 48500.3 8796.7 8896.2 8934.9 8938.8 8943.9 8715.1 8832.6 8848.6 8864.1 8864.3 8881.2 8922.8 8926.8 8930.5 8936.2 8867.8 8895.4 8897.6 8909.4 8935.6 8771.8 8819.6 8841.8 8845.6 8850.3 43349.3 43581.1 43611.6 43621.6 43628.1 3490.1 3669.6 3707.6 3800.8 3875.0 31785.7 32184.2 32195.2 33432.7 33751.0 4233.3 4245.4 4302.4 4351.2 4487.4 310322.0 310860.6 311018.0 312981.0 314227.0 57554.0 57596.0 57719.1 57931.7 58016.0 59936.7 59980.7 60000.7 60024.0 60208.0 14502.5 14692.2 14715.2 14725.7 14733.0 11132.2 11175.9 11191.5 11194.8 11210.3 15543.7 17840.5 17884.5 17886.4 17980.3 6283.4 6298.3 6380.5 6445.3 6538.5 912.4 1013.8 1015.9 1065.3 1078.3 29708.3 31344.7 31600.7 31623.2 32253.5 907.8 1052.7 1107.7 1122.5 1123.8 15693.0 16619.0 16707.7 16771.4 16771.8 469096.0 471204.0 471690.0 472999.0 474123.0 56745.1 57202.4 57348.7 57444.7 57561.0 1182.8 1208.5 1281.3 1303.9 1346.4 29492.3 32596.8 32741.8 32996.8 33185.2 47826.0 48297.3 48420.5 48420.5 48422.0 338712.0 340182.0 340433.0 341781.0 341913.0 28627.3 29545.4 29619.4 29636.3 39968.8 46725.5 46737.0 46803.0 47157.5 48540.0 38718.8 38920.2 38970.8 40145.8 41142.8 38906.0 38915.4 39188.0 39866.2 40448.6 39739.0 40010.6 40457.6 40849.8 41002.8 31783.0 35494.8 35706.0 36462.3 36634.3 27290.2 27444.0 27759.7 27933.4 27978.4 19:46:55 INFO - PROCESS | 15989 | 19:46:55 INFO - PROCESS | 15989 | [#2] jquery.html Cycles:180 Average:27641.88 Median:19727.06 stddev:76526.69 (387.9%) stddev-sans-first:76713.92 19:46:55 INFO - PROCESS | 15989 | Values: 347.4 352.9 369.1 379.6 390.5 14232.6 18095.5 18988.3 20101.8 20333.9 17707.2 17853.9 18300.7 18313.7 18492.0 5424.3 5692.4 5701.1 5710.3 5716.2 4143.6 4346.5 4367.7 5616.9 5714.3 6250.4 6279.7 6364.3 6371.4 6378.6 5441.5 5676.4 5703.8 6377.5 6382.7 5618.7 5648.5 5657.4 5657.5 5662.4 13443.7 16942.3 20305.9 21866.3 22077.6 2096.2 2301.0 2389.6 2651.2 2864.3 9541.0 9747.3 9868.5 10371.0 10400.7 1849.3 1859.8 1897.5 1933.8 1944.7 81357.0 81363.2 81656.6 83128.8 86421.0 10441.9 10496.6 10701.3 10721.7 10757.8 15152.5 15153.4 15163.8 15165.8 15192.8 7380.2 7482.3 7484.7 7521.5 7591.9 6957.1 7055.1 7075.9 7130.3 7316.8 4455.4 4567.3 4609.2 4686.2 4740.6 1862.8 1873.9 1876.0 1939.0 1960.2 838.8 961.6 994.6 1008.4 1042.0 17929.7 18617.5 19100.6 19414.2 19523.7 958.4 964.8 965.8 993.4 1004.2 10056.5 10479.1 10770.4 10775.8 10777.9 431103.0 460119.0 473743.0 473758.0 474662.0 85144.0 88526.0 89598.3 90183.0 93511.1 1000.2 1015.3 1044.7 1052.6 1062.1 16155.9 16853.0 17474.6 17646.6 17832.4 39063.6 39591.8 40279.2 40521.2 40915.0 52425.7 55101.7 56168.4 56585.2 57087.4 5469.9 7942.9 8280.5 8300.9 8489.4 9226.9 12080.3 12251.9 12692.2 12703.6 5858.4 6537.9 10725.3 11237.9 11350.2 10397.2 10636.8 10937.9 10994.9 11195.3 10891.7 10961.6 11136.8 11138.0 11813.9 7956.3 8155.9 8192.0 8240.8 8397.1 9759.6 10782.9 11085.7 11161.4 11196.4 19:46:55 INFO - PROCESS | 15989 | 19:46:55 INFO - PROCESS | 15989 | [#3] mootools.html Cycles:180 Average:5727.56 Median:4921.64 stddev:3307.23 (67.2%) stddev-sans-first:3299.79 19:46:55 INFO - PROCESS | 15989 | Values: 1302.4 1429.1 1478.3 1577.5 1782.2 7745.5 8609.3 8882.1 8893.2 9136.5 8972.9 9057.6 9058.6 9060.3 9064.2 2215.9 2234.7 2249.0 2260.5 2261.7 2201.3 2224.8 2292.6 2294.8 2299.9 2250.2 2260.8 2263.0 2267.3 2277.8 2166.6 2176.7 2192.4 2192.7 2193.0 2221.0 2230.3 2230.6 2235.5 2238.5 8700.6 8814.6 8882.7 8901.1 8923.8 5164.7 5386.7 5391.3 5401.3 5404.6 3409.4 3443.0 3453.4 3473.7 3501.7 1103.2 1119.8 1125.3 1146.6 1147.9 12252.1 12256.0 12292.8 12319.0 12328.1 4264.8 4468.1 4476.3 4554.5 4558.9 9720.7 9748.5 9757.4 9764.1 9765.8 5220.1 5238.7 5242.4 5251.7 5259.1 4043.1 4239.2 4406.0 4892.6 4894.9 3690.9 3727.5 3800.4 3803.4 3803.9 1148.2 1169.2 1177.8 1182.3 1182.8 917.4 926.8 930.8 934.1 951.8 5572.9 5611.1 5752.9 5772.8 5788.2 926.6 986.2 986.4 991.5 994.7 3542.6 3815.5 3877.5 3903.0 3993.2 10691.6 11083.5 11092.8 11111.4 11136.6 10307.7 10720.2 10989.5 11024.4 11038.4 7911.4 8079.2 8081.3 8096.7 8105.3 5662.2 5717.8 5776.4 5802.2 5950.3 10067.9 10196.6 10202.4 10210.6 10359.1 9146.2 9745.7 10136.6 10139.3 10395.1 7088.0 7331.7 7506.9 7591.9 7714.0 8439.8 8540.9 8615.3 8621.1 8701.5 7694.8 7747.0 7889.6 7898.7 7923.2 7690.5 7818.0 7870.8 7904.6 8010.1 6862.9 7006.5 7069.7 7075.4 7085.8 4839.5 4926.9 4930.3 5002.0 5014.1 4818.3 4916.4 4954.7 4962.4 4964.2 19:46:55 INFO - PROCESS | 15989 | 19:46:55 INFO - PROCESS | 15989 | [#4] prototype.html Cycles:180 Average:4469.80 Median:5033.56 stddev:1313.89 (26.1%) stddev-sans-first:1279.82 19:46:55 INFO - PROCESS | 15989 | Values: 303.4 311.7 318.7 322.4 324.8 4967.2 5087.4 5115.4 5135.9 5182.6 4939.0 5061.3 5085.4 5112.0 5128.5 4076.7 4083.1 4084.0 4086.6 4086.8 3971.4 4078.9 4082.3 4086.0 4094.7 4027.9 4046.9 4053.3 4059.0 4060.9 4022.2 4033.5 4039.4 4048.1 4050.4 3398.8 3532.4 3602.3 3606.1 3613.3 4957.9 5005.9 5007.5 5029.8 5037.3 4506.2 4524.3 4528.8 4535.3 4576.7 5117.5 5288.8 5292.5 5298.8 5299.9 3804.6 3866.3 3869.2 3869.7 3876.3 5473.9 5481.8 5485.2 5497.9 5509.5 3802.4 3870.9 3872.8 3877.2 3894.4 3912.6 3927.3 3944.8 3963.0 3968.1 4500.2 4502.3 4512.7 4516.5 4530.9 5332.9 5335.2 5338.3 5339.8 5347.7 1312.7 1359.2 1373.8 1375.2 1384.5 857.9 877.6 885.8 886.8 892.3 4569.3 4569.9 4586.8 4588.4 4609.8 4780.9 4813.3 4819.6 4820.8 4824.9 4556.7 4568.0 4573.5 4578.2 4583.9 2703.5 2873.6 2879.4 2901.9 2907.6 5679.7 5688.0 5688.4 5696.2 5698.5 5431.9 5565.5 5593.8 5603.2 5625.6 5591.9 5616.7 5639.3 5640.5 5664.7 5457.3 5489.7 5506.3 5524.7 5534.1 5297.8 5342.9 5419.4 5465.4 5485.2 5695.4 5708.5 5710.9 5712.0 5719.5 3722.1 3814.1 3888.4 3925.5 3934.5 5120.5 5499.5 5548.8 5554.3 5555.4 5403.5 5406.2 5417.8 5425.1 5439.8 5157.4 5390.6 5397.9 5429.5 5434.2 5357.4 5374.5 5434.5 5441.9 5443.4 5450.4 5492.3 5492.4 5493.1 5494.5 5152.3 5297.7 5331.1 5335.7 5347.4 19:46:55 INFO - PROCESS | 15989 | 19:46:55 INFO - PROCESS | 15989 | [#5] yui.html Cycles:180 Average:20424.97 Median:52071.53 stddev:30235.45 (58.1%) stddev-sans-first:30284.15 19:46:55 INFO - PROCESS | 15989 | Values: 743.2 744.2 750.5 774.3 798.0 15639.7 16894.8 16971.9 17020.4 17033.7 15081.3 15304.2 15305.5 15306.4 15313.5 661.5 673.7 787.0 791.0 813.7 772.6 813.8 822.8 823.0 823.1 879.0 883.2 884.2 884.4 885.0 693.5 710.1 880.4 882.7 883.1 608.0 618.1 618.2 620.7 625.5 13786.1 13788.8 13812.2 13816.2 13828.3 13926.2 14209.6 14617.2 14665.2 14797.5 12442.3 12574.9 12667.2 12758.0 12793.3 4238.9 4298.8 4303.8 4312.6 4321.9 79798.6 79922.6 79995.8 80147.0 80150.2 10722.6 10785.6 11181.1 11280.4 11650.7 21244.9 21248.6 21262.8 21272.7 21282.5 8303.0 8320.7 8552.0 8560.7 8564.3 4567.3 4617.1 4706.2 4910.0 4988.2 3316.6 3361.8 3403.5 3414.5 3430.2 576.4 585.7 595.4 606.4 628.8 540.2 578.5 638.2 640.7 656.6 8740.1 9244.7 9292.2 9323.9 9583.5 654.8 671.4 679.4 684.5 688.9 4305.8 4383.2 4665.3 4725.5 4788.0 112583.0 113655.4 115461.0 117315.4 120970.0 72678.6 89435.1 100816.5 101436.0 103578.0 87981.0 89967.0 90305.0 91257.5 92394.1 8558.7 8582.7 8629.9 8737.5 8979.8 51096.0 51249.2 51403.1 52740.0 53358.7 66038.7 68773.0 75380.6 75828.2 78483.6 10518.3 11010.3 11218.7 11219.3 11420.4 11795.6 11796.6 12188.4 12578.4 13025.7 11326.3 11370.3 11721.9 11791.6 11879.8 11183.3 11488.7 11760.4 11880.2 11916.9 10356.8 10517.2 10802.1 10854.9 11141.9 8820.9 8952.8 9305.0 9794.4 9822.6 7831.6 7910.2 8710.1 9018.9 9472.6 19:46:55 INFO - PROCESS | 15989 | -------- Summary: end -------- 19:46:55 INFO - PROCESS | 15989 | 19:46:55 INFO - TEST-INFO | 15989: exit 0 19:46:55 INFO - TEST-OK | dromaeo_css | took 1117042ms 19:46:55 INFO - TEST-START | kraken 19:46:55 INFO - operating with platform_type : linux_ 19:46:55 INFO - Initialising browser for kraken test... 19:46:55 INFO - TEST-INFO | started process 16298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnL14F3/profile http://localhost:42303/getInfo.html) 19:46:59 INFO - PROCESS | 16298 | __metrics Screen width/height:1600/1200 19:46:59 INFO - PROCESS | 16298 | colorDepth:24 19:46:59 INFO - PROCESS | 16298 | Browser inner width/height: 1024/697 19:46:59 INFO - PROCESS | 16298 | __metrics 19:47:00 INFO - PROCESS | 16298 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 19:47:00 INFO - PROCESS | 16298 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:47:00 INFO - PROCESS | 16298 | console.error: PushService: 19:47:00 INFO - PROCESS | 16298 | stateChangeProcessEnqueue: Error transitioning state 19:47:00 INFO - PROCESS | 16298 | UnknownError 19:47:01 INFO - TEST-INFO | 16298: exit 0 19:47:01 INFO - Browser initialized. 19:47:01 INFO - Running cycle 1/1 for kraken test... 19:47:01 INFO - TEST-INFO | started process 16379 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnL14F3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:47:13 INFO - PROCESS | 16379 | RSS: Main: 172412928 19:47:13 INFO - PROCESS | 16379 | 19:47:16 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42303/tests/kraken/driver.html?testName=audio-beat-detection) 19:47:17 INFO - PROCESS | 16379 | RSS: Main: 231628800 19:47:17 INFO - PROCESS | 16379 | 19:47:19 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42303/tests/kraken/driver.html?testName=audio-dft) 19:47:20 INFO - PROCESS | 16379 | RSS: Main: 216338432 19:47:20 INFO - PROCESS | 16379 | 19:47:23 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42303/tests/kraken/driver.html?testName=audio-fft) 19:47:24 INFO - PROCESS | 16379 | RSS: Main: 298184704 19:47:24 INFO - PROCESS | 16379 | 19:47:26 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42303/tests/kraken/driver.html?testName=audio-oscillator) 19:47:26 INFO - PROCESS | 16379 | RSS: Main: 209424384 19:47:26 INFO - PROCESS | 16379 | 19:47:29 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42303/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:47:29 INFO - PROCESS | 16379 | RSS: Main: 212086784 19:47:29 INFO - PROCESS | 16379 | 19:47:32 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42303/tests/kraken/driver.html?testName=imaging-darkroom) 19:47:33 INFO - PROCESS | 16379 | RSS: Main: 248672256 19:47:33 INFO - PROCESS | 16379 | 19:47:36 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42303/tests/kraken/driver.html?testName=imaging-desaturate) 19:47:37 INFO - PROCESS | 16379 | RSS: Main: 247095296 19:47:37 INFO - PROCESS | 16379 | 19:47:40 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42303/tests/kraken/driver.html?testName=json-parse-financial) 19:47:40 INFO - PROCESS | 16379 | RSS: Main: 247443456 19:47:40 INFO - PROCESS | 16379 | 19:47:42 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42303/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:47:42 INFO - PROCESS | 16379 | RSS: Main: 209469440 19:47:42 INFO - PROCESS | 16379 | 19:47:44 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42303/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:47:45 INFO - PROCESS | 16379 | RSS: Main: 217305088 19:47:45 INFO - PROCESS | 16379 | 19:47:47 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42303/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:47:47 INFO - PROCESS | 16379 | RSS: Main: 225906688 19:47:47 INFO - PROCESS | 16379 | 19:47:50 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:47:51 INFO - PROCESS | 16379 | RSS: Main: 234774528 19:47:51 INFO - PROCESS | 16379 | 19:47:53 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:47:54 INFO - PROCESS | 16379 | RSS: Main: 231841792 19:47:54 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | Cycle 1(1): loaded http://localhost:42303/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42303/tests/kraken/driver.html?testName=ai-astar) 19:47:56 INFO - PROCESS | 16379 | RSS: Main: 282267648 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | __start_tp_report 19:47:56 INFO - PROCESS | 16379 | _x_x_mozilla_page_load 19:47:56 INFO - PROCESS | 16379 | _x_x_mozilla_page_load_details 19:47:56 INFO - PROCESS | 16379 | |i|pagename|runs| 19:47:56 INFO - PROCESS | 16379 | |0;ai-astar;110;111;112;111;114;111;112;114;110;111 19:47:56 INFO - PROCESS | 16379 | |1;audio-beat-detection;155;122;129;169;123;133;129;126;174;123 19:47:56 INFO - PROCESS | 16379 | |2;audio-dft;162;162;160;161;164;162;163;162;160;162 19:47:56 INFO - PROCESS | 16379 | |3;audio-fft;75;75;76;114;76;77;76;76;102;74 19:47:56 INFO - PROCESS | 16379 | |4;audio-oscillator;83;82;119;82;82;82;105;82;82;117 19:47:56 INFO - PROCESS | 16379 | |5;imaging-gaussian-blur;118;116;117;117;117;116;117;118;117;117 19:47:56 INFO - PROCESS | 16379 | |6;imaging-darkroom;146;147;147;146;147;147;148;146;146;146 19:47:56 INFO - PROCESS | 16379 | |7;imaging-desaturate;95;96;95;95;95;95;95;95;94;95 19:47:56 INFO - PROCESS | 16379 | |8;json-parse-financial;52;52;53;52;52;53;53;52;54;52 19:47:56 INFO - PROCESS | 16379 | |9;json-stringify-tinderbox;61;61;61;62;62;66;62;62;62;62 19:47:56 INFO - PROCESS | 16379 | |10;stanford-crypto-aes;82;85;78;79;79;80;79;79;79;79 19:47:56 INFO - PROCESS | 16379 | |11;stanford-crypto-ccm;136;130;131;129;139;129;144;134;171;130 19:47:56 INFO - PROCESS | 16379 | |12;stanford-crypto-pbkdf2;166;172;170;164;168;165;164;168;167;163 19:47:56 INFO - PROCESS | 16379 | |13;stanford-crypto-sha256-iterative;68;66;67;66;67;76;67;67;66;67 19:47:56 INFO - PROCESS | 16379 | __end_tp_report 19:47:56 INFO - PROCESS | 16379 | __start_cc_report 19:47:56 INFO - PROCESS | 16379 | _x_x_mozilla_cycle_collect,1690 19:47:56 INFO - PROCESS | 16379 | __end_cc_report 19:47:56 INFO - PROCESS | 16379 | __startTimestamp1476326876441__endTimestamp 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | ------- Summary: start ------- 19:47:56 INFO - PROCESS | 16379 | Number of tests: 14 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#0] ai-astar Cycles:10 Average:111.60 Median:111.50 stddev:1.43 (1.3%) stddev-sans-first:1.39 19:47:56 INFO - PROCESS | 16379 | Values: 110.0 111.0 112.0 111.0 114.0 111.0 112.0 114.0 110.0 111.0 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#1] audio-beat-detection Cycles:10 Average:138.30 Median:131.00 stddev:19.95 (15.2%) stddev-sans-first:20.22 19:47:56 INFO - PROCESS | 16379 | Values: 155.0 122.0 129.0 169.0 123.0 133.0 129.0 126.0 174.0 123.0 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 19:47:56 INFO - PROCESS | 16379 | Values: 162.0 162.0 160.0 161.0 164.0 162.0 163.0 162.0 160.0 162.0 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#3] audio-fft Cycles:10 Average:82.10 Median:76.00 stddev:13.96 (18.4%) stddev-sans-first:14.57 19:47:56 INFO - PROCESS | 16379 | Values: 75.0 75.0 76.0 114.0 76.0 77.0 76.0 76.0 102.0 74.0 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:82.00 stddev:15.64 (19.1%) stddev-sans-first:16.28 19:47:56 INFO - PROCESS | 16379 | Values: 83.0 82.0 119.0 82.0 82.0 82.0 105.0 82.0 82.0 117.0 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 19:47:56 INFO - PROCESS | 16379 | Values: 118.0 116.0 117.0 117.0 117.0 116.0 117.0 118.0 117.0 117.0 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 19:47:56 INFO - PROCESS | 16379 | Values: 146.0 147.0 147.0 146.0 147.0 147.0 148.0 146.0 146.0 146.0 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 19:47:56 INFO - PROCESS | 16379 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:52.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 19:47:56 INFO - PROCESS | 16379 | Values: 52.0 52.0 53.0 52.0 52.0 53.0 53.0 52.0 54.0 52.0 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#9] json-stringify-tinderbox Cycles:10 Average:62.10 Median:62.00 stddev:1.45 (2.3%) stddev-sans-first:1.48 19:47:56 INFO - PROCESS | 16379 | Values: 61.0 61.0 61.0 62.0 62.0 66.0 62.0 62.0 62.0 62.0 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:79.00 stddev:2.08 (2.6%) stddev-sans-first:2.06 19:47:56 INFO - PROCESS | 16379 | Values: 82.0 85.0 78.0 79.0 79.0 80.0 79.0 79.0 79.0 79.0 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:135.00 stddev:12.82 (9.5%) stddev-sans-first:13.59 19:47:56 INFO - PROCESS | 16379 | Values: 136.0 130.0 131.0 129.0 139.0 129.0 144.0 134.0 171.0 130.0 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.50 stddev:2.87 (1.7%) stddev-sans-first:3.03 19:47:56 INFO - PROCESS | 16379 | Values: 166.0 172.0 170.0 164.0 168.0 165.0 164.0 168.0 167.0 163.0 19:47:56 INFO - PROCESS | 16379 | 19:47:56 INFO - PROCESS | 16379 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:2.98 (4.5%) stddev-sans-first:3.16 19:47:56 INFO - PROCESS | 16379 | Values: 68.0 66.0 67.0 66.0 67.0 76.0 67.0 67.0 66.0 67.0 19:47:56 INFO - PROCESS | 16379 | -------- Summary: end -------- 19:47:56 INFO - PROCESS | 16379 | 19:47:57 INFO - TEST-INFO | 16379: exit 0 19:47:57 INFO - TEST-OK | kraken | took 61679ms 19:47:57 INFO - SUITE-END | took 1178s 19:47:58 INFO - Completed test suite (00:19:39) 19:47:58 INFO - javascript benchmark 19:47:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3011.367612801312, 3041.4221297953372, 3054.7708921830863, 3068.493698539741, 3103.7516998640112, 5093.337866077405, 5183.663061900974, 5207.5052869977335, 5283.630145889784, 5306.7346632668405, 5234.50272224139, 5244.79020839166, 5318.840434786953, 5320.122179840331, 5431.891362172754, 4776.307435421862, 4840.056189043138, 4869.65912386134, 4875.780589873464, 4897.3878265216845, 4830.541098595628, 4854.951450485485, 4858.902821943577, 4859.343988561552, 4891.5353041461185, 4917.803287868481, 4938.407391113054, 4945.67853089548, 4986.551210391064, 4995.075910956467, 4708.0, 4741.407324084489, 4742.383490146259, 4886.315915771759, 4950.381202349707, 4676.251799712029, 4716.103940251342, 4731.763411829429, 4750.334953106568, 4795.376601041842, 5121.539061484485, 5141.922871156936, 5166.767495462713, 5181.53366197044, 5224.843254702365, 5527.281453411071, 5534.446555344473, 5536.4186760389985, 5537.1140617501405, 5548.056830338812, 5473.2063850741415, 5531.25328080708, 5626.0, 5679.4036626154075, 5686.5735069869515, 5297.655652382583, 5307.52232299095, 5315.1761476971515, 5316.4683531646915, 5364.785408583652, 5761.9135712964335, 5769.88460230793, 5781.855453613609, 5782.6819524925695, 5786.797462088891, 5350.117230656898, 5450.400455949843, 5456.0, 5579.9163012554845, 5640.717964101778, 5548.750306236229, 5588.050031494575, 5593.888122237532, 5609.747561359749, 5626.718664066862, 5549.5837812163445, 5555.694436805934, 5558.805441809517, 5563.13771365439, 5652.660840349592, 5439.809606663748, 5605.299337582802, 5613.326400831845, 5614.522765564891, 5618.129189975561, 4243.724157929724, 4364.214441400578, 4364.956350436519, 4365.694401391936, 4367.061081867414, 3918.4710064140977, 3926.254011737818, 3946.7631942083567, 3949.624785645359, 3950.9529974556767, 5240.737963101829, 5244.134717771602, 5293.708846013429, 5362.624616276901, 5371.677699338053, 5559.577240480675, 5610.326760788732, 5612.130119831432, 5613.410591887875, 5621.213030175779, 5264.78940842362, 5292.126799078109, 5297.54970827484, 5308.362996440452, 5338.599605029638, 4811.254255590389, 4828.589569886529, 4837.564619184291, 4843.491433399513, 4866.124097662455, 5764.682942438122, 5764.769409223752, 5768.884622307531, 5772.480476757028, 5821.446962538552, 5547.694876781816, 5588.524975377139, 5598.468145526169, 5598.720063996865, 5603.243562119224, 5593.049181639212, 5645.887082258414, 5739.053056245672, 5744.253247077853, 5791.971040144772, 5553.611247212656, 5556.499915007668, 5558.3607885092115, 5596.300462442195, 5607.495325420732, 5614.803481878114, 5627.071533196977, 5629.831105066854, 5659.179418984142, 5671.943280567141, 5352.5985551084605, 5413.945860541344, 5456.508914197582, 5512.090505066619, 5515.972420137874, 5478.205660179331, 5506.091494903296, 5515.751791169327, 5567.77728890856, 5579.414161512983, 5440.102383106743, 5500.147477141049, 5501.669899806025, 5505.284313039279, 5525.806596769094, 5347.973260133675, 5406.945930540644, 5416.972915135557, 5527.565568828004, 5559.555235581225, 5314.8937021260135, 5336.546393556591, 5387.434319396407, 5390.541803946709, 5391.245225668331], "value": 5185.243494001051, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.7471350535507, 596.8985272503674, 599.7421108923161, 607.1045208317735, 612.6048698589409, 31404.84297578512, 34977.82511087447, 34993.65006349936, 35006.824965875196, 35145.0, 34814.82592587033, 42541.0, 43918.0, 43926.12147757043, 48500.272495912504, 8796.736097917057, 8896.154865287788, 8934.865977010317, 8938.776530586754, 8943.910560894374, 8715.084916083782, 8832.602532886003, 8848.5575721214, 8864.113588641148, 8864.290856731446, 8881.200691937724, 8922.821543569156, 8926.821463570725, 8930.508822014786, 8936.195742383185, 8867.77830554238, 8895.421797583136, 8897.644094236222, 8909.376343655947, 8935.64257429702, 8771.78070548235, 8819.559022048872, 8841.778955526099, 8845.557722113868, 8850.291976641853, 43349.349759753626, 43581.12837743259, 43611.63883611614, 43621.563784362064, 43628.127437451076, 3490.0925759302763, 3669.5779985301765, 3707.6292370762976, 3800.7529510582, 3874.9987583315983, 31785.728570857136, 32184.195395115075, 32195.19512012195, 33432.66567334344, 33751.0, 4233.308040607225, 4245.405643209953, 4302.397664326965, 4351.216780979423, 4487.371767952489, 310322.0, 310860.56557737663, 311018.0, 312980.99999999773, 314227.0, 57554.0, 57596.0, 57719.134212986835, 57931.71034144802, 58016.0, 59936.70031649901, 59980.70009650011, 60000.69999649974, 60024.0, 60208.0, 14502.492412765714, 14692.191929443983, 14715.19066451334, 14725.705485890223, 14733.0, 11132.165087618461, 11175.888241117647, 11191.496382662799, 11194.832077518844, 11210.327380357205, 15543.689126217412, 17840.46478605644, 17884.463466096036, 17886.373976910745, 17980.280788768563, 6283.37166283368, 6298.307186209513, 6380.457661098766, 6445.323241059715, 6538.509611779041, 912.4160537256162, 1013.8428543575758, 1015.9136473399844, 1065.3394895165047, 1078.250615822012, 29708.257293567833, 31344.686553134634, 31600.683993159775, 31623.20941976469, 32253.452120266753, 907.7594437474074, 1052.652624633869, 1107.7286064914147, 1122.5341483284508, 1123.8201887698092, 15693.0, 16619.0, 16707.749383759252, 16771.413000544922, 16771.832281677027, 469096.0, 471204.0, 471690.0, 472999.0, 474123.0, 56745.14882276769, 57202.427975720544, 57348.71325643345, 57444.71277643585, 57561.0, 1182.8284898689642, 1208.5407545132969, 1281.2568710148091, 1303.9152455090577, 1346.4277681985118, 29492.262693432836, 32596.83701581572, 32741.83629081839, 32996.83501582477, 33185.170370740925, 47826.0, 48297.27554086621, 48420.5157948416, 48420.5157948416, 48422.0, 338712.0, 340182.0, 340433.0, 341781.0, 341913.0, 28627.284317891386, 29545.40909181761, 29619.407611848073, 29636.259093522833, 39968.80015599904, 46725.53274467348, 46737.0, 46803.0, 47157.52842471531, 48540.0, 38718.772965649274, 38920.22159556737, 38970.805145975224, 40145.79927100346, 41142.79428602838, 38906.0, 38915.41626875543, 39188.0, 39866.20267594574, 40448.59551404566, 39739.0, 40010.59989400069, 40457.59542404656, 40849.795751021054, 41002.84957256435, 31783.0, 35494.822525887204, 35706.0, 36462.27075458529, 36634.26731465409, 27290.181294561196, 27444.0, 27759.722402775715, 27933.441331173668, 27978.440431190855], "value": 19328.082531339525, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.43194876377146, 352.8817846021583, 369.10492056762354, 379.5843551311313, 390.50600989747954, 14232.644183895407, 18095.547611309707, 18988.335408260715, 20101.798982010176, 20333.898330508364, 17707.203175857085, 17853.91073044633, 18300.72548911764, 18313.725294120566, 18491.982940938244, 5424.349078110622, 5692.402297758737, 5701.116326969326, 5710.257666503348, 5716.1711551824965, 4143.564925682806, 4346.521882592912, 4367.737935723851, 5616.887662246752, 5714.25714657094, 6250.374962503759, 6279.68601569922, 6364.2681091674585, 6371.394717501853, 6378.617282963014, 5441.455854414547, 5676.375598684142, 5703.800366987177, 6377.521685873555, 6382.712777924981, 5618.7190640468225, 5648.491635752802, 5657.377688454267, 5657.462541058593, 5662.405447428043, 13443.731125377437, 16942.3223071077, 20305.88317642529, 21866.344009679575, 22077.558448831092, 2096.1510588211645, 2300.9654855177187, 2389.569877422063, 2651.180032126529, 2864.3412015236404, 9540.952295238549, 9747.268954828345, 9868.45723485208, 10371.0, 10400.687979360631, 1849.2880241107136, 1859.8326150646508, 1897.5351038995395, 1933.835623971964, 1944.6888497840278, 81357.0, 81363.18636813674, 81656.59171704162, 83128.75306870401, 86420.99999999937, 10441.947790261, 10496.632617858339, 10701.304415212986, 10721.731956701145, 10757.83863242052, 15152.545423637308, 15153.393864245307, 15163.848361516244, 15165.848341516665, 15192.772108418383, 7380.225076366904, 7482.289182527651, 7484.663190156456, 7521.4734968551675, 7591.932407184963, 6957.095577574883, 7055.118110236221, 7075.929240707527, 7130.290749244104, 7316.780496585111, 4455.376247325377, 4567.332923482905, 4609.193391156534, 4686.203345431285, 4740.6444516660695, 1862.841658459019, 1873.9063046847602, 1876.0041112430708, 1938.9709154362695, 1960.1767257751778, 838.773531146587, 961.6297725375781, 994.5773046455372, 1008.4432404642874, 1041.9788607165021, 17929.7310540342, 18617.534561635795, 19100.61798764017, 19414.2234310626, 19523.707144392847, 958.4297343080856, 964.7781010367655, 965.8406362950035, 993.3890657245742, 1004.1866088468364, 10056.547455364525, 10479.109275711497, 10770.407627580558, 10775.78448431027, 10777.892221077846, 431103.0, 460118.9881011872, 473743.0, 473758.0, 474662.0, 85144.0, 88526.0, 89598.30803533619, 90183.0, 93511.06488935159, 1000.1798525209404, 1015.294370412571, 1044.681372181492, 1052.552665117322, 1062.134360496193, 16155.919220403823, 16853.0, 17474.563135921704, 17646.558836029202, 17832.3758668446, 39063.609363906, 39591.80204098961, 40279.19441611093, 40521.1895762089, 40915.0, 52425.7378713104, 55101.72449137729, 56168.438315616324, 56585.15122273087, 57087.42912570821, 5469.863253418696, 7942.927704759783, 8280.544570048705, 8300.916990830256, 8489.4481858679, 9226.907730922605, 12080.335581542748, 12251.87748122543, 12692.238465692088, 12703.55537556218, 5858.414158584107, 6537.901931471127, 10725.30285531438, 11237.943810280896, 11350.205485615928, 10397.16822654201, 10636.787264254826, 10937.851525589698, 10994.890051099386, 11195.328280303207, 10891.67324980252, 10961.56153753841, 11136.777264454504, 11138.0, 11813.940930295294, 7956.323712484504, 8155.918440815516, 8191.959040204761, 8240.83518329642, 8397.118302578141, 9759.56081976327, 10782.946085269523, 11085.722856928642, 11161.386123762946, 11196.440177991231], "value": 8817.587504039739, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.4139137388179, 1429.099667209658, 1478.2904205981126, 1577.4636623548, 1782.224732241475, 7745.457817952739, 8609.311255099585, 8882.067382924797, 8893.199612034916, 9136.497492637902, 8972.8654070189, 9057.637694492212, 9058.637654493812, 9060.275177985763, 9064.22954048905, 2215.8781267030386, 2234.709487766588, 2248.9662655060188, 2260.547890421914, 2261.6607508873717, 2201.2955854126685, 2224.7552769195377, 2292.610256256432, 2294.7705229477087, 2299.908003679851, 2250.1561914282142, 2260.8078313343385, 2262.9773702263014, 2267.30847091637, 2277.840551161419, 2166.566686662674, 2176.662617294314, 2192.3642143778284, 2192.6710993351044, 2192.9890350548303, 2220.9555808883892, 2230.342049095521, 2230.5984922713906, 2235.4634887627017, 2238.4851484158735, 8700.608472618747, 8814.647414103429, 8882.689105881327, 8901.109889011112, 8923.776905577348, 5164.741762911839, 5386.703731294777, 5391.272178255964, 5401.297831281948, 5404.567634589223, 3409.4203985322556, 3443.0359499340225, 3453.4474484082675, 3473.7221022318154, 3501.7023552998025, 1103.194667892443, 1119.7872404243167, 1125.3416751200557, 1146.5528443906883, 1147.9483423245974, 12252.081093917903, 12256.019518438503, 12292.815607765891, 12318.99999999991, 12328.075394345371, 4264.786760661955, 4468.061707041557, 4476.261416866246, 4554.521775213621, 4558.8632341029825, 9720.659776907774, 9748.512574371394, 9757.414555126716, 9764.072413120743, 9765.755856103513, 5220.112580861187, 5238.711870847063, 5242.397124330674, 5251.737413129405, 5259.132243179909, 4043.130726893732, 4239.215745087169, 4406.030673251879, 4892.633052521004, 4894.926576101361, 3690.944635830465, 3727.5340582427198, 3800.4489349044234, 3803.410471376941, 3803.8858834235016, 1148.1675785055768, 1169.2283093158474, 1177.776222517719, 1182.3319824299244, 1182.798924182891, 917.3899356927568, 926.8321914387919, 930.8184903943666, 934.1265916368218, 951.8191543606692, 5572.860678482989, 5611.102223644198, 5752.884942301131, 5772.7690892363835, 5788.218590490314, 926.6478738079621, 986.2405947420447, 986.4475893499663, 991.5092029445326, 994.6568433890296, 3542.557180352456, 3815.523059617548, 3877.4765406670303, 3903.0437542802197, 3993.241284156059, 10691.625793097204, 11083.50124244411, 11092.833607495893, 11111.388873611868, 11136.61021864247, 10307.742306442398, 10720.195985301134, 10989.450527473595, 11024.393658348707, 11038.44807759625, 7911.406644501685, 8079.151689072681, 8081.272685458337, 8096.716614918568, 8105.2705256526015, 5662.178984047372, 5717.771289148387, 5776.393478684678, 5802.216700745345, 5950.285965684146, 10067.949660251652, 10196.59213631476, 10202.38785672862, 10210.642627508001, 10359.119474844723, 9146.222571081533, 9745.658901938397, 10136.594536218468, 10139.340942838691, 10395.116415104801, 7088.0, 7331.74338898136, 7506.887396688945, 7591.8861217080685, 7714.0, 8439.831203375776, 8540.914590854012, 8615.3107751381, 8621.051684314594, 8701.52141632191, 7694.846103077795, 7746.961265193638, 7889.64496597643, 7898.723544675909, 7923.1680673530755, 7690.538567685957, 7818.022747156606, 7870.842583148419, 7904.604769761604, 8010.078840933367, 6862.862742745017, 7006.5095443320515, 7069.681864316221, 7075.433965282868, 7085.82285442868, 4839.540243676845, 4926.8768280793265, 4930.309756634002, 5002.049610573979, 5014.122528557561, 4818.325434439112, 4916.410030796327, 4954.702717836942, 4962.354893863775, 4964.156093464047], "value": 4556.21516909797, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [303.43258107339267, 311.7163381322996, 318.74500399680255, 322.44861287198887, 324.7791501778792, 4967.230079337699, 5087.414947281064, 5115.360579927509, 5135.922961155586, 5182.611304152189, 4938.98721779715, 5061.266116413118, 5085.389753229609, 5112.0, 5128.512791284831, 4076.653484453825, 4083.081306705997, 4083.9795801020955, 4086.5504794472586, 4086.795660216992, 3971.4042893565907, 4078.8980275493054, 4082.326416141348, 4085.9795701021453, 4094.7338423002557, 4027.879163625081, 4046.9392959105635, 4053.27041132596, 4059.0, 4060.878173654795, 4022.2045678253626, 4033.4958130233867, 4039.35370340747, 4048.089179934506, 4050.3721923101966, 3398.8470518826466, 3532.434810430319, 3602.3335682898487, 3606.134527713356, 3613.313470440608, 4957.851264462072, 5005.874853128701, 5007.549320561167, 5029.7736601853, 5037.345145131146, 4506.188886000518, 4524.3213517972235, 4528.796204170821, 4535.319702044687, 4576.748278844662, 5117.48825117489, 5288.8413347599635, 5292.523672869422, 5298.781280305513, 5299.906536917934, 3804.5814960354337, 3866.3427217373114, 3869.187470631171, 3869.7484663497066, 3876.341022026234, 5473.877855039707, 5481.75332110056, 5485.177223416479, 5497.862553436156, 5509.531689806371, 3802.4486449465226, 3870.8645197417954, 3872.8063596820048, 3877.2439374321734, 3894.415837624322, 3912.6478616924614, 3927.3127202739406, 3944.8224829882724, 3963.0, 3968.0873399118364, 4500.234960056799, 4502.279635258343, 4512.706674066175, 4516.458025036951, 4530.909381812346, 5332.866678333073, 5335.199720042025, 5338.332708411449, 5339.839804805862, 5347.689815995028, 1312.6587087357166, 1359.198073136854, 1373.7870630052357, 1375.18863870317, 1384.5154196031308, 857.8970523537215, 877.6050777150308, 885.840548701227, 886.8492356299315, 892.3173772064376, 4569.281277639799, 4569.885752856205, 4586.793594288265, 4588.357629931812, 4609.7695115244105, 4780.880477988078, 4813.253945638432, 4819.566239038503, 4820.758962051884, 4824.903501929942, 4556.650861616709, 4567.954320456753, 4573.451185857652, 4578.221702310615, 4583.931241031387, 2703.5133675938127, 2873.6407949006375, 2879.3953269813155, 2901.9251235366814, 2907.6334122962176, 5679.716014199274, 5688.0, 5688.40271771458, 5696.231008813757, 5698.458646428583, 5431.891362172813, 5565.499105080562, 5593.804216852472, 5603.215549823028, 5625.634333768292, 5591.8881622368135, 5616.747246373923, 5639.2668953035845, 5640.520555752725, 5664.660120392789, 5457.263269458573, 5489.709918169307, 5506.284183056177, 5524.66851988882, 5534.08687566547, 5297.8145764898045, 5342.9465705342445, 5419.376771671308, 5465.37148227943, 5485.204645326326, 5695.401982791913, 5708.514776244066, 5710.915515836773, 5712.0, 5719.456651618089, 3722.10669439338, 3814.1418180909072, 3888.3778595424596, 3925.4504369387737, 3934.5475270344277, 5120.462351453193, 5499.50504454601, 5548.781706610076, 5554.250176226158, 5555.416681248573, 5403.540699040625, 5406.243125962447, 5417.83746487606, 5425.13197888336, 5439.836804895859, 5157.355330583677, 5390.595705322038, 5397.865053373697, 5429.484199001088, 5434.184872269191, 5357.383900851452, 5374.543163830962, 5434.510894019557, 5441.891162176814, 5443.374011988513, 5450.373207081077, 5492.286002819608, 5492.368377636463, 5493.09363954943, 5494.500002498774, 5152.252923326172, 5297.682139071668, 5331.107456852761, 5335.718533102036, 5347.438518955453], "value": 4049.218357161615, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.1824992508242, 744.1925510820763, 750.470918002808, 774.3418094619574, 797.952122872628, 15639.687206255881, 16894.831051689478, 16971.91514042428, 17020.404285849996, 17033.7444938326, 15081.321340539675, 15304.23478826057, 15305.540833774976, 15306.387744490235, 15313.540593782205, 661.5071771530216, 673.7170388436843, 786.952782833029, 790.9762707118796, 813.7029984055806, 772.6098320348216, 813.780279324585, 822.7901885019312, 822.9629666665014, 823.086374124721, 879.0242830458218, 883.152173913041, 884.2042162054138, 884.4251236696167, 884.95575221239, 693.5076095971866, 710.1229980973494, 880.3617377401397, 882.6734108379876, 883.0948278015022, 608.0362625239002, 618.0698049435571, 618.245740196959, 620.7330847735471, 625.4527288622455, 13786.103903246258, 13788.793168102486, 13812.171269723749, 13816.171029738249, 13828.308584570732, 13926.234057126854, 14209.573712788633, 14617.196054217015, 14665.193414362206, 14797.482088126864, 12442.253464792142, 12574.874251257463, 12667.176633518791, 12758.0, 12793.296368699717, 4238.936415953764, 4298.763568003758, 4303.751911945532, 4312.611864932172, 4321.913561728779, 79798.60100699459, 79922.6003869977, 79995.80006299968, 80147.0, 80150.19849801486, 10722.641018975813, 10785.62250321235, 11181.105511559055, 11280.379579123228, 11650.6504804856, 21244.89377553133, 21248.575028499654, 21262.78737212639, 21272.680909786366, 21282.467938301357, 8303.04514980773, 8320.70877519284, 8552.0, 8560.700375486953, 8564.3148548116, 4567.337736028324, 4617.12274667812, 4706.1999460091865, 4910.0, 4988.152014157602, 3316.6351701312838, 3361.83190840457, 3403.4894765784834, 3414.504896790001, 3430.2281986552825, 576.4322142689448, 585.718854949618, 595.4164918380012, 606.3936063936064, 628.8302158417293, 540.151961420566, 578.467809615155, 638.2436812377348, 640.6508452893185, 656.5929123943185, 8740.06186504623, 9244.722658320261, 9292.210162136158, 9323.906760932305, 9583.472908990072, 654.8166513376262, 671.385682100882, 679.3681875855502, 684.5139950635005, 688.9345512176435, 4305.815900627353, 4383.180979893308, 4665.300204969214, 4725.4565724941385, 4787.952120478821, 112583.0, 113655.43172284086, 115461.0, 117315.41342293234, 120970.0, 72678.63660681662, 89435.10564894398, 100816.49591751995, 101436.0, 103578.0, 87981.0, 89967.0, 90304.99999999869, 91257.54371228101, 92394.07605923989, 8558.700445484626, 8582.699605513777, 8629.913700862911, 8737.475751454933, 8979.82040359176, 51096.0, 51249.23126153185, 51403.0605868203, 52740.0, 53358.733206333716, 66038.67922641616, 68773.0, 75380.62309688417, 75828.24171758212, 78483.60758196173, 10518.263721539724, 11010.284331518425, 11218.663440096483, 11219.326840389604, 11420.371879546705, 11795.646130616095, 11796.587119450778, 12188.390580471118, 12578.433970471167, 13025.674358141123, 11326.32042077478, 11370.31778093317, 11721.882781172078, 11791.646250612495, 11879.76240475203, 11183.273087249303, 11488.655340339803, 11760.411979400824, 11880.168388212742, 11916.940415297868, 10356.792864142826, 10517.15862730995, 10802.081823044815, 10854.891451085705, 11141.888581114084, 8820.91179088201, 8952.820943581222, 9304.95347523258, 9794.412335259907, 9822.557984890555, 7831.608419579112, 7910.169432209766, 8710.116287152883, 9018.86471702938, 9472.621095156117], "value": 7213.9318347431745, "unit": "score"}], "name": "dromaeo_css", "value": 6999.766017695743, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 112.0, 111.0, 114.0, 111.0, 112.0, 114.0, 110.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 122.0, 129.0, 169.0, 123.0, 133.0, 129.0, 126.0, 174.0, 123.0], "value": 138.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 161.0, 164.0, 162.0, 163.0, 162.0, 160.0, 162.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 114.0, 76.0, 77.0, 76.0, 76.0, 102.0, 74.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 119.0, 82.0, 82.0, 82.0, 105.0, 82.0, 82.0, 117.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 52.0, 52.0, 53.0, 53.0, 52.0, 54.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 62.0, 62.0, 66.0, 62.0, 62.0, 62.0, 62.0], "value": 62.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 78.0, 79.0, 79.0, 80.0, 79.0, 79.0, 79.0, 79.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 130.0, 131.0, 129.0, 139.0, 129.0, 144.0, 134.0, 171.0, 130.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 172.0, 170.0, 164.0, 168.0, 165.0, 164.0, 168.0, 167.0, 163.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 67.0, 66.0, 67.0, 76.0, 67.0, 67.0, 66.0, 67.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1510.2000000000003, "alertThreshold": 2.0}]} 19:47:58 INFO - Return code: 0 19:47:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:47:58 INFO - # TBPL SUCCESS # 19:47:58 INFO - Running post-action listener: _resource_record_post_action 19:47:58 INFO - [mozharness: 2016-10-13 02:47:58.247385Z] Finished run-tests step (success) 19:47:58 INFO - Running post-run listener: _resource_record_post_run 19:47:58 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 12288; Write bytes: 405491712; Read time: 236; Write time: 270400 19:47:58 INFO - TinderboxPrint: CPU usage
13.1% 19:47:58 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 236 19:47:58 INFO - TinderboxPrint: I/O write bytes / time
405,491,712 / 270,400 19:47:58 INFO - TinderboxPrint: CPU idle
8,295.6 (86.9%) 19:47:58 INFO - TinderboxPrint: CPU user
1,198.2 (12.6%) 19:47:58 INFO - TinderboxPrint: Swap in / out
0 / 0 19:47:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 114622464; Read time: 40; Write time: 59296 19:47:58 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289726464; Read time: 176; Write time: 211072 19:47:58 INFO - Running post-run listener: _upload_blobber_files 19:47:58 INFO - Blob upload gear active. 19:47:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:47:58 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 19:47:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:47:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:47:59 INFO - (blobuploader) - INFO - Open directory for files ... 19:47:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:47:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:47:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:48:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:02 INFO - (blobuploader) - INFO - Done attempting. 19:48:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:48:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:48:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:03 INFO - (blobuploader) - INFO - Done attempting. 19:48:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:48:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:48:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:48:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:48:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:48:04 INFO - (blobuploader) - INFO - Done attempting. 19:48:04 INFO - (blobuploader) - INFO - Iteration through files over. 19:48:04 INFO - Return code: 0 19:48:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:48:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:48:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b75d5aa682309747b0b41fc270ec0831b72fc8145e77655cb9493d99c19e5de8eb2880ae6b9625ac0b0840e9aae04b5ad7184337a16e0c3d196bb3c101e16d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7be15ee9c6116be4515af7688fb9e59a4a80a6193be5f5f016b3c05d7c2769a71a0f610b636e123945bb2afe79eb127499c898d4b340a54aaf61604a1cfc51a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c847658a2e0d27cbcab7fa5ba6accc5ced3ecbe28a0de469473fd63012bff380304b834829b2f133115e0bbef40d729d1886e7dae8116d4164cf0b747f22678c"} 19:48:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:48:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:48:04 INFO - Contents: 19:48:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b75d5aa682309747b0b41fc270ec0831b72fc8145e77655cb9493d99c19e5de8eb2880ae6b9625ac0b0840e9aae04b5ad7184337a16e0c3d196bb3c101e16d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7be15ee9c6116be4515af7688fb9e59a4a80a6193be5f5f016b3c05d7c2769a71a0f610b636e123945bb2afe79eb127499c898d4b340a54aaf61604a1cfc51a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c847658a2e0d27cbcab7fa5ba6accc5ced3ecbe28a0de469473fd63012bff380304b834829b2f133115e0bbef40d729d1886e7dae8116d4164cf0b747f22678c"} 19:48:04 INFO - Running post-run listener: copy_logs_to_upload_dir 19:48:04 INFO - Copying logs to upload dir... 19:48:04 INFO - mkdir: /builds/slave/test/build/upload/logs 19:48:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.498434 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-10-12 19:48:03.766470) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 19:48:03.770435) ========= 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: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b75d5aa682309747b0b41fc270ec0831b72fc8145e77655cb9493d99c19e5de8eb2880ae6b9625ac0b0840e9aae04b5ad7184337a16e0c3d196bb3c101e16d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7be15ee9c6116be4515af7688fb9e59a4a80a6193be5f5f016b3c05d7c2769a71a0f610b636e123945bb2afe79eb127499c898d4b340a54aaf61604a1cfc51a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c847658a2e0d27cbcab7fa5ba6accc5ced3ecbe28a0de469473fd63012bff380304b834829b2f133115e0bbef40d729d1886e7dae8116d4164cf0b747f22678c"} build_url:https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://queue.taskcluster.net/v1/task/FrubNuYDR32PFD73EpjOVA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0b75d5aa682309747b0b41fc270ec0831b72fc8145e77655cb9493d99c19e5de8eb2880ae6b9625ac0b0840e9aae04b5ad7184337a16e0c3d196bb3c101e16d6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7be15ee9c6116be4515af7688fb9e59a4a80a6193be5f5f016b3c05d7c2769a71a0f610b636e123945bb2afe79eb127499c898d4b340a54aaf61604a1cfc51a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c847658a2e0d27cbcab7fa5ba6accc5ced3ecbe28a0de469473fd63012bff380304b834829b2f133115e0bbef40d729d1886e7dae8116d4164cf0b747f22678c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 19:48:03.797015) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 19:48:03.797401) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e0e61f6f900f4dc42e3e8956000001ad-1476325642.465728-897114220 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 19:48:03.880055) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 19:48:03.880450) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 19:48:03.880882) ========= ========= Total master_lag: 0.15 =========