builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-031 starttime: 1472790471.29 results: success (0) buildid: 20160901183005 builduid: 12a211e6d9aa4092b300c20d3f3d3b4a revision: e12415c1560179174bd3bdaca11dd20e6b97d35a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:51.286912) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:51.287349) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:51.287626) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:51.307462) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:51.307770) ========= 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=db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-01 21:27:51-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2016-09-01 21:27:51 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127578 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:51.460051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:51.460327) ========= 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=db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019789 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:51.516732) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:51.517055) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e12415c1560179174bd3bdaca11dd20e6b97d35a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e12415c1560179174bd3bdaca11dd20e6b97d35a --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=db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-01 21:27:51,830 truncating revision to first 12 chars 2016-09-01 21:27:51,830 Setting DEBUG logging. 2016-09-01 21:27:51,830 attempt 1/10 2016-09-01 21:27:51,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e12415c15601?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-01 21:27:52,175 unpacking tar archive at: autoland-e12415c15601/testing/mozharness/ program finished with exit code 0 elapsedTime=0.714975 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:52.248282) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:52.248571) ========= script_repo_revision: e12415c1560179174bd3bdaca11dd20e6b97d35a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:52.248995) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:52.249321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-01 21:27:52.259383) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-01 21:27:52.259756) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 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', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:27:52 INFO - MultiFileLogger online at 20160901 21:27:52 in /builds/slave/test 21:27:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:27:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:27:52 INFO - {'append_to_log': False, 21:27:52 INFO - 'base_work_dir': '/builds/slave/test', 21:27:52 INFO - 'blob_upload_branch': 'Autoland', 21:27:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:27:52 INFO - 'branch': 'Autoland', 21:27:52 INFO - 'buildbot_json_path': 'buildprops.json', 21:27:52 INFO - 'config_files': ('talos/linux_config.py',), 21:27:52 INFO - 'default_actions': ('clobber', 21:27:52 INFO - 'read-buildbot-config', 21:27:52 INFO - 'download-and-extract', 21:27:52 INFO - 'populate-webroot', 21:27:52 INFO - 'create-virtualenv', 21:27:52 INFO - 'install', 21:27:52 INFO - 'run-tests'), 21:27:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:27:52 INFO - 'download_minidump_stackwalk': True, 21:27:52 INFO - 'download_symbols': 'ondemand', 21:27:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:27:52 INFO - 'tooltool.py': '/tools/tooltool.py', 21:27:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:27:52 INFO - '/tools/misc-python/virtualenv.py')}, 21:27:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:27:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:27:52 INFO - 'installer_path': 'installer.exe', 21:27:52 INFO - 'log_level': 'info', 21:27:52 INFO - 'log_name': 'talos', 21:27:52 INFO - 'log_to_console': True, 21:27:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:27:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:27:52 INFO - 'opt_config_files': (), 21:27:52 INFO - 'pip_index': False, 21:27:52 INFO - 'sps_profile': False, 21:27:52 INFO - 'sps_profile_interval': 0, 21:27:52 INFO - 'suite': 'dromaeojs', 21:27:52 INFO - 'system_bits': '32', 21:27:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:27:52 INFO - 'title': 'talos-linux64-ix-031', 21:27:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:27:52 INFO - 'use_talos_json': True, 21:27:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:27:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:27:52 INFO - 'work_dir': 'build'} 21:27:52 INFO - [mozharness: 2016-09-02 04:27:52.670893Z] Running clobber step. 21:27:52 INFO - Running pre-action listener: _resource_record_pre_action 21:27:52 INFO - Running main action method: clobber 21:27:52 INFO - rmtree: /builds/slave/test/build 21:27:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:27:53 INFO - Running post-action listener: _resource_record_post_action 21:27:53 INFO - [mozharness: 2016-09-02 04:27:53.647818Z] Finished clobber step (success) 21:27:53 INFO - [mozharness: 2016-09-02 04:27:53.647917Z] Running read-buildbot-config step. 21:27:53 INFO - Running pre-action listener: _resource_record_pre_action 21:27:53 INFO - Running main action method: read_buildbot_config 21:27:53 INFO - Using buildbot properties: 21:27:53 INFO - { 21:27:53 INFO - "project": "", 21:27:53 INFO - "product": "firefox", 21:27:53 INFO - "script_repo_revision": "production", 21:27:53 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:27:53 INFO - "repository": "", 21:27:53 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 21:27:53 INFO - "buildid": "20160901183005", 21:27:53 INFO - "pgo_build": "True", 21:27:53 INFO - "basedir": "/builds/slave/test", 21:27:53 INFO - "buildnumber": 166, 21:27:53 INFO - "slavename": "talos-linux64-ix-031", 21:27:53 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:27:53 INFO - "platform": "ubuntu64_hw", 21:27:53 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:27:53 INFO - "branch": "autoland", 21:27:53 INFO - "repo_path": "integration/autoland", 21:27:53 INFO - "revision": "e12415c1560179174bd3bdaca11dd20e6b97d35a", 21:27:53 INFO - "stage_platform": "linux64-pgo", 21:27:53 INFO - "builduid": "12a211e6d9aa4092b300c20d3f3d3b4a", 21:27:53 INFO - "slavebuilddir": "test" 21:27:53 INFO - } 21:27:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 21:27:53 INFO - Running post-action listener: _resource_record_post_action 21:27:53 INFO - [mozharness: 2016-09-02 04:27:53.650417Z] Finished read-buildbot-config step (success) 21:27:53 INFO - [mozharness: 2016-09-02 04:27:53.650508Z] Running download-and-extract step. 21:27:53 INFO - Running pre-action listener: _resource_record_pre_action 21:27:53 INFO - Running main action method: download_and_extract 21:27:53 INFO - mkdir: /builds/slave/test/build/tests 21: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')]} 21:27:53 INFO - trying https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:27:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:27:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:27:54 INFO - Downloaded 1361 bytes. 21:27:54 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 21:27:54 INFO - Using the following test package requirements: 21:27:54 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:27:54 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:27:54 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:27:54 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:54 INFO - u'jsshell-linux-x86_64.zip'], 21:27:54 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:27:54 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 21:27:54 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:27:54 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:27:54 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:27:54 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 21:27:54 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:27:54 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:27:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:27:54 INFO - trying https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:27:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:27:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:27:55 INFO - Downloaded 21904574 bytes. 21:27:55 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 21:27:59 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:27:59 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')]} 21:27:59 INFO - trying https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:27:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 21:27:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:28:00 INFO - Downloaded 21904574 bytes. 21:28:00 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 21:28:04 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')]} 21:28:04 INFO - trying https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 21:28:04 INFO - Downloading https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 21:28:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:28:05 INFO - Downloaded 14413998 bytes. 21:28:05 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 21:28:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:05 INFO - trying https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:28:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:28:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:28:07 INFO - Downloaded 59750744 bytes. 21:28:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:28:07 INFO - mkdir: /builds/slave/test/properties 21:28:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:28:07 INFO - Writing to file /builds/slave/test/properties/build_url 21:28:07 INFO - Contents: 21:28:07 INFO - build_url:https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 21:28:08 INFO - Running post-action listener: _resource_record_post_action 21:28:08 INFO - Running post-action listener: set_extra_try_arguments 21:28:08 INFO - [mozharness: 2016-09-02 04:28:08.539762Z] Finished download-and-extract step (success) 21:28:08 INFO - [mozharness: 2016-09-02 04:28:08.539990Z] Running populate-webroot step. 21:28:08 INFO - Running pre-action listener: _resource_record_pre_action 21:28:08 INFO - Running main action method: populate_webroot 21:28:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:28:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:28:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:28:08 INFO - '--tppagecycles', 21:28:08 INFO - '7'], 21:28:08 INFO - 'tests': ['tsvgm']}}, 21:28:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:28:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:28:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:28:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:28:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:28:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:28:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:08 INFO - 'talos_options': ['--disable-e10s'], 21:28:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:28:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:28:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:08 INFO - 'talos_options': ['--disable-e10s'], 21:28:08 INFO - 'tests': ['damp', 'tps']}, 21:28:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:08 INFO - 'tests': ['damp', 'tps']}, 21:28:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:28:08 INFO - 'tests': ['dromaeo_dom']}, 21:28:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:28:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:28:08 INFO - 'tests': ['basic_compositor_video']}, 21:28:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:28:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:28:08 INFO - 'tests': ['a11yr', 21:28:08 INFO - 'ts_paint', 21:28:08 INFO - 'tpaint', 21:28:08 INFO - 'sessionrestore', 21:28:08 INFO - 'sessionrestore_no_auto_restore', 21:28:08 INFO - 'tabpaint']}, 21:28:08 INFO - 'other-e10s': {'tests': ['a11yr', 21:28:08 INFO - 'ts_paint', 21:28:08 INFO - 'tpaint', 21:28:08 INFO - 'sessionrestore', 21:28:08 INFO - 'sessionrestore_no_auto_restore', 21:28:08 INFO - 'tabpaint']}, 21:28:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:28:08 INFO - 'ts_paint', 21:28:08 INFO - 'tpaint', 21:28:08 INFO - 'sessionrestore', 21:28:08 INFO - 'sessionrestore_no_auto_restore', 21:28:08 INFO - 'tabpaint']}, 21:28:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:28:08 INFO - 'ts_paint', 21:28:08 INFO - 'tpaint', 21:28:08 INFO - 'sessionrestore', 21:28:08 INFO - 'sessionrestore_no_auto_restore', 21:28:08 INFO - 'tabpaint']}, 21:28:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:28:08 INFO - 'tests': ['a11yr', 21:28:08 INFO - 'ts_paint', 21:28:08 INFO - 'tpaint', 21:28:08 INFO - 'sessionrestore', 21:28:08 INFO - 'sessionrestore_no_auto_restore', 21:28:08 INFO - 'tabpaint']}, 21:28:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:28:08 INFO - 'tests': ['a11yr', 21:28:08 INFO - 'ts_paint', 21:28:08 INFO - 'tpaint', 21:28:08 INFO - 'sessionrestore', 21:28:08 INFO - 'sessionrestore_no_auto_restore', 21:28:08 INFO - 'tabpaint']}, 21:28:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:28:08 INFO - 'tests': ['tsvgx', 21:28:08 INFO - 'tsvgr_opacity', 21:28:08 INFO - 'tart', 21:28:08 INFO - 'tscrollx', 21:28:08 INFO - 'cart']}, 21:28:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:28:08 INFO - 'tsvgr_opacity', 21:28:08 INFO - 'tart', 21:28:08 INFO - 'tscrollx', 21:28:08 INFO - 'cart']}, 21:28:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:08 INFO - 'talos_options': ['--disable-e10s'], 21:28:08 INFO - 'tests': ['tp5o']}, 21:28:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:08 INFO - 'tests': ['tp5o']}, 21:28:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:08 INFO - 'talos_options': ['--disable-e10s', 21:28:08 INFO - '--xperf_path', 21:28:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:28:08 INFO - 'tests': ['tp5n']}, 21:28:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:28:08 INFO - 'talos_options': ['--xperf_path', 21:28:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:28:08 INFO - 'tests': ['tp5n']}}, 21:28:08 INFO - 'talos.zip': {'path': '', 21:28:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:28:08 INFO - Running post-action listener: _resource_record_post_action 21:28:08 INFO - [mozharness: 2016-09-02 04:28:08.557081Z] Finished populate-webroot step (success) 21:28:08 INFO - [mozharness: 2016-09-02 04:28:08.557172Z] Running create-virtualenv step. 21:28:08 INFO - Running pre-action listener: _resource_record_pre_action 21:28:08 INFO - Running main action method: create_virtualenv 21:28:08 INFO - Creating virtualenv /builds/slave/test/build/venv 21:28:08 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 21:28:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:28:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:28:08 INFO - Using real prefix '/usr' 21:28:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:28:09 INFO - Installing distribute.............................................................................................................................................................................................done. 21:28:11 INFO - Installing pip.................done. 21:28:11 INFO - Return code: 0 21:28:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:28:11 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')]} 21:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:11 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')]} 21:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:11 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 0x7f646d41ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe58370>, '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 0xe5b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5bd80>, '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': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', '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 21:28:11 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 21:28:11 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 21:28:11 INFO - Using env: {'DISPLAY': ':0', 21:28:11 INFO - 'HOME': '/home/cltbld', 21:28:11 INFO - 'LANG': 'en_US.UTF-8', 21:28:11 INFO - 'LANGUAGE': 'en_US:en', 21:28:11 INFO - 'LOGNAME': 'cltbld', 21:28:11 INFO - 'MAIL': '/var/mail/cltbld', 21:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:11 INFO - 'MOZ_NO_REMOTE': '1', 21:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:11 INFO - 'NO_EM_RESTART': '1', 21:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:11 INFO - 'PWD': '/builds/slave/test', 21:28:11 INFO - 'SHELL': '/bin/bash', 21:28:11 INFO - 'SHLVL': '1', 21:28:11 INFO - 'TERM': 'linux', 21:28:11 INFO - 'TMOUT': '86400', 21:28:11 INFO - 'USER': 'cltbld', 21:28:11 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', 21:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:11 INFO - '_': '/tools/buildbot/bin/python'} 21:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:11 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 21:28:11 INFO - Cleaning up... 21:28:11 INFO - Return code: 0 21:28:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:28:11 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')]} 21:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:11 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')]} 21:28:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:11 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 0x7f646d41ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe58370>, '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 0xe5b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5bd80>, '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': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', '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 21:28:11 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 21:28:11 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 21:28:11 INFO - Using env: {'DISPLAY': ':0', 21:28:11 INFO - 'HOME': '/home/cltbld', 21:28:11 INFO - 'LANG': 'en_US.UTF-8', 21:28:11 INFO - 'LANGUAGE': 'en_US:en', 21:28:11 INFO - 'LOGNAME': 'cltbld', 21:28:11 INFO - 'MAIL': '/var/mail/cltbld', 21:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:11 INFO - 'MOZ_NO_REMOTE': '1', 21:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:11 INFO - 'NO_EM_RESTART': '1', 21:28:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:11 INFO - 'PWD': '/builds/slave/test', 21:28:11 INFO - 'SHELL': '/bin/bash', 21:28:11 INFO - 'SHLVL': '1', 21:28:11 INFO - 'TERM': 'linux', 21:28:11 INFO - 'TMOUT': '86400', 21:28:11 INFO - 'USER': 'cltbld', 21:28:11 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', 21:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:11 INFO - '_': '/tools/buildbot/bin/python'} 21:28:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:11 INFO - Downloading/unpacking psutil>=3.1.1 21:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:28:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:28:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:28:13 INFO - Installing collected packages: psutil 21:28:13 INFO - Running setup.py install for psutil 21:28:13 INFO - building 'psutil._psutil_linux' extension 21:28:13 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 21:28:13 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 21:28:13 INFO - building 'psutil._psutil_posix' extension 21:28:13 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 21:28:13 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 21:28:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:28:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:28:14 INFO - Successfully installed psutil 21:28:14 INFO - Cleaning up... 21:28:14 INFO - Return code: 0 21:28:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f646d41ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe58370>, '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 0xe5b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5bd80>, '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': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', '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 21:28:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:28:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:28:14 INFO - Using env: {'DISPLAY': ':0', 21:28:14 INFO - 'HOME': '/home/cltbld', 21:28:14 INFO - 'LANG': 'en_US.UTF-8', 21:28:14 INFO - 'LANGUAGE': 'en_US:en', 21:28:14 INFO - 'LOGNAME': 'cltbld', 21:28:14 INFO - 'MAIL': '/var/mail/cltbld', 21:28:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:14 INFO - 'MOZ_NO_REMOTE': '1', 21:28:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:14 INFO - 'NO_EM_RESTART': '1', 21:28:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:14 INFO - 'PWD': '/builds/slave/test', 21:28:14 INFO - 'SHELL': '/bin/bash', 21:28:14 INFO - 'SHLVL': '1', 21:28:14 INFO - 'TERM': 'linux', 21:28:14 INFO - 'TMOUT': '86400', 21:28:14 INFO - 'USER': 'cltbld', 21:28:14 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', 21:28:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:14 INFO - '_': '/tools/buildbot/bin/python'} 21:28:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:28:14 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 21:28:14 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 21:28:14 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 21:28:14 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 21:28:14 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 21:28:14 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 21:28:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:28:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:28:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:28:16 INFO - Installing collected packages: mozsystemmonitor 21:28:16 INFO - Running setup.py install for mozsystemmonitor 21:28:16 INFO - Successfully installed mozsystemmonitor 21:28:16 INFO - Cleaning up... 21:28:16 INFO - Return code: 0 21:28:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:28:16 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')]} 21:28:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:16 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')]} 21:28:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:16 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 0x7f646d41ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe58370>, '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 0xe5b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5bd80>, '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': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', '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 21:28:16 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 21:28:16 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 21:28:16 INFO - Using env: {'DISPLAY': ':0', 21:28:16 INFO - 'HOME': '/home/cltbld', 21:28:16 INFO - 'LANG': 'en_US.UTF-8', 21:28:16 INFO - 'LANGUAGE': 'en_US:en', 21:28:16 INFO - 'LOGNAME': 'cltbld', 21:28:16 INFO - 'MAIL': '/var/mail/cltbld', 21:28:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:16 INFO - 'MOZ_NO_REMOTE': '1', 21:28:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:16 INFO - 'NO_EM_RESTART': '1', 21:28:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:16 INFO - 'PWD': '/builds/slave/test', 21:28:16 INFO - 'SHELL': '/bin/bash', 21:28:16 INFO - 'SHLVL': '1', 21:28:16 INFO - 'TERM': 'linux', 21:28:16 INFO - 'TMOUT': '86400', 21:28:16 INFO - 'USER': 'cltbld', 21:28:16 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', 21:28:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:16 INFO - '_': '/tools/buildbot/bin/python'} 21:28:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:16 INFO - Downloading/unpacking jsonschema==2.5.1 21:28:16 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 21:28:16 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 21:28:16 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 21:28:16 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 21:28:16 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 21:28:16 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 21:28:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:28:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:18 INFO - Downloading functools32-3.2.3-2.tar.gz 21:28:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:28:18 INFO - warning: no files found matching '*.txt' 21:28:18 INFO - no previously-included directories found matching 'build' 21:28:18 INFO - no previously-included directories found matching 'dist' 21:28:18 INFO - no previously-included directories found matching '.git*' 21:28:18 INFO - Installing collected packages: jsonschema, functools32 21:28:18 INFO - Running setup.py install for functools32 21:28:18 INFO - warning: no files found matching '*.txt' 21:28:18 INFO - no previously-included directories found matching 'build' 21:28:18 INFO - no previously-included directories found matching 'dist' 21:28:18 INFO - no previously-included directories found matching '.git*' 21:28:18 INFO - Successfully installed jsonschema functools32 21:28:18 INFO - Cleaning up... 21:28:19 INFO - Return code: 0 21:28:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:28:19 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')]} 21:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:19 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')]} 21:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:19 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 0x7f646d41ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe58370>, '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 0xe5b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5bd80>, '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': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', '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 21:28:19 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 21:28:19 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 21:28:19 INFO - Using env: {'DISPLAY': ':0', 21:28:19 INFO - 'HOME': '/home/cltbld', 21:28:19 INFO - 'LANG': 'en_US.UTF-8', 21:28:19 INFO - 'LANGUAGE': 'en_US:en', 21:28:19 INFO - 'LOGNAME': 'cltbld', 21:28:19 INFO - 'MAIL': '/var/mail/cltbld', 21:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:19 INFO - 'MOZ_NO_REMOTE': '1', 21:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:19 INFO - 'NO_EM_RESTART': '1', 21:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:19 INFO - 'PWD': '/builds/slave/test', 21:28:19 INFO - 'SHELL': '/bin/bash', 21:28:19 INFO - 'SHLVL': '1', 21:28:19 INFO - 'TERM': 'linux', 21:28:19 INFO - 'TMOUT': '86400', 21:28:19 INFO - 'USER': 'cltbld', 21:28:19 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', 21:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:19 INFO - '_': '/tools/buildbot/bin/python'} 21:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:28:19 INFO - Cleaning up... 21:28:19 INFO - Return code: 0 21:28:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:28:19 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')]} 21:28:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:19 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')]} 21:28:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:19 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 0x7f646d41ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe58370>, '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 0xe5b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5bd80>, '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': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', '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 21:28:19 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 21:28:19 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 21:28:19 INFO - Using env: {'DISPLAY': ':0', 21:28:19 INFO - 'HOME': '/home/cltbld', 21:28:19 INFO - 'LANG': 'en_US.UTF-8', 21:28:19 INFO - 'LANGUAGE': 'en_US:en', 21:28:19 INFO - 'LOGNAME': 'cltbld', 21:28:19 INFO - 'MAIL': '/var/mail/cltbld', 21:28:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:19 INFO - 'MOZ_NO_REMOTE': '1', 21:28:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:19 INFO - 'NO_EM_RESTART': '1', 21:28:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:19 INFO - 'PWD': '/builds/slave/test', 21:28:19 INFO - 'SHELL': '/bin/bash', 21:28:19 INFO - 'SHLVL': '1', 21:28:19 INFO - 'TERM': 'linux', 21:28:19 INFO - 'TMOUT': '86400', 21:28:19 INFO - 'USER': 'cltbld', 21:28:19 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', 21:28:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:19 INFO - '_': '/tools/buildbot/bin/python'} 21:28:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:19 INFO - Downloading/unpacking blobuploader==1.2.4 21:28:19 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 21:28:19 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 21:28:19 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 21:28:19 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 21:28:19 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 21:28:19 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 21:28:21 INFO - Downloading blobuploader-1.2.4.tar.gz 21:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:28:21 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:28:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:22 INFO - Downloading docopt-0.6.1.tar.gz 21:28:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:28:22 INFO - Installing collected packages: blobuploader, requests, docopt 21:28:22 INFO - Running setup.py install for blobuploader 21:28:22 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:28:22 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:28:22 INFO - Running setup.py install for requests 21:28:22 INFO - Running setup.py install for docopt 21:28:22 INFO - Successfully installed blobuploader requests docopt 21:28:22 INFO - Cleaning up... 21:28:22 INFO - Return code: 0 21:28:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:22 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 0x7f646d41ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe58370>, '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 0xe5b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5bd80>, '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': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', '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 21:28:22 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 21:28:22 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 21:28:22 INFO - Using env: {'DISPLAY': ':0', 21:28:22 INFO - 'HOME': '/home/cltbld', 21:28:22 INFO - 'LANG': 'en_US.UTF-8', 21:28:22 INFO - 'LANGUAGE': 'en_US:en', 21:28:22 INFO - 'LOGNAME': 'cltbld', 21:28:22 INFO - 'MAIL': '/var/mail/cltbld', 21:28:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:22 INFO - 'MOZ_NO_REMOTE': '1', 21:28:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:22 INFO - 'NO_EM_RESTART': '1', 21:28:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:22 INFO - 'PWD': '/builds/slave/test', 21:28:22 INFO - 'SHELL': '/bin/bash', 21:28:22 INFO - 'SHLVL': '1', 21:28:22 INFO - 'TERM': 'linux', 21:28:22 INFO - 'TMOUT': '86400', 21:28:22 INFO - 'USER': 'cltbld', 21:28:22 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', 21:28:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:22 INFO - '_': '/tools/buildbot/bin/python'} 21:28:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:28:22 INFO - Running setup.py (path:/tmp/pip-lsfh0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:28:23 INFO - Running setup.py (path:/tmp/pip-u3cqdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:28:23 INFO - Running setup.py (path:/tmp/pip-gNw6aP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:28:23 INFO - Running setup.py (path:/tmp/pip-nzpOpN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:28:23 INFO - Running setup.py (path:/tmp/pip-Nf2V5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:28:23 INFO - Running setup.py (path:/tmp/pip-BZpECH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:28:23 INFO - Running setup.py (path:/tmp/pip-LNQEkA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:28:23 INFO - Running setup.py (path:/tmp/pip-Ov5z4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:28:23 INFO - Running setup.py (path:/tmp/pip-0q855N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:28:23 INFO - Running setup.py (path:/tmp/pip-5yFxI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:28:23 INFO - Running setup.py (path:/tmp/pip-k5vpNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:28:23 INFO - Running setup.py (path:/tmp/pip-Uzgwyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:28:23 INFO - Running setup.py (path:/tmp/pip-fvLmOI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:28:23 INFO - Running setup.py (path:/tmp/pip-Sf54bJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:28:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:23 INFO - Running setup.py (path:/tmp/pip-BQPfUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:28:24 INFO - Running setup.py (path:/tmp/pip-9qs4Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:28:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:28:24 INFO - Running setup.py (path:/tmp/pip-ER8bGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:28:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:28:24 INFO - Running setup.py install for manifestparser 21:28:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Running setup.py install for mozcrash 21:28:24 INFO - Running setup.py install for mozdebug 21:28:24 INFO - Running setup.py install for mozdevice 21:28:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Running setup.py install for mozfile 21:28:24 INFO - Running setup.py install for mozhttpd 21:28:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Running setup.py install for mozinfo 21:28:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Running setup.py install for mozInstall 21:28:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:28:24 INFO - Running setup.py install for mozleak 21:28:25 INFO - Running setup.py install for mozlog 21:28:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:28:25 INFO - Running setup.py install for moznetwork 21:28:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:28:25 INFO - Running setup.py install for mozprocess 21:28:25 INFO - Running setup.py install for mozprofile 21:28:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:28:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:28:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:28:25 INFO - Running setup.py install for mozrunner 21:28:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:28:25 INFO - Running setup.py install for mozscreenshot 21:28:25 INFO - Running setup.py install for moztest 21:28:25 INFO - Running setup.py install for mozversion 21:28:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:28:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:28:25 INFO - Cleaning up... 21:28:25 INFO - Return code: 0 21:28:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:28: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')]} 21:28:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28: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')]} 21:28:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:25 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 0x7f646d41ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe58370>, '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 0xe5b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5bd80>, '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': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', '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 21:28:26 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 21:28:26 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 21:28:26 INFO - Using env: {'DISPLAY': ':0', 21:28:26 INFO - 'HOME': '/home/cltbld', 21:28:26 INFO - 'LANG': 'en_US.UTF-8', 21:28:26 INFO - 'LANGUAGE': 'en_US:en', 21:28:26 INFO - 'LOGNAME': 'cltbld', 21:28:26 INFO - 'MAIL': '/var/mail/cltbld', 21:28:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:26 INFO - 'MOZ_NO_REMOTE': '1', 21:28:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:26 INFO - 'NO_EM_RESTART': '1', 21:28:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:26 INFO - 'PWD': '/builds/slave/test', 21:28:26 INFO - 'SHELL': '/bin/bash', 21:28:26 INFO - 'SHLVL': '1', 21:28:26 INFO - 'TERM': 'linux', 21:28:26 INFO - 'TMOUT': '86400', 21:28:26 INFO - 'USER': 'cltbld', 21:28:26 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', 21:28:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:26 INFO - '_': '/tools/buildbot/bin/python'} 21:28:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:28:26 INFO - Running setup.py (path:/tmp/pip-fo3sDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:28:26 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)) 21:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:28:26 INFO - Running setup.py (path:/tmp/pip-6l2RVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:28:26 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)) 21:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:28:26 INFO - Running setup.py (path:/tmp/pip-5wCZgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:28:26 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)) 21:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:28:26 INFO - Running setup.py (path:/tmp/pip-do_qcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:28:26 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)) 21:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:28:26 INFO - Running setup.py (path:/tmp/pip-U_vMfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:28:26 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)) 21:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:28:26 INFO - Running setup.py (path:/tmp/pip-4H4Ame-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:28:26 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)) 21:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:28:26 INFO - Running setup.py (path:/tmp/pip-QcQIFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:28:26 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)) 21:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:28:26 INFO - Running setup.py (path:/tmp/pip-qsI57D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:28:26 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)) 21:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:28:26 INFO - Running setup.py (path:/tmp/pip-cjFKKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:28:26 INFO - Running setup.py (path:/tmp/pip-oZCyNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 21:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:28:26 INFO - Running setup.py (path:/tmp/pip-IbxO0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:28:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:28:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:28:27 INFO - Running setup.py (path:/tmp/pip-DvW3Gt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:28:27 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)) 21:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:28:27 INFO - Running setup.py (path:/tmp/pip-UJcepK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:28:27 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)) 21:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:28:27 INFO - Running setup.py (path:/tmp/pip-NQBcOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:28:27 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)) 21:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:27 INFO - Running setup.py (path:/tmp/pip-nTHHCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:28:27 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)) 21:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:28:27 INFO - Running setup.py (path:/tmp/pip-LdUeOo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:28:27 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)) 21:28:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:28:27 INFO - Running setup.py (path:/tmp/pip-2O9QPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:28:27 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)) 21:28:27 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)) 21:28:27 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)) 21:28:27 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)) 21:28:27 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)) 21:28:27 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)) 21:28:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:28:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:28:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:28:29 INFO - Downloading blessings-1.6.tar.gz 21:28:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:28:29 INFO - Installing collected packages: blessings 21:28:29 INFO - Running setup.py install for blessings 21:28:29 INFO - Successfully installed blessings 21:28:29 INFO - Cleaning up... 21:28:29 INFO - Return code: 0 21:28:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:28:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:28:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:28:29 INFO - Reading from file tmpfile_stdout 21:28:29 INFO - Current package versions: 21:28:29 INFO - argparse == 1.2.1 21:28:29 INFO - blessings == 1.6 21:28:29 INFO - blobuploader == 1.2.4 21:28:29 INFO - docopt == 0.6.1 21:28:29 INFO - functools32 == 3.2.3-2 21:28:29 INFO - jsonschema == 2.5.1 21:28:29 INFO - manifestparser == 1.1 21:28:29 INFO - mozInstall == 1.12 21:28:29 INFO - mozcrash == 0.17 21:28:29 INFO - mozdebug == 0.1 21:28:29 INFO - mozdevice == 0.48 21:28:29 INFO - mozfile == 1.2 21:28:29 INFO - mozhttpd == 0.7 21:28:29 INFO - mozinfo == 0.9 21:28:29 INFO - mozleak == 0.1 21:28:29 INFO - mozlog == 3.3 21:28:29 INFO - moznetwork == 0.27 21:28:29 INFO - mozprocess == 0.23 21:28:29 INFO - mozprofile == 0.28 21:28:29 INFO - mozrunner == 6.12 21:28:29 INFO - mozscreenshot == 0.1 21:28:29 INFO - mozsystemmonitor == 0.3 21:28:29 INFO - moztest == 0.7 21:28:29 INFO - mozversion == 1.4 21:28:29 INFO - psutil == 3.1.1 21:28:29 INFO - requests == 1.2.3 21:28:29 INFO - wsgiref == 0.1.2 21:28:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:29 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 0x7f646d41ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe58370>, '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 0xe5b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5bd80>, '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': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', '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 21:28:29 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 21:28:29 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 21:28:29 INFO - Using env: {'DISPLAY': ':0', 21:28:29 INFO - 'HOME': '/home/cltbld', 21:28:29 INFO - 'LANG': 'en_US.UTF-8', 21:28:29 INFO - 'LANGUAGE': 'en_US:en', 21:28:29 INFO - 'LOGNAME': 'cltbld', 21:28:29 INFO - 'MAIL': '/var/mail/cltbld', 21:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:29 INFO - 'MOZ_NO_REMOTE': '1', 21:28:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:29 INFO - 'NO_EM_RESTART': '1', 21:28:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:29 INFO - 'PWD': '/builds/slave/test', 21:28:29 INFO - 'SHELL': '/bin/bash', 21:28:29 INFO - 'SHLVL': '1', 21:28:29 INFO - 'TERM': 'linux', 21:28:29 INFO - 'TMOUT': '86400', 21:28:29 INFO - 'USER': 'cltbld', 21:28:29 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', 21:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:29 INFO - '_': '/tools/buildbot/bin/python'} 21:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:30 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)) 21:28:30 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)) 21:28:30 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)) 21:28:30 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)) 21:28:30 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)) 21:28:30 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)) 21:28:30 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)) 21:28:30 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)) 21:28:30 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)) 21:28:30 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)) 21:28:30 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)) 21:28:30 INFO - Cleaning up... 21:28:30 INFO - Return code: 0 21:28:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:28:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:28:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:28:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:28:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f646d41ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd908a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe5d850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe58370>, '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 0xe5b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5bd80>, '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': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', '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 21:28:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:28:30 INFO - Using env: {'DISPLAY': ':0', 21:28:30 INFO - 'HOME': '/home/cltbld', 21:28:30 INFO - 'LANG': 'en_US.UTF-8', 21:28:30 INFO - 'LANGUAGE': 'en_US:en', 21:28:30 INFO - 'LOGNAME': 'cltbld', 21:28:30 INFO - 'MAIL': '/var/mail/cltbld', 21:28:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:30 INFO - 'MOZ_NO_REMOTE': '1', 21:28:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:30 INFO - 'NO_EM_RESTART': '1', 21:28:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:30 INFO - 'PWD': '/builds/slave/test', 21:28:30 INFO - 'SHELL': '/bin/bash', 21:28:30 INFO - 'SHLVL': '1', 21:28:30 INFO - 'TERM': 'linux', 21:28:30 INFO - 'TMOUT': '86400', 21:28:30 INFO - 'USER': 'cltbld', 21:28:30 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', 21:28:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:30 INFO - '_': '/tools/buildbot/bin/python'} 21:28:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:28:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:28:30 INFO - Cleaning up... 21:28:30 INFO - Return code: 0 21:28:30 INFO - Running post-action listener: _resource_record_post_action 21:28:30 INFO - Running post-action listener: _start_resource_monitoring 21:28:30 INFO - Starting resource monitoring. 21:28:30 INFO - [mozharness: 2016-09-02 04:28:30.317479Z] Finished create-virtualenv step (success) 21:28:30 INFO - [mozharness: 2016-09-02 04:28:30.318127Z] Running install step. 21:28:30 INFO - Running pre-action listener: _resource_record_pre_action 21:28:30 INFO - Running main action method: install 21:28:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:28:30 INFO - Reading from file tmpfile_stdout 21:28:30 INFO - Detecting whether we're running mozinstall >=1.0... 21:28:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:28:30 INFO - Reading from file tmpfile_stdout 21:28:30 INFO - Output received: 21:28:30 INFO - Usage: mozinstall [options] installer 21:28:30 INFO - Options: 21:28:30 INFO - -h, --help show this help message and exit 21:28:30 INFO - -d DEST, --destination=DEST 21:28:30 INFO - Directory to install application into. [default: 21:28:30 INFO - "/builds/slave/test"] 21:28:30 INFO - --app=APP Application being installed. [default: firefox] 21:28:30 INFO - mkdir: /builds/slave/test/build/application 21:28:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:28:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:28:47 INFO - Reading from file tmpfile_stdout 21:28:47 INFO - Output received: 21:28:47 INFO - /builds/slave/test/build/application/firefox/firefox 21:28:47 INFO - Running post-action listener: _resource_record_post_action 21:28:47 INFO - [mozharness: 2016-09-02 04:28:47.645986Z] Finished install step (success) 21:28:47 INFO - [mozharness: 2016-09-02 04:28:47.646272Z] Running run-tests step. 21:28:47 INFO - Running pre-action listener: _resource_record_pre_action 21:28:47 INFO - Running main action method: run_tests 21:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:28:47 INFO - Python 2.7.3 21:28:47 INFO - Return code: 0 21:28:47 INFO - grabbing minidump binary from tooltool 21:28: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')]} 21:28:47 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 0xe58370>, '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 0xe5b8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5bd80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:28:47 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 21:28:47 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 21:28:47 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 21:28:47 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:28:47 INFO - Return code: 0 21:28:47 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:28:47 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:28:47 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:28:47 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:28:47 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 21:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 21:28:47 INFO - Using env: {'DISPLAY': ':0', 21:28:47 INFO - 'HOME': '/home/cltbld', 21:28:47 INFO - 'LANG': 'en_US.UTF-8', 21:28:47 INFO - 'LANGUAGE': 'en_US:en', 21:28:47 INFO - 'LOGNAME': 'cltbld', 21:28:47 INFO - 'MAIL': '/var/mail/cltbld', 21:28:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:28:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:28:47 INFO - 'MOZ_NO_REMOTE': '1', 21:28:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:28:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:28:47 INFO - 'NO_EM_RESTART': '1', 21:28:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:28:47 INFO - 'PWD': '/builds/slave/test', 21:28:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:28:47 INFO - 'SHELL': '/bin/bash', 21:28:47 INFO - 'SHLVL': '1', 21:28:47 INFO - 'TERM': 'linux', 21:28:47 INFO - 'TMOUT': '86400', 21:28:47 INFO - 'USER': 'cltbld', 21:28:47 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957', 21:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:28:47 INFO - '_': '/tools/buildbot/bin/python'} 21:28:47 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 21:28:47 INFO - mozversion application_buildid: 20160901183005 21:28:47 INFO - mozversion application_changeset: e12415c1560179174bd3bdaca11dd20e6b97d35a 21:28:47 INFO - mozversion application_display_name: Nightly 21:28:47 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:28:47 INFO - mozversion application_name: Firefox 21:28:47 INFO - mozversion application_remotingname: firefox 21:28:47 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:28:47 INFO - mozversion application_vendor: Mozilla 21:28:47 INFO - mozversion application_version: 51.0a1 21:28:47 INFO - mozversion platform_buildid: 20160901183005 21:28:47 INFO - mozversion platform_changeset: e12415c1560179174bd3bdaca11dd20e6b97d35a 21:28:47 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:28:47 INFO - mozversion platform_version: 51.0a1 21:28:47 INFO - using testdate: 1472790527 21:28:47 INFO - actual date: 1472790527 21:28:47 INFO - starting webserver on 'localhost:47491' 21:28:47 INFO - SUITE-START | Running 2 tests 21:28:47 INFO - TEST-START | dromaeo_css 21:28:47 INFO - operating with platform_type : linux_ 21:28:47 INFO - Initialising browser for dromaeo_css test... 21:28:47 INFO - TEST-INFO | started process 12451 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp03ypYG/profile http://localhost:47491/getInfo.html) 21:28:52 INFO - PROCESS | 12451 | __metrics Screen width/height:1600/1200 21:28:52 INFO - PROCESS | 12451 | colorDepth:24 21:28:52 INFO - PROCESS | 12451 | Browser inner width/height: 1024/697 21:28:52 INFO - PROCESS | 12451 | __metrics 21:28:53 INFO - PROCESS | 12451 | 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" 21:28:53 INFO - PROCESS | 12451 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:28:53 INFO - PROCESS | 12451 | console.error: PushService: 21:28:53 INFO - PROCESS | 12451 | stateChangeProcessEnqueue: Error transitioning state 21:28:53 INFO - PROCESS | 12451 | UnknownError 21:28:54 INFO - TEST-INFO | 12451: exit 0 21:28:54 INFO - Browser initialized. 21:28:54 INFO - Running cycle 1/1 for dromaeo_css test... 21:28:54 INFO - TEST-INFO | started process 12531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp03ypYG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:29:06 INFO - PROCESS | 12531 | RSS: Main: 179679232 21:29:06 INFO - PROCESS | 12531 | 21:29:57 INFO - PROCESS | 12531 | 1472790597653 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] 21:32:07 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:47491/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47491/tests/dromaeo/cssquery-ext.html) 21:32:08 INFO - PROCESS | 12531 | RSS: Main: 281681920 21:32:08 INFO - PROCESS | 12531 | 21:35:10 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:47491/tests/dromaeo/cssquery-ext.html (next: http://localhost:47491/tests/dromaeo/cssquery-jquery.html) 21:35:11 INFO - PROCESS | 12531 | RSS: Main: 266715136 21:35:11 INFO - PROCESS | 12531 | 21:38:13 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:47491/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47491/tests/dromaeo/cssquery-mootools.html) 21:38:13 INFO - PROCESS | 12531 | RSS: Main: 214278144 21:38:13 INFO - PROCESS | 12531 | 21:41:15 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:47491/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47491/tests/dromaeo/cssquery-prototype.html) 21:41:16 INFO - PROCESS | 12531 | RSS: Main: 212205568 21:41:16 INFO - PROCESS | 12531 | 21:44:19 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:47491/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47491/tests/dromaeo/cssquery-yui.html) 21:44:19 INFO - PROCESS | 12531 | RSS: Main: 213999616 21:44:19 INFO - PROCESS | 12531 | 21:47:22 INFO - PROCESS | 12531 | Cycle 1(1): loaded http://localhost:47491/tests/dromaeo/cssquery-yui.html (next: http://localhost:47491/tests/dromaeo/cssquery-dojo.html) 21:47:22 INFO - PROCESS | 12531 | RSS: Main: 303112192 21:47:22 INFO - PROCESS | 12531 | 21:47:22 INFO - PROCESS | 12531 | __start_tp_report 21:47:22 INFO - PROCESS | 12531 | _x_x_mozilla_page_load 21:47:22 INFO - PROCESS | 12531 | _x_x_mozilla_page_load_details 21:47:22 INFO - PROCESS | 12531 | |i|pagename|runs| 21:47:22 INFO - PROCESS | 12531 | |0;dojo.html;2987.7759168062394;2998.115555911006;3013.276813564745;3041.9695803041964;3068.754499640029;5089.211172268295;5144.408393034802;5206.479352064792;5260.473952604738;5299.5230429261355;5185.948140518603;5253.369595648527;5318.1225097858805;5338.3860856001575;5436.238926550286;4763.333133361332;4811.13399588074;4814.975925120387;4851.442084160322;4893.241547560134;4840.491748366424;4866.586340161073;4886.340344053543;4987.17711577591;4999.725015124185;4921.926171107436;4944.678595891256;4947.50524947506;4987.451380348159;5004.499550045003;4645;4665;4817.012512434942;4823.324734537167;4898.53463920927;4770.45139808923;4771.713697178146;4799.712017278939;4855.295982082614;4924.064427758714;5317.2821669074565;5322.7072511011875;5341.03861304965;5356.276902618175;5423.674579525202;5468.125099983983;5552.583556233259;5688.118341657008;5700.7719691212305;5720.971395143039;5635.577331700098;5638.4361563843695;5652.717364131818;5664.26364572603;5730.36965933747;5245.737713114368;5275.841724748187;5278.604104692164;5280.973595132;5283.762230699628;5564.33228012641;5700.287464066992;5730.34101078373;5776.133579962955;5784.1034639630925;5556.805511807148;5558;5562.610617256834;5605.691686957257;5612.410696876851;5635.661860288314;5636.577256705764;5637.68992705397;5638.210650508932;5642.830715078554;5413.10683737179;5566.443355664401;5569.554435645138;5636.04187288162;5689.743961521742;5667.064934285879;5682.659040457585;5687;5735.426457354315;5747.453991870766;4388.71473354231;4390.824367025347;4390.978045109754;4391.407160033418;4437.312216606431;3853.344931361675;3855.3445914194654;3868.323043467382;3957.604239576019;3977.880663580097;5366.490183432567;5367.221752845816;5368.463153684678;5409.269748583891;5425.9186112208345;5676.375598684142;5681.034224181899;5683.829485115453;5685.3177618685195;5692.430756924275;5208.73956302191;5309.230161626542;5325.4940780625775;5330.333708286465;5434.538064264502;4938.629602779806;4939.629527785431;4941.802327906916;4970.130227210224;4999.65002449825;5867.3839246879315;5872.853178670567;5875.441833025856;5881.17663527098;5884.382139875337;5400.027994960945;5622;5639.718014099197;5678.403767604342;5739.282589676291;5871.530277577869;5873.676947767743;5874.676892770939;5894.440028197314;5914.911276330772;5591.580631452576;5595.160725891149;5600.691961942132;5602.747876345493;5609.747561359667;5434.076207044891;5647.265855438766;5656.717164141859;5675.914861277167;5696.088625819849;5585.497305242548;5590.413006634245;5602.719864006865;5637.774489020393;5651.689157096234;5580.86047848807;5590.8043218487155;5594.16087586849;5597.496225339739;5599.244102046335;5271.89456210866;5399.4600539945695;5402.648827826179;5451.291332126798;5581.441855814386;5514.200440936122;5555.916661250165;5564.081926482085;5589.245451864109;5614;5430.67415955044;5443.809466668806;5445.972770136124;5448.727563621724;5449.891002180014 21:47:22 INFO - PROCESS | 12531 | |1;ext.html;574;600.7026521871675;604.0425924909019;615.4030590327383;625.2684359299619;32118;42417.57582424175;43491;43702.78148609253;43733.56266437335;44729;45209.513476758766;45231.77384113083;45237.547624523744;45241.321380179324;8067.354611631055;8860.556972151398;8995.235404990584;9002;9025.729228123168;10511.211659125596;10764.407957562331;10773.515191816387;11005.449727513593;11018;10919.672409827677;10965.342079475216;10995.505202265877;11069.446527673625;11085.168612354066;10712.089472394817;10782.245242833005;10787.946060269687;10835.620753273677;10858.72853178669;10644.254902156852;10699.144068474503;10716.517756700889;10724.678259652223;10725.141988640968;41401.378979315035;41690.791546042376;41730.1653966922;41730.79134604338;41758;3401.4047541680357;3518.982405087984;3597.7661452005536;3719.6466335698065;3892.143728379752;31404.842975785203;31624.209394765086;31668;32119.19702007445;32886.506702399485;4340.262155433584;4349.13017396522;4459.710118842265;4464.709793863389;4585.922308257557;352639;352991;353956;354267;354352.99999999744;34732.13169670728;58209.41790582125;58570;58612.41387586069;58627.41372586305;35841.64158358435;37603.247935041145;37605.62394376076;37625.435618465744;37635.43546846799;14829.851701482847;14965;15029;15061.322240499203;15089.396424143131;11137;12225.877741222652;12476.440444944383;12651.683707907376;12655.43050562727;8428.536430496259;8463.74608761738;8584.74245772628;8610.569471526398;8622.396432249683;3339.148517128165;3361.1429085583018;3364.9495257571157;3377.189474526096;3386.817280658385;946.8958414574391;986.8125056239292;1009.4448053570507;1066.989330106689;1086.3536195963388;31127;31819.772615917125;32083;32315.19212019718;32648.347033059206;1061.3207547169663;1100.6973082402403;1101.0090918173548;1113.6714669172613;1127.261643623428;16034.599135021484;16661.91669041647;16696.248668809934;16840.663186736198;16870.15649217534;584693;590710;591636;596402;597227;57584.42415575791;57951.71024144852;58279;58336.08319584004;58362.70818645965;1214.878512148778;1311.2394811009592;1320.7820709583004;1344.9529266475627;1367.1591970937802;31297.8435107823;32375.67624323821;33114.33771324608;33154.668453316124;33900;50128.749356252985;50981.490185097675;50984.74507627438;50991.2351314738;51052.23421648604;416691;418191;418950;419948;420286;24784.628230576196;25603.743962560136;25893.87053064798;25935.092271770398;29823.25441863884;46914.76542617265;46989.76505117452;48452.5154748448;48658.513414865396;48765.5123448761;39504;39547.2090558193;41406.171876562905;41726.165476690905;43779.562204378824;41474.13591401665;41841;44485;44568.10863782771;44693.55306446894;41826.581734183485;42911.570884290755;43235;45103;46419.53580464152;40648.18703625852;41880.79059604683;42078.579214207464;42494.26759179327;43271.35092973545;28136.15070268148;28548.85725571359;28953.420931581673;29027.85486072556;29186.56220156742 21:47:22 INFO - PROCESS | 12531 | |2;jquery.html;366.1487042625892;380.94095415210654;396.25701809107915;401.0995315516665;417.5469615467218;16180.0291982481;18713.90643046786;18719.719204211946;18906.149223284952;19373;17283.30866765328;17886.28454861807;17910;18917.243310267608;19225.903870480663;5470.234167216573;5509.752061157237;5721.685307308117;5722.055860782966;5727.770889164429;5615.354234263071;5620.9437905621035;5658.151277308396;5694.288213973254;5702.543796496291;5407.999520088796;5541.27963364764;5619.887602247953;5624.887502249952;5625.115586278602;5524.502794748471;5548.972255138739;5557;5561.193626924114;5562.304711910991;4869.829555965524;4891.633127515451;4892.290617860426;4986.301917731521;4993.925091123636;22766.089356425724;22775.886120569292;22914.427139321484;22920.54158916829;23135.652965205536;2105.9368218953455;2921.5033444314518;3032.2267821705545;3063.463893818595;3087.0275863103275;10207.948960255151;10326.122279606243;10348.482575871176;10356.326838755456;10473.26687131901;1847.7413162157309;1924.913378897953;1997.9001049947444;2024.4230394337544;2036.2262340310735;51894.22158667623;71447.64276178638;81006;81379;83190.58404707938;10835.67492975212;10855.131589472981;11062.336259824437;11239;11465.598704045486;15127.621809454851;15157.166355850313;15158.242087895562;15169.544913652608;15191;7678.8080297993;7761.495502792301;8007.359411247086;8145.674173033012;8243.876341854877;7154.642267886689;7273.527220730742;7282.672279747424;7391.926080739231;7582.507137036075;4633.606143477775;4684.414448193976;4704.717716936994;4728.763561821896;4821.108095002436;1963.2539634938632;1969.714391413237;1980.6929925861514;1993.8205561499535;2075.1699320272014;834.1991687979607;888.9777755556163;930.7905721212809;963.9518024098767;965;18065.54836129081;19463.80536194648;19569.510762230773;19589;19973.800261997483;959.8320293948531;963.4276481793628;973.8880028796779;981.4405788700373;1011.7622358745689;10349.172066234683;10664.946675266729;10715.410652414037;10781.926676911417;10793.50171848768;447782;448003;457184;463176;463911;55377.16934245989;67740;86120.56939715262;88646.55676721575;88796.11203887878;994.5425104452033;996.1184351848666;996.7956568903502;1000.139879703469;1027.9537420816082;16317.592060198114;16352.182390880645;16560.917195413946;17161.485155445356;17347.65304693874;38516.80741596274;39657.80171099126;40412.59587404206;40513.39229911612;42724.78637606916;54702.854001099295;55019;56057;58403.70798145982;58934.70532647309;8214.4660597061;8254.917450825655;8396.076431592643;8502.319814414708;8753.64985400577;11889.940550297193;12613.432395542406;12790.872091278969;12822.87177128254;13103.672408189872;10908.454577271263;11217.326960382403;11217.439128043728;11416.82874756896;11608.30350178992;5366.651167674088;8105.675772969015;11341.26281791681;11362.659120226406;11711.648650540497;11441.599544015919;11506.194566380273;11512.194146410005;11846.466908988943;11944.820827687417;8282.461639993382;8519.872201916853;8539.402241843012;8553.315734741082;8636.913630863863;11417.31496110236;11423.828642570534;11473.655790326304;11568.363739994382;11815.468303926516 21:47:22 INFO - PROCESS | 12531 | |3;mootools.html;1337.0306527767375;1467.1343907094815;1488.7245859515988;1622.3186261770056;1777.5733823882272;8116.944797176367;8483.745487635373;8537.914620853797;8774.561271936394;8793.472391656505;8570.228679418851;8681.782955426117;8687.73936781896;8696;8700.65197392105;2342.2973108067595;2365.8817059146972;2375.964360534593;2377.061060880951;2377.9643305350346;2253.6732173834785;2275.2036787124457;2328.7787660172257;2330.8018818400456;2330.8718020508863;2270.14869423966;2270.20542810016;2279.9772002280015;2341.95316093678;2344.4490544721975;2257.7742225777456;2271.4094335472814;2280.646499792535;2284.4288927768057;2285.5543169082034;2256.4133325335365;2268.0474200835524;2271.6251818449937;2271.7501074881748;2277.8974946127464;8415.032271288757;8450.19723126302;8509.319254459628;8523.573821308972;8523.701670441567;5051.696898186121;5256.421793602701;5281.128613778722;5281.39263984639;5291.126964050927;3122.9063128106195;3268.950965735516;3289.9965510519282;3327.933441331184;3340.064781861083;1112.6105862947984;1115.380963565221;1137.010800603472;1144.3820337018;1150.2925700694097;11434.942825285903;11480.196386252966;11529.077673786078;11532.308061516336;11545.538178472934;4227.852025179104;4388.802503887333;4439.223135951195;4528.184926713223;4542.046170304207;9349.111834375723;9370.062993700712;9392.01383854699;9392.389494682824;9423.905760942303;5037.370328708911;5052.949470505321;5067.087924173684;5070.366204224472;5078.492150784892;4095.1604920991126;4640.095181439654;4751.786169622375;4781.043791241766;4838.2016967200725;3710.2376371223454;3761.7022127366013;3853.614638536124;3872.7095467839463;3894.201688653819;1112.2047735868894;1132.1678566253797;1156.4102307822902;1164.6098556983336;1185.4250688416112;863.710656929923;963.5808423335872;966.3042609321277;973.1922504321396;1008.7982403519326;5649.858753531113;5870.090136028923;6014.699265036731;6086.60437071589;6119.479844213202;957.5451660461225;987.5852142100335;996.1234113979797;1018.2057994764095;1044.12815299226;4045.7431767426915;4111.259973204852;4232.661387089025;4252.213340532012;4320.222359975234;10188.745281367877;10322.380657160595;10561.419121948367;10569.735756605993;10790.622328218475;10600.416977066336;10768.0847127995;10773.89226107729;10774.353538787698;10775.030247277782;7859.724909628136;7883.960580197062;7980.600969951479;7992.800179995546;8015.919840801634;5585.855558885356;5589.301337332833;5659.3491748447805;5798.213022820357;5800;9295.769015436383;9444;9447.102525260088;9484.241260699266;9522.238220942447;9569.952150239204;9602.423854568748;9651.131398174199;9659.806803863743;9716.951415242878;6769.898451523132;7318.451116166202;7540.773776786705;7622.885656715264;7751.914731937421;8161.79595510117;8295.377846661646;8303.501789892625;8305.46014509055;8308.667653294042;7365.852682946418;7543.057117860268;7583.355414789805;7597.88603170964;7682.0397450318715;7335.669894854637;7391.630418478947;7410.62946852666;7412.1846596875375;7620.657070431955;6946.409555187865;7043.471739619446;7066.7173313066905;7068;7072.328128827753;5050.965771625655;5073.416557095981;5082.2122571001555;5110;5251.816186433456;5056.367954005749;5071.340725705634;5162.612804039787;5228.032813929435;5357.214248590633 21:47:22 INFO - PROCESS | 12531 | |4;prototype.html;313.68161316263996;321.77314992929985;322.80631621027374;323.2194250884115;327.5888759606693;5207.609429292804;5267.578593712504;5286.682799032056;5287.233351164079;5299.655522391046;5212.2963399941;5212.348456442945;5237.083510385677;5265.420803711589;5281.815136470224;3974.3839704845795;4037.212743515001;4144.109016561439;4177.415161877339;4189.853355132571;4156.6051225133715;4167.374893765929;4210.2737877470245;4214.450257594157;4228.830846766141;4120.278951183546;4122.278601244785;4129.174165166964;4131.52487463941;4137.66898648109;3947.131631041166;3980.3879428831515;4138.958610413887;4145.481814773153;4156.771377574232;3655.8354874030733;3656.6526180012856;3669.9816500917323;3681.3189559931498;3684.2631473705096;5122.1804511278015;5123.538881500645;5131.974340128313;5191;5203.687778733288;4472.84345047925;4670.252759558488;4676.812927482896;4702.976485117552;4787.760611969387;5451.291332126798;5458.935507576024;5465.617406781527;5469.671819690791;5478.616496845222;3988.441618173429;4008.779517126557;4009.31841586928;4021.9798901005306;4025.188665100687;5550.250716153308;5682.886342273131;5732;5733.713314334266;5774.451427114417;4074.796260187038;4078.653314468244;4086.1827634473225;4087.7138600297694;4101.651359634405;4122.525909520444;4127.277726397869;4134.669226461876;4137.2552940471005;4150.833966641361;4622.791974361162;4691;4753.643476739258;4760.33355330254;4764.690295130806;5494.587905907073;5515.227868098469;5519.944800551943;5526.640768350045;5557.221988921554;1383.7094210215766;1405.7821037739168;1408.7393832141086;1408.7745960646248;1415.4621243927243;869.7043005378201;911.7401540560908;914.6341463414687;935.2377812083131;946.1437399153776;5214.191800270964;5368.785248590013;5369.254992127574;5371.650842695212;5392.164214546751;5626.324841019104;5644.350899646511;5644.8024319148635;5667.40492248308;5667.80162694312;5191.84424467259;5340.839774806762;5347.786088556492;5348.893022139613;5402.135658294733;2963.392504536565;2979.1658335666048;2987.5966744489215;2994.4011197760533;2998.220462679719;5770.5095066919785;5810.767569297265;5813;5836.883262334814;5875.764969401176;5526.668399895939;5772.777480669973;5778.682172480554;5789.247397838254;5790.739416726257;5837.912431313449;5838.153467747068;5855.092460668603;5862.384449632812;5870.618409803435;5456.91814622773;5631.662100273997;5655.264815573949;5655.953648575027;5721.885562288648;5617.185508101385;5626;5628.971855140698;5680.375158732453;5682.403347648437;5847.222569279558;5879.412058794086;5903.524118970257;5919.023361145363;5945.702714864153;3897.3374526330026;4036.616521430459;4051.9797401012806;4071.307877660864;4084.264832330209;5618.887622247614;5639.7744090237575;5656.095024796013;5663.8867222656145;5666.575006874584;5321.920171197513;5633.690147041952;5661.348944871228;5666.801661941977;5673.815581001261;5466.80866169698;5483.245361484287;5483.424240454854;5531.944680553304;5532.561534001269;5414.918776218281;5435.483629055233;5498.917516237179;5541.833744987657;5555.638883472561;5359.732013399393;5496.175573663822;5503.679117011969;5565.860853478695;5575.414581468887;5357.78568857257;5402.8649283766645;5405.459454054563;5423.972880135574;5441.8572099859475 21:47:22 INFO - PROCESS | 12531 | |5;yui.html;693.3066933066933;694.0976730250673;715.3669002932403;732.5201992694787;751.823321519443;14048.929755351222;15008.324625391857;15079.92460037701;15120.54638360851;15178.2410879456;12949.35253237339;13009.934950325234;13020.348982550882;13030.34848257588;13039.21764694119;654.5189285874878;775.4726785785664;780.379598219417;791.6754130806371;796.8326651403212;793.6071644535963;796.5499492786586;797.11520212564;797.1271457753751;797.1948332184478;846.4117438380329;848.6732607945954;849.0109022988212;850.7873031742065;856.3577317012241;692.2627401817049;811.9797005074861;834.1283358889974;836.7196989008689;850.7745447456429;614.4132353602299;614.797116951405;615.8090991792559;615.9846003849894;615.9969200154015;13304.13523120994;13329.266890321029;13334.799978000337;13341.332933353293;13351.933240333834;12716.809009107665;12740.299283539402;13085.803712944313;13383.79545840879;13390.19658820464;12693.11148219625;12890;13022.544210952572;13069.346532673328;13583.52457663977;4344.478662560481;4376.7811609419405;4408.7354758714255;4425.668074894395;4492.663050271242;75788;76871;77112.61443692802;77648.61175694142;79546.20453795446;10705.9464702676;10877.782444351227;11173.72065698364;11187.552497900155;11467.827982580267;21644.134234630437;21781;21787.23744668929;21814.345569632937;21908.23321183751;8067.112617612058;8168.632411541495;8310.916890831015;8344.165583441729;8498.617562209716;3987.900302492461;4019.7990100495444;4297.076128632359;4302.677299202573;4309.482862056573;3143.795653282529;3231.2406584452633;3233.2401885556874;3237.271613886857;3238.0609623209475;545.9926435726079;585.7422733997028;592.6207227374484;593.489598944907;594.4768603628779;729.5877829026583;739.164743839458;750.2759836757555;751.620431681997;764.4648745877907;8943.508107054175;9797.265205109645;9813.705588832347;9868.457234852009;10107.595696172071;621.9346968568235;666.6000399760105;739.3863093632273;741.195802554224;785.6032703484703;4562.338460923214;4573.3368661544555;4576.199165146086;4681.204195286809;4732.384789977281;97850;117871;122569.38715306367;127922;128072;85567.14432855716;89869;91351.54324228337;92027;96065;79748.60125699334;83997;86105.5694721535;87811.56094219616;89951.10048899427;9308.698815111553;10242.231832612435;10310.948445257725;10320;10583.237543105479;51832.740836295576;52347.21479177739;53333;54195.729021354644;56157.71921140368;61807.38192618196;73374;73765.26234737584;74780.62609687135;75023.24976750162;12712;12929.353532323157;13296.667583310495;13348;13514.39185236647;13634.318284085557;14030.508932187733;14161.716765664834;14348.354324055234;14469;12633.305168215837;12729.427175777297;12899.744025191605;12990.090693651353;13329.200247985153;13156.60530184096;13642.795358069836;13765.38055787512;13831.723365532835;14391.64020899444;13383.933080334926;13690.726185476036;13725.862741372459;13957.511487097903;14782.113073215642;11192.83210751823;11297.43512824339;11332.830007550057;11387.943060284646;11397.601083962021;10332.50974905478;10502.947485262524;10601.734956626146;10711.517981690688;10741.785164296514 21:47:22 INFO - PROCESS | 12531 | __end_tp_report 21:47:22 INFO - PROCESS | 12531 | __start_cc_report 21:47:22 INFO - PROCESS | 12531 | _x_x_mozilla_cycle_collect,927 21:47:22 INFO - PROCESS | 12531 | __end_cc_report 21:47:22 INFO - PROCESS | 12531 | __startTimestamp1472791642964__endTimestamp 21:47:22 INFO - PROCESS | 12531 | 21:47:22 INFO - PROCESS | 12531 | ------- Summary: start ------- 21:47:22 INFO - PROCESS | 12531 | Number of tests: 6 21:47:22 INFO - PROCESS | 12531 | 21:47:22 INFO - PROCESS | 12531 | [#0] dojo.html Cycles:165 Average:5267.92 Median:5443.81 stddev:589.65 (10.8%) stddev-sans-first:563.67 21:47:22 INFO - PROCESS | 12531 | Values: 2987.8 2998.1 3013.3 3042.0 3068.8 5089.2 5144.4 5206.5 5260.5 5299.5 5185.9 5253.4 5318.1 5338.4 5436.2 4763.3 4811.1 4815.0 4851.4 4893.2 4840.5 4866.6 4886.3 4987.2 4999.7 4921.9 4944.7 4947.5 4987.5 5004.5 4645.0 4665.0 4817.0 4823.3 4898.5 4770.5 4771.7 4799.7 4855.3 4924.1 5317.3 5322.7 5341.0 5356.3 5423.7 5468.1 5552.6 5688.1 5700.8 5721.0 5635.6 5638.4 5652.7 5664.3 5730.4 5245.7 5275.8 5278.6 5281.0 5283.8 5564.3 5700.3 5730.3 5776.1 5784.1 5556.8 5558.0 5562.6 5605.7 5612.4 5635.7 5636.6 5637.7 5638.2 5642.8 5413.1 5566.4 5569.6 5636.0 5689.7 5667.1 5682.7 5687.0 5735.4 5747.5 4388.7 4390.8 4391.0 4391.4 4437.3 3853.3 3855.3 3868.3 3957.6 3977.9 5366.5 5367.2 5368.5 5409.3 5425.9 5676.4 5681.0 5683.8 5685.3 5692.4 5208.7 5309.2 5325.5 5330.3 5434.5 4938.6 4939.6 4941.8 4970.1 4999.7 5867.4 5872.9 5875.4 5881.2 5884.4 5400.0 5622.0 5639.7 5678.4 5739.3 5871.5 5873.7 5874.7 5894.4 5914.9 5591.6 5595.2 5600.7 5602.7 5609.7 5434.1 5647.3 5656.7 5675.9 5696.1 5585.5 5590.4 5602.7 5637.8 5651.7 5580.9 5590.8 5594.2 5597.5 5599.2 5271.9 5399.5 5402.6 5451.3 5581.4 5514.2 5555.9 5564.1 5589.2 5614.0 5430.7 5443.8 5446.0 5448.7 5449.9 21:47:22 INFO - PROCESS | 12531 | 21:47:22 INFO - PROCESS | 12531 | [#1] ext.html Cycles:180 Average:60633.35 Median:37604.44 stddev:123962.13 (329.6%) stddev-sans-first:124227.85 21:47:22 INFO - PROCESS | 12531 | Values: 574.0 600.7 604.0 615.4 625.3 32118.0 42417.6 43491.0 43702.8 43733.6 44729.0 45209.5 45231.8 45237.5 45241.3 8067.4 8860.6 8995.2 9002.0 9025.7 10511.2 10764.4 10773.5 11005.4 11018.0 10919.7 10965.3 10995.5 11069.4 11085.2 10712.1 10782.2 10787.9 10835.6 10858.7 10644.3 10699.1 10716.5 10724.7 10725.1 41401.4 41690.8 41730.2 41730.8 41758.0 3401.4 3519.0 3597.8 3719.6 3892.1 31404.8 31624.2 31668.0 32119.2 32886.5 4340.3 4349.1 4459.7 4464.7 4585.9 352639.0 352991.0 353956.0 354267.0 354353.0 34732.1 58209.4 58570.0 58612.4 58627.4 35841.6 37603.2 37605.6 37625.4 37635.4 14829.9 14965.0 15029.0 15061.3 15089.4 11137.0 12225.9 12476.4 12651.7 12655.4 8428.5 8463.7 8584.7 8610.6 8622.4 3339.1 3361.1 3364.9 3377.2 3386.8 946.9 986.8 1009.4 1067.0 1086.4 31127.0 31819.8 32083.0 32315.2 32648.3 1061.3 1100.7 1101.0 1113.7 1127.3 16034.6 16661.9 16696.2 16840.7 16870.2 584693.0 590710.0 591636.0 596402.0 597227.0 57584.4 57951.7 58279.0 58336.1 58362.7 1214.9 1311.2 1320.8 1345.0 1367.2 31297.8 32375.7 33114.3 33154.7 33900.0 50128.7 50981.5 50984.7 50991.2 51052.2 416691.0 418191.0 418950.0 419948.0 420286.0 24784.6 25603.7 25893.9 25935.1 29823.3 46914.8 46989.8 48452.5 48658.5 48765.5 39504.0 39547.2 41406.2 41726.2 43779.6 41474.1 41841.0 44485.0 44568.1 44693.6 41826.6 42911.6 43235.0 45103.0 46419.5 40648.2 41880.8 42078.6 42494.3 43271.4 28136.2 28548.9 28953.4 29027.9 29186.6 21:47:22 INFO - PROCESS | 12531 | 21:47:22 INFO - PROCESS | 12531 | [#2] jquery.html Cycles:180 Average:27167.80 Median:20029.45 stddev:75030.66 (374.6%) stddev-sans-first:75214.15 21:47:22 INFO - PROCESS | 12531 | Values: 366.1 380.9 396.3 401.1 417.5 16180.0 18713.9 18719.7 18906.1 19373.0 17283.3 17886.3 17910.0 18917.2 19225.9 5470.2 5509.8 5721.7 5722.1 5727.8 5615.4 5620.9 5658.2 5694.3 5702.5 5408.0 5541.3 5619.9 5624.9 5625.1 5524.5 5549.0 5557.0 5561.2 5562.3 4869.8 4891.6 4892.3 4986.3 4993.9 22766.1 22775.9 22914.4 22920.5 23135.7 2105.9 2921.5 3032.2 3063.5 3087.0 10207.9 10326.1 10348.5 10356.3 10473.3 1847.7 1924.9 1997.9 2024.4 2036.2 51894.2 71447.6 81006.0 81379.0 83190.6 10835.7 10855.1 11062.3 11239.0 11465.6 15127.6 15157.2 15158.2 15169.5 15191.0 7678.8 7761.5 8007.4 8145.7 8243.9 7154.6 7273.5 7282.7 7391.9 7582.5 4633.6 4684.4 4704.7 4728.8 4821.1 1963.3 1969.7 1980.7 1993.8 2075.2 834.2 889.0 930.8 964.0 965.0 18065.5 19463.8 19569.5 19589.0 19973.8 959.8 963.4 973.9 981.4 1011.8 10349.2 10664.9 10715.4 10781.9 10793.5 447782.0 448003.0 457184.0 463176.0 463911.0 55377.2 67740.0 86120.6 88646.6 88796.1 994.5 996.1 996.8 1000.1 1028.0 16317.6 16352.2 16560.9 17161.5 17347.7 38516.8 39657.8 40412.6 40513.4 42724.8 54702.9 55019.0 56057.0 58403.7 58934.7 8214.5 8254.9 8396.1 8502.3 8753.6 11889.9 12613.4 12790.9 12822.9 13103.7 10908.5 11217.3 11217.4 11416.8 11608.3 5366.7 8105.7 11341.3 11362.7 11711.6 11441.6 11506.2 11512.2 11846.5 11944.8 8282.5 8519.9 8539.4 8553.3 8636.9 11417.3 11423.8 11473.7 11568.4 11815.5 21:47:22 INFO - PROCESS | 12531 | 21:47:22 INFO - PROCESS | 12531 | [#3] mootools.html Cycles:180 Average:5621.55 Median:5072.38 stddev:3125.61 (61.6%) stddev-sans-first:3117.79 21:47:22 INFO - PROCESS | 12531 | Values: 1337.0 1467.1 1488.7 1622.3 1777.6 8116.9 8483.7 8537.9 8774.6 8793.5 8570.2 8681.8 8687.7 8696.0 8700.7 2342.3 2365.9 2376.0 2377.1 2378.0 2253.7 2275.2 2328.8 2330.8 2330.9 2270.1 2270.2 2280.0 2342.0 2344.4 2257.8 2271.4 2280.6 2284.4 2285.6 2256.4 2268.0 2271.6 2271.8 2277.9 8415.0 8450.2 8509.3 8523.6 8523.7 5051.7 5256.4 5281.1 5281.4 5291.1 3122.9 3269.0 3290.0 3327.9 3340.1 1112.6 1115.4 1137.0 1144.4 1150.3 11434.9 11480.2 11529.1 11532.3 11545.5 4227.9 4388.8 4439.2 4528.2 4542.0 9349.1 9370.1 9392.0 9392.4 9423.9 5037.4 5052.9 5067.1 5070.4 5078.5 4095.2 4640.1 4751.8 4781.0 4838.2 3710.2 3761.7 3853.6 3872.7 3894.2 1112.2 1132.2 1156.4 1164.6 1185.4 863.7 963.6 966.3 973.2 1008.8 5649.9 5870.1 6014.7 6086.6 6119.5 957.5 987.6 996.1 1018.2 1044.1 4045.7 4111.3 4232.7 4252.2 4320.2 10188.7 10322.4 10561.4 10569.7 10790.6 10600.4 10768.1 10773.9 10774.4 10775.0 7859.7 7884.0 7980.6 7992.8 8015.9 5585.9 5589.3 5659.3 5798.2 5800.0 9295.8 9444.0 9447.1 9484.2 9522.2 9570.0 9602.4 9651.1 9659.8 9717.0 6769.9 7318.5 7540.8 7622.9 7751.9 8161.8 8295.4 8303.5 8305.5 8308.7 7365.9 7543.1 7583.4 7597.9 7682.0 7335.7 7391.6 7410.6 7412.2 7620.7 6946.4 7043.5 7066.7 7068.0 7072.3 5051.0 5073.4 5082.2 5110.0 5251.8 5056.4 5071.3 5162.6 5228.0 5357.2 21:47:22 INFO - PROCESS | 12531 | 21:47:22 INFO - PROCESS | 12531 | [#4] prototype.html Cycles:180 Average:4661.61 Median:5353.34 stddev:1368.88 (25.6%) stddev-sans-first:1333.25 21:47:22 INFO - PROCESS | 12531 | Values: 313.7 321.8 322.8 323.2 327.6 5207.6 5267.6 5286.7 5287.2 5299.7 5212.3 5212.3 5237.1 5265.4 5281.8 3974.4 4037.2 4144.1 4177.4 4189.9 4156.6 4167.4 4210.3 4214.5 4228.8 4120.3 4122.3 4129.2 4131.5 4137.7 3947.1 3980.4 4139.0 4145.5 4156.8 3655.8 3656.7 3670.0 3681.3 3684.3 5122.2 5123.5 5132.0 5191.0 5203.7 4472.8 4670.3 4676.8 4703.0 4787.8 5451.3 5458.9 5465.6 5469.7 5478.6 3988.4 4008.8 4009.3 4022.0 4025.2 5550.3 5682.9 5732.0 5733.7 5774.5 4074.8 4078.7 4086.2 4087.7 4101.7 4122.5 4127.3 4134.7 4137.3 4150.8 4622.8 4691.0 4753.6 4760.3 4764.7 5494.6 5515.2 5519.9 5526.6 5557.2 1383.7 1405.8 1408.7 1408.8 1415.5 869.7 911.7 914.6 935.2 946.1 5214.2 5368.8 5369.3 5371.7 5392.2 5626.3 5644.4 5644.8 5667.4 5667.8 5191.8 5340.8 5347.8 5348.9 5402.1 2963.4 2979.2 2987.6 2994.4 2998.2 5770.5 5810.8 5813.0 5836.9 5875.8 5526.7 5772.8 5778.7 5789.2 5790.7 5837.9 5838.2 5855.1 5862.4 5870.6 5456.9 5631.7 5655.3 5656.0 5721.9 5617.2 5626.0 5629.0 5680.4 5682.4 5847.2 5879.4 5903.5 5919.0 5945.7 3897.3 4036.6 4052.0 4071.3 4084.3 5618.9 5639.8 5656.1 5663.9 5666.6 5321.9 5633.7 5661.3 5666.8 5673.8 5466.8 5483.2 5483.4 5531.9 5532.6 5414.9 5435.5 5498.9 5541.8 5555.6 5359.7 5496.2 5503.7 5565.9 5575.4 5357.8 5402.9 5405.5 5424.0 5441.9 21:47:22 INFO - PROCESS | 12531 | 21:47:22 INFO - PROCESS | 12531 | [#5] yui.html Cycles:180 Average:20533.71 Median:4392.76 stddev:29773.12 (677.8%) stddev-sans-first:29819.37 21:47:22 INFO - PROCESS | 12531 | Values: 693.3 694.1 715.4 732.5 751.8 14048.9 15008.3 15079.9 15120.5 15178.2 12949.4 13009.9 13020.3 13030.3 13039.2 654.5 775.5 780.4 791.7 796.8 793.6 796.5 797.1 797.1 797.2 846.4 848.7 849.0 850.8 856.4 692.3 812.0 834.1 836.7 850.8 614.4 614.8 615.8 616.0 616.0 13304.1 13329.3 13334.8 13341.3 13351.9 12716.8 12740.3 13085.8 13383.8 13390.2 12693.1 12890.0 13022.5 13069.3 13583.5 4344.5 4376.8 4408.7 4425.7 4492.7 75788.0 76871.0 77112.6 77648.6 79546.2 10705.9 10877.8 11173.7 11187.6 11467.8 21644.1 21781.0 21787.2 21814.3 21908.2 8067.1 8168.6 8310.9 8344.2 8498.6 3987.9 4019.8 4297.1 4302.7 4309.5 3143.8 3231.2 3233.2 3237.3 3238.1 546.0 585.7 592.6 593.5 594.5 729.6 739.2 750.3 751.6 764.5 8943.5 9797.3 9813.7 9868.5 10107.6 621.9 666.6 739.4 741.2 785.6 4562.3 4573.3 4576.2 4681.2 4732.4 97850.0 117871.0 122569.4 127922.0 128072.0 85567.1 89869.0 91351.5 92027.0 96065.0 79748.6 83997.0 86105.6 87811.6 89951.1 9308.7 10242.2 10310.9 10320.0 10583.2 51832.7 52347.2 53333.0 54195.7 56157.7 61807.4 73374.0 73765.3 74780.6 75023.2 12712.0 12929.4 13296.7 13348.0 13514.4 13634.3 14030.5 14161.7 14348.4 14469.0 12633.3 12729.4 12899.7 12990.1 13329.2 13156.6 13642.8 13765.4 13831.7 14391.6 13383.9 13690.7 13725.9 13957.5 14782.1 11192.8 11297.4 11332.8 11387.9 11397.6 10332.5 10502.9 10601.7 10711.5 10741.8 21:47:22 INFO - PROCESS | 12531 | -------- Summary: end -------- 21:47:22 INFO - PROCESS | 12531 | 21:47:23 INFO - TEST-INFO | 12531: exit 0 21:47:23 INFO - TEST-OK | dromaeo_css | took 1115984ms 21:47:23 INFO - TEST-START | kraken 21:47:23 INFO - operating with platform_type : linux_ 21:47:23 INFO - Initialising browser for kraken test... 21:47:23 INFO - TEST-INFO | started process 12838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb398fW/profile http://localhost:47491/getInfo.html) 21:47:28 INFO - PROCESS | 12838 | __metrics Screen width/height:1600/1200 21:47:28 INFO - PROCESS | 12838 | colorDepth:24 21:47:28 INFO - PROCESS | 12838 | Browser inner width/height: 1024/697 21:47:28 INFO - PROCESS | 12838 | __metrics 21:47:28 INFO - PROCESS | 12838 | 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" 21:47:28 INFO - PROCESS | 12838 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:47:29 INFO - PROCESS | 12838 | console.error: PushService: 21:47:29 INFO - PROCESS | 12838 | stateChangeProcessEnqueue: Error transitioning state 21:47:29 INFO - PROCESS | 12838 | UnknownError 21:47:29 INFO - TEST-INFO | 12838: exit 0 21:47:29 INFO - Browser initialized. 21:47:29 INFO - Running cycle 1/1 for kraken test... 21:47:29 INFO - TEST-INFO | started process 12919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb398fW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:47:41 INFO - PROCESS | 12919 | RSS: Main: 183468032 21:47:41 INFO - PROCESS | 12919 | 21:47:44 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47491/tests/kraken/driver.html?testName=audio-beat-detection) 21:47:45 INFO - PROCESS | 12919 | RSS: Main: 238821376 21:47:45 INFO - PROCESS | 12919 | 21:47:47 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47491/tests/kraken/driver.html?testName=audio-dft) 21:47:48 INFO - PROCESS | 12919 | RSS: Main: 229109760 21:47:48 INFO - PROCESS | 12919 | 21:47:51 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47491/tests/kraken/driver.html?testName=audio-fft) 21:47:52 INFO - PROCESS | 12919 | RSS: Main: 305405952 21:47:52 INFO - PROCESS | 12919 | 21:47:54 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47491/tests/kraken/driver.html?testName=audio-oscillator) 21:47:54 INFO - PROCESS | 12919 | RSS: Main: 216240128 21:47:54 INFO - PROCESS | 12919 | 21:47:56 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47491/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:47:57 INFO - PROCESS | 12919 | RSS: Main: 218689536 21:47:57 INFO - PROCESS | 12919 | 21:48:00 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47491/tests/kraken/driver.html?testName=imaging-darkroom) 21:48:01 INFO - PROCESS | 12919 | RSS: Main: 257708032 21:48:01 INFO - PROCESS | 12919 | 21:48:04 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47491/tests/kraken/driver.html?testName=imaging-desaturate) 21:48:05 INFO - PROCESS | 12919 | RSS: Main: 255590400 21:48:05 INFO - PROCESS | 12919 | 21:48:07 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47491/tests/kraken/driver.html?testName=json-parse-financial) 21:48:08 INFO - PROCESS | 12919 | RSS: Main: 256626688 21:48:08 INFO - PROCESS | 12919 | 21:48:10 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47491/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:48:10 INFO - PROCESS | 12919 | RSS: Main: 218890240 21:48:10 INFO - PROCESS | 12919 | 21:48:12 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47491/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:48:13 INFO - PROCESS | 12919 | RSS: Main: 226996224 21:48:13 INFO - PROCESS | 12919 | 21:48:15 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47491/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:48:15 INFO - PROCESS | 12919 | RSS: Main: 223059968 21:48:15 INFO - PROCESS | 12919 | 21:48:18 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:48:19 INFO - PROCESS | 12919 | RSS: Main: 224616448 21:48:19 INFO - PROCESS | 12919 | 21:48:21 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:48:22 INFO - PROCESS | 12919 | RSS: Main: 221827072 21:48:22 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | Cycle 1(1): loaded http://localhost:47491/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47491/tests/kraken/driver.html?testName=ai-astar) 21:48:24 INFO - PROCESS | 12919 | RSS: Main: 273211392 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | __start_tp_report 21:48:24 INFO - PROCESS | 12919 | _x_x_mozilla_page_load 21:48:24 INFO - PROCESS | 12919 | _x_x_mozilla_page_load_details 21:48:24 INFO - PROCESS | 12919 | |i|pagename|runs| 21:48:24 INFO - PROCESS | 12919 | |0;ai-astar;114;110;122;112;112;112;110;111;110;127 21:48:24 INFO - PROCESS | 12919 | |1;audio-beat-detection;144;129;153;180;121;145;152;118;170;119 21:48:24 INFO - PROCESS | 12919 | |2;audio-dft;160;162;162;161;160;162;161;162;161;160 21:48:24 INFO - PROCESS | 12919 | |3;audio-fft;75;74;75;171;77;76;75;76;161;75 21:48:24 INFO - PROCESS | 12919 | |4;audio-oscillator;82;82;140;83;82;83;138;82;83;135 21:48:24 INFO - PROCESS | 12919 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;116;116;116 21:48:24 INFO - PROCESS | 12919 | |6;imaging-darkroom;148;145;146;146;152;146;145;145;145;146 21:48:24 INFO - PROCESS | 12919 | |7;imaging-desaturate;96;95;95;96;96;95;95;95;96;96 21:48:24 INFO - PROCESS | 12919 | |8;json-parse-financial;51;51;52;54;65;53;53;53;53;60 21:48:24 INFO - PROCESS | 12919 | |9;json-stringify-tinderbox;62;62;61;61;62;60;61;60;61;61 21:48:24 INFO - PROCESS | 12919 | |10;stanford-crypto-aes;79;92;79;78;86;78;77;78;87;78 21:48:24 INFO - PROCESS | 12919 | |11;stanford-crypto-ccm;134;141;123;125;133;125;129;125;170;123 21:48:24 INFO - PROCESS | 12919 | |12;stanford-crypto-pbkdf2;165;168;165;167;163;162;163;164;166;165 21:48:24 INFO - PROCESS | 12919 | |13;stanford-crypto-sha256-iterative;63;64;66;65;67;64;66;71;65;66 21:48:24 INFO - PROCESS | 12919 | __end_tp_report 21:48:24 INFO - PROCESS | 12919 | __start_cc_report 21:48:24 INFO - PROCESS | 12919 | _x_x_mozilla_cycle_collect,1667 21:48:24 INFO - PROCESS | 12919 | __end_cc_report 21:48:24 INFO - PROCESS | 12919 | __startTimestamp1472791704346__endTimestamp 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | ------- Summary: start ------- 21:48:24 INFO - PROCESS | 12919 | Number of tests: 14 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#0] ai-astar Cycles:10 Average:114.00 Median:112.00 stddev:5.79 (5.2%) stddev-sans-first:6.14 21:48:24 INFO - PROCESS | 12919 | Values: 114.0 110.0 122.0 112.0 112.0 112.0 110.0 111.0 110.0 127.0 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:148.50 stddev:21.51 (14.5%) stddev-sans-first:22.81 21:48:24 INFO - PROCESS | 12919 | Values: 144.0 129.0 153.0 180.0 121.0 145.0 152.0 118.0 170.0 119.0 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.83 21:48:24 INFO - PROCESS | 12919 | Values: 160.0 162.0 162.0 161.0 160.0 162.0 161.0 162.0 161.0 160.0 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.00 stddev:38.29 (51.1%) stddev-sans-first:40.03 21:48:24 INFO - PROCESS | 12919 | Values: 75.0 74.0 75.0 171.0 77.0 76.0 75.0 76.0 161.0 75.0 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#4] audio-oscillator Cycles:10 Average:99.00 Median:82.00 stddev:26.71 (32.6%) stddev-sans-first:27.62 21:48:24 INFO - PROCESS | 12919 | Values: 82.0 82.0 140.0 83.0 82.0 83.0 138.0 82.0 83.0 135.0 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 21:48:24 INFO - PROCESS | 12919 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 116.0 116.0 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.00 stddev:2.17 (1.5%) stddev-sans-first:2.22 21:48:24 INFO - PROCESS | 12919 | Values: 148.0 145.0 146.0 146.0 152.0 146.0 145.0 145.0 145.0 146.0 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 21:48:24 INFO - PROCESS | 12919 | Values: 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 96.0 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:53.00 stddev:4.48 (8.4%) stddev-sans-first:4.57 21:48:24 INFO - PROCESS | 12919 | Values: 51.0 51.0 52.0 54.0 65.0 53.0 53.0 53.0 53.0 60.0 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.71 21:48:24 INFO - PROCESS | 12919 | Values: 62.0 62.0 61.0 61.0 62.0 60.0 61.0 60.0 61.0 61.0 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:79.00 stddev:5.18 (6.6%) stddev-sans-first:5.43 21:48:24 INFO - PROCESS | 12919 | Values: 79.0 92.0 79.0 78.0 86.0 78.0 77.0 78.0 87.0 78.0 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:131.00 stddev:14.30 (10.9%) stddev-sans-first:15.17 21:48:24 INFO - PROCESS | 12919 | Values: 134.0 141.0 123.0 125.0 133.0 125.0 129.0 125.0 170.0 123.0 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.00 stddev:1.87 (1.1%) stddev-sans-first:1.99 21:48:24 INFO - PROCESS | 12919 | Values: 165.0 168.0 165.0 167.0 163.0 162.0 163.0 164.0 166.0 165.0 21:48:24 INFO - PROCESS | 12919 | 21:48:24 INFO - PROCESS | 12919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:2.21 (3.4%) stddev-sans-first:2.12 21:48:24 INFO - PROCESS | 12919 | Values: 63.0 64.0 66.0 65.0 67.0 64.0 66.0 71.0 65.0 66.0 21:48:24 INFO - PROCESS | 12919 | -------- Summary: end -------- 21:48:24 INFO - PROCESS | 12919 | 21:48:25 INFO - TEST-INFO | 12919: exit 0 21:48:25 INFO - TEST-OK | kraken | took 61689ms 21:48:25 INFO - SUITE-END | took 1177s 21:48:25 INFO - Completed test suite (00:19:38) 21:48:25 INFO - javascript benchmark 21:48:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2987.7759168062394, 2998.115555911006, 3013.276813564745, 3041.9695803041964, 3068.754499640029, 5089.211172268295, 5144.408393034802, 5206.479352064792, 5260.473952604738, 5299.5230429261355, 5185.948140518603, 5253.369595648527, 5318.1225097858805, 5338.3860856001575, 5436.238926550286, 4763.333133361332, 4811.13399588074, 4814.975925120387, 4851.442084160322, 4893.241547560134, 4840.491748366424, 4866.586340161073, 4886.340344053543, 4987.17711577591, 4999.725015124185, 4921.926171107436, 4944.678595891256, 4947.50524947506, 4987.451380348159, 5004.499550045003, 4645.0, 4665.0, 4817.012512434942, 4823.324734537167, 4898.53463920927, 4770.45139808923, 4771.713697178146, 4799.712017278939, 4855.295982082614, 4924.064427758714, 5317.2821669074565, 5322.7072511011875, 5341.03861304965, 5356.276902618175, 5423.674579525202, 5468.125099983983, 5552.583556233259, 5688.118341657008, 5700.7719691212305, 5720.971395143039, 5635.577331700098, 5638.4361563843695, 5652.717364131818, 5664.26364572603, 5730.36965933747, 5245.737713114368, 5275.841724748187, 5278.604104692164, 5280.973595132, 5283.762230699628, 5564.33228012641, 5700.287464066992, 5730.34101078373, 5776.133579962955, 5784.1034639630925, 5556.805511807148, 5558.0, 5562.610617256834, 5605.691686957257, 5612.410696876851, 5635.661860288314, 5636.577256705764, 5637.68992705397, 5638.210650508932, 5642.830715078554, 5413.10683737179, 5566.443355664401, 5569.554435645138, 5636.04187288162, 5689.743961521742, 5667.064934285879, 5682.659040457585, 5687.0, 5735.426457354315, 5747.453991870766, 4388.71473354231, 4390.824367025347, 4390.978045109754, 4391.407160033418, 4437.312216606431, 3853.344931361675, 3855.3445914194654, 3868.323043467382, 3957.604239576019, 3977.880663580097, 5366.490183432567, 5367.221752845816, 5368.463153684678, 5409.269748583891, 5425.9186112208345, 5676.375598684142, 5681.034224181899, 5683.829485115453, 5685.3177618685195, 5692.430756924275, 5208.73956302191, 5309.230161626542, 5325.4940780625775, 5330.333708286465, 5434.538064264502, 4938.629602779806, 4939.629527785431, 4941.802327906916, 4970.130227210224, 4999.65002449825, 5867.3839246879315, 5872.853178670567, 5875.441833025856, 5881.17663527098, 5884.382139875337, 5400.027994960945, 5622.0, 5639.718014099197, 5678.403767604342, 5739.282589676291, 5871.530277577869, 5873.676947767743, 5874.676892770939, 5894.440028197314, 5914.911276330772, 5591.580631452576, 5595.160725891149, 5600.691961942132, 5602.747876345493, 5609.747561359667, 5434.076207044891, 5647.265855438766, 5656.717164141859, 5675.914861277167, 5696.088625819849, 5585.497305242548, 5590.413006634245, 5602.719864006865, 5637.774489020393, 5651.689157096234, 5580.86047848807, 5590.8043218487155, 5594.16087586849, 5597.496225339739, 5599.244102046335, 5271.89456210866, 5399.4600539945695, 5402.648827826179, 5451.291332126798, 5581.441855814386, 5514.200440936122, 5555.916661250165, 5564.081926482085, 5589.245451864109, 5614.0, 5430.67415955044, 5443.809466668806, 5445.972770136124, 5448.727563621724, 5449.891002180014], "value": 5228.256335621, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [574.0, 600.7026521871675, 604.0425924909019, 615.4030590327383, 625.2684359299619, 32118.0, 42417.57582424175, 43491.0, 43702.78148609253, 43733.56266437335, 44729.0, 45209.513476758766, 45231.77384113083, 45237.547624523744, 45241.321380179324, 8067.354611631055, 8860.556972151398, 8995.235404990584, 9002.0, 9025.729228123168, 10511.211659125596, 10764.407957562331, 10773.515191816387, 11005.449727513593, 11018.0, 10919.672409827677, 10965.342079475216, 10995.505202265877, 11069.446527673625, 11085.168612354066, 10712.089472394817, 10782.245242833005, 10787.946060269687, 10835.620753273677, 10858.72853178669, 10644.254902156852, 10699.144068474503, 10716.517756700889, 10724.678259652223, 10725.141988640968, 41401.378979315035, 41690.791546042376, 41730.1653966922, 41730.79134604338, 41758.0, 3401.4047541680357, 3518.982405087984, 3597.7661452005536, 3719.6466335698065, 3892.143728379752, 31404.842975785203, 31624.209394765086, 31668.0, 32119.19702007445, 32886.506702399485, 4340.262155433584, 4349.13017396522, 4459.710118842265, 4464.709793863389, 4585.922308257557, 352639.0, 352991.0, 353956.0, 354267.0, 354352.99999999744, 34732.13169670728, 58209.41790582125, 58570.0, 58612.41387586069, 58627.41372586305, 35841.64158358435, 37603.247935041145, 37605.62394376076, 37625.435618465744, 37635.43546846799, 14829.851701482847, 14965.0, 15029.0, 15061.322240499203, 15089.396424143131, 11137.0, 12225.877741222652, 12476.440444944383, 12651.683707907376, 12655.43050562727, 8428.536430496259, 8463.74608761738, 8584.74245772628, 8610.569471526398, 8622.396432249683, 3339.148517128165, 3361.1429085583018, 3364.9495257571157, 3377.189474526096, 3386.817280658385, 946.8958414574391, 986.8125056239292, 1009.4448053570507, 1066.989330106689, 1086.3536195963388, 31127.0, 31819.772615917125, 32083.0, 32315.19212019718, 32648.347033059206, 1061.3207547169663, 1100.6973082402403, 1101.0090918173548, 1113.6714669172613, 1127.261643623428, 16034.599135021484, 16661.91669041647, 16696.248668809934, 16840.663186736198, 16870.15649217534, 584693.0, 590710.0, 591636.0, 596402.0, 597227.0, 57584.42415575791, 57951.71024144852, 58279.0, 58336.08319584004, 58362.70818645965, 1214.878512148778, 1311.2394811009592, 1320.7820709583004, 1344.9529266475627, 1367.1591970937802, 31297.8435107823, 32375.67624323821, 33114.33771324608, 33154.668453316124, 33900.0, 50128.749356252985, 50981.490185097675, 50984.74507627438, 50991.2351314738, 51052.23421648604, 416691.0, 418191.0, 418950.0, 419948.0, 420286.0, 24784.628230576196, 25603.743962560136, 25893.87053064798, 25935.092271770398, 29823.25441863884, 46914.76542617265, 46989.76505117452, 48452.5154748448, 48658.513414865396, 48765.5123448761, 39504.0, 39547.2090558193, 41406.171876562905, 41726.165476690905, 43779.562204378824, 41474.13591401665, 41841.0, 44485.0, 44568.10863782771, 44693.55306446894, 41826.581734183485, 42911.570884290755, 43235.0, 45103.0, 46419.53580464152, 40648.18703625852, 41880.79059604683, 42078.579214207464, 42494.26759179327, 43271.35092973545, 28136.15070268148, 28548.85725571359, 28953.420931581673, 29027.85486072556, 29186.56220156742], "value": 19437.307932990065, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.1487042625892, 380.94095415210654, 396.25701809107915, 401.0995315516665, 417.5469615467218, 16180.0291982481, 18713.90643046786, 18719.719204211946, 18906.149223284952, 19373.0, 17283.30866765328, 17886.28454861807, 17910.0, 18917.243310267608, 19225.903870480663, 5470.234167216573, 5509.752061157237, 5721.685307308117, 5722.055860782966, 5727.770889164429, 5615.354234263071, 5620.9437905621035, 5658.151277308396, 5694.288213973254, 5702.543796496291, 5407.999520088796, 5541.27963364764, 5619.887602247953, 5624.887502249952, 5625.115586278602, 5524.502794748471, 5548.972255138739, 5557.0, 5561.193626924114, 5562.304711910991, 4869.829555965524, 4891.633127515451, 4892.290617860426, 4986.301917731521, 4993.925091123636, 22766.089356425724, 22775.886120569292, 22914.427139321484, 22920.54158916829, 23135.652965205536, 2105.9368218953455, 2921.5033444314518, 3032.2267821705545, 3063.463893818595, 3087.0275863103275, 10207.948960255151, 10326.122279606243, 10348.482575871176, 10356.326838755456, 10473.26687131901, 1847.7413162157309, 1924.913378897953, 1997.9001049947444, 2024.4230394337544, 2036.2262340310735, 51894.22158667623, 71447.64276178638, 81006.0, 81379.0, 83190.58404707938, 10835.67492975212, 10855.131589472981, 11062.336259824437, 11239.0, 11465.598704045486, 15127.621809454851, 15157.166355850313, 15158.242087895562, 15169.544913652608, 15191.0, 7678.8080297993, 7761.495502792301, 8007.359411247086, 8145.674173033012, 8243.876341854877, 7154.642267886689, 7273.527220730742, 7282.672279747424, 7391.926080739231, 7582.507137036075, 4633.606143477775, 4684.414448193976, 4704.717716936994, 4728.763561821896, 4821.108095002436, 1963.2539634938632, 1969.714391413237, 1980.6929925861514, 1993.8205561499535, 2075.1699320272014, 834.1991687979607, 888.9777755556163, 930.7905721212809, 963.9518024098767, 965.0, 18065.54836129081, 19463.80536194648, 19569.510762230773, 19589.0, 19973.800261997483, 959.8320293948531, 963.4276481793628, 973.8880028796779, 981.4405788700373, 1011.7622358745689, 10349.172066234683, 10664.946675266729, 10715.410652414037, 10781.926676911417, 10793.50171848768, 447782.0, 448003.0, 457184.0, 463176.0, 463911.0, 55377.16934245989, 67740.0, 86120.56939715262, 88646.55676721575, 88796.11203887878, 994.5425104452033, 996.1184351848666, 996.7956568903502, 1000.139879703469, 1027.9537420816082, 16317.592060198114, 16352.182390880645, 16560.917195413946, 17161.485155445356, 17347.65304693874, 38516.80741596274, 39657.80171099126, 40412.59587404206, 40513.39229911612, 42724.78637606916, 54702.854001099295, 55019.0, 56057.0, 58403.70798145982, 58934.70532647309, 8214.4660597061, 8254.917450825655, 8396.076431592643, 8502.319814414708, 8753.64985400577, 11889.940550297193, 12613.432395542406, 12790.872091278969, 12822.87177128254, 13103.672408189872, 10908.454577271263, 11217.326960382403, 11217.439128043728, 11416.82874756896, 11608.30350178992, 5366.651167674088, 8105.675772969015, 11341.26281791681, 11362.659120226406, 11711.648650540497, 11441.599544015919, 11506.194566380273, 11512.194146410005, 11846.466908988943, 11944.820827687417, 8282.461639993382, 8519.872201916853, 8539.402241843012, 8553.315734741082, 8636.913630863863, 11417.31496110236, 11423.828642570534, 11473.655790326304, 11568.363739994382, 11815.468303926516], "value": 8958.51069093999, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.0306527767375, 1467.1343907094815, 1488.7245859515988, 1622.3186261770056, 1777.5733823882272, 8116.944797176367, 8483.745487635373, 8537.914620853797, 8774.561271936394, 8793.472391656505, 8570.228679418851, 8681.782955426117, 8687.73936781896, 8696.0, 8700.65197392105, 2342.2973108067595, 2365.8817059146972, 2375.964360534593, 2377.061060880951, 2377.9643305350346, 2253.6732173834785, 2275.2036787124457, 2328.7787660172257, 2330.8018818400456, 2330.8718020508863, 2270.14869423966, 2270.20542810016, 2279.9772002280015, 2341.95316093678, 2344.4490544721975, 2257.7742225777456, 2271.4094335472814, 2280.646499792535, 2284.4288927768057, 2285.5543169082034, 2256.4133325335365, 2268.0474200835524, 2271.6251818449937, 2271.7501074881748, 2277.8974946127464, 8415.032271288757, 8450.19723126302, 8509.319254459628, 8523.573821308972, 8523.701670441567, 5051.696898186121, 5256.421793602701, 5281.128613778722, 5281.39263984639, 5291.126964050927, 3122.9063128106195, 3268.950965735516, 3289.9965510519282, 3327.933441331184, 3340.064781861083, 1112.6105862947984, 1115.380963565221, 1137.010800603472, 1144.3820337018, 1150.2925700694097, 11434.942825285903, 11480.196386252966, 11529.077673786078, 11532.308061516336, 11545.538178472934, 4227.852025179104, 4388.802503887333, 4439.223135951195, 4528.184926713223, 4542.046170304207, 9349.111834375723, 9370.062993700712, 9392.01383854699, 9392.389494682824, 9423.905760942303, 5037.370328708911, 5052.949470505321, 5067.087924173684, 5070.366204224472, 5078.492150784892, 4095.1604920991126, 4640.095181439654, 4751.786169622375, 4781.043791241766, 4838.2016967200725, 3710.2376371223454, 3761.7022127366013, 3853.614638536124, 3872.7095467839463, 3894.201688653819, 1112.2047735868894, 1132.1678566253797, 1156.4102307822902, 1164.6098556983336, 1185.4250688416112, 863.710656929923, 963.5808423335872, 966.3042609321277, 973.1922504321396, 1008.7982403519326, 5649.858753531113, 5870.090136028923, 6014.699265036731, 6086.60437071589, 6119.479844213202, 957.5451660461225, 987.5852142100335, 996.1234113979797, 1018.2057994764095, 1044.12815299226, 4045.7431767426915, 4111.259973204852, 4232.661387089025, 4252.213340532012, 4320.222359975234, 10188.745281367877, 10322.380657160595, 10561.419121948367, 10569.735756605993, 10790.622328218475, 10600.416977066336, 10768.0847127995, 10773.89226107729, 10774.353538787698, 10775.030247277782, 7859.724909628136, 7883.960580197062, 7980.600969951479, 7992.800179995546, 8015.919840801634, 5585.855558885356, 5589.301337332833, 5659.3491748447805, 5798.213022820357, 5800.0, 9295.769015436383, 9444.0, 9447.102525260088, 9484.241260699266, 9522.238220942447, 9569.952150239204, 9602.423854568748, 9651.131398174199, 9659.806803863743, 9716.951415242878, 6769.898451523132, 7318.451116166202, 7540.773776786705, 7622.885656715264, 7751.914731937421, 8161.79595510117, 8295.377846661646, 8303.501789892625, 8305.46014509055, 8308.667653294042, 7365.852682946418, 7543.057117860268, 7583.355414789805, 7597.88603170964, 7682.0397450318715, 7335.669894854637, 7391.630418478947, 7410.62946852666, 7412.1846596875375, 7620.657070431955, 6946.409555187865, 7043.471739619446, 7066.7173313066905, 7068.0, 7072.328128827753, 5050.965771625655, 5073.416557095981, 5082.2122571001555, 5110.0, 5251.816186433456, 5056.367954005749, 5071.340725705634, 5162.612804039787, 5228.032813929435, 5357.214248590633], "value": 4531.765223384424, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.68161316263996, 321.77314992929985, 322.80631621027374, 323.2194250884115, 327.5888759606693, 5207.609429292804, 5267.578593712504, 5286.682799032056, 5287.233351164079, 5299.655522391046, 5212.2963399941, 5212.348456442945, 5237.083510385677, 5265.420803711589, 5281.815136470224, 3974.3839704845795, 4037.212743515001, 4144.109016561439, 4177.415161877339, 4189.853355132571, 4156.6051225133715, 4167.374893765929, 4210.2737877470245, 4214.450257594157, 4228.830846766141, 4120.278951183546, 4122.278601244785, 4129.174165166964, 4131.52487463941, 4137.66898648109, 3947.131631041166, 3980.3879428831515, 4138.958610413887, 4145.481814773153, 4156.771377574232, 3655.8354874030733, 3656.6526180012856, 3669.9816500917323, 3681.3189559931498, 3684.2631473705096, 5122.1804511278015, 5123.538881500645, 5131.974340128313, 5191.0, 5203.687778733288, 4472.84345047925, 4670.252759558488, 4676.812927482896, 4702.976485117552, 4787.760611969387, 5451.291332126798, 5458.935507576024, 5465.617406781527, 5469.671819690791, 5478.616496845222, 3988.441618173429, 4008.779517126557, 4009.31841586928, 4021.9798901005306, 4025.188665100687, 5550.250716153308, 5682.886342273131, 5732.0, 5733.713314334266, 5774.451427114417, 4074.796260187038, 4078.653314468244, 4086.1827634473225, 4087.7138600297694, 4101.651359634405, 4122.525909520444, 4127.277726397869, 4134.669226461876, 4137.2552940471005, 4150.833966641361, 4622.791974361162, 4691.0, 4753.643476739258, 4760.33355330254, 4764.690295130806, 5494.587905907073, 5515.227868098469, 5519.944800551943, 5526.640768350045, 5557.221988921554, 1383.7094210215766, 1405.7821037739168, 1408.7393832141086, 1408.7745960646248, 1415.4621243927243, 869.7043005378201, 911.7401540560908, 914.6341463414687, 935.2377812083131, 946.1437399153776, 5214.191800270964, 5368.785248590013, 5369.254992127574, 5371.650842695212, 5392.164214546751, 5626.324841019104, 5644.350899646511, 5644.8024319148635, 5667.40492248308, 5667.80162694312, 5191.84424467259, 5340.839774806762, 5347.786088556492, 5348.893022139613, 5402.135658294733, 2963.392504536565, 2979.1658335666048, 2987.5966744489215, 2994.4011197760533, 2998.220462679719, 5770.5095066919785, 5810.767569297265, 5813.0, 5836.883262334814, 5875.764969401176, 5526.668399895939, 5772.777480669973, 5778.682172480554, 5789.247397838254, 5790.739416726257, 5837.912431313449, 5838.153467747068, 5855.092460668603, 5862.384449632812, 5870.618409803435, 5456.91814622773, 5631.662100273997, 5655.264815573949, 5655.953648575027, 5721.885562288648, 5617.185508101385, 5626.0, 5628.971855140698, 5680.375158732453, 5682.403347648437, 5847.222569279558, 5879.412058794086, 5903.524118970257, 5919.023361145363, 5945.702714864153, 3897.3374526330026, 4036.616521430459, 4051.9797401012806, 4071.307877660864, 4084.264832330209, 5618.887622247614, 5639.7744090237575, 5656.095024796013, 5663.8867222656145, 5666.575006874584, 5321.920171197513, 5633.690147041952, 5661.348944871228, 5666.801661941977, 5673.815581001261, 5466.80866169698, 5483.245361484287, 5483.424240454854, 5531.944680553304, 5532.561534001269, 5414.918776218281, 5435.483629055233, 5498.917516237179, 5541.833744987657, 5555.638883472561, 5359.732013399393, 5496.175573663822, 5503.679117011969, 5565.860853478695, 5575.414581468887, 5357.78568857257, 5402.8649283766645, 5405.459454054563, 5423.972880135574, 5441.8572099859475], "value": 4219.341135943229, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [693.3066933066933, 694.0976730250673, 715.3669002932403, 732.5201992694787, 751.823321519443, 14048.929755351222, 15008.324625391857, 15079.92460037701, 15120.54638360851, 15178.2410879456, 12949.35253237339, 13009.934950325234, 13020.348982550882, 13030.34848257588, 13039.21764694119, 654.5189285874878, 775.4726785785664, 780.379598219417, 791.6754130806371, 796.8326651403212, 793.6071644535963, 796.5499492786586, 797.11520212564, 797.1271457753751, 797.1948332184478, 846.4117438380329, 848.6732607945954, 849.0109022988212, 850.7873031742065, 856.3577317012241, 692.2627401817049, 811.9797005074861, 834.1283358889974, 836.7196989008689, 850.7745447456429, 614.4132353602299, 614.797116951405, 615.8090991792559, 615.9846003849894, 615.9969200154015, 13304.13523120994, 13329.266890321029, 13334.799978000337, 13341.332933353293, 13351.933240333834, 12716.809009107665, 12740.299283539402, 13085.803712944313, 13383.79545840879, 13390.19658820464, 12693.11148219625, 12890.0, 13022.544210952572, 13069.346532673328, 13583.52457663977, 4344.478662560481, 4376.7811609419405, 4408.7354758714255, 4425.668074894395, 4492.663050271242, 75788.0, 76871.0, 77112.61443692802, 77648.61175694142, 79546.20453795446, 10705.9464702676, 10877.782444351227, 11173.72065698364, 11187.552497900155, 11467.827982580267, 21644.134234630437, 21781.0, 21787.23744668929, 21814.345569632937, 21908.23321183751, 8067.112617612058, 8168.632411541495, 8310.916890831015, 8344.165583441729, 8498.617562209716, 3987.900302492461, 4019.7990100495444, 4297.076128632359, 4302.677299202573, 4309.482862056573, 3143.795653282529, 3231.2406584452633, 3233.2401885556874, 3237.271613886857, 3238.0609623209475, 545.9926435726079, 585.7422733997028, 592.6207227374484, 593.489598944907, 594.4768603628779, 729.5877829026583, 739.164743839458, 750.2759836757555, 751.620431681997, 764.4648745877907, 8943.508107054175, 9797.265205109645, 9813.705588832347, 9868.457234852009, 10107.595696172071, 621.9346968568235, 666.6000399760105, 739.3863093632273, 741.195802554224, 785.6032703484703, 4562.338460923214, 4573.3368661544555, 4576.199165146086, 4681.204195286809, 4732.384789977281, 97850.0, 117871.0, 122569.38715306367, 127922.0, 128072.0, 85567.14432855716, 89869.0, 91351.54324228337, 92027.0, 96065.0, 79748.60125699334, 83997.0, 86105.5694721535, 87811.56094219616, 89951.10048899427, 9308.698815111553, 10242.231832612435, 10310.948445257725, 10320.0, 10583.237543105479, 51832.740836295576, 52347.21479177739, 53333.0, 54195.729021354644, 56157.71921140368, 61807.38192618196, 73374.0, 73765.26234737584, 74780.62609687135, 75023.24976750162, 12712.0, 12929.353532323157, 13296.667583310495, 13348.0, 13514.39185236647, 13634.318284085557, 14030.508932187733, 14161.716765664834, 14348.354324055234, 14469.0, 12633.305168215837, 12729.427175777297, 12899.744025191605, 12990.090693651353, 13329.200247985153, 13156.60530184096, 13642.795358069836, 13765.38055787512, 13831.723365532835, 14391.64020899444, 13383.933080334926, 13690.726185476036, 13725.862741372459, 13957.511487097903, 14782.113073215642, 11192.83210751823, 11297.43512824339, 11332.830007550057, 11387.943060284646, 11397.601083962021, 10332.50974905478, 10502.947485262524, 10601.734956626146, 10711.517981690688, 10741.785164296514], "value": 7410.098505986637, "unit": "score"}], "name": "dromaeo_css", "value": 7108.340931388837, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 110.0, 122.0, 112.0, 112.0, 112.0, 110.0, 111.0, 110.0, 127.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 129.0, 153.0, 180.0, 121.0, 145.0, 152.0, 118.0, 170.0, 119.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 162.0, 162.0, 161.0, 160.0, 162.0, 161.0, 162.0, 161.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 171.0, 77.0, 76.0, 75.0, 76.0, 161.0, 75.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 140.0, 83.0, 82.0, 83.0, 138.0, 82.0, 83.0, 135.0], "value": 99.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 116.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 145.0, 146.0, 146.0, 152.0, 146.0, 145.0, 145.0, 145.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 52.0, 54.0, 65.0, 53.0, 53.0, 53.0, 53.0, 60.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 61.0, 61.0, 62.0, 60.0, 61.0, 60.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 92.0, 79.0, 78.0, 86.0, 78.0, 77.0, 78.0, 87.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 141.0, 123.0, 125.0, 133.0, 125.0, 129.0, 125.0, 170.0, 123.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 165.0, 167.0, 163.0, 162.0, 163.0, 164.0, 166.0, 165.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 66.0, 65.0, 67.0, 64.0, 66.0, 71.0, 65.0, 66.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1529.3, "alertThreshold": 2.0}]} 21:48:26 INFO - Return code: 0 21:48:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:48:26 INFO - # TBPL SUCCESS # 21:48:26 INFO - Running post-action listener: _resource_record_post_action 21:48:26 INFO - [mozharness: 2016-09-02 04:48:26.120916Z] Finished run-tests step (success) 21:48:26 INFO - Running post-run listener: _resource_record_post_run 21:48:26 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 424341504; Read time: 12; Write time: 355388 21:48:26 INFO - TinderboxPrint: CPU usage
13.1% 21:48:26 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:48:26 INFO - TinderboxPrint: I/O write bytes / time
424,341,504 / 355,388 21:48:26 INFO - TinderboxPrint: CPU idle
8,287.8 (86.9%) 21:48:26 INFO - TinderboxPrint: CPU user
1,196.5 (12.5%) 21:48:26 INFO - TinderboxPrint: Swap in / out
0 / 0 21:48:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 135241728; Read time: 0; Write time: 105044 21:48:26 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 289099776; Read time: 0; Write time: 250344 21:48:26 INFO - Running post-run listener: _upload_blobber_files 21:48:26 INFO - Blob upload gear active. 21:48:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:48:26 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 21:48:26 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:48:26 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:48:27 INFO - (blobuploader) - INFO - Open directory for files ... 21:48:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:48:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:48:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:48:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:48:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:48:30 INFO - (blobuploader) - INFO - Done attempting. 21:48:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:48:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:48:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:48:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:48:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:48:31 INFO - (blobuploader) - INFO - Done attempting. 21:48:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:48:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:48:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:48:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:48:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:48:32 INFO - (blobuploader) - INFO - Done attempting. 21:48:32 INFO - (blobuploader) - INFO - Iteration through files over. 21:48:32 INFO - Return code: 0 21:48:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:48:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:48:32 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4b7d352ff0c65fe6727c156b47842fe207c0e0dfcb38632267a8c6a95ced5accb015e5d9f6e5a01f84fc1bd0066b1830bdf988653599444b7ab28a1cefb1c277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d17f86d7166701460f79fe34909fb448603ee69914182733cf09301d0cffcc577702077c37a40984ac6555e9025b25cbf06a099f7a97fdf3998ea1f319abeae2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bd3e94583c98909efd525dc34e37c19ba9dae72a046a827e21eb2f37958b9d7851667ceb2209d74e676ef0d94be631632c020113aa89a571dc1b3359f85fac9"} 21:48:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:48:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:48:32 INFO - Contents: 21:48:32 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4b7d352ff0c65fe6727c156b47842fe207c0e0dfcb38632267a8c6a95ced5accb015e5d9f6e5a01f84fc1bd0066b1830bdf988653599444b7ab28a1cefb1c277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d17f86d7166701460f79fe34909fb448603ee69914182733cf09301d0cffcc577702077c37a40984ac6555e9025b25cbf06a099f7a97fdf3998ea1f319abeae2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bd3e94583c98909efd525dc34e37c19ba9dae72a046a827e21eb2f37958b9d7851667ceb2209d74e676ef0d94be631632c020113aa89a571dc1b3359f85fac9"} 21:48:32 INFO - Running post-run listener: copy_logs_to_upload_dir 21:48:32 INFO - Copying logs to upload dir... 21:48:32 INFO - mkdir: /builds/slave/test/build/upload/logs 21:48:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.546393 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-09-01 21:48:31.834861) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 21:48:31.838420) ========= 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=db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4b7d352ff0c65fe6727c156b47842fe207c0e0dfcb38632267a8c6a95ced5accb015e5d9f6e5a01f84fc1bd0066b1830bdf988653599444b7ab28a1cefb1c277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d17f86d7166701460f79fe34909fb448603ee69914182733cf09301d0cffcc577702077c37a40984ac6555e9025b25cbf06a099f7a97fdf3998ea1f319abeae2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bd3e94583c98909efd525dc34e37c19ba9dae72a046a827e21eb2f37958b9d7851667ceb2209d74e676ef0d94be631632c020113aa89a571dc1b3359f85fac9"} build_url:https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/Co1a0G03SnmxzHBMTy5b4w/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/4b7d352ff0c65fe6727c156b47842fe207c0e0dfcb38632267a8c6a95ced5accb015e5d9f6e5a01f84fc1bd0066b1830bdf988653599444b7ab28a1cefb1c277", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/d17f86d7166701460f79fe34909fb448603ee69914182733cf09301d0cffcc577702077c37a40984ac6555e9025b25cbf06a099f7a97fdf3998ea1f319abeae2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/9bd3e94583c98909efd525dc34e37c19ba9dae72a046a827e21eb2f37958b9d7851667ceb2209d74e676ef0d94be631632c020113aa89a571dc1b3359f85fac9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-01 21:48:31.864263) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 21:48:31.864626) ========= 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=db0483c52d987ecb441a263b000001ad-1472787742.106158-208300957 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004527 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-01 21:48:31.974175) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 21:48:31.974508) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-01 21:48:31.974783) ========= ========= Total master_lag: 0.23 =========