builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-068 starttime: 1471564446.25 results: success (0) buildid: 20160818150855 builduid: b0ea43cc06f24f3ca1595ee90ab05788 revision: e7b45868aa75fe8c3d6c47e9c819ed8bf36deb53 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:06.252894) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:06.253450) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:06.253783) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:06.274423) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:06.274813) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 16:54:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-08-18 16:54:07 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119084 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:06.407729) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:06.408050) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023038 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:06.457914) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:06.458291) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e7b45868aa75fe8c3d6c47e9c819ed8bf36deb53 --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 e7b45868aa75fe8c3d6c47e9c819ed8bf36deb53 --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=97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 16:54:07,139 truncating revision to first 12 chars 2016-08-18 16:54:07,139 Setting DEBUG logging. 2016-08-18 16:54:07,139 attempt 1/10 2016-08-18 16:54:07,139 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e7b45868aa75?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 16:54:07,717 unpacking tar archive at: autoland-e7b45868aa75/testing/mozharness/ program finished with exit code 0 elapsedTime=0.936398 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:07.408556) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:07.408886) ========= script_repo_revision: e7b45868aa75fe8c3d6c47e9c819ed8bf36deb53 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:07.409278) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:07.409548) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 16:54:07.419600) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 4 secs) (at 2016-08-18 16:54:07.419908) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 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-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] 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=97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:54:08 INFO - MultiFileLogger online at 20160818 16:54:08 in /builds/slave/test 16:54:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 16:54:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:54:08 INFO - {'append_to_log': False, 16:54:08 INFO - 'base_work_dir': '/builds/slave/test', 16:54:08 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 16:54:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:54:08 INFO - 'branch': 'Autoland-Non-PGO', 16:54:08 INFO - 'buildbot_json_path': 'buildprops.json', 16:54:08 INFO - 'config_files': ('talos/linux_config.py',), 16:54:08 INFO - 'default_actions': ('clobber', 16:54:08 INFO - 'read-buildbot-config', 16:54:08 INFO - 'download-and-extract', 16:54:08 INFO - 'populate-webroot', 16:54:08 INFO - 'create-virtualenv', 16:54:08 INFO - 'install', 16:54:08 INFO - 'run-tests'), 16:54:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:54:08 INFO - 'download_minidump_stackwalk': True, 16:54:08 INFO - 'download_symbols': 'ondemand', 16:54:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:54:08 INFO - 'tooltool.py': '/tools/tooltool.py', 16:54:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:54:08 INFO - '/tools/misc-python/virtualenv.py')}, 16:54:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:54:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:54:08 INFO - 'installer_path': 'installer.exe', 16:54:08 INFO - 'log_level': 'info', 16:54:08 INFO - 'log_name': 'talos', 16:54:08 INFO - 'log_to_console': True, 16:54:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:54:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:54:08 INFO - 'opt_config_files': (), 16:54:08 INFO - 'pip_index': False, 16:54:08 INFO - 'sps_profile': False, 16:54:08 INFO - 'sps_profile_interval': 0, 16:54:08 INFO - 'suite': 'dromaeojs', 16:54:08 INFO - 'system_bits': '32', 16:54:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:54:08 INFO - 'title': 'talos-linux64-ix-068', 16:54:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:54:08 INFO - 'use_talos_json': True, 16:54:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:54:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:54:08 INFO - 'work_dir': 'build'} 16:54:08 INFO - [mozharness: 2016-08-18 23:54:08.199373Z] Running clobber step. 16:54:08 INFO - Running pre-action listener: _resource_record_pre_action 16:54:08 INFO - Running main action method: clobber 16:54:08 INFO - rmtree: /builds/slave/test/build 16:54:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:54:08 INFO - Running post-action listener: _resource_record_post_action 16:54:08 INFO - [mozharness: 2016-08-18 23:54:08.662306Z] Finished clobber step (success) 16:54:08 INFO - [mozharness: 2016-08-18 23:54:08.662407Z] Running read-buildbot-config step. 16:54:08 INFO - Running pre-action listener: _resource_record_pre_action 16:54:08 INFO - Running main action method: read_buildbot_config 16:54:08 INFO - Using buildbot properties: 16:54:08 INFO - { 16:54:08 INFO - "project": "", 16:54:08 INFO - "product": "firefox", 16:54:08 INFO - "script_repo_revision": "production", 16:54:08 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 16:54:08 INFO - "repository": "", 16:54:08 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 16:54:08 INFO - "buildid": "20160818150855", 16:54:08 INFO - "pgo_build": "False", 16:54:08 INFO - "basedir": "/builds/slave/test", 16:54:08 INFO - "buildnumber": 330, 16:54:08 INFO - "slavename": "talos-linux64-ix-068", 16:54:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:54:08 INFO - "platform": "ubuntu64_hw", 16:54:08 INFO - "scheduler": "tests-autoland-linux64-talos", 16:54:08 INFO - "branch": "autoland", 16:54:08 INFO - "repo_path": "integration/autoland", 16:54:08 INFO - "revision": "e7b45868aa75fe8c3d6c47e9c819ed8bf36deb53", 16:54:08 INFO - "stage_platform": "linux64", 16:54:08 INFO - "builduid": "b0ea43cc06f24f3ca1595ee90ab05788", 16:54:08 INFO - "slavebuilddir": "test" 16:54:08 INFO - } 16:54:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 16:54:08 INFO - Running post-action listener: _resource_record_post_action 16:54:08 INFO - [mozharness: 2016-08-18 23:54:08.664847Z] Finished read-buildbot-config step (success) 16:54:08 INFO - [mozharness: 2016-08-18 23:54:08.664935Z] Running download-and-extract step. 16:54:08 INFO - Running pre-action listener: _resource_record_pre_action 16:54:08 INFO - Running main action method: download_and_extract 16:54:08 INFO - mkdir: /builds/slave/test/build/tests 16:54:08 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')]} 16:54:08 INFO - trying https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:54:08 INFO - Downloading https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/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 16:54:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/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 16:54:09 INFO - Downloaded 1361 bytes. 16:54:09 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 16:54:09 INFO - Using the following test package requirements: 16:54:09 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:54:09 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:54:09 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:54:09 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:09 INFO - u'jsshell-linux-x86_64.zip'], 16:54:09 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:54:09 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 16:54:09 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:54:09 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:54:09 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:54:09 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 16:54:09 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:54:09 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:54:09 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')]} 16:54:09 INFO - trying https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:54:09 INFO - Downloading https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/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 16:54:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/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 16:54:10 INFO - Downloaded 20317434 bytes. 16:54:10 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 16:54:14 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 16:54: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')]} 16:54:14 INFO - trying https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 16:54:14 INFO - Downloading https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/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 16:54:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/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 16:54:15 INFO - Downloaded 20317434 bytes. 16:54:15 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 16:54: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')]} 16:54:19 INFO - trying https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 16:54:19 INFO - Downloading https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/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 16:54:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/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 16:54:20 INFO - Downloaded 14413981 bytes. 16:54:20 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 16:54:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:20 INFO - trying https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:54:20 INFO - Downloading https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/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 16:54:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/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 16:54:21 INFO - Downloaded 55768330 bytes. 16:54:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:54:21 INFO - mkdir: /builds/slave/test/properties 16:54:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:54:21 INFO - Writing to file /builds/slave/test/properties/build_url 16:54:21 INFO - Contents: 16:54:21 INFO - build_url:https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 16:54:22 INFO - Running post-action listener: _resource_record_post_action 16:54:22 INFO - Running post-action listener: set_extra_try_arguments 16:54:22 INFO - [mozharness: 2016-08-18 23:54:22.596330Z] Finished download-and-extract step (success) 16:54:22 INFO - [mozharness: 2016-08-18 23:54:22.596556Z] Running populate-webroot step. 16:54:22 INFO - Running pre-action listener: _resource_record_pre_action 16:54:22 INFO - Running main action method: populate_webroot 16:54:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:54:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:54:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:54:22 INFO - '--tppagecycles', 16:54:22 INFO - '7'], 16:54:22 INFO - 'tests': ['tsvgm']}}, 16:54:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:54:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:54:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:54:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:54:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:54:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:54:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:22 INFO - 'talos_options': ['--disable-e10s'], 16:54:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:54:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:22 INFO - 'talos_options': ['--disable-e10s'], 16:54:22 INFO - 'tests': ['damp', 'tps']}, 16:54:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:22 INFO - 'tests': ['damp', 'tps']}, 16:54:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:54:22 INFO - 'tests': ['dromaeo_dom']}, 16:54:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:54:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:54:22 INFO - 'tests': ['basic_compositor_video']}, 16:54:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:54:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:54:22 INFO - 'tests': ['a11yr', 16:54:22 INFO - 'ts_paint', 16:54:22 INFO - 'tpaint', 16:54:22 INFO - 'sessionrestore', 16:54:22 INFO - 'sessionrestore_no_auto_restore', 16:54:22 INFO - 'tabpaint']}, 16:54:22 INFO - 'other-e10s': {'tests': ['a11yr', 16:54:22 INFO - 'ts_paint', 16:54:22 INFO - 'tpaint', 16:54:22 INFO - 'sessionrestore', 16:54:22 INFO - 'sessionrestore_no_auto_restore', 16:54:22 INFO - 'tabpaint']}, 16:54:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:54:22 INFO - 'ts_paint', 16:54:22 INFO - 'tpaint', 16:54:22 INFO - 'sessionrestore', 16:54:22 INFO - 'sessionrestore_no_auto_restore', 16:54:22 INFO - 'tabpaint']}, 16:54:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:54:22 INFO - 'ts_paint', 16:54:22 INFO - 'tpaint', 16:54:22 INFO - 'sessionrestore', 16:54:22 INFO - 'sessionrestore_no_auto_restore', 16:54:22 INFO - 'tabpaint']}, 16:54:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:54:22 INFO - 'tests': ['a11yr', 16:54:22 INFO - 'ts_paint', 16:54:22 INFO - 'tpaint', 16:54:22 INFO - 'sessionrestore', 16:54:22 INFO - 'sessionrestore_no_auto_restore', 16:54:22 INFO - 'tabpaint']}, 16:54:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:54:22 INFO - 'tests': ['a11yr', 16:54:22 INFO - 'ts_paint', 16:54:22 INFO - 'tpaint', 16:54:22 INFO - 'sessionrestore', 16:54:22 INFO - 'sessionrestore_no_auto_restore', 16:54:22 INFO - 'tabpaint']}, 16:54:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:54:22 INFO - 'tests': ['tsvgx', 16:54:22 INFO - 'tsvgr_opacity', 16:54:22 INFO - 'tart', 16:54:22 INFO - 'tscrollx', 16:54:22 INFO - 'cart']}, 16:54:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:54:22 INFO - 'tsvgr_opacity', 16:54:22 INFO - 'tart', 16:54:22 INFO - 'tscrollx', 16:54:22 INFO - 'cart']}, 16:54:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:22 INFO - 'talos_options': ['--disable-e10s'], 16:54:22 INFO - 'tests': ['tp5o']}, 16:54:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:22 INFO - 'tests': ['tp5o']}, 16:54:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:22 INFO - 'talos_options': ['--disable-e10s', 16:54:22 INFO - '--xperf_path', 16:54:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:22 INFO - 'tests': ['tp5n']}, 16:54:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:54:22 INFO - 'talos_options': ['--xperf_path', 16:54:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:54:22 INFO - 'tests': ['tp5n']}}, 16:54:22 INFO - 'talos.zip': {'path': '', 16:54:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:54:22 INFO - Running post-action listener: _resource_record_post_action 16:54:22 INFO - [mozharness: 2016-08-18 23:54:22.618424Z] Finished populate-webroot step (success) 16:54:22 INFO - [mozharness: 2016-08-18 23:54:22.618513Z] Running create-virtualenv step. 16:54:22 INFO - Running pre-action listener: _resource_record_pre_action 16:54:22 INFO - Running main action method: create_virtualenv 16:54:22 INFO - Creating virtualenv /builds/slave/test/build/venv 16:54:22 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 16:54:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:54:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:54:22 INFO - Using real prefix '/usr' 16:54:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:54:23 INFO - Installing distribute.............................................................................................................................................................................................done. 16:54:25 INFO - Installing pip.................done. 16:54:25 INFO - Return code: 0 16:54:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:25 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 0x7fdc46f37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1346090>, '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 0x13499b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1349e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', '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 16:54:25 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 16:54:25 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 16:54:25 INFO - Using env: {'DISPLAY': ':0', 16:54:25 INFO - 'HOME': '/home/cltbld', 16:54:25 INFO - 'LANG': 'en_US.UTF-8', 16:54:25 INFO - 'LANGUAGE': 'en_US:en', 16:54:25 INFO - 'LOGNAME': 'cltbld', 16:54:25 INFO - 'MAIL': '/var/mail/cltbld', 16:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:25 INFO - 'MOZ_NO_REMOTE': '1', 16:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:25 INFO - 'NO_EM_RESTART': '1', 16:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:25 INFO - 'PWD': '/builds/slave/test', 16:54:25 INFO - 'SHELL': '/bin/bash', 16:54:25 INFO - 'SHLVL': '1', 16:54:25 INFO - 'TERM': 'linux', 16:54:25 INFO - 'TMOUT': '86400', 16:54:25 INFO - 'USER': 'cltbld', 16:54:25 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', 16:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:25 INFO - '_': '/tools/buildbot/bin/python'} 16:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:25 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 16:54:25 INFO - Cleaning up... 16:54:25 INFO - Return code: 0 16:54:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:25 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 0x7fdc46f37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1346090>, '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 0x13499b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1349e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', '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 16:54:25 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 16:54:25 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 16:54:25 INFO - Using env: {'DISPLAY': ':0', 16:54:25 INFO - 'HOME': '/home/cltbld', 16:54:25 INFO - 'LANG': 'en_US.UTF-8', 16:54:25 INFO - 'LANGUAGE': 'en_US:en', 16:54:25 INFO - 'LOGNAME': 'cltbld', 16:54:25 INFO - 'MAIL': '/var/mail/cltbld', 16:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:25 INFO - 'MOZ_NO_REMOTE': '1', 16:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:25 INFO - 'NO_EM_RESTART': '1', 16:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:25 INFO - 'PWD': '/builds/slave/test', 16:54:25 INFO - 'SHELL': '/bin/bash', 16:54:25 INFO - 'SHLVL': '1', 16:54:25 INFO - 'TERM': 'linux', 16:54:25 INFO - 'TMOUT': '86400', 16:54:25 INFO - 'USER': 'cltbld', 16:54:25 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', 16:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:25 INFO - '_': '/tools/buildbot/bin/python'} 16:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:25 INFO - Downloading/unpacking psutil>=3.1.1 16:54:25 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 16:54:25 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 16:54:25 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 16:54:25 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 16:54:25 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 16:54:25 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 16:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:54:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:27 INFO - Installing collected packages: psutil 16:54:27 INFO - Running setup.py install for psutil 16:54:27 INFO - building 'psutil._psutil_linux' extension 16:54:27 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 16:54:27 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 16:54:27 INFO - building 'psutil._psutil_posix' extension 16:54:27 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 16:54:28 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 16:54:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:28 INFO - Successfully installed psutil 16:54:28 INFO - Cleaning up... 16:54:28 INFO - Return code: 0 16:54:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:54:28 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')]} 16:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:28 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')]} 16:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:28 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 0x7fdc46f37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1346090>, '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 0x13499b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1349e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', '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 16:54:28 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 16:54:28 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 16:54:28 INFO - Using env: {'DISPLAY': ':0', 16:54:28 INFO - 'HOME': '/home/cltbld', 16:54:28 INFO - 'LANG': 'en_US.UTF-8', 16:54:28 INFO - 'LANGUAGE': 'en_US:en', 16:54:28 INFO - 'LOGNAME': 'cltbld', 16:54:28 INFO - 'MAIL': '/var/mail/cltbld', 16:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:28 INFO - 'MOZ_NO_REMOTE': '1', 16:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:28 INFO - 'NO_EM_RESTART': '1', 16:54:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:28 INFO - 'PWD': '/builds/slave/test', 16:54:28 INFO - 'SHELL': '/bin/bash', 16:54:28 INFO - 'SHLVL': '1', 16:54:28 INFO - 'TERM': 'linux', 16:54:28 INFO - 'TMOUT': '86400', 16:54:28 INFO - 'USER': 'cltbld', 16:54:28 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', 16:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:28 INFO - '_': '/tools/buildbot/bin/python'} 16:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:54:28 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 16:54:28 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 16:54:28 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 16:54:28 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 16:54:28 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 16:54:28 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 16:54:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:54:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:54:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:54:30 INFO - Installing collected packages: mozsystemmonitor 16:54:30 INFO - Running setup.py install for mozsystemmonitor 16:54:30 INFO - Successfully installed mozsystemmonitor 16:54:30 INFO - Cleaning up... 16:54:30 INFO - Return code: 0 16:54:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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')]} 16:54:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc46f37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1346090>, '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 0x13499b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1349e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', '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 16:54: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==2.5.1'] in /builds/slave/test/build 16:54: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==2.5.1 16:54:30 INFO - Using env: {'DISPLAY': ':0', 16:54:30 INFO - 'HOME': '/home/cltbld', 16:54:30 INFO - 'LANG': 'en_US.UTF-8', 16:54:30 INFO - 'LANGUAGE': 'en_US:en', 16:54:30 INFO - 'LOGNAME': 'cltbld', 16:54:30 INFO - 'MAIL': '/var/mail/cltbld', 16:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:30 INFO - 'MOZ_NO_REMOTE': '1', 16:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:30 INFO - 'NO_EM_RESTART': '1', 16:54:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:30 INFO - 'PWD': '/builds/slave/test', 16:54:30 INFO - 'SHELL': '/bin/bash', 16:54:30 INFO - 'SHLVL': '1', 16:54:30 INFO - 'TERM': 'linux', 16:54:30 INFO - 'TMOUT': '86400', 16:54:30 INFO - 'USER': 'cltbld', 16:54:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', 16:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:30 INFO - '_': '/tools/buildbot/bin/python'} 16:54:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:30 INFO - Downloading/unpacking jsonschema==2.5.1 16:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:54:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:33 INFO - Downloading functools32-3.2.3-2.tar.gz 16:54:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:54:33 INFO - warning: no files found matching '*.txt' 16:54:33 INFO - no previously-included directories found matching 'build' 16:54:33 INFO - no previously-included directories found matching 'dist' 16:54:33 INFO - no previously-included directories found matching '.git*' 16:54:33 INFO - Installing collected packages: jsonschema, functools32 16:54:33 INFO - Running setup.py install for functools32 16:54:33 INFO - warning: no files found matching '*.txt' 16:54:33 INFO - no previously-included directories found matching 'build' 16:54:33 INFO - no previously-included directories found matching 'dist' 16:54:33 INFO - no previously-included directories found matching '.git*' 16:54:33 INFO - Successfully installed jsonschema functools32 16:54:33 INFO - Cleaning up... 16:54:33 INFO - Return code: 0 16:54:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc46f37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1346090>, '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 0x13499b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1349e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', '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 16:54:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:54:33 INFO - Using env: {'DISPLAY': ':0', 16:54:33 INFO - 'HOME': '/home/cltbld', 16:54:33 INFO - 'LANG': 'en_US.UTF-8', 16:54:33 INFO - 'LANGUAGE': 'en_US:en', 16:54:33 INFO - 'LOGNAME': 'cltbld', 16:54:33 INFO - 'MAIL': '/var/mail/cltbld', 16:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:33 INFO - 'MOZ_NO_REMOTE': '1', 16:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:33 INFO - 'NO_EM_RESTART': '1', 16:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:33 INFO - 'PWD': '/builds/slave/test', 16:54:33 INFO - 'SHELL': '/bin/bash', 16:54:33 INFO - 'SHLVL': '1', 16:54:33 INFO - 'TERM': 'linux', 16:54:33 INFO - 'TMOUT': '86400', 16:54:33 INFO - 'USER': 'cltbld', 16:54:33 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', 16:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:33 INFO - '_': '/tools/buildbot/bin/python'} 16:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:54:33 INFO - Cleaning up... 16:54:33 INFO - Return code: 0 16:54:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdc46f37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1346090>, '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 0x13499b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1349e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', '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 16:54:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:54:33 INFO - Using env: {'DISPLAY': ':0', 16:54:33 INFO - 'HOME': '/home/cltbld', 16:54:33 INFO - 'LANG': 'en_US.UTF-8', 16:54:33 INFO - 'LANGUAGE': 'en_US:en', 16:54:33 INFO - 'LOGNAME': 'cltbld', 16:54:33 INFO - 'MAIL': '/var/mail/cltbld', 16:54:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:33 INFO - 'MOZ_NO_REMOTE': '1', 16:54:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:33 INFO - 'NO_EM_RESTART': '1', 16:54:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:33 INFO - 'PWD': '/builds/slave/test', 16:54:33 INFO - 'SHELL': '/bin/bash', 16:54:33 INFO - 'SHLVL': '1', 16:54:33 INFO - 'TERM': 'linux', 16:54:33 INFO - 'TMOUT': '86400', 16:54:33 INFO - 'USER': 'cltbld', 16:54:33 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', 16:54:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:33 INFO - '_': '/tools/buildbot/bin/python'} 16:54:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:33 INFO - Downloading/unpacking blobuploader==1.2.4 16:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:35 INFO - Downloading blobuploader-1.2.4.tar.gz 16:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:54:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:54:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:54:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:54:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:54:36 INFO - Downloading docopt-0.6.1.tar.gz 16:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:54:36 INFO - Installing collected packages: blobuploader, requests, docopt 16:54:36 INFO - Running setup.py install for blobuploader 16:54:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:54:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:54:36 INFO - Running setup.py install for requests 16:54:36 INFO - Running setup.py install for docopt 16:54:36 INFO - Successfully installed blobuploader requests docopt 16:54:36 INFO - Cleaning up... 16:54:37 INFO - Return code: 0 16:54:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:37 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 0x7fdc46f37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1346090>, '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 0x13499b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1349e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', '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 16:54:37 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 16:54:37 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 16:54:37 INFO - Using env: {'DISPLAY': ':0', 16:54:37 INFO - 'HOME': '/home/cltbld', 16:54:37 INFO - 'LANG': 'en_US.UTF-8', 16:54:37 INFO - 'LANGUAGE': 'en_US:en', 16:54:37 INFO - 'LOGNAME': 'cltbld', 16:54:37 INFO - 'MAIL': '/var/mail/cltbld', 16:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:37 INFO - 'MOZ_NO_REMOTE': '1', 16:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:37 INFO - 'NO_EM_RESTART': '1', 16:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:37 INFO - 'PWD': '/builds/slave/test', 16:54:37 INFO - 'SHELL': '/bin/bash', 16:54:37 INFO - 'SHLVL': '1', 16:54:37 INFO - 'TERM': 'linux', 16:54:37 INFO - 'TMOUT': '86400', 16:54:37 INFO - 'USER': 'cltbld', 16:54:37 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', 16:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:37 INFO - '_': '/tools/buildbot/bin/python'} 16:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:37 INFO - Running setup.py (path:/tmp/pip-vvsNWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:37 INFO - Running setup.py (path:/tmp/pip-rb3Hcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:37 INFO - Running setup.py (path:/tmp/pip-E1WONh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:37 INFO - Running setup.py (path:/tmp/pip-qXgK6d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:37 INFO - Running setup.py (path:/tmp/pip-Alp5rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:37 INFO - Running setup.py (path:/tmp/pip-6943Xi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:37 INFO - Running setup.py (path:/tmp/pip-i0oRdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:37 INFO - Running setup.py (path:/tmp/pip-tgYtEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:37 INFO - Running setup.py (path:/tmp/pip-YFjezF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:37 INFO - Running setup.py (path:/tmp/pip-OBm1b3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:37 INFO - Running setup.py (path:/tmp/pip-br669j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:38 INFO - Running setup.py (path:/tmp/pip-dOKzKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:38 INFO - Running setup.py (path:/tmp/pip-PL9Y0c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:38 INFO - Running setup.py (path:/tmp/pip-MdWFVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:38 INFO - Running setup.py (path:/tmp/pip-HrrTUT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:38 INFO - Running setup.py (path:/tmp/pip-1FFuJn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:38 INFO - Running setup.py (path:/tmp/pip-ZEuYNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:54:38 INFO - Running setup.py install for manifestparser 16:54:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:54:38 INFO - Running setup.py install for mozcrash 16:54:38 INFO - Running setup.py install for mozdebug 16:54:38 INFO - Running setup.py install for mozdevice 16:54:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:54:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:54:38 INFO - Running setup.py install for mozfile 16:54:38 INFO - Running setup.py install for mozhttpd 16:54:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:54:39 INFO - Running setup.py install for mozinfo 16:54:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:54:39 INFO - Running setup.py install for mozInstall 16:54:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:54:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:54:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:54:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:54:39 INFO - Running setup.py install for mozleak 16:54:39 INFO - Running setup.py install for mozlog 16:54:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:54:39 INFO - Running setup.py install for moznetwork 16:54:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:54:39 INFO - Running setup.py install for mozprocess 16:54:39 INFO - Running setup.py install for mozprofile 16:54:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:54:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:54:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:54:39 INFO - Running setup.py install for mozrunner 16:54:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:54:39 INFO - Running setup.py install for mozscreenshot 16:54:40 INFO - Running setup.py install for moztest 16:54:40 INFO - Running setup.py install for mozversion 16:54:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:54:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:54:40 INFO - Cleaning up... 16:54:40 INFO - Return code: 0 16:54:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:40 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')]} 16:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:40 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')]} 16:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:40 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 0x7fdc46f37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1346090>, '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 0x13499b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1349e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', '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 16:54:40 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 16:54:40 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 16:54:40 INFO - Using env: {'DISPLAY': ':0', 16:54:40 INFO - 'HOME': '/home/cltbld', 16:54:40 INFO - 'LANG': 'en_US.UTF-8', 16:54:40 INFO - 'LANGUAGE': 'en_US:en', 16:54:40 INFO - 'LOGNAME': 'cltbld', 16:54:40 INFO - 'MAIL': '/var/mail/cltbld', 16:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:40 INFO - 'MOZ_NO_REMOTE': '1', 16:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:40 INFO - 'NO_EM_RESTART': '1', 16:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:40 INFO - 'PWD': '/builds/slave/test', 16:54:40 INFO - 'SHELL': '/bin/bash', 16:54:40 INFO - 'SHLVL': '1', 16:54:40 INFO - 'TERM': 'linux', 16:54:40 INFO - 'TMOUT': '86400', 16:54:40 INFO - 'USER': 'cltbld', 16:54:40 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', 16:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:40 INFO - '_': '/tools/buildbot/bin/python'} 16:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:40 INFO - Running setup.py (path:/tmp/pip-KQ88lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:40 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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:40 INFO - Running setup.py (path:/tmp/pip-CY2aq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:40 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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:40 INFO - Running setup.py (path:/tmp/pip-NFRGRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:40 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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:40 INFO - Running setup.py (path:/tmp/pip-KeuN72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:40 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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:40 INFO - Running setup.py (path:/tmp/pip-eK8M5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:40 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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:40 INFO - Running setup.py (path:/tmp/pip-Yycvc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:40 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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:40 INFO - Running setup.py (path:/tmp/pip-RA18Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:40 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)) 16:54:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:40 INFO - Running setup.py (path:/tmp/pip-EAQti1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:41 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)) 16:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:41 INFO - Running setup.py (path:/tmp/pip-ZAn95t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:41 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)) 16:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:41 INFO - Running setup.py (path:/tmp/pip-d41LW2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:41 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)) 16:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:41 INFO - Running setup.py (path:/tmp/pip-TQ90Kc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:41 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)) 16:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:41 INFO - Running setup.py (path:/tmp/pip-Kcitc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:41 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)) 16:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:41 INFO - Running setup.py (path:/tmp/pip-3M4uFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:41 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)) 16:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:41 INFO - Running setup.py (path:/tmp/pip-uIS6XK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:41 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)) 16:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:41 INFO - Running setup.py (path:/tmp/pip-WBabof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:41 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)) 16:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:41 INFO - Running setup.py (path:/tmp/pip-7ZMafE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:41 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)) 16:54:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:41 INFO - Running setup.py (path:/tmp/pip-5dgMLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:41 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)) 16:54:41 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)) 16:54:41 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)) 16:54:41 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)) 16:54:41 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)) 16:54:41 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)) 16:54:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:54:41 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 16:54:41 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 16:54:41 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 16:54:41 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 16:54:41 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 16:54:41 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 16:54:43 INFO - Downloading blessings-1.6.tar.gz 16:54:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:54:43 INFO - Installing collected packages: blessings 16:54:43 INFO - Running setup.py install for blessings 16:54:43 INFO - Successfully installed blessings 16:54:43 INFO - Cleaning up... 16:54:43 INFO - Return code: 0 16:54:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:54:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:44 INFO - Reading from file tmpfile_stdout 16:54:44 INFO - Current package versions: 16:54:44 INFO - argparse == 1.2.1 16:54:44 INFO - blessings == 1.6 16:54:44 INFO - blobuploader == 1.2.4 16:54:44 INFO - docopt == 0.6.1 16:54:44 INFO - functools32 == 3.2.3-2 16:54:44 INFO - jsonschema == 2.5.1 16:54:44 INFO - manifestparser == 1.1 16:54:44 INFO - mozInstall == 1.12 16:54:44 INFO - mozcrash == 0.17 16:54:44 INFO - mozdebug == 0.1 16:54:44 INFO - mozdevice == 0.48 16:54:44 INFO - mozfile == 1.2 16:54:44 INFO - mozhttpd == 0.7 16:54:44 INFO - mozinfo == 0.9 16:54:44 INFO - mozleak == 0.1 16:54:44 INFO - mozlog == 3.3 16:54:44 INFO - moznetwork == 0.27 16:54:44 INFO - mozprocess == 0.23 16:54:44 INFO - mozprofile == 0.28 16:54:44 INFO - mozrunner == 6.12 16:54:44 INFO - mozscreenshot == 0.1 16:54:44 INFO - mozsystemmonitor == 0.3 16:54:44 INFO - moztest == 0.7 16:54:44 INFO - mozversion == 1.4 16:54:44 INFO - psutil == 3.1.1 16:54:44 INFO - requests == 1.2.3 16:54:44 INFO - wsgiref == 0.1.2 16:54:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:44 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')]} 16:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:44 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')]} 16:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:44 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 0x7fdc46f37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1346090>, '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 0x13499b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1349e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', '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 16:54:44 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 16:54:44 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 16:54:44 INFO - Using env: {'DISPLAY': ':0', 16:54:44 INFO - 'HOME': '/home/cltbld', 16:54:44 INFO - 'LANG': 'en_US.UTF-8', 16:54:44 INFO - 'LANGUAGE': 'en_US:en', 16:54:44 INFO - 'LOGNAME': 'cltbld', 16:54:44 INFO - 'MAIL': '/var/mail/cltbld', 16:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:44 INFO - 'MOZ_NO_REMOTE': '1', 16:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:44 INFO - 'NO_EM_RESTART': '1', 16:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:44 INFO - 'PWD': '/builds/slave/test', 16:54:44 INFO - 'SHELL': '/bin/bash', 16:54:44 INFO - 'SHLVL': '1', 16:54:44 INFO - 'TERM': 'linux', 16:54:44 INFO - 'TMOUT': '86400', 16:54:44 INFO - 'USER': 'cltbld', 16:54:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', 16:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:44 INFO - '_': '/tools/buildbot/bin/python'} 16:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:44 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)) 16:54:44 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)) 16:54:44 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)) 16:54:44 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)) 16:54:44 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)) 16:54:44 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)) 16:54:44 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)) 16:54:44 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)) 16:54:44 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)) 16:54:44 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)) 16:54:44 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)) 16:54:44 INFO - Cleaning up... 16:54:44 INFO - Return code: 0 16:54:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:54:44 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')]} 16:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:44 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')]} 16:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:54:44 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 0x7fdc46f37f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x127d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x134c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1346090>, '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 0x13499b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1349e40>, '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': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', '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 16:54:44 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 16:54:44 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 16:54:44 INFO - Using env: {'DISPLAY': ':0', 16:54:44 INFO - 'HOME': '/home/cltbld', 16:54:44 INFO - 'LANG': 'en_US.UTF-8', 16:54:44 INFO - 'LANGUAGE': 'en_US:en', 16:54:44 INFO - 'LOGNAME': 'cltbld', 16:54:44 INFO - 'MAIL': '/var/mail/cltbld', 16:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:44 INFO - 'MOZ_NO_REMOTE': '1', 16:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:44 INFO - 'NO_EM_RESTART': '1', 16:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:44 INFO - 'PWD': '/builds/slave/test', 16:54:44 INFO - 'SHELL': '/bin/bash', 16:54:44 INFO - 'SHLVL': '1', 16:54:44 INFO - 'TERM': 'linux', 16:54:44 INFO - 'TMOUT': '86400', 16:54:44 INFO - 'USER': 'cltbld', 16:54:44 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', 16:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:44 INFO - '_': '/tools/buildbot/bin/python'} 16:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:54:44 INFO - Cleaning up... 16:54:44 INFO - Return code: 0 16:54:44 INFO - Running post-action listener: _resource_record_post_action 16:54:44 INFO - Running post-action listener: _start_resource_monitoring 16:54:44 INFO - Starting resource monitoring. 16:54:44 INFO - [mozharness: 2016-08-18 23:54:44.560613Z] Finished create-virtualenv step (success) 16:54:44 INFO - [mozharness: 2016-08-18 23:54:44.561198Z] Running install step. 16:54:44 INFO - Running pre-action listener: _resource_record_pre_action 16:54:44 INFO - Running main action method: install 16:54:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:44 INFO - Reading from file tmpfile_stdout 16:54:44 INFO - Detecting whether we're running mozinstall >=1.0... 16:54:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:54:44 INFO - Reading from file tmpfile_stdout 16:54:44 INFO - Output received: 16:54:44 INFO - Usage: mozinstall [options] installer 16:54:44 INFO - Options: 16:54:44 INFO - -h, --help show this help message and exit 16:54:44 INFO - -d DEST, --destination=DEST 16:54:44 INFO - Directory to install application into. [default: 16:54:44 INFO - "/builds/slave/test"] 16:54:44 INFO - --app=APP Application being installed. [default: firefox] 16:54:44 INFO - mkdir: /builds/slave/test/build/application 16:54:44 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'] 16:54:44 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 16:55:01 INFO - Reading from file tmpfile_stdout 16:55:01 INFO - Output received: 16:55:01 INFO - /builds/slave/test/build/application/firefox/firefox 16:55:01 INFO - Running post-action listener: _resource_record_post_action 16:55:01 INFO - [mozharness: 2016-08-18 23:55:01.653888Z] Finished install step (success) 16:55:01 INFO - [mozharness: 2016-08-18 23:55:01.654137Z] Running run-tests step. 16:55:01 INFO - Running pre-action listener: _resource_record_pre_action 16:55:01 INFO - Running main action method: run_tests 16:55:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:55:01 INFO - Python 2.7.3 16:55:01 INFO - Return code: 0 16:55:01 INFO - grabbing minidump binary from tooltool 16:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:55:01 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 0x1346090>, '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 0x13499b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1349e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:55:01 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 16:55:01 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 16:55:01 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 16:55:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:55:01 INFO - Return code: 0 16:55:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:55:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:55:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:55:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:55:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:55:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 16:55:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 16:55:01 INFO - Using env: {'DISPLAY': ':0', 16:55:01 INFO - 'HOME': '/home/cltbld', 16:55:01 INFO - 'LANG': 'en_US.UTF-8', 16:55:01 INFO - 'LANGUAGE': 'en_US:en', 16:55:01 INFO - 'LOGNAME': 'cltbld', 16:55:01 INFO - 'MAIL': '/var/mail/cltbld', 16:55:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:55:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:55:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:55:01 INFO - 'MOZ_NO_REMOTE': '1', 16:55:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:55:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:55:01 INFO - 'NO_EM_RESTART': '1', 16:55:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:55:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:55:01 INFO - 'PWD': '/builds/slave/test', 16:55:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:55:01 INFO - 'SHELL': '/bin/bash', 16:55:01 INFO - 'SHLVL': '1', 16:55:01 INFO - 'TERM': 'linux', 16:55:01 INFO - 'TMOUT': '86400', 16:55:01 INFO - 'USER': 'cltbld', 16:55:01 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565', 16:55:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:55:01 INFO - '_': '/tools/buildbot/bin/python'} 16:55:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 16:55:01 INFO - mozversion application_buildid: 20160818150855 16:55:01 INFO - mozversion application_changeset: e7b45868aa75fe8c3d6c47e9c819ed8bf36deb53 16:55:01 INFO - mozversion application_display_name: Nightly 16:55:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:55:01 INFO - mozversion application_name: Firefox 16:55:01 INFO - mozversion application_remotingname: firefox 16:55:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 16:55:01 INFO - mozversion application_vendor: Mozilla 16:55:01 INFO - mozversion application_version: 51.0a1 16:55:01 INFO - mozversion platform_buildid: 20160818150855 16:55:01 INFO - mozversion platform_changeset: e7b45868aa75fe8c3d6c47e9c819ed8bf36deb53 16:55:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 16:55:01 INFO - mozversion platform_version: 51.0a1 16:55:01 INFO - using testdate: 1471564501 16:55:01 INFO - actual date: 1471564501 16:55:01 INFO - starting webserver on 'localhost:48091' 16:55:01 INFO - SUITE-START | Running 2 tests 16:55:01 INFO - TEST-START | dromaeo_css 16:55:01 INFO - operating with platform_type : linux_ 16:55:01 INFO - Initialising browser for dromaeo_css test... 16:55:01 INFO - TEST-INFO | started process 21739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKpOAK7/profile http://localhost:48091/getInfo.html) 16:55:06 INFO - PROCESS | 21739 | __metrics Screen width/height:1600/1200 16:55:06 INFO - PROCESS | 21739 | colorDepth:24 16:55:06 INFO - PROCESS | 21739 | Browser inner width/height: 1024/697 16:55:06 INFO - PROCESS | 21739 | __metrics 16:55:07 INFO - PROCESS | 21739 | 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" 16:55:07 INFO - PROCESS | 21739 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:55:07 INFO - PROCESS | 21739 | console.error: PushService: 16:55:07 INFO - PROCESS | 21739 | stateChangeProcessEnqueue: Error transitioning state 16:55:07 INFO - PROCESS | 21739 | UnknownError 16:55:08 INFO - TEST-INFO | 21739: exit 0 16:55:08 INFO - Browser initialized. 16:55:08 INFO - Running cycle 1/1 for dromaeo_css test... 16:55:08 INFO - TEST-INFO | started process 21820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKpOAK7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:55:20 INFO - PROCESS | 21820 | RSS: Main: 157392896 16:55:20 INFO - PROCESS | 21820 | 16:56:11 INFO - PROCESS | 21820 | 1471564571232 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] 16:58:24 INFO - PROCESS | 21820 | Cycle 1(1): loaded http://localhost:48091/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48091/tests/dromaeo/cssquery-ext.html) 16:58:26 INFO - PROCESS | 21820 | RSS: Main: 272580608 16:58:26 INFO - PROCESS | 21820 | 17:01:28 INFO - PROCESS | 21820 | Cycle 1(1): loaded http://localhost:48091/tests/dromaeo/cssquery-ext.html (next: http://localhost:48091/tests/dromaeo/cssquery-jquery.html) 17:01:29 INFO - PROCESS | 21820 | RSS: Main: 242458624 17:01:29 INFO - PROCESS | 21820 | 17:04:31 INFO - PROCESS | 21820 | Cycle 1(1): loaded http://localhost:48091/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48091/tests/dromaeo/cssquery-mootools.html) 17:04:32 INFO - PROCESS | 21820 | RSS: Main: 189435904 17:04:32 INFO - PROCESS | 21820 | 17:07:34 INFO - PROCESS | 21820 | Cycle 1(1): loaded http://localhost:48091/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48091/tests/dromaeo/cssquery-prototype.html) 17:07:35 INFO - PROCESS | 21820 | RSS: Main: 230957056 17:07:35 INFO - PROCESS | 21820 | 17:10:38 INFO - PROCESS | 21820 | Cycle 1(1): loaded http://localhost:48091/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48091/tests/dromaeo/cssquery-yui.html) 17:10:39 INFO - PROCESS | 21820 | RSS: Main: 190013440 17:10:39 INFO - PROCESS | 21820 | 17:13:41 INFO - PROCESS | 21820 | Cycle 1(1): loaded http://localhost:48091/tests/dromaeo/cssquery-yui.html (next: http://localhost:48091/tests/dromaeo/cssquery-dojo.html) 17:13:42 INFO - PROCESS | 21820 | RSS: Main: 281530368 17:13:42 INFO - PROCESS | 21820 | 17:13:42 INFO - PROCESS | 21820 | __start_tp_report 17:13:42 INFO - PROCESS | 21820 | _x_x_mozilla_page_load 17:13:42 INFO - PROCESS | 21820 | _x_x_mozilla_page_load_details 17:13:42 INFO - PROCESS | 21820 | |i|pagename|runs| 17:13:42 INFO - PROCESS | 21820 | |0;dojo.html;2563.577009793384;2579.7420257974204;2582.909598164065;2604.140633590915;2618.2930608735655;4587.38070360502;4630.12027714734;4683.625309975202;4730.90538189236;4759.2385218365025;4708.9764551177195;4724.692894961825;4743.359646447729;4747.8338258160975;4772.093302272575;4332.111917057012;4400.7579583122915;4411.09572537629;4415.094905544356;4419.955800442002;4392.29723244281;4431.1802316571375;4460.843870464534;4463.732176069446;4498.212812757771;4476.395686582302;4483.865484035484;4494.528074552174;4523.457185137771;4524;4216.894577635584;4261.339492378686;4420.381146639473;4432.401625780511;4473.664475164375;4278.2940814765525;4302.591253830881;4310.051788606502;4338.067315527145;4373.628241599468;4697.459792123881;4706.576408123286;4713.622910167179;4741.075490279397;4782.641301902337;4900.901981960341;5088.694678319275;5123.462036486189;5131.486851314876;5133.871653208662;5067.594592432597;5070.366204224472;5132.153194722866;5160.432352441228;5171.301874246966;4790.305405716222;4793.32893394925;4804.375431193957;4814.494478079821;4817.156997525419;4833.613310935117;4927.063857866994;5262.815801446931;5274.947250527523;5276.34045744282;4726.858194254178;4810.975945120252;4818.590419814285;4824.95175048245;4832.323474713543;4846.636502262344;4850.660453768273;4857.441394239637;4899;4899.363082799213;4810.013947140827;4812.278158276286;4848.369711937426;4863.80544778212;4891.388576427947;4966.081274964144;5030.346055012898;5031.949680503221;5065.721385323843;5088.745562721849;4448.5773851484055;4449.844255451044;4466.553344665573;4489.820407183742;4490.977545112253;3852.210296889131;3876.8643097491454;3900.239453306635;3902.453656488094;3904.863329783444;4269.338252570857;4316.460442444694;4336.067745434747;4336.869893903188;4456.420665313489;5038;5047.470015648304;5047.4952504749235;5049.394072711299;5082.18685010404;4348;4349.717268377545;4353.82584696615;4371.540988196257;4392.033752574429;4474.709143905636;4575.771211439414;4613.0312634347165;4638.744869032235;4662.184117779375;4767.356406885165;4803.18345881208;4849.175640141114;4877.414710234794;4892.241702536113;5117.8720531987;5127.53852153308;5129.128048231735;5135.666181698178;5139.408967968582;4732.574068333866;4773.618110551078;4828.155072862305;4840.636952228527;4842.4189097308545;5021.49785021495;5023.246513023076;5036.949630503648;5043.924341134959;5062.240663900445;5111.693298402108;5121.769520371667;5128.923066153936;5134.383873935151;5149.948500514947;4729.881752956204;4877.561019508261;4903.141950158779;4967.180415231446;4968.801247950041;5040.495950405077;5042.243663450512;5046.924296135488;5054.620903432184;5054.949450505448;4946.060248552763;4979.178435558238;4995.950040499694;4997.975010125072;5002.824901128443;4808.374911261513;4844.539768721966;4975.402951645681;4990.426100998432;5033.345665063518;4965.627577931597;4966.950330496648;4971.353724015855;4980.327655766425;5016.974915125547 17:13:42 INFO - PROCESS | 21820 | |1;ext.html;566.7676252736379;578.4851482180862;579.7883772423066;584.1938125386966;586.8092869817308;29676.406471870578;32000;32087.876924307624;39595;40820.59179408205;41357.793211033975;41753.58246417535;41789.7910510447;41795.373069403904;41832.79083604585;7559.546427214371;7696.538207707527;7698;7701.306882380584;7703.653335599912;7481.326680598745;7532.548047117163;7553.055868016498;7556.395488360918;7565.583892885889;7550;7584.393248540104;7589.506682065676;7590.278923502258;7713.7685869424;7538.359239464652;7568.243175682388;7572.697092116308;7576.356009739151;7583.582902940336;7543.660535275926;7605.505642133244;7606.201348858345;7610.238976102401;7616.657250423744;38380.61619383798;38781;38805;38808.417873731916;38895.41656875149;2942.7204415580486;3030.8787648494035;3065.203047207742;3161.731252843511;3559.0924314299687;29436.852815735998;29506.262343441373;29571.852140739375;29767.70232297671;30999;3402.2515046689687;3421.196018935548;3447.6552344765323;3470.410030294856;3567.7502574819514;255364;255747;256146;256814;257164;52719.47280527222;53057.24555448308;53095.203571946455;53116.73441632844;53263.20105198425;32384.83807580947;33496.16259593481;33522.832385837915;35341.46987795185;35383.64616353855;13154.539591114266;13218.272994985176;13227.404766785517;13230.867691323156;13244.072914895865;10704.518296676668;10779.784404312026;10784.13726901846;10788;10789.514471848786;18081.819181808278;18127.365542206222;18162.27350905949;18244.726329105073;18259.543511412056;6761.898571521431;6792.966035169792;6833.214180369321;6940.271271516519;7025.156981162293;745.411125211088;869.3002133282641;898.4564338575199;927.1655510040882;952.3048174832411;26794.866025669748;27375.315617109733;28043;28187.57718634222;28517.857410712815;817.9918200818034;920.6225447566466;926.6339795780764;931.5156118818177;985.669800616787;13851.22975404923;14816.555503334917;14980;15292.770608440882;15338.693226135414;362937;365879;368232;368511;370287;50088;50467.747661261456;50540.49459505431;50549;50566.24150637743;1041.13065590233;1097.1277834121893;1137.7553825927466;1143.5197217168975;1147.649966760146;27381.589276160474;28490.287742806595;29212.853935730185;29503.87357757328;29627.703722962495;41473;41872;41968.79015604902;41980.37029444622;42010;285218;287062;287656;287834;288514;23607.527849443257;24355.39111522155;24359.14742983987;25074.874625626755;25659.486810264065;41879.58120418757;41908.37137443002;41947.790261048496;42407.575924240366;42825.78587107169;34884.65115348814;35147.121321967155;35191;35241;35461;34660.82669586636;35039.47440788339;35045.47431788576;35145.297094058486;35146.12134696653;34657.13357166091;35051.649483504836;35486.645133548336;35692;35842.64157358393;29970.550441743828;32534.34931301408;33156.33687326288;33311;33399.16502087467;24787.25638230856;25069.87465062736;25197.622035669112;25327.620085699098;25357 17:13:42 INFO - PROCESS | 21820 | |2;jquery.html;348.17308891382964;369.23752451188295;370.9851605935761;374.8706696189814;376.54438129862865;12471.127021108527;13204.735905281901;14790.408383664653;16940.915295423536;16941.66116677669;14912.17983010934;15165;15881;15885.920570397131;16624.83375166248;4574.931376029363;4705.1530724469585;4707.482176960531;4710.057988402316;4714.151452738506;3490.982545087271;5749.885002299951;6038.758449662008;6106.267247930255;6166.290876549209;5310;6055.818067087014;6113.7860174893885;6116.266048074215;6126.142340072393;5203.115470370028;5224.190250511177;5226.268322434843;5227.555657769094;5239.423663397023;5018.422881368653;5083.085044691954;5091.974540127313;5093.414257360414;5316.175992721134;20358.574899757023;20596;20638.690419643717;20792.896035519876;20903.477413064644;1826.1325870211676;1941.825235728791;1973.8815671059638;2328.795142855716;2402.7957623602015;8903.866442003375;9553.187979021792;9676.806463870684;12121.636350909399;12581.496740130384;1612.1213938403598;1702.3360889253202;1706.7439884017372;1728.9567760805955;1729.4206440842333;62039.37960620426;67393.66303168502;70193.94709079368;70194;72297;9164.770880727901;9350.392224505385;9647.565859536338;9801.558929848174;9960.402375857471;12612.747745045232;12615.116941814169;12755.808662870064;12783.61649150527;12788;6734.528582999241;6953.165620125516;6985.755498557526;7095.113110861143;7139.214686384494;6593.142891424084;6622.139121914217;6646.368594983469;6675.632840193836;6824.454043676494;4077.612626800449;4082.387641853686;4152.273352163359;4187.5184353799095;4334.523202447728;1840.144332885215;1917.2331067572804;1922.1542521290587;1928.363639998797;1933.3136736458637;741.8924255982852;848.868425394065;899.983019188313;914.350810924238;916.7753900294471;16426.260818263207;17096;17571;17661.38185163513;18107.54731131732;810.9107998120202;811.8011087283653;841.3857883744901;851.3487182305541;905.0270958719403;9178.632854685871;9718;9762.414255144571;9774.51127443625;9865.506724663881;353820;354790;356150;356223;387792;72210.2778972214;74511.62744186244;77210;79637;82596.58701706454;907.5099446298925;917.1378903830512;947.4646824544111;950.6197520991659;955.0974329258784;15398.538043858702;15583.532494024745;16339.836601633831;16363.590910226863;16588.50234492967;28581.142565722228;38216.42675359816;38603.80698096492;38606.6139338603;38821.41767873427;48901.510984891116;49906.51402289686;50053;54175.18737218866;55564.66448052519;7281.599512026889;7667.654955527126;7719.343855772322;7720.652570634447;7750.302472777477;10579.62971296001;11597.710057248636;11796.823047654121;12109.273443593413;12147.817782733442;10299.227557933034;10605.840912386475;10611.628592999208;10648.467576621293;11048.116150707763;10175.79648407013;10235.283530152818;10511.57953681844;10643.148548115978;10701.304415212986;9968.900310997087;10154.825365580778;10221.540030698488;10508.632197873343;11205.831912521482;7533.660985255787;7621.1616722161625;7786.7663970080985;7882.487638303492;7983.760487185394;10292.279540432099;10552.736181595521;10672.039516443558;10690.144788417063;10802.08182304513 17:13:42 INFO - PROCESS | 21820 | |3;mootools.html;1241.28626040027;1335.5592654424038;1374.9243791591462;1410.4992727581707;1614.3461897931334;6416.4225219730215;7379.926200737991;7592.886106708397;7633.129883178629;7840.0199975003125;7680.807979800507;7749.573773442458;7751.0698716154;7754.534727916329;7756.457048006641;2187.332863476639;2210.900509477069;2213.1921848525253;2215.9224427145055;2216.1246307708448;2120.056574824204;2167.5556510915303;2170.446536133292;2172.3374370816896;2174.3368272676826;2181.2801775414077;2186.464316242515;2192.3642143778284;2195.4511372156962;2225.032111031698;2116.9153233870625;2125.7767934366902;2128.9254876079417;2130.350243175823;2131.0075079800436;2102.737157855268;2150.774168712294;2160.3626930055516;2161.664941933987;2166.967495487569;7666.693332266703;7723.266289702526;7784.571848548328;7785.338246249075;7789.844203115906;4296.398504209413;4429.069895321986;4439.533848945846;4449.599536041772;4478.932816007762;2756.1318184771935;2790.4140130572605;2865.068852622885;2882.164172390025;2882.2650224192907;933.682547933699;939.6429356844424;949.2690628216235;953.4184147669915;959.9856002159974;10069.446180460072;10210.693679189637;10215.489225538693;10272.178225741998;10273.537690804007;4107.281225785476;4171.436856024458;4269.637080848101;4276.550962148992;4343;7871.134175240719;7986.201379862084;7987.281144697005;8003.399745019147;8010.919890801134;4396.032872767986;4404.405405270248;4405.3612226227015;4407.338899165086;4410.625096866802;3621.4567814827988;3953.9604603953594;4106.630403263721;4108.137291168829;4109.691773116969;3202.4235637584993;3274.8690052398115;3297.4394352960053;3325.833708314575;3476.4090104682264;1011.7571782772081;1044.8223801953686;1051.3849398102043;1054.2778196935124;1091.8853520380405;780.7969927818694;780.9648565814553;785.2461636828708;800.9359251259885;802.574635443216;5026.824061157842;5080.974595127001;5122.231665250242;5128.25640282157;5304.0187565299775;401.8432811203633;406.1308799169779;407.18359688823716;412.1612518524847;417.6137073207271;3303.620083690358;3318.8008719476907;3339.1985923378215;3395.422778127724;3542.964570354315;9367.484788336571;9747.756306092262;9758.46328451942;9765.267604929659;9776.902230977741;9689.563969621384;9693.6122555097;9695.272854535939;9704.27217958656;9704.514774261259;7148.17795953472;7154.534955227893;7184.856302874018;7201.495895287384;7212.819679507949;5103.668261562986;5124.8206312778875;5238.371395432572;5272.130098533699;5359.517643412111;8794.868076978722;8907.554622268732;8931.062238465127;8935.195832375117;8989.505577193317;9029;9105.590248438968;9128.269738421042;9157.267418606361;9162.496062716615;5506.284183056177;6022.247219097613;6097.847553811191;6100.511959043355;6108.541859360477;6558.704858281484;6752.898706519308;6755.831104222434;6761.763338283136;6906.896396554156;6010.849728756816;6277.18396608438;6292.528060395397;6295.1186833842385;6425.1968503937005;6186.597871138361;6199.876002480015;6267.467265282502;6272.466840318441;6318.241810982528;5952.851178720567;6010;6053.273607167168;6056.03103503455;6058.4244496772735;4484.1255955088445;4487.7980490878645;4491.079328737666;4547.59229097455;4637.397138372125;4405.691601587986;4425.535318791609;4449.33260010988;4484.1255955088445;4640.791164397678 17:13:42 INFO - PROCESS | 21820 | |4;prototype.html;290.89963962432967;301.38667811004603;307.4358552056975;311.68986858076215;311.7241241501271;4785.162596545603;4819.614430845532;4828.565429111383;4844.854654360366;4849;4573.176828170928;4606.03273312604;4711.481737008926;4738.502457241983;4809.2786082087705;3758.9099161243207;3767.8869633911027;3771.963139904455;3774.5470543534675;3787.9810600947094;3770.2836461072447;3771.8868433947027;3779.149691319445;3786.280606684721;3789.602091780365;3522.6653467920505;3604.2611264690677;3737.4020156774923;3744.475773391727;3756.4177552479273;3696.2053158571034;3719.9070023249365;3723.590405055442;3733.8693145739767;3749.4814600087007;3285.9649210498615;3288.391647545212;3291.4569096099117;3292.588426446694;3293.5224392463197;4465.799039043219;4610.561996610317;4629.884252893671;4632.791524381377;4642.234031384817;4255.148970205972;4276.807543660543;4280.315149576084;4288.520460441143;4292.785360731951;4933.555979961785;4948.505149485059;4951.306817045616;4952.826651067196;4970.279309500138;3636.818159092035;3641.6176301488226;3653.1049892776173;3657.6708096271464;3659.597444281127;4965.138073222542;5140.563052140573;5148.871278218037;5180.290504133664;5199.428062913076;3714.8699795507027;3716.21959388526;3719.2933342665347;3721.888343349704;3731.7014638829373;3768.3217020935945;3780.773153610792;3783.24335132969;3794.8236046825573;3816.809159542012;4008.4388185654034;4255.382969469471;4291.892702682396;4295.033617436052;4300.462442194726;4992.201247800407;5001.324821149098;5006.199008158677;5007.472720820112;5008.774605142778;1255.378587599126;1272.166730791333;1272.2887716021935;1272.7581759465857;1275.190254188597;815.4129027100478;839.6515446089804;856.6530555125184;865.9870101948476;869.699953516036;4475.7244185407;4489.73061616304;4494.797734101973;4497.437820272466;4501.662375321864;5154.61340399464;5154.8969020620125;5160.638755287169;5181.678671938632;5222.869428264324;4386.1008493258805;4499.865004049884;4506.59440650343;4508.819647214074;4516.751578663139;2755.2973991632007;2757.4071574611553;2759.2550011496783;2760.806743527974;2763.0743700860035;4797.7601119943865;4864.856758661712;4878.658493905464;4888.584470320063;4894.681845680019;5035.899282014412;5199.688018718889;5201.609879259071;5262.815801446931;5342.679439233659;4915.21356582945;4922.261660750916;4926.211806111005;4927.236278376786;4936.358273424432;5215.2698622192165;5228.477152284741;5235.528802407802;5235.764390602508;5238.659487133325;4835.927461088157;5000.67495612784;5097.28637990689;5115.721069732567;5127.6410651254055;4916.222334381063;4918.114739346952;4923.950760492349;4933.925991110208;4937.975310123426;3647.8905632831056;3670.1191713988983;3678.9080272993388;3681.8343174557745;3689.114612493036;5088.491150884882;5209.47905209476;5230.11088115029;5256.316678831728;5257.526822585985;5044.319016932667;5047.772850221675;5053.267276244997;5056.974715126401;5069.935313584188;5005.374328208974;5008.248762685626;5028.851197761788;5030.270610761492;5082.517160869711;4686.297055441711;4953.479884612064;4973.428055773487;4976.129177393869;5006.974965125297;4858.6356023297685;4937.407511098691;5076.923846142237;5081.415637201769;5090.211017292326;4947.282644016669;4951.603871690184;4966.751662416792;4970.3290055843445;4983.127952608352 17:13:42 INFO - PROCESS | 21820 | |5;yui.html;596.8179705189918;602.7137109872808;629.6977450823605;721.7004942948677;746.2947514598704;12423.378831058444;13338.266395348252;13350.465981360734;13353.399097040632;13363.06458547902;12991.415386307615;13095.672608184776;13143.539976100838;13153.40809663565;13154;613.7268915332679;732.2896790113581;752.4845480845611;752.853193627243;756.2966441209672;746.5520687587458;758.863404587174;759.0094926121409;765.2921048030578;765.8353454007387;799.160881074872;800.2397722163938;800.8158123631569;801.0267524957176;801.410962942237;639.2648454277571;779.5128044971892;796.0884786918974;797.1908512859452;803.1727320859524;592.2330581896455;592.8103007037749;593.1517929361012;593.9842868694537;594.0287629725387;12326.260424374566;12359.93820030903;12385.75228495434;12388.070894682935;12399.13206075575;11888.821667674993;12030.097742669248;12176.878231217752;12242.265464072185;12387.75224495505;9174.954125229398;9326.114019168235;11475.713107172303;11636.825447618292;11864.940675296568;3959.2873282809082;4027.375756757707;4030.2745505808944;4037.212743515016;4172.874813755592;61930;62051;62576;62648.373516264706;63643.363566364205;9760.658376956773;9768.316217864824;9776.266779991529;9876.061774131445;10298.17614590831;18002.279908803765;18069.27722891096;18105.909470452825;18106.094695265183;18171.182296796676;6280.089387038854;6368.840778980562;6380.7128679209545;6396.584222025554;6397.10440538325;3502.842372093211;3512.613612502623;3560.857565697395;3562.8931132066077;3634.2186429917697;2749.463854548384;2844.6728626207837;2859.1136747608307;2861.4992376334058;2863.727945845141;468.63212378282884;472.5015109059906;481.5810245086797;481.75189777264734;488.99511004890206;475.6456439952258;494.33265092125345;558.9385167631557;586.3432955090241;589.131031728206;7448.292412220939;7519.323260906544;7556.886646700304;7565.394768418513;7921.772125320585;514.904742622616;515.9912371314072;525.9973700131475;529.7271904968944;541.5099335101739;3684.9815750921075;3692.778433294011;3762.379207430798;3776.6978641708597;3859.749116307431;98787;102807.52272113609;103351.4832425833;104319.47840260902;105302.47348763207;84507;85116.57441712875;85748;85956.57021714977;88578.55710721404;72748;76448.61775691308;78094.60952695314;78775.87956782791;80477;7184.389326907271;7349.228331025379;7597.772066838003;7651.234876512304;7876.763697089096;44775;45306.77346613246;45850.31224531568;46073.76963115163;46632.30051549162;63702.3629763715;66968.33031669621;67447.66276168588;67549.3245067543;68363;8662.740117796477;8741.606627701642;8786.297096232414;8926.375153739176;9013.63945442175;9555.808883822145;9569.665061722806;9652.372595781251;9656.565454554702;9684.273679473927;8653.61058752345;8821.514816685143;8822.823543528964;9026.413283136575;9091.545422728705;8664.653413863374;8668.566571671265;8673.392862499564;8700.608472618875;8812.427192232484;8981.506017168856;9151.862722059308;9332.953335233551;9381.390209636353;9700.223982081276;7704.884426733492;7842.764717058498;7984.081830589556;8173.509589424653;8211.753647390588;7574.469787114849;7781.92218077812;7872.921270787448;7914.802129946567;8245.628946697292 17:13:42 INFO - PROCESS | 21820 | __end_tp_report 17:13:42 INFO - PROCESS | 21820 | __start_cc_report 17:13:42 INFO - PROCESS | 21820 | _x_x_mozilla_cycle_collect,1201 17:13:42 INFO - PROCESS | 21820 | __end_cc_report 17:13:42 INFO - PROCESS | 21820 | __startTimestamp1471565622198__endTimestamp 17:13:42 INFO - PROCESS | 21820 | 17:13:42 INFO - PROCESS | 21820 | ------- Summary: start ------- 17:13:42 INFO - PROCESS | 21820 | Number of tests: 6 17:13:42 INFO - PROCESS | 21820 | 17:13:42 INFO - PROCESS | 21820 | [#0] dojo.html Cycles:165 Average:4694.29 Median:4812.28 stddev:483.23 (10.0%) stddev-sans-first:454.89 17:13:42 INFO - PROCESS | 21820 | Values: 2563.6 2579.7 2582.9 2604.1 2618.3 4587.4 4630.1 4683.6 4730.9 4759.2 4709.0 4724.7 4743.4 4747.8 4772.1 4332.1 4400.8 4411.1 4415.1 4420.0 4392.3 4431.2 4460.8 4463.7 4498.2 4476.4 4483.9 4494.5 4523.5 4524.0 4216.9 4261.3 4420.4 4432.4 4473.7 4278.3 4302.6 4310.1 4338.1 4373.6 4697.5 4706.6 4713.6 4741.1 4782.6 4900.9 5088.7 5123.5 5131.5 5133.9 5067.6 5070.4 5132.2 5160.4 5171.3 4790.3 4793.3 4804.4 4814.5 4817.2 4833.6 4927.1 5262.8 5274.9 5276.3 4726.9 4811.0 4818.6 4825.0 4832.3 4846.6 4850.7 4857.4 4899.0 4899.4 4810.0 4812.3 4848.4 4863.8 4891.4 4966.1 5030.3 5031.9 5065.7 5088.7 4448.6 4449.8 4466.6 4489.8 4491.0 3852.2 3876.9 3900.2 3902.5 3904.9 4269.3 4316.5 4336.1 4336.9 4456.4 5038.0 5047.5 5047.5 5049.4 5082.2 4348.0 4349.7 4353.8 4371.5 4392.0 4474.7 4575.8 4613.0 4638.7 4662.2 4767.4 4803.2 4849.2 4877.4 4892.2 5117.9 5127.5 5129.1 5135.7 5139.4 4732.6 4773.6 4828.2 4840.6 4842.4 5021.5 5023.2 5036.9 5043.9 5062.2 5111.7 5121.8 5128.9 5134.4 5149.9 4729.9 4877.6 4903.1 4967.2 4968.8 5040.5 5042.2 5046.9 5054.6 5054.9 4946.1 4979.2 4996.0 4998.0 5002.8 4808.4 4844.5 4975.4 4990.4 5033.3 4965.6 4967.0 4971.4 4980.3 5017.0 17:13:42 INFO - PROCESS | 21820 | 17:13:42 INFO - PROCESS | 21820 | [#1] ext.html Cycles:180 Average:45381.78 Median:35362.56 stddev:80690.09 (228.2%) stddev-sans-first:80846.29 17:13:42 INFO - PROCESS | 21820 | Values: 566.8 578.5 579.8 584.2 586.8 29676.4 32000.0 32087.9 39595.0 40820.6 41357.8 41753.6 41789.8 41795.4 41832.8 7559.5 7696.5 7698.0 7701.3 7703.7 7481.3 7532.5 7553.1 7556.4 7565.6 7550.0 7584.4 7589.5 7590.3 7713.8 7538.4 7568.2 7572.7 7576.4 7583.6 7543.7 7605.5 7606.2 7610.2 7616.7 38380.6 38781.0 38805.0 38808.4 38895.4 2942.7 3030.9 3065.2 3161.7 3559.1 29436.9 29506.3 29571.9 29767.7 30999.0 3402.3 3421.2 3447.7 3470.4 3567.8 255364.0 255747.0 256146.0 256814.0 257164.0 52719.5 53057.2 53095.2 53116.7 53263.2 32384.8 33496.2 33522.8 35341.5 35383.6 13154.5 13218.3 13227.4 13230.9 13244.1 10704.5 10779.8 10784.1 10788.0 10789.5 18081.8 18127.4 18162.3 18244.7 18259.5 6761.9 6793.0 6833.2 6940.3 7025.2 745.4 869.3 898.5 927.2 952.3 26794.9 27375.3 28043.0 28187.6 28517.9 818.0 920.6 926.6 931.5 985.7 13851.2 14816.6 14980.0 15292.8 15338.7 362937.0 365879.0 368232.0 368511.0 370287.0 50088.0 50467.7 50540.5 50549.0 50566.2 1041.1 1097.1 1137.8 1143.5 1147.6 27381.6 28490.3 29212.9 29503.9 29627.7 41473.0 41872.0 41968.8 41980.4 42010.0 285218.0 287062.0 287656.0 287834.0 288514.0 23607.5 24355.4 24359.1 25074.9 25659.5 41879.6 41908.4 41947.8 42407.6 42825.8 34884.7 35147.1 35191.0 35241.0 35461.0 34660.8 35039.5 35045.5 35145.3 35146.1 34657.1 35051.6 35486.6 35692.0 35842.6 29970.6 32534.3 33156.3 33311.0 33399.2 24787.3 25069.9 25197.6 25327.6 25357.0 17:13:42 INFO - PROCESS | 21820 | 17:13:42 INFO - PROCESS | 21820 | [#2] jquery.html Cycles:180 Average:23473.02 Median:4261.02 stddev:59979.68 (1407.6%) stddev-sans-first:60122.81 17:13:42 INFO - PROCESS | 21820 | Values: 348.2 369.2 371.0 374.9 376.5 12471.1 13204.7 14790.4 16940.9 16941.7 14912.2 15165.0 15881.0 15885.9 16624.8 4574.9 4705.2 4707.5 4710.1 4714.2 3491.0 5749.9 6038.8 6106.3 6166.3 5310.0 6055.8 6113.8 6116.3 6126.1 5203.1 5224.2 5226.3 5227.6 5239.4 5018.4 5083.1 5092.0 5093.4 5316.2 20358.6 20596.0 20638.7 20792.9 20903.5 1826.1 1941.8 1973.9 2328.8 2402.8 8903.9 9553.2 9676.8 12121.6 12581.5 1612.1 1702.3 1706.7 1729.0 1729.4 62039.4 67393.7 70193.9 70194.0 72297.0 9164.8 9350.4 9647.6 9801.6 9960.4 12612.7 12615.1 12755.8 12783.6 12788.0 6734.5 6953.2 6985.8 7095.1 7139.2 6593.1 6622.1 6646.4 6675.6 6824.5 4077.6 4082.4 4152.3 4187.5 4334.5 1840.1 1917.2 1922.2 1928.4 1933.3 741.9 848.9 900.0 914.4 916.8 16426.3 17096.0 17571.0 17661.4 18107.5 810.9 811.8 841.4 851.3 905.0 9178.6 9718.0 9762.4 9774.5 9865.5 353820.0 354790.0 356150.0 356223.0 387792.0 72210.3 74511.6 77210.0 79637.0 82596.6 907.5 917.1 947.5 950.6 955.1 15398.5 15583.5 16339.8 16363.6 16588.5 28581.1 38216.4 38603.8 38606.6 38821.4 48901.5 49906.5 50053.0 54175.2 55564.7 7281.6 7667.7 7719.3 7720.7 7750.3 10579.6 11597.7 11796.8 12109.3 12147.8 10299.2 10605.8 10611.6 10648.5 11048.1 10175.8 10235.3 10511.6 10643.1 10701.3 9968.9 10154.8 10221.5 10508.6 11205.8 7533.7 7621.2 7786.8 7882.5 7983.8 10292.3 10552.7 10672.0 10690.1 10802.1 17:13:42 INFO - PROCESS | 21820 | 17:13:42 INFO - PROCESS | 21820 | [#3] mootools.html Cycles:180 Average:4951.21 Median:5053.90 stddev:2812.50 (55.7%) stddev-sans-first:2806.57 17:13:42 INFO - PROCESS | 21820 | Values: 1241.3 1335.6 1374.9 1410.5 1614.3 6416.4 7379.9 7592.9 7633.1 7840.0 7680.8 7749.6 7751.1 7754.5 7756.5 2187.3 2210.9 2213.2 2215.9 2216.1 2120.1 2167.6 2170.4 2172.3 2174.3 2181.3 2186.5 2192.4 2195.5 2225.0 2116.9 2125.8 2128.9 2130.4 2131.0 2102.7 2150.8 2160.4 2161.7 2167.0 7666.7 7723.3 7784.6 7785.3 7789.8 4296.4 4429.1 4439.5 4449.6 4478.9 2756.1 2790.4 2865.1 2882.2 2882.3 933.7 939.6 949.3 953.4 960.0 10069.4 10210.7 10215.5 10272.2 10273.5 4107.3 4171.4 4269.6 4276.6 4343.0 7871.1 7986.2 7987.3 8003.4 8010.9 4396.0 4404.4 4405.4 4407.3 4410.6 3621.5 3954.0 4106.6 4108.1 4109.7 3202.4 3274.9 3297.4 3325.8 3476.4 1011.8 1044.8 1051.4 1054.3 1091.9 780.8 781.0 785.2 800.9 802.6 5026.8 5081.0 5122.2 5128.3 5304.0 401.8 406.1 407.2 412.2 417.6 3303.6 3318.8 3339.2 3395.4 3543.0 9367.5 9747.8 9758.5 9765.3 9776.9 9689.6 9693.6 9695.3 9704.3 9704.5 7148.2 7154.5 7184.9 7201.5 7212.8 5103.7 5124.8 5238.4 5272.1 5359.5 8794.9 8907.6 8931.1 8935.2 8989.5 9029.0 9105.6 9128.3 9157.3 9162.5 5506.3 6022.2 6097.8 6100.5 6108.5 6558.7 6752.9 6755.8 6761.8 6906.9 6010.8 6277.2 6292.5 6295.1 6425.2 6186.6 6199.9 6267.5 6272.5 6318.2 5952.9 6010.0 6053.3 6056.0 6058.4 4484.1 4487.8 4491.1 4547.6 4637.4 4405.7 4425.5 4449.3 4484.1 4640.8 17:13:42 INFO - PROCESS | 21820 | 17:13:42 INFO - PROCESS | 21820 | [#4] prototype.html Cycles:180 Average:4180.07 Median:4791.46 stddev:1208.20 (25.2%) stddev-sans-first:1175.80 17:13:42 INFO - PROCESS | 21820 | Values: 290.9 301.4 307.4 311.7 311.7 4785.2 4819.6 4828.6 4844.9 4849.0 4573.2 4606.0 4711.5 4738.5 4809.3 3758.9 3767.9 3772.0 3774.5 3788.0 3770.3 3771.9 3779.1 3786.3 3789.6 3522.7 3604.3 3737.4 3744.5 3756.4 3696.2 3719.9 3723.6 3733.9 3749.5 3286.0 3288.4 3291.5 3292.6 3293.5 4465.8 4610.6 4629.9 4632.8 4642.2 4255.1 4276.8 4280.3 4288.5 4292.8 4933.6 4948.5 4951.3 4952.8 4970.3 3636.8 3641.6 3653.1 3657.7 3659.6 4965.1 5140.6 5148.9 5180.3 5199.4 3714.9 3716.2 3719.3 3721.9 3731.7 3768.3 3780.8 3783.2 3794.8 3816.8 4008.4 4255.4 4291.9 4295.0 4300.5 4992.2 5001.3 5006.2 5007.5 5008.8 1255.4 1272.2 1272.3 1272.8 1275.2 815.4 839.7 856.7 866.0 869.7 4475.7 4489.7 4494.8 4497.4 4501.7 5154.6 5154.9 5160.6 5181.7 5222.9 4386.1 4499.9 4506.6 4508.8 4516.8 2755.3 2757.4 2759.3 2760.8 2763.1 4797.8 4864.9 4878.7 4888.6 4894.7 5035.9 5199.7 5201.6 5262.8 5342.7 4915.2 4922.3 4926.2 4927.2 4936.4 5215.3 5228.5 5235.5 5235.8 5238.7 4835.9 5000.7 5097.3 5115.7 5127.6 4916.2 4918.1 4924.0 4933.9 4938.0 3647.9 3670.1 3678.9 3681.8 3689.1 5088.5 5209.5 5230.1 5256.3 5257.5 5044.3 5047.8 5053.3 5057.0 5069.9 5005.4 5008.2 5028.9 5030.3 5082.5 4686.3 4953.5 4973.4 4976.1 5007.0 4858.6 4937.4 5076.9 5081.4 5090.2 4947.3 4951.6 4966.8 4970.3 4983.1 17:13:42 INFO - PROCESS | 21820 | 17:13:42 INFO - PROCESS | 21820 | [#5] yui.html Cycles:180 Average:17597.78 Median:3509.99 stddev:26548.85 (756.4%) stddev-sans-first:26592.64 17:13:42 INFO - PROCESS | 21820 | Values: 596.8 602.7 629.7 721.7 746.3 12423.4 13338.3 13350.5 13353.4 13363.1 12991.4 13095.7 13143.5 13153.4 13154.0 613.7 732.3 752.5 752.9 756.3 746.6 758.9 759.0 765.3 765.8 799.2 800.2 800.8 801.0 801.4 639.3 779.5 796.1 797.2 803.2 592.2 592.8 593.2 594.0 594.0 12326.3 12359.9 12385.8 12388.1 12399.1 11888.8 12030.1 12176.9 12242.3 12387.8 9175.0 9326.1 11475.7 11636.8 11864.9 3959.3 4027.4 4030.3 4037.2 4172.9 61930.0 62051.0 62576.0 62648.4 63643.4 9760.7 9768.3 9776.3 9876.1 10298.2 18002.3 18069.3 18105.9 18106.1 18171.2 6280.1 6368.8 6380.7 6396.6 6397.1 3502.8 3512.6 3560.9 3562.9 3634.2 2749.5 2844.7 2859.1 2861.5 2863.7 468.6 472.5 481.6 481.8 489.0 475.6 494.3 558.9 586.3 589.1 7448.3 7519.3 7556.9 7565.4 7921.8 514.9 516.0 526.0 529.7 541.5 3685.0 3692.8 3762.4 3776.7 3859.7 98787.0 102807.5 103351.5 104319.5 105302.5 84507.0 85116.6 85748.0 85956.6 88578.6 72748.0 76448.6 78094.6 78775.9 80477.0 7184.4 7349.2 7597.8 7651.2 7876.8 44775.0 45306.8 45850.3 46073.8 46632.3 63702.4 66968.3 67447.7 67549.3 68363.0 8662.7 8741.6 8786.3 8926.4 9013.6 9555.8 9569.7 9652.4 9656.6 9684.3 8653.6 8821.5 8822.8 9026.4 9091.5 8664.7 8668.6 8673.4 8700.6 8812.4 8981.5 9151.9 9333.0 9381.4 9700.2 7704.9 7842.8 7984.1 8173.5 8211.8 7574.5 7781.9 7872.9 7914.8 8245.6 17:13:42 INFO - PROCESS | 21820 | -------- Summary: end -------- 17:13:42 INFO - PROCESS | 21820 | 17:13:43 INFO - TEST-INFO | 21820: exit 0 17:13:43 INFO - TEST-OK | dromaeo_css | took 1121127ms 17:13:43 INFO - TEST-START | kraken 17:13:43 INFO - operating with platform_type : linux_ 17:13:43 INFO - Initialising browser for kraken test... 17:13:43 INFO - TEST-INFO | started process 22126 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUGMoOS/profile http://localhost:48091/getInfo.html) 17:13:47 INFO - PROCESS | 22126 | __metrics Screen width/height:1600/1200 17:13:47 INFO - PROCESS | 22126 | colorDepth:24 17:13:47 INFO - PROCESS | 22126 | Browser inner width/height: 1024/697 17:13:47 INFO - PROCESS | 22126 | __metrics 17:13:48 INFO - PROCESS | 22126 | 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" 17:13:48 INFO - PROCESS | 22126 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:13:48 INFO - PROCESS | 22126 | console.error: PushService: 17:13:48 INFO - PROCESS | 22126 | stateChangeProcessEnqueue: Error transitioning state 17:13:48 INFO - PROCESS | 22126 | UnknownError 17:13:49 INFO - TEST-INFO | 22126: exit 0 17:13:49 INFO - Browser initialized. 17:13:49 INFO - Running cycle 1/1 for kraken test... 17:13:49 INFO - TEST-INFO | started process 22205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUGMoOS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:14:01 INFO - PROCESS | 22205 | RSS: Main: 157446144 17:14:01 INFO - PROCESS | 22205 | 17:14:03 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48091/tests/kraken/driver.html?testName=audio-beat-detection) 17:14:04 INFO - PROCESS | 22205 | RSS: Main: 204861440 17:14:04 INFO - PROCESS | 22205 | 17:14:07 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48091/tests/kraken/driver.html?testName=audio-dft) 17:14:08 INFO - PROCESS | 22205 | RSS: Main: 195874816 17:14:08 INFO - PROCESS | 22205 | 17:14:11 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48091/tests/kraken/driver.html?testName=audio-fft) 17:14:12 INFO - PROCESS | 22205 | RSS: Main: 277180416 17:14:12 INFO - PROCESS | 22205 | 17:14:14 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48091/tests/kraken/driver.html?testName=audio-oscillator) 17:14:14 INFO - PROCESS | 22205 | RSS: Main: 187097088 17:14:14 INFO - PROCESS | 22205 | 17:14:17 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48091/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:14:17 INFO - PROCESS | 22205 | RSS: Main: 191721472 17:14:17 INFO - PROCESS | 22205 | 17:14:20 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48091/tests/kraken/driver.html?testName=imaging-darkroom) 17:14:21 INFO - PROCESS | 22205 | RSS: Main: 227811328 17:14:21 INFO - PROCESS | 22205 | 17:14:25 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48091/tests/kraken/driver.html?testName=imaging-desaturate) 17:14:25 INFO - PROCESS | 22205 | RSS: Main: 226787328 17:14:25 INFO - PROCESS | 22205 | 17:14:28 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48091/tests/kraken/driver.html?testName=json-parse-financial) 17:14:29 INFO - PROCESS | 22205 | RSS: Main: 227102720 17:14:29 INFO - PROCESS | 22205 | 17:14:30 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48091/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:14:31 INFO - PROCESS | 22205 | RSS: Main: 189964288 17:14:31 INFO - PROCESS | 22205 | 17:14:33 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:14:34 INFO - PROCESS | 22205 | RSS: Main: 197386240 17:14:34 INFO - PROCESS | 22205 | 17:14:36 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:14:36 INFO - PROCESS | 22205 | RSS: Main: 194306048 17:14:36 INFO - PROCESS | 22205 | 17:14:39 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:14:40 INFO - PROCESS | 22205 | RSS: Main: 188751872 17:14:40 INFO - PROCESS | 22205 | 17:14:43 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:14:43 INFO - PROCESS | 22205 | RSS: Main: 192565248 17:14:43 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48091/tests/kraken/driver.html?testName=ai-astar) 17:14:45 INFO - PROCESS | 22205 | RSS: Main: 243482624 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | __start_tp_report 17:14:45 INFO - PROCESS | 22205 | _x_x_mozilla_page_load 17:14:45 INFO - PROCESS | 22205 | _x_x_mozilla_page_load_details 17:14:45 INFO - PROCESS | 22205 | |i|pagename|runs| 17:14:45 INFO - PROCESS | 22205 | |0;ai-astar;107;116;115;116;110;114;115;111;116;115 17:14:45 INFO - PROCESS | 22205 | |1;audio-beat-detection;148;123;122;181;123;123;147;121;158;120 17:14:45 INFO - PROCESS | 22205 | |2;audio-dft;162;164;162;163;161;162;161;161;161;162 17:14:45 INFO - PROCESS | 22205 | |3;audio-fft;78;76;77;107;76;78;75;76;107;77 17:14:45 INFO - PROCESS | 22205 | |4;audio-oscillator;87;87;124;87;88;88;114;86;86;129 17:14:45 INFO - PROCESS | 22205 | |5;imaging-gaussian-blur;117;118;118;118;118;117;116;118;117;116 17:14:45 INFO - PROCESS | 22205 | |6;imaging-darkroom;146;147;146;146;146;148;146;146;147;145 17:14:45 INFO - PROCESS | 22205 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;94;95 17:14:45 INFO - PROCESS | 22205 | |8;json-parse-financial;67;65;67;65;66;70;66;67;67;66 17:14:45 INFO - PROCESS | 22205 | |9;json-stringify-tinderbox;65;65;65;64;66;65;65;65;66;66 17:14:45 INFO - PROCESS | 22205 | |10;stanford-crypto-aes;89;81;82;91;84;81;81;82;83;83 17:14:45 INFO - PROCESS | 22205 | |11;stanford-crypto-ccm;134;130;132;132;132;136;142;131;155;135 17:14:45 INFO - PROCESS | 22205 | |12;stanford-crypto-pbkdf2;176;178;171;174;175;170;170;173;173;171 17:14:45 INFO - PROCESS | 22205 | |13;stanford-crypto-sha256-iterative;72;69;69;72;68;67;67;69;69;68 17:14:45 INFO - PROCESS | 22205 | __end_tp_report 17:14:45 INFO - PROCESS | 22205 | __start_cc_report 17:14:45 INFO - PROCESS | 22205 | _x_x_mozilla_cycle_collect,1941 17:14:45 INFO - PROCESS | 22205 | __end_cc_report 17:14:45 INFO - PROCESS | 22205 | __startTimestamp1471565685909__endTimestamp 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | ------- Summary: start ------- 17:14:45 INFO - PROCESS | 22205 | Number of tests: 14 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.10 (2.7%) stddev-sans-first:2.22 17:14:45 INFO - PROCESS | 22205 | Values: 107.0 116.0 115.0 116.0 110.0 114.0 115.0 111.0 116.0 115.0 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:135.00 stddev:20.96 (15.5%) stddev-sans-first:21.82 17:14:45 INFO - PROCESS | 22205 | Values: 148.0 123.0 122.0 181.0 123.0 123.0 147.0 121.0 158.0 120.0 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.99 (0.6%) stddev-sans-first:1.05 17:14:45 INFO - PROCESS | 22205 | Values: 162.0 164.0 162.0 163.0 161.0 162.0 161.0 161.0 161.0 162.0 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#3] audio-fft Cycles:10 Average:82.70 Median:76.50 stddev:12.84 (16.8%) stddev-sans-first:13.51 17:14:45 INFO - PROCESS | 22205 | Values: 78.0 76.0 77.0 107.0 76.0 78.0 75.0 76.0 107.0 77.0 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:87.00 stddev:17.46 (20.1%) stddev-sans-first:18.09 17:14:45 INFO - PROCESS | 22205 | Values: 87.0 87.0 124.0 87.0 88.0 88.0 114.0 86.0 86.0 129.0 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 17:14:45 INFO - PROCESS | 22205 | Values: 117.0 118.0 118.0 118.0 118.0 117.0 116.0 118.0 117.0 116.0 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 17:14:45 INFO - PROCESS | 22205 | Values: 146.0 147.0 146.0 146.0 146.0 148.0 146.0 146.0 147.0 145.0 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:14:45 INFO - PROCESS | 22205 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:67.00 stddev:1.43 (2.1%) stddev-sans-first:1.51 17:14:45 INFO - PROCESS | 22205 | Values: 67.0 65.0 67.0 65.0 66.0 70.0 66.0 67.0 67.0 66.0 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 17:14:45 INFO - PROCESS | 22205 | Values: 65.0 65.0 65.0 64.0 66.0 65.0 65.0 65.0 66.0 66.0 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:3.50 (4.2%) stddev-sans-first:3.14 17:14:45 INFO - PROCESS | 22205 | Values: 89.0 81.0 82.0 91.0 84.0 81.0 81.0 82.0 83.0 83.0 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#11] stanford-crypto-ccm Cycles:10 Average:135.90 Median:134.50 stddev:7.53 (5.6%) stddev-sans-first:7.96 17:14:45 INFO - PROCESS | 22205 | Values: 134.0 130.0 132.0 132.0 132.0 136.0 142.0 131.0 155.0 135.0 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:173.50 stddev:2.69 (1.5%) stddev-sans-first:2.64 17:14:45 INFO - PROCESS | 22205 | Values: 176.0 178.0 171.0 174.0 175.0 170.0 170.0 173.0 173.0 171.0 17:14:45 INFO - PROCESS | 22205 | 17:14:45 INFO - PROCESS | 22205 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.76 (2.6%) stddev-sans-first:1.50 17:14:45 INFO - PROCESS | 22205 | Values: 72.0 69.0 69.0 72.0 68.0 67.0 67.0 69.0 69.0 68.0 17:14:45 INFO - PROCESS | 22205 | -------- Summary: end -------- 17:14:45 INFO - PROCESS | 22205 | 17:14:46 INFO - TEST-INFO | 22205: exit 0 17:14:47 INFO - TEST-OK | kraken | took 64061ms 17:14:47 INFO - SUITE-END | took 1185s 17:14:47 INFO - Completed test suite (00:19:45) 17:14:47 INFO - javascript benchmark 17:14:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2563.577009793384, 2579.7420257974204, 2582.909598164065, 2604.140633590915, 2618.2930608735655, 4587.38070360502, 4630.12027714734, 4683.625309975202, 4730.90538189236, 4759.2385218365025, 4708.9764551177195, 4724.692894961825, 4743.359646447729, 4747.8338258160975, 4772.093302272575, 4332.111917057012, 4400.7579583122915, 4411.09572537629, 4415.094905544356, 4419.955800442002, 4392.29723244281, 4431.1802316571375, 4460.843870464534, 4463.732176069446, 4498.212812757771, 4476.395686582302, 4483.865484035484, 4494.528074552174, 4523.457185137771, 4524.0, 4216.894577635584, 4261.339492378686, 4420.381146639473, 4432.401625780511, 4473.664475164375, 4278.2940814765525, 4302.591253830881, 4310.051788606502, 4338.067315527145, 4373.628241599468, 4697.459792123881, 4706.576408123286, 4713.622910167179, 4741.075490279397, 4782.641301902337, 4900.901981960341, 5088.694678319275, 5123.462036486189, 5131.486851314876, 5133.871653208662, 5067.594592432597, 5070.366204224472, 5132.153194722866, 5160.432352441228, 5171.301874246966, 4790.305405716222, 4793.32893394925, 4804.375431193957, 4814.494478079821, 4817.156997525419, 4833.613310935117, 4927.063857866994, 5262.815801446931, 5274.947250527523, 5276.34045744282, 4726.858194254178, 4810.975945120252, 4818.590419814285, 4824.95175048245, 4832.323474713543, 4846.636502262344, 4850.660453768273, 4857.441394239637, 4899.0, 4899.363082799213, 4810.013947140827, 4812.278158276286, 4848.369711937426, 4863.80544778212, 4891.388576427947, 4966.081274964144, 5030.346055012898, 5031.949680503221, 5065.721385323843, 5088.745562721849, 4448.5773851484055, 4449.844255451044, 4466.553344665573, 4489.820407183742, 4490.977545112253, 3852.210296889131, 3876.8643097491454, 3900.239453306635, 3902.453656488094, 3904.863329783444, 4269.338252570857, 4316.460442444694, 4336.067745434747, 4336.869893903188, 4456.420665313489, 5038.0, 5047.470015648304, 5047.4952504749235, 5049.394072711299, 5082.18685010404, 4348.0, 4349.717268377545, 4353.82584696615, 4371.540988196257, 4392.033752574429, 4474.709143905636, 4575.771211439414, 4613.0312634347165, 4638.744869032235, 4662.184117779375, 4767.356406885165, 4803.18345881208, 4849.175640141114, 4877.414710234794, 4892.241702536113, 5117.8720531987, 5127.53852153308, 5129.128048231735, 5135.666181698178, 5139.408967968582, 4732.574068333866, 4773.618110551078, 4828.155072862305, 4840.636952228527, 4842.4189097308545, 5021.49785021495, 5023.246513023076, 5036.949630503648, 5043.924341134959, 5062.240663900445, 5111.693298402108, 5121.769520371667, 5128.923066153936, 5134.383873935151, 5149.948500514947, 4729.881752956204, 4877.561019508261, 4903.141950158779, 4967.180415231446, 4968.801247950041, 5040.495950405077, 5042.243663450512, 5046.924296135488, 5054.620903432184, 5054.949450505448, 4946.060248552763, 4979.178435558238, 4995.950040499694, 4997.975010125072, 5002.824901128443, 4808.374911261513, 4844.539768721966, 4975.402951645681, 4990.426100998432, 5033.345665063518, 4965.627577931597, 4966.950330496648, 4971.353724015855, 4980.327655766425, 5016.974915125547], "value": 4663.348720211828, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.7676252736379, 578.4851482180862, 579.7883772423066, 584.1938125386966, 586.8092869817308, 29676.406471870578, 32000.0, 32087.876924307624, 39595.0, 40820.59179408205, 41357.793211033975, 41753.58246417535, 41789.7910510447, 41795.373069403904, 41832.79083604585, 7559.546427214371, 7696.538207707527, 7698.0, 7701.306882380584, 7703.653335599912, 7481.326680598745, 7532.548047117163, 7553.055868016498, 7556.395488360918, 7565.583892885889, 7550.0, 7584.393248540104, 7589.506682065676, 7590.278923502258, 7713.7685869424, 7538.359239464652, 7568.243175682388, 7572.697092116308, 7576.356009739151, 7583.582902940336, 7543.660535275926, 7605.505642133244, 7606.201348858345, 7610.238976102401, 7616.657250423744, 38380.61619383798, 38781.0, 38805.0, 38808.417873731916, 38895.41656875149, 2942.7204415580486, 3030.8787648494035, 3065.203047207742, 3161.731252843511, 3559.0924314299687, 29436.852815735998, 29506.262343441373, 29571.852140739375, 29767.70232297671, 30999.0, 3402.2515046689687, 3421.196018935548, 3447.6552344765323, 3470.410030294856, 3567.7502574819514, 255364.0, 255747.0, 256146.0, 256814.0, 257164.0, 52719.47280527222, 53057.24555448308, 53095.203571946455, 53116.73441632844, 53263.20105198425, 32384.83807580947, 33496.16259593481, 33522.832385837915, 35341.46987795185, 35383.64616353855, 13154.539591114266, 13218.272994985176, 13227.404766785517, 13230.867691323156, 13244.072914895865, 10704.518296676668, 10779.784404312026, 10784.13726901846, 10788.0, 10789.514471848786, 18081.819181808278, 18127.365542206222, 18162.27350905949, 18244.726329105073, 18259.543511412056, 6761.898571521431, 6792.966035169792, 6833.214180369321, 6940.271271516519, 7025.156981162293, 745.411125211088, 869.3002133282641, 898.4564338575199, 927.1655510040882, 952.3048174832411, 26794.866025669748, 27375.315617109733, 28043.0, 28187.57718634222, 28517.857410712815, 817.9918200818034, 920.6225447566466, 926.6339795780764, 931.5156118818177, 985.669800616787, 13851.22975404923, 14816.555503334917, 14980.0, 15292.770608440882, 15338.693226135414, 362937.0, 365879.0, 368232.0, 368511.0, 370287.0, 50088.0, 50467.747661261456, 50540.49459505431, 50549.0, 50566.24150637743, 1041.13065590233, 1097.1277834121893, 1137.7553825927466, 1143.5197217168975, 1147.649966760146, 27381.589276160474, 28490.287742806595, 29212.853935730185, 29503.87357757328, 29627.703722962495, 41473.0, 41872.0, 41968.79015604902, 41980.37029444622, 42010.0, 285218.0, 287062.0, 287656.0, 287834.0, 288514.0, 23607.527849443257, 24355.39111522155, 24359.14742983987, 25074.874625626755, 25659.486810264065, 41879.58120418757, 41908.37137443002, 41947.790261048496, 42407.575924240366, 42825.78587107169, 34884.65115348814, 35147.121321967155, 35191.0, 35241.0, 35461.0, 34660.82669586636, 35039.47440788339, 35045.47431788576, 35145.297094058486, 35146.12134696653, 34657.13357166091, 35051.649483504836, 35486.645133548336, 35692.0, 35842.64157358393, 29970.550441743828, 32534.34931301408, 33156.33687326288, 33311.0, 33399.16502087467, 24787.25638230856, 25069.87465062736, 25197.622035669112, 25327.620085699098, 25357.0], "value": 16992.50077716996, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.17308891382964, 369.23752451188295, 370.9851605935761, 374.8706696189814, 376.54438129862865, 12471.127021108527, 13204.735905281901, 14790.408383664653, 16940.915295423536, 16941.66116677669, 14912.17983010934, 15165.0, 15881.0, 15885.920570397131, 16624.83375166248, 4574.931376029363, 4705.1530724469585, 4707.482176960531, 4710.057988402316, 4714.151452738506, 3490.982545087271, 5749.885002299951, 6038.758449662008, 6106.267247930255, 6166.290876549209, 5310.0, 6055.818067087014, 6113.7860174893885, 6116.266048074215, 6126.142340072393, 5203.115470370028, 5224.190250511177, 5226.268322434843, 5227.555657769094, 5239.423663397023, 5018.422881368653, 5083.085044691954, 5091.974540127313, 5093.414257360414, 5316.175992721134, 20358.574899757023, 20596.0, 20638.690419643717, 20792.896035519876, 20903.477413064644, 1826.1325870211676, 1941.825235728791, 1973.8815671059638, 2328.795142855716, 2402.7957623602015, 8903.866442003375, 9553.187979021792, 9676.806463870684, 12121.636350909399, 12581.496740130384, 1612.1213938403598, 1702.3360889253202, 1706.7439884017372, 1728.9567760805955, 1729.4206440842333, 62039.37960620426, 67393.66303168502, 70193.94709079368, 70194.0, 72297.0, 9164.770880727901, 9350.392224505385, 9647.565859536338, 9801.558929848174, 9960.402375857471, 12612.747745045232, 12615.116941814169, 12755.808662870064, 12783.61649150527, 12788.0, 6734.528582999241, 6953.165620125516, 6985.755498557526, 7095.113110861143, 7139.214686384494, 6593.142891424084, 6622.139121914217, 6646.368594983469, 6675.632840193836, 6824.454043676494, 4077.612626800449, 4082.387641853686, 4152.273352163359, 4187.5184353799095, 4334.523202447728, 1840.144332885215, 1917.2331067572804, 1922.1542521290587, 1928.363639998797, 1933.3136736458637, 741.8924255982852, 848.868425394065, 899.983019188313, 914.350810924238, 916.7753900294471, 16426.260818263207, 17096.0, 17571.0, 17661.38185163513, 18107.54731131732, 810.9107998120202, 811.8011087283653, 841.3857883744901, 851.3487182305541, 905.0270958719403, 9178.632854685871, 9718.0, 9762.414255144571, 9774.51127443625, 9865.506724663881, 353820.0, 354790.0, 356150.0, 356223.0, 387792.0, 72210.2778972214, 74511.62744186244, 77210.0, 79637.0, 82596.58701706454, 907.5099446298925, 917.1378903830512, 947.4646824544111, 950.6197520991659, 955.0974329258784, 15398.538043858702, 15583.532494024745, 16339.836601633831, 16363.590910226863, 16588.50234492967, 28581.142565722228, 38216.42675359816, 38603.80698096492, 38606.6139338603, 38821.41767873427, 48901.510984891116, 49906.51402289686, 50053.0, 54175.18737218866, 55564.66448052519, 7281.599512026889, 7667.654955527126, 7719.343855772322, 7720.652570634447, 7750.302472777477, 10579.62971296001, 11597.710057248636, 11796.823047654121, 12109.273443593413, 12147.817782733442, 10299.227557933034, 10605.840912386475, 10611.628592999208, 10648.467576621293, 11048.116150707763, 10175.79648407013, 10235.283530152818, 10511.57953681844, 10643.148548115978, 10701.304415212986, 9968.900310997087, 10154.825365580778, 10221.540030698488, 10508.632197873343, 11205.831912521482, 7533.660985255787, 7621.1616722161625, 7786.7663970080985, 7882.487638303492, 7983.760487185394, 10292.279540432099, 10552.736181595521, 10672.039516443558, 10690.144788417063, 10802.08182304513], "value": 8172.198588739538, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.28626040027, 1335.5592654424038, 1374.9243791591462, 1410.4992727581707, 1614.3461897931334, 6416.4225219730215, 7379.926200737991, 7592.886106708397, 7633.129883178629, 7840.0199975003125, 7680.807979800507, 7749.573773442458, 7751.0698716154, 7754.534727916329, 7756.457048006641, 2187.332863476639, 2210.900509477069, 2213.1921848525253, 2215.9224427145055, 2216.1246307708448, 2120.056574824204, 2167.5556510915303, 2170.446536133292, 2172.3374370816896, 2174.3368272676826, 2181.2801775414077, 2186.464316242515, 2192.3642143778284, 2195.4511372156962, 2225.032111031698, 2116.9153233870625, 2125.7767934366902, 2128.9254876079417, 2130.350243175823, 2131.0075079800436, 2102.737157855268, 2150.774168712294, 2160.3626930055516, 2161.664941933987, 2166.967495487569, 7666.693332266703, 7723.266289702526, 7784.571848548328, 7785.338246249075, 7789.844203115906, 4296.398504209413, 4429.069895321986, 4439.533848945846, 4449.599536041772, 4478.932816007762, 2756.1318184771935, 2790.4140130572605, 2865.068852622885, 2882.164172390025, 2882.2650224192907, 933.682547933699, 939.6429356844424, 949.2690628216235, 953.4184147669915, 959.9856002159974, 10069.446180460072, 10210.693679189637, 10215.489225538693, 10272.178225741998, 10273.537690804007, 4107.281225785476, 4171.436856024458, 4269.637080848101, 4276.550962148992, 4343.0, 7871.134175240719, 7986.201379862084, 7987.281144697005, 8003.399745019147, 8010.919890801134, 4396.032872767986, 4404.405405270248, 4405.3612226227015, 4407.338899165086, 4410.625096866802, 3621.4567814827988, 3953.9604603953594, 4106.630403263721, 4108.137291168829, 4109.691773116969, 3202.4235637584993, 3274.8690052398115, 3297.4394352960053, 3325.833708314575, 3476.4090104682264, 1011.7571782772081, 1044.8223801953686, 1051.3849398102043, 1054.2778196935124, 1091.8853520380405, 780.7969927818694, 780.9648565814553, 785.2461636828708, 800.9359251259885, 802.574635443216, 5026.824061157842, 5080.974595127001, 5122.231665250242, 5128.25640282157, 5304.0187565299775, 401.8432811203633, 406.1308799169779, 407.18359688823716, 412.1612518524847, 417.6137073207271, 3303.620083690358, 3318.8008719476907, 3339.1985923378215, 3395.422778127724, 3542.964570354315, 9367.484788336571, 9747.756306092262, 9758.46328451942, 9765.267604929659, 9776.902230977741, 9689.563969621384, 9693.6122555097, 9695.272854535939, 9704.27217958656, 9704.514774261259, 7148.17795953472, 7154.534955227893, 7184.856302874018, 7201.495895287384, 7212.819679507949, 5103.668261562986, 5124.8206312778875, 5238.371395432572, 5272.130098533699, 5359.517643412111, 8794.868076978722, 8907.554622268732, 8931.062238465127, 8935.195832375117, 8989.505577193317, 9029.0, 9105.590248438968, 9128.269738421042, 9157.267418606361, 9162.496062716615, 5506.284183056177, 6022.247219097613, 6097.847553811191, 6100.511959043355, 6108.541859360477, 6558.704858281484, 6752.898706519308, 6755.831104222434, 6761.763338283136, 6906.896396554156, 6010.849728756816, 6277.18396608438, 6292.528060395397, 6295.1186833842385, 6425.1968503937005, 6186.597871138361, 6199.876002480015, 6267.467265282502, 6272.466840318441, 6318.241810982528, 5952.851178720567, 6010.0, 6053.273607167168, 6056.03103503455, 6058.4244496772735, 4484.1255955088445, 4487.7980490878645, 4491.079328737666, 4547.59229097455, 4637.397138372125, 4405.691601587986, 4425.535318791609, 4449.33260010988, 4484.1255955088445, 4640.791164397678], "value": 3920.2776756403764, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.89963962432967, 301.38667811004603, 307.4358552056975, 311.68986858076215, 311.7241241501271, 4785.162596545603, 4819.614430845532, 4828.565429111383, 4844.854654360366, 4849.0, 4573.176828170928, 4606.03273312604, 4711.481737008926, 4738.502457241983, 4809.2786082087705, 3758.9099161243207, 3767.8869633911027, 3771.963139904455, 3774.5470543534675, 3787.9810600947094, 3770.2836461072447, 3771.8868433947027, 3779.149691319445, 3786.280606684721, 3789.602091780365, 3522.6653467920505, 3604.2611264690677, 3737.4020156774923, 3744.475773391727, 3756.4177552479273, 3696.2053158571034, 3719.9070023249365, 3723.590405055442, 3733.8693145739767, 3749.4814600087007, 3285.9649210498615, 3288.391647545212, 3291.4569096099117, 3292.588426446694, 3293.5224392463197, 4465.799039043219, 4610.561996610317, 4629.884252893671, 4632.791524381377, 4642.234031384817, 4255.148970205972, 4276.807543660543, 4280.315149576084, 4288.520460441143, 4292.785360731951, 4933.555979961785, 4948.505149485059, 4951.306817045616, 4952.826651067196, 4970.279309500138, 3636.818159092035, 3641.6176301488226, 3653.1049892776173, 3657.6708096271464, 3659.597444281127, 4965.138073222542, 5140.563052140573, 5148.871278218037, 5180.290504133664, 5199.428062913076, 3714.8699795507027, 3716.21959388526, 3719.2933342665347, 3721.888343349704, 3731.7014638829373, 3768.3217020935945, 3780.773153610792, 3783.24335132969, 3794.8236046825573, 3816.809159542012, 4008.4388185654034, 4255.382969469471, 4291.892702682396, 4295.033617436052, 4300.462442194726, 4992.201247800407, 5001.324821149098, 5006.199008158677, 5007.472720820112, 5008.774605142778, 1255.378587599126, 1272.166730791333, 1272.2887716021935, 1272.7581759465857, 1275.190254188597, 815.4129027100478, 839.6515446089804, 856.6530555125184, 865.9870101948476, 869.699953516036, 4475.7244185407, 4489.73061616304, 4494.797734101973, 4497.437820272466, 4501.662375321864, 5154.61340399464, 5154.8969020620125, 5160.638755287169, 5181.678671938632, 5222.869428264324, 4386.1008493258805, 4499.865004049884, 4506.59440650343, 4508.819647214074, 4516.751578663139, 2755.2973991632007, 2757.4071574611553, 2759.2550011496783, 2760.806743527974, 2763.0743700860035, 4797.7601119943865, 4864.856758661712, 4878.658493905464, 4888.584470320063, 4894.681845680019, 5035.899282014412, 5199.688018718889, 5201.609879259071, 5262.815801446931, 5342.679439233659, 4915.21356582945, 4922.261660750916, 4926.211806111005, 4927.236278376786, 4936.358273424432, 5215.2698622192165, 5228.477152284741, 5235.528802407802, 5235.764390602508, 5238.659487133325, 4835.927461088157, 5000.67495612784, 5097.28637990689, 5115.721069732567, 5127.6410651254055, 4916.222334381063, 4918.114739346952, 4923.950760492349, 4933.925991110208, 4937.975310123426, 3647.8905632831056, 3670.1191713988983, 3678.9080272993388, 3681.8343174557745, 3689.114612493036, 5088.491150884882, 5209.47905209476, 5230.11088115029, 5256.316678831728, 5257.526822585985, 5044.319016932667, 5047.772850221675, 5053.267276244997, 5056.974715126401, 5069.935313584188, 5005.374328208974, 5008.248762685626, 5028.851197761788, 5030.270610761492, 5082.517160869711, 4686.297055441711, 4953.479884612064, 4973.428055773487, 4976.129177393869, 5006.974965125297, 4858.6356023297685, 4937.407511098691, 5076.923846142237, 5081.415637201769, 5090.211017292326, 4947.282644016669, 4951.603871690184, 4966.751662416792, 4970.3290055843445, 4983.127952608352], "value": 3796.511755055865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [596.8179705189918, 602.7137109872808, 629.6977450823605, 721.7004942948677, 746.2947514598704, 12423.378831058444, 13338.266395348252, 13350.465981360734, 13353.399097040632, 13363.06458547902, 12991.415386307615, 13095.672608184776, 13143.539976100838, 13153.40809663565, 13154.0, 613.7268915332679, 732.2896790113581, 752.4845480845611, 752.853193627243, 756.2966441209672, 746.5520687587458, 758.863404587174, 759.0094926121409, 765.2921048030578, 765.8353454007387, 799.160881074872, 800.2397722163938, 800.8158123631569, 801.0267524957176, 801.410962942237, 639.2648454277571, 779.5128044971892, 796.0884786918974, 797.1908512859452, 803.1727320859524, 592.2330581896455, 592.8103007037749, 593.1517929361012, 593.9842868694537, 594.0287629725387, 12326.260424374566, 12359.93820030903, 12385.75228495434, 12388.070894682935, 12399.13206075575, 11888.821667674993, 12030.097742669248, 12176.878231217752, 12242.265464072185, 12387.75224495505, 9174.954125229398, 9326.114019168235, 11475.713107172303, 11636.825447618292, 11864.940675296568, 3959.2873282809082, 4027.375756757707, 4030.2745505808944, 4037.212743515016, 4172.874813755592, 61930.0, 62051.0, 62576.0, 62648.373516264706, 63643.363566364205, 9760.658376956773, 9768.316217864824, 9776.266779991529, 9876.061774131445, 10298.17614590831, 18002.279908803765, 18069.27722891096, 18105.909470452825, 18106.094695265183, 18171.182296796676, 6280.089387038854, 6368.840778980562, 6380.7128679209545, 6396.584222025554, 6397.10440538325, 3502.842372093211, 3512.613612502623, 3560.857565697395, 3562.8931132066077, 3634.2186429917697, 2749.463854548384, 2844.6728626207837, 2859.1136747608307, 2861.4992376334058, 2863.727945845141, 468.63212378282884, 472.5015109059906, 481.5810245086797, 481.75189777264734, 488.99511004890206, 475.6456439952258, 494.33265092125345, 558.9385167631557, 586.3432955090241, 589.131031728206, 7448.292412220939, 7519.323260906544, 7556.886646700304, 7565.394768418513, 7921.772125320585, 514.904742622616, 515.9912371314072, 525.9973700131475, 529.7271904968944, 541.5099335101739, 3684.9815750921075, 3692.778433294011, 3762.379207430798, 3776.6978641708597, 3859.749116307431, 98787.0, 102807.52272113609, 103351.4832425833, 104319.47840260902, 105302.47348763207, 84507.0, 85116.57441712875, 85748.0, 85956.57021714977, 88578.55710721404, 72748.0, 76448.61775691308, 78094.60952695314, 78775.87956782791, 80477.0, 7184.389326907271, 7349.228331025379, 7597.772066838003, 7651.234876512304, 7876.763697089096, 44775.0, 45306.77346613246, 45850.31224531568, 46073.76963115163, 46632.30051549162, 63702.3629763715, 66968.33031669621, 67447.66276168588, 67549.3245067543, 68363.0, 8662.740117796477, 8741.606627701642, 8786.297096232414, 8926.375153739176, 9013.63945442175, 9555.808883822145, 9569.665061722806, 9652.372595781251, 9656.565454554702, 9684.273679473927, 8653.61058752345, 8821.514816685143, 8822.823543528964, 9026.413283136575, 9091.545422728705, 8664.653413863374, 8668.566571671265, 8673.392862499564, 8700.608472618875, 8812.427192232484, 8981.506017168856, 9151.862722059308, 9332.953335233551, 9381.390209636353, 9700.223982081276, 7704.884426733492, 7842.764717058498, 7984.081830589556, 8173.509589424653, 8211.753647390588, 7574.469787114849, 7781.92218077812, 7872.921270787448, 7914.802129946567, 8245.628946697292], "value": 6150.0897126481295, "unit": "score"}], "name": "dromaeo_css", "value": 6244.359616058466, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 115.0, 116.0, 110.0, 114.0, 115.0, 111.0, 116.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 122.0, 181.0, 123.0, 123.0, 147.0, 121.0, 158.0, 120.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 162.0, 163.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 77.0, 107.0, 76.0, 78.0, 75.0, 76.0, 107.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 124.0, 87.0, 88.0, 88.0, 114.0, 86.0, 86.0, 129.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 116.0, 118.0, 117.0, 116.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 148.0, 146.0, 146.0, 147.0, 145.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 67.0, 65.0, 66.0, 70.0, 66.0, 67.0, 67.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 81.0, 82.0, 91.0, 84.0, 81.0, 81.0, 82.0, 83.0, 83.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 130.0, 132.0, 132.0, 132.0, 136.0, 142.0, 131.0, 155.0, 135.0], "value": 135.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 178.0, 171.0, 174.0, 175.0, 170.0, 170.0, 173.0, 173.0, 171.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 69.0, 72.0, 68.0, 67.0, 67.0, 69.0, 69.0, 68.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1544.1999999999998, "alertThreshold": 2.0}]} 17:14:47 INFO - Return code: 0 17:14:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:14:47 INFO - # TBPL SUCCESS # 17:14:47 INFO - Running post-action listener: _resource_record_post_action 17:14:47 INFO - [mozharness: 2016-08-19 00:14:47.704356Z] Finished run-tests step (success) 17:14:47 INFO - Running post-run listener: _resource_record_post_run 17:14:47 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 414482432; Read time: 20; Write time: 369196 17:14:47 INFO - TinderboxPrint: CPU usage
13.0% 17:14:47 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 17:14:47 INFO - TinderboxPrint: I/O write bytes / time
414,482,432 / 369,196 17:14:47 INFO - TinderboxPrint: CPU idle
8,355.7 (87.0%) 17:14:47 INFO - TinderboxPrint: CPU user
1,198.7 (12.5%) 17:14:47 INFO - TinderboxPrint: Swap in / out
0 / 0 17:14:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 121520128; Read time: 0; Write time: 128400 17:14:47 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 292581376; Read time: 0; Write time: 240740 17:14:48 INFO - Running post-run listener: _upload_blobber_files 17:14:48 INFO - Blob upload gear active. 17:14:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:14:48 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 17:14:48 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:14:48 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:14:48 INFO - (blobuploader) - INFO - Open directory for files ... 17:14:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:14:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:14:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:53 INFO - (blobuploader) - INFO - Done attempting. 17:14:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:14:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:14:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:54 INFO - (blobuploader) - INFO - Done attempting. 17:14:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:14:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:14:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:55 INFO - (blobuploader) - INFO - Done attempting. 17:14:55 INFO - (blobuploader) - INFO - Iteration through files over. 17:14:55 INFO - Return code: 0 17:14:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:14:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:14:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d84111e72f5042ef82e744d93b9b3ddfcb703a3dec648f61ab7084735940e68e47e392a71aa46e05dbad1a7d8fa7b80efdbf5b3d0826a5f4c84fe7e0c34ab57f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4576ab2ecdebe20aba31edf78010998920cc4414c814d437cb0522b6b8094b9bedadeb50e3f304550d1317e24ef57941d179310bd537e63fd4646afa7e2f4e6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55e19c800100bc3c568b8fa420481e72097c459eeb9de8e55dee8f06992df9af8b0e7ca4dba5a957203c2a491a9ca927f4d33eeb531554122c1c68a4e907fc14"} 17:14:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:14:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:14:55 INFO - Contents: 17:14:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d84111e72f5042ef82e744d93b9b3ddfcb703a3dec648f61ab7084735940e68e47e392a71aa46e05dbad1a7d8fa7b80efdbf5b3d0826a5f4c84fe7e0c34ab57f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4576ab2ecdebe20aba31edf78010998920cc4414c814d437cb0522b6b8094b9bedadeb50e3f304550d1317e24ef57941d179310bd537e63fd4646afa7e2f4e6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55e19c800100bc3c568b8fa420481e72097c459eeb9de8e55dee8f06992df9af8b0e7ca4dba5a957203c2a491a9ca927f4d33eeb531554122c1c68a4e907fc14"} 17:14:55 INFO - Running post-run listener: copy_logs_to_upload_dir 17:14:55 INFO - Copying logs to upload dir... 17:14:55 INFO - mkdir: /builds/slave/test/build/upload/logs 17:14:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.001287 ========= master_lag: 137.60 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 23 mins, 4 secs) (at 2016-08-18 17:17:12.022780) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-08-18 17:17:12.026041) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565 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-Non-PGO/sha512/d84111e72f5042ef82e744d93b9b3ddfcb703a3dec648f61ab7084735940e68e47e392a71aa46e05dbad1a7d8fa7b80efdbf5b3d0826a5f4c84fe7e0c34ab57f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4576ab2ecdebe20aba31edf78010998920cc4414c814d437cb0522b6b8094b9bedadeb50e3f304550d1317e24ef57941d179310bd537e63fd4646afa7e2f4e6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55e19c800100bc3c568b8fa420481e72097c459eeb9de8e55dee8f06992df9af8b0e7ca4dba5a957203c2a491a9ca927f4d33eeb531554122c1c68a4e907fc14"} build_url:https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011321 build_url: 'https://queue.taskcluster.net/v1/task/fBdD2o2BR2arpgwcp0mmlA/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-Non-PGO/sha512/d84111e72f5042ef82e744d93b9b3ddfcb703a3dec648f61ab7084735940e68e47e392a71aa46e05dbad1a7d8fa7b80efdbf5b3d0826a5f4c84fe7e0c34ab57f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/4576ab2ecdebe20aba31edf78010998920cc4414c814d437cb0522b6b8094b9bedadeb50e3f304550d1317e24ef57941d179310bd537e63fd4646afa7e2f4e6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/55e19c800100bc3c568b8fa420481e72097c459eeb9de8e55dee8f06992df9af8b0e7ca4dba5a957203c2a491a9ca927f4d33eeb531554122c1c68a4e907fc14"}' ========= master_lag: 1.38 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-08-18 17:17:13.418366) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 17:17:13.418748) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1471564445.973619-544769565 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 17:17:13.552965) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 17:17:13.553288) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 17:17:13.553729) ========= ========= Total master_lag: 139.17 =========