builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1468257240.55 results: success (0) buildid: 20160711094226 builduid: affa0c95cd5b4c11a41aea14b3dbf5d0 revision: d13afbb70d7b600ccf688ac62e9c2871c7e87850 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 10:14:00.554784) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-11 10:14:00.555499) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 10:14:00.555836) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-11 10:14:00.596166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:14:00.596492) ========= 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=fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-11 10:14:00-- 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% 226M=0s 2016-07-11 10:14:00 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.215217 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:14:00.861623) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:14:00.861955) ========= 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=fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.085959 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:14:00.989663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 10:14:00.990007) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d13afbb70d7b600ccf688ac62e9c2871c7e87850 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d13afbb70d7b600ccf688ac62e9c2871c7e87850 --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=fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-11 10:14:01,084 truncating revision to first 12 chars 2016-07-11 10:14:01,084 Setting DEBUG logging. 2016-07-11 10:14:01,085 attempt 1/10 2016-07-11 10:14:01,085 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d13afbb70d7b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-11 10:14:01,848 unpacking tar archive at: fx-team-d13afbb70d7b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.114662 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-11 10:14:02.122232) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 10:14:02.122626) ========= script_repo_revision: d13afbb70d7b600ccf688ac62e9c2871c7e87850 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-11 10:14:02.123103) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 10:14:02.123523) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-11 10:14:02.133592) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-11 10:14:02.133942) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:14:02 INFO - MultiFileLogger online at 20160711 10:14:02 in /builds/slave/test 10:14:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:14:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:14:02 INFO - {'append_to_log': False, 10:14:02 INFO - 'base_work_dir': '/builds/slave/test', 10:14:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:14:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:14:02 INFO - 'branch': 'Fx-Team-Non-PGO', 10:14:02 INFO - 'buildbot_json_path': 'buildprops.json', 10:14:02 INFO - 'config_files': ('talos/linux_config.py',), 10:14:02 INFO - 'default_actions': ('clobber', 10:14:02 INFO - 'read-buildbot-config', 10:14:02 INFO - 'download-and-extract', 10:14:02 INFO - 'populate-webroot', 10:14:02 INFO - 'create-virtualenv', 10:14:02 INFO - 'install', 10:14:02 INFO - 'run-tests'), 10:14:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:14:02 INFO - 'download_minidump_stackwalk': True, 10:14:02 INFO - 'download_symbols': 'ondemand', 10:14:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:14:02 INFO - 'tooltool.py': '/tools/tooltool.py', 10:14:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:14:02 INFO - '/tools/misc-python/virtualenv.py')}, 10:14:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:14:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:14:02 INFO - 'installer_path': 'installer.exe', 10:14:02 INFO - 'log_level': 'info', 10:14:02 INFO - 'log_name': 'talos', 10:14:02 INFO - 'log_to_console': True, 10:14:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:14:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:14:02 INFO - 'opt_config_files': (), 10:14:02 INFO - 'pip_index': False, 10:14:02 INFO - 'sps_profile': False, 10:14:02 INFO - 'sps_profile_interval': 0, 10:14:02 INFO - 'suite': 'dromaeojs', 10:14:02 INFO - 'system_bits': '32', 10:14:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:14:02 INFO - 'title': 'talos-linux64-ix-048', 10:14:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:14:02 INFO - 'use_talos_json': True, 10:14:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:14:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:14:02 INFO - 'work_dir': 'build'} 10:14:02 INFO - ##### 10:14:02 INFO - ##### Running clobber step. 10:14:02 INFO - ##### 10:14:02 INFO - Running pre-action listener: _resource_record_pre_action 10:14:02 INFO - Running main action method: clobber 10:14:02 INFO - rmtree: /builds/slave/test/build 10:14:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:14:04 INFO - Running post-action listener: _resource_record_post_action 10:14:04 INFO - ##### 10:14:04 INFO - ##### Finished clobber step (success) 10:14:04 INFO - ##### 10:14:04 INFO - ##### 10:14:04 INFO - ##### Running read-buildbot-config step. 10:14:04 INFO - ##### 10:14:04 INFO - Running pre-action listener: _resource_record_pre_action 10:14:04 INFO - Running main action method: read_buildbot_config 10:14:04 INFO - Using buildbot properties: 10:14:04 INFO - { 10:14:04 INFO - "project": "", 10:14:04 INFO - "product": "firefox", 10:14:04 INFO - "script_repo_revision": "production", 10:14:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:14:04 INFO - "repository": "", 10:14:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:14:04 INFO - "buildid": "20160711094226", 10:14:04 INFO - "pgo_build": "False", 10:14:04 INFO - "basedir": "/builds/slave/test", 10:14:04 INFO - "buildnumber": 1967, 10:14:04 INFO - "slavename": "talos-linux64-ix-048", 10:14:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:14:04 INFO - "platform": "ubuntu64_hw", 10:14:04 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:14:04 INFO - "branch": "fx-team", 10:14:04 INFO - "repo_path": "integration/fx-team", 10:14:04 INFO - "revision": "d13afbb70d7b600ccf688ac62e9c2871c7e87850", 10:14:04 INFO - "stage_platform": "linux64", 10:14:04 INFO - "builduid": "affa0c95cd5b4c11a41aea14b3dbf5d0", 10:14:04 INFO - "slavebuilddir": "test" 10:14:04 INFO - } 10:14:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:14:04 INFO - Running post-action listener: _resource_record_post_action 10:14:04 INFO - ##### 10:14:04 INFO - ##### Finished read-buildbot-config step (success) 10:14:04 INFO - ##### 10:14:04 INFO - ##### 10:14:04 INFO - ##### Running download-and-extract step. 10:14:04 INFO - ##### 10:14:04 INFO - Running pre-action listener: _resource_record_pre_action 10:14:04 INFO - Running main action method: download_and_extract 10:14:04 INFO - mkdir: /builds/slave/test/build/tests 10:14:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:04 INFO - https://queue.taskcluster.net/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:14:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:14:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:14:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:14:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 10:14:05 INFO - Downloaded 1361 bytes. 10:14:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:14:05 INFO - Using the following test package requirements: 10:14:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:14:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:14:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:05 INFO - u'jsshell-linux-x86_64.zip'], 10:14:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:14:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:14:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:14:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:14:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:14:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:14:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:14:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:05 INFO - https://queue.taskcluster.net/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:14:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:14:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:14:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:14:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:14:07 INFO - Downloaded 22700380 bytes. 10:14:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:14:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:14:08 INFO - Return code: 0 10:14:08 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:08 INFO - https://queue.taskcluster.net/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:14:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:14:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:14:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:14:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:14:25 INFO - Downloaded 22700380 bytes. 10:14:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:14:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:14:26 INFO - Return code: 0 10:14:26 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:26 INFO - https://queue.taskcluster.net/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:14:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:14:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:14:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:14:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:14:27 INFO - Downloaded 14403333 bytes. 10:14:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:14:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:14:27 INFO - Return code: 0 10:14:27 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:27 INFO - https://queue.taskcluster.net/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:14:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:14:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:14:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:14:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:14:29 INFO - Downloaded 56651594 bytes. 10:14:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:14:29 INFO - mkdir: /builds/slave/test/properties 10:14:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:14:29 INFO - Writing to file /builds/slave/test/properties/build_url 10:14:29 INFO - Contents: 10:14:29 INFO - build_url:https://queue.taskcluster.net/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:14:30 INFO - Running post-action listener: _resource_record_post_action 10:14:30 INFO - Running post-action listener: set_extra_try_arguments 10:14:30 INFO - ##### 10:14:30 INFO - ##### Finished download-and-extract step (success) 10:14:30 INFO - ##### 10:14:30 INFO - ##### 10:14:30 INFO - ##### Running populate-webroot step. 10:14:30 INFO - ##### 10:14:30 INFO - Running pre-action listener: _resource_record_pre_action 10:14:30 INFO - Running main action method: populate_webroot 10:14:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:14:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:14:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:14:30 INFO - '--tppagecycles', 10:14:30 INFO - '7'], 10:14:30 INFO - 'tests': ['tsvgm']}}, 10:14:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:14:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:14:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:14:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:14:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:14:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:14:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:30 INFO - 'talos_options': ['--disable-e10s'], 10:14:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:14:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:30 INFO - 'talos_options': ['--disable-e10s'], 10:14:30 INFO - 'tests': ['damp', 'tps']}, 10:14:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:30 INFO - 'tests': ['damp', 'tps']}, 10:14:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:14:30 INFO - 'tests': ['dromaeo_dom']}, 10:14:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:14:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:14:30 INFO - 'tests': ['basic_compositor_video']}, 10:14:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:14:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:14:30 INFO - 'tests': ['a11yr', 10:14:30 INFO - 'ts_paint', 10:14:30 INFO - 'tpaint', 10:14:30 INFO - 'sessionrestore', 10:14:30 INFO - 'sessionrestore_no_auto_restore', 10:14:30 INFO - 'tabpaint']}, 10:14:30 INFO - 'other-e10s': {'tests': ['a11yr', 10:14:30 INFO - 'ts_paint', 10:14:30 INFO - 'tpaint', 10:14:30 INFO - 'sessionrestore', 10:14:30 INFO - 'sessionrestore_no_auto_restore', 10:14:30 INFO - 'tabpaint']}, 10:14:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:14:30 INFO - 'ts_paint', 10:14:30 INFO - 'tpaint', 10:14:30 INFO - 'sessionrestore', 10:14:30 INFO - 'sessionrestore_no_auto_restore', 10:14:30 INFO - 'tabpaint']}, 10:14:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:14:30 INFO - 'ts_paint', 10:14:30 INFO - 'tpaint', 10:14:30 INFO - 'sessionrestore', 10:14:30 INFO - 'sessionrestore_no_auto_restore', 10:14:30 INFO - 'tabpaint']}, 10:14:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:14:30 INFO - 'tests': ['a11yr', 10:14:30 INFO - 'ts_paint', 10:14:30 INFO - 'tpaint', 10:14:30 INFO - 'sessionrestore', 10:14:30 INFO - 'sessionrestore_no_auto_restore', 10:14:30 INFO - 'tabpaint']}, 10:14:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:14:30 INFO - 'tests': ['a11yr', 10:14:30 INFO - 'ts_paint', 10:14:30 INFO - 'tpaint', 10:14:30 INFO - 'sessionrestore', 10:14:30 INFO - 'sessionrestore_no_auto_restore', 10:14:30 INFO - 'tabpaint']}, 10:14:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:14:30 INFO - 'tests': ['tsvgx', 10:14:30 INFO - 'tsvgr_opacity', 10:14:30 INFO - 'tart', 10:14:30 INFO - 'tscrollx', 10:14:30 INFO - 'cart']}, 10:14:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:14:30 INFO - 'tsvgr_opacity', 10:14:30 INFO - 'tart', 10:14:30 INFO - 'tscrollx', 10:14:30 INFO - 'cart']}, 10:14:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:30 INFO - 'talos_options': ['--disable-e10s'], 10:14:30 INFO - 'tests': ['tp5o']}, 10:14:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:30 INFO - 'tests': ['tp5o']}, 10:14:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:30 INFO - 'talos_options': ['--disable-e10s', 10:14:30 INFO - '--xperf_path', 10:14:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:30 INFO - 'tests': ['tp5n']}, 10:14:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:14:30 INFO - 'talos_options': ['--xperf_path', 10:14:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:14:30 INFO - 'tests': ['tp5n']}}, 10:14:30 INFO - 'talos.zip': {'path': '', 10:14:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:14:30 INFO - Running post-action listener: _resource_record_post_action 10:14:30 INFO - ##### 10:14:30 INFO - ##### Finished populate-webroot step (success) 10:14:30 INFO - ##### 10:14:30 INFO - ##### 10:14:30 INFO - ##### Running create-virtualenv step. 10:14:30 INFO - ##### 10:14:30 INFO - Running pre-action listener: _resource_record_pre_action 10:14:30 INFO - Running main action method: create_virtualenv 10:14:30 INFO - Creating virtualenv /builds/slave/test/build/venv 10:14:30 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 10:14:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:14:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:14:30 INFO - Using real prefix '/usr' 10:14:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:14:30 INFO - Installing distribute.............................................................................................................................................................................................done. 10:14:33 INFO - Installing pip.................done. 10:14:33 INFO - Return code: 0 10:14:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe88030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11473b0>, '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 0x11482b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1148740>, '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': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', '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 10:14: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', 'pip>=1.5'] in /builds/slave/test/build 10:14: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 pip>=1.5 10:14:33 INFO - Using env: {'DISPLAY': ':0', 10:14:33 INFO - 'HOME': '/home/cltbld', 10:14:33 INFO - 'LANG': 'en_US.UTF-8', 10:14:33 INFO - 'LANGUAGE': 'en_US:en', 10:14:33 INFO - 'LOGNAME': 'cltbld', 10:14:33 INFO - 'MAIL': '/var/mail/cltbld', 10:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:33 INFO - 'MOZ_NO_REMOTE': '1', 10:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:33 INFO - 'NO_EM_RESTART': '1', 10:14:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:33 INFO - 'PWD': '/builds/slave/test', 10:14:33 INFO - 'SHELL': '/bin/bash', 10:14:33 INFO - 'SHLVL': '1', 10:14:33 INFO - 'TERM': 'linux', 10:14:33 INFO - 'TMOUT': '86400', 10:14:33 INFO - 'USER': 'cltbld', 10:14:33 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', 10:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:33 INFO - '_': '/tools/buildbot/bin/python'} 10:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:34 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 10:14:34 INFO - Cleaning up... 10:14:34 INFO - Return code: 0 10:14:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:34 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 0xe88030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11473b0>, '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 0x11482b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1148740>, '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': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', '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 10:14:34 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 10:14:34 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 10:14:34 INFO - Using env: {'DISPLAY': ':0', 10:14:34 INFO - 'HOME': '/home/cltbld', 10:14:34 INFO - 'LANG': 'en_US.UTF-8', 10:14:34 INFO - 'LANGUAGE': 'en_US:en', 10:14:34 INFO - 'LOGNAME': 'cltbld', 10:14:34 INFO - 'MAIL': '/var/mail/cltbld', 10:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:34 INFO - 'MOZ_NO_REMOTE': '1', 10:14:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:34 INFO - 'NO_EM_RESTART': '1', 10:14:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:34 INFO - 'PWD': '/builds/slave/test', 10:14:34 INFO - 'SHELL': '/bin/bash', 10:14:34 INFO - 'SHLVL': '1', 10:14:34 INFO - 'TERM': 'linux', 10:14:34 INFO - 'TMOUT': '86400', 10:14:34 INFO - 'USER': 'cltbld', 10:14:34 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', 10:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:34 INFO - '_': '/tools/buildbot/bin/python'} 10:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:34 INFO - Downloading/unpacking psutil>=3.1.1 10:14:34 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 10:14:34 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 10:14:34 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 10:14:34 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 10:14:34 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 10:14:34 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 10:14:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:14:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:36 INFO - Installing collected packages: psutil 10:14:36 INFO - Running setup.py install for psutil 10:14:36 INFO - building 'psutil._psutil_linux' extension 10:14:36 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 10:14:37 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 10:14:37 INFO - building 'psutil._psutil_posix' extension 10:14:37 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 10:14:37 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 10:14:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:14:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:14:37 INFO - Successfully installed psutil 10:14:37 INFO - Cleaning up... 10:14:38 INFO - Return code: 0 10:14:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe88030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11473b0>, '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 0x11482b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1148740>, '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': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', '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 10:14:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:14:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:14:38 INFO - Using env: {'DISPLAY': ':0', 10:14:38 INFO - 'HOME': '/home/cltbld', 10:14:38 INFO - 'LANG': 'en_US.UTF-8', 10:14:38 INFO - 'LANGUAGE': 'en_US:en', 10:14:38 INFO - 'LOGNAME': 'cltbld', 10:14:38 INFO - 'MAIL': '/var/mail/cltbld', 10:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:38 INFO - 'MOZ_NO_REMOTE': '1', 10:14:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:38 INFO - 'NO_EM_RESTART': '1', 10:14:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:38 INFO - 'PWD': '/builds/slave/test', 10:14:38 INFO - 'SHELL': '/bin/bash', 10:14:38 INFO - 'SHLVL': '1', 10:14:38 INFO - 'TERM': 'linux', 10:14:38 INFO - 'TMOUT': '86400', 10:14:38 INFO - 'USER': 'cltbld', 10:14:38 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', 10:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:38 INFO - '_': '/tools/buildbot/bin/python'} 10:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:14:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:14:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:14:40 INFO - Installing collected packages: mozsystemmonitor 10:14:40 INFO - Running setup.py install for mozsystemmonitor 10:14:40 INFO - Successfully installed mozsystemmonitor 10:14:40 INFO - Cleaning up... 10:14:40 INFO - Return code: 0 10:14:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:40 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 0xe88030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11473b0>, '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 0x11482b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1148740>, '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': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', '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 10:14:40 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 10:14:40 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 10:14:40 INFO - Using env: {'DISPLAY': ':0', 10:14:40 INFO - 'HOME': '/home/cltbld', 10:14:40 INFO - 'LANG': 'en_US.UTF-8', 10:14:40 INFO - 'LANGUAGE': 'en_US:en', 10:14:40 INFO - 'LOGNAME': 'cltbld', 10:14:40 INFO - 'MAIL': '/var/mail/cltbld', 10:14:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:40 INFO - 'MOZ_NO_REMOTE': '1', 10:14:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:40 INFO - 'NO_EM_RESTART': '1', 10:14:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:40 INFO - 'PWD': '/builds/slave/test', 10:14:40 INFO - 'SHELL': '/bin/bash', 10:14:40 INFO - 'SHLVL': '1', 10:14:40 INFO - 'TERM': 'linux', 10:14:40 INFO - 'TMOUT': '86400', 10:14:40 INFO - 'USER': 'cltbld', 10:14:40 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', 10:14:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:40 INFO - '_': '/tools/buildbot/bin/python'} 10:14:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:40 INFO - Downloading/unpacking jsonschema==2.5.1 10:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:14:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:42 INFO - Downloading functools32-3.2.3-2.tar.gz 10:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:14:42 INFO - warning: no files found matching '*.txt' 10:14:42 INFO - no previously-included directories found matching 'build' 10:14:42 INFO - no previously-included directories found matching 'dist' 10:14:42 INFO - no previously-included directories found matching '.git*' 10:14:42 INFO - Installing collected packages: jsonschema, functools32 10:14:42 INFO - Running setup.py install for functools32 10:14:42 INFO - warning: no files found matching '*.txt' 10:14:42 INFO - no previously-included directories found matching 'build' 10:14:42 INFO - no previously-included directories found matching 'dist' 10:14:42 INFO - no previously-included directories found matching '.git*' 10:14:42 INFO - Successfully installed jsonschema functools32 10:14:42 INFO - Cleaning up... 10:14:42 INFO - Return code: 0 10:14:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xe88030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11473b0>, '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 0x11482b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1148740>, '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': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', '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 10:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:14:42 INFO - Using env: {'DISPLAY': ':0', 10:14:42 INFO - 'HOME': '/home/cltbld', 10:14:42 INFO - 'LANG': 'en_US.UTF-8', 10:14:42 INFO - 'LANGUAGE': 'en_US:en', 10:14:42 INFO - 'LOGNAME': 'cltbld', 10:14:42 INFO - 'MAIL': '/var/mail/cltbld', 10:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:42 INFO - 'MOZ_NO_REMOTE': '1', 10:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:42 INFO - 'NO_EM_RESTART': '1', 10:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:42 INFO - 'PWD': '/builds/slave/test', 10:14:42 INFO - 'SHELL': '/bin/bash', 10:14:42 INFO - 'SHLVL': '1', 10:14:42 INFO - 'TERM': 'linux', 10:14:42 INFO - 'TMOUT': '86400', 10:14:42 INFO - 'USER': 'cltbld', 10:14:42 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', 10:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:42 INFO - '_': '/tools/buildbot/bin/python'} 10:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:43 INFO - Downloading/unpacking blobuploader==1.2.4 10:14:43 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 10:14:43 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 10:14:43 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 10:14:43 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 10:14:43 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 10:14:43 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 10:14:44 INFO - Downloading blobuploader-1.2.4.tar.gz 10:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:14:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:14:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:14:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:14:45 INFO - Downloading docopt-0.6.1.tar.gz 10:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:14:45 INFO - Installing collected packages: blobuploader, requests, docopt 10:14:45 INFO - Running setup.py install for blobuploader 10:14:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:14:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:14:45 INFO - Running setup.py install for requests 10:14:46 INFO - Running setup.py install for docopt 10:14:46 INFO - Successfully installed blobuploader requests docopt 10:14:46 INFO - Cleaning up... 10:14:46 INFO - Return code: 0 10:14:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:46 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:46 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 0xe88030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11473b0>, '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 0x11482b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1148740>, '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': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', '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 10:14:46 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 10:14:46 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 10:14:46 INFO - Using env: {'DISPLAY': ':0', 10:14:46 INFO - 'HOME': '/home/cltbld', 10:14:46 INFO - 'LANG': 'en_US.UTF-8', 10:14:46 INFO - 'LANGUAGE': 'en_US:en', 10:14:46 INFO - 'LOGNAME': 'cltbld', 10:14:46 INFO - 'MAIL': '/var/mail/cltbld', 10:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:46 INFO - 'MOZ_NO_REMOTE': '1', 10:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:46 INFO - 'NO_EM_RESTART': '1', 10:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:46 INFO - 'PWD': '/builds/slave/test', 10:14:46 INFO - 'SHELL': '/bin/bash', 10:14:46 INFO - 'SHLVL': '1', 10:14:46 INFO - 'TERM': 'linux', 10:14:46 INFO - 'TMOUT': '86400', 10:14:46 INFO - 'USER': 'cltbld', 10:14:46 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', 10:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:46 INFO - '_': '/tools/buildbot/bin/python'} 10:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:46 INFO - Running setup.py (path:/tmp/pip-eB0xfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:46 INFO - Running setup.py (path:/tmp/pip-1y8xqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:46 INFO - Running setup.py (path:/tmp/pip-VXOmmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:46 INFO - Running setup.py (path:/tmp/pip-IM4vT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:46 INFO - Running setup.py (path:/tmp/pip-97xFQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:46 INFO - Running setup.py (path:/tmp/pip-eCz_3g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:47 INFO - Running setup.py (path:/tmp/pip-dYxZV0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:47 INFO - Running setup.py (path:/tmp/pip-1KDvG5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:47 INFO - Running setup.py (path:/tmp/pip-JvQnMJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:47 INFO - Running setup.py (path:/tmp/pip-3vWku9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:47 INFO - Running setup.py (path:/tmp/pip-DqkSex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:47 INFO - Running setup.py (path:/tmp/pip-m9c9Qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:47 INFO - Running setup.py (path:/tmp/pip-DSjJ6W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:47 INFO - Running setup.py (path:/tmp/pip-c_z8yA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:47 INFO - Running setup.py (path:/tmp/pip-UfuHuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:47 INFO - Running setup.py (path:/tmp/pip-kkqKwh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:47 INFO - Running setup.py (path:/tmp/pip-WqrkRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:14:47 INFO - Running setup.py install for manifestparser 10:14:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:14:47 INFO - Running setup.py install for mozcrash 10:14:48 INFO - Running setup.py install for mozdebug 10:14:48 INFO - Running setup.py install for mozdevice 10:14:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:14:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:14:48 INFO - Running setup.py install for mozfile 10:14:48 INFO - Running setup.py install for mozhttpd 10:14:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:14:48 INFO - Running setup.py install for mozinfo 10:14:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:14:48 INFO - Running setup.py install for mozInstall 10:14:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:14:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:14:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:14:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:14:48 INFO - Running setup.py install for mozleak 10:14:48 INFO - Running setup.py install for mozlog 10:14:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:14:48 INFO - Running setup.py install for moznetwork 10:14:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:14:48 INFO - Running setup.py install for mozprocess 10:14:49 INFO - Running setup.py install for mozprofile 10:14:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:14:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:14:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:14:49 INFO - Running setup.py install for mozrunner 10:14:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:14:49 INFO - Running setup.py install for mozscreenshot 10:14:49 INFO - Running setup.py install for moztest 10:14:49 INFO - Running setup.py install for mozversion 10:14:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:14:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:14:49 INFO - Cleaning up... 10:14:49 INFO - Return code: 0 10:14:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:49 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 0xe88030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11473b0>, '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 0x11482b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1148740>, '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': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', '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 10:14:49 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 10:14:49 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 10:14:49 INFO - Using env: {'DISPLAY': ':0', 10:14:49 INFO - 'HOME': '/home/cltbld', 10:14:49 INFO - 'LANG': 'en_US.UTF-8', 10:14:49 INFO - 'LANGUAGE': 'en_US:en', 10:14:49 INFO - 'LOGNAME': 'cltbld', 10:14:49 INFO - 'MAIL': '/var/mail/cltbld', 10:14:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:49 INFO - 'MOZ_NO_REMOTE': '1', 10:14:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:49 INFO - 'NO_EM_RESTART': '1', 10:14:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:49 INFO - 'PWD': '/builds/slave/test', 10:14:49 INFO - 'SHELL': '/bin/bash', 10:14:49 INFO - 'SHLVL': '1', 10:14:49 INFO - 'TERM': 'linux', 10:14:49 INFO - 'TMOUT': '86400', 10:14:49 INFO - 'USER': 'cltbld', 10:14:49 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', 10:14:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:49 INFO - '_': '/tools/buildbot/bin/python'} 10:14:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:14:49 INFO - Running setup.py (path:/tmp/pip-h3zeIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:14:49 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)) 10:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:14:49 INFO - Running setup.py (path:/tmp/pip-c0wPtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:14:49 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)) 10:14:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:14:49 INFO - Running setup.py (path:/tmp/pip-S0IGX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:14:50 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)) 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:14:50 INFO - Running setup.py (path:/tmp/pip-UszSGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:14:50 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)) 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:14:50 INFO - Running setup.py (path:/tmp/pip-8wFcGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:14:50 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)) 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:14:50 INFO - Running setup.py (path:/tmp/pip-3wBLDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:14:50 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)) 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:14:50 INFO - Running setup.py (path:/tmp/pip-vyPRqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:14:50 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)) 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:14:50 INFO - Running setup.py (path:/tmp/pip-Dog1e6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:14:50 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)) 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:14:50 INFO - Running setup.py (path:/tmp/pip-HLLLxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:14:50 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)) 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:14:50 INFO - Running setup.py (path:/tmp/pip-FCv00p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:14:50 INFO - Running setup.py (path:/tmp/pip-lgc9YI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:14:50 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)) 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:14:50 INFO - Running setup.py (path:/tmp/pip-PQCbuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:14:50 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)) 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:14:50 INFO - Running setup.py (path:/tmp/pip-QMT5Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:14:50 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)) 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:14:50 INFO - Running setup.py (path:/tmp/pip-fL0T18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:14:50 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)) 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:50 INFO - Running setup.py (path:/tmp/pip-Szezxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:14:50 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)) 10:14:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:14:50 INFO - Running setup.py (path:/tmp/pip-uscEAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:14:51 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)) 10:14:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:14:51 INFO - Running setup.py (path:/tmp/pip-pu_h3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:14:51 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)) 10:14:51 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)) 10:14:51 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)) 10:14:51 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)) 10:14:51 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)) 10:14:51 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)) 10:14:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:14:51 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 10:14:51 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 10:14:51 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 10:14:51 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 10:14:51 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 10:14:51 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 10:14:52 INFO - Downloading blessings-1.6.tar.gz 10:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:14:53 INFO - Installing collected packages: blessings 10:14:53 INFO - Running setup.py install for blessings 10:14:53 INFO - Successfully installed blessings 10:14:53 INFO - Cleaning up... 10:14:53 INFO - Return code: 0 10:14:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:53 INFO - Reading from file tmpfile_stdout 10:14:53 INFO - Current package versions: 10:14:53 INFO - argparse == 1.2.1 10:14:53 INFO - blessings == 1.6 10:14:53 INFO - blobuploader == 1.2.4 10:14:53 INFO - docopt == 0.6.1 10:14:53 INFO - functools32 == 3.2.3-2 10:14:53 INFO - jsonschema == 2.5.1 10:14:53 INFO - manifestparser == 1.1 10:14:53 INFO - mozInstall == 1.12 10:14:53 INFO - mozcrash == 0.17 10:14:53 INFO - mozdebug == 0.1 10:14:53 INFO - mozdevice == 0.48 10:14:53 INFO - mozfile == 1.2 10:14:53 INFO - mozhttpd == 0.7 10:14:53 INFO - mozinfo == 0.9 10:14:53 INFO - mozleak == 0.1 10:14:53 INFO - mozlog == 3.2 10:14:53 INFO - moznetwork == 0.27 10:14:53 INFO - mozprocess == 0.23 10:14:53 INFO - mozprofile == 0.28 10:14:53 INFO - mozrunner == 6.12 10:14:53 INFO - mozscreenshot == 0.1 10:14:53 INFO - mozsystemmonitor == 0.3 10:14:53 INFO - moztest == 0.7 10:14:53 INFO - mozversion == 1.4 10:14:53 INFO - psutil == 3.1.1 10:14:53 INFO - requests == 1.2.3 10:14:53 INFO - wsgiref == 0.1.2 10:14:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:53 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 0xe88030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11473b0>, '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 0x11482b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1148740>, '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': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', '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 10:14:53 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 10:14:53 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 10:14:53 INFO - Using env: {'DISPLAY': ':0', 10:14:53 INFO - 'HOME': '/home/cltbld', 10:14:53 INFO - 'LANG': 'en_US.UTF-8', 10:14:53 INFO - 'LANGUAGE': 'en_US:en', 10:14:53 INFO - 'LOGNAME': 'cltbld', 10:14:53 INFO - 'MAIL': '/var/mail/cltbld', 10:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:53 INFO - 'MOZ_NO_REMOTE': '1', 10:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:53 INFO - 'NO_EM_RESTART': '1', 10:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:53 INFO - 'PWD': '/builds/slave/test', 10:14:53 INFO - 'SHELL': '/bin/bash', 10:14:53 INFO - 'SHLVL': '1', 10:14:53 INFO - 'TERM': 'linux', 10:14:53 INFO - 'TMOUT': '86400', 10:14:53 INFO - 'USER': 'cltbld', 10:14:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', 10:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:53 INFO - '_': '/tools/buildbot/bin/python'} 10:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:53 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)) 10:14:53 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)) 10:14:53 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)) 10:14:53 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)) 10:14:53 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)) 10:14:53 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)) 10:14:53 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)) 10:14:53 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)) 10:14:53 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)) 10:14:53 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)) 10:14:53 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)) 10:14:53 INFO - Cleaning up... 10:14:53 INFO - Return code: 0 10:14:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:14:53 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 0xe88030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfeb8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1149180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11473b0>, '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 0x11482b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1148740>, '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': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', '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 10:14:53 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 10:14:53 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 10:14:53 INFO - Using env: {'DISPLAY': ':0', 10:14:53 INFO - 'HOME': '/home/cltbld', 10:14:53 INFO - 'LANG': 'en_US.UTF-8', 10:14:53 INFO - 'LANGUAGE': 'en_US:en', 10:14:53 INFO - 'LOGNAME': 'cltbld', 10:14:53 INFO - 'MAIL': '/var/mail/cltbld', 10:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:14:53 INFO - 'MOZ_NO_REMOTE': '1', 10:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:14:53 INFO - 'NO_EM_RESTART': '1', 10:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:14:53 INFO - 'PWD': '/builds/slave/test', 10:14:53 INFO - 'SHELL': '/bin/bash', 10:14:53 INFO - 'SHLVL': '1', 10:14:53 INFO - 'TERM': 'linux', 10:14:53 INFO - 'TMOUT': '86400', 10:14:53 INFO - 'USER': 'cltbld', 10:14:53 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', 10:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:14:53 INFO - '_': '/tools/buildbot/bin/python'} 10:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:14:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:14:53 INFO - Cleaning up... 10:14:53 INFO - Return code: 0 10:14:53 INFO - Running post-action listener: _resource_record_post_action 10:14:53 INFO - Running post-action listener: _start_resource_monitoring 10:14:53 INFO - Starting resource monitoring. 10:14:53 INFO - ##### 10:14:53 INFO - ##### Finished create-virtualenv step (success) 10:14:53 INFO - ##### 10:14:53 INFO - ##### 10:14:53 INFO - ##### Running install step. 10:14:53 INFO - ##### 10:14:53 INFO - Running pre-action listener: _resource_record_pre_action 10:14:53 INFO - Running main action method: install 10:14:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:14:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:14:54 INFO - Reading from file tmpfile_stdout 10:14:54 INFO - Detecting whether we're running mozinstall >=1.0... 10:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:14:54 INFO - Reading from file tmpfile_stdout 10:14:54 INFO - Output received: 10:14:54 INFO - Usage: mozinstall [options] installer 10:14:54 INFO - Options: 10:14:54 INFO - -h, --help show this help message and exit 10:14:54 INFO - -d DEST, --destination=DEST 10:14:54 INFO - Directory to install application into. [default: 10:14:54 INFO - "/builds/slave/test"] 10:14:54 INFO - --app=APP Application being installed. [default: firefox] 10:14:54 INFO - mkdir: /builds/slave/test/build/application 10:14:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:14:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:15:10 INFO - Reading from file tmpfile_stdout 10:15:10 INFO - Output received: 10:15:10 INFO - /builds/slave/test/build/application/firefox/firefox 10:15:10 INFO - Running post-action listener: _resource_record_post_action 10:15:10 INFO - ##### 10:15:10 INFO - ##### Finished install step (success) 10:15:10 INFO - ##### 10:15:10 INFO - ##### 10:15:10 INFO - ##### Running run-tests step. 10:15:10 INFO - ##### 10:15:10 INFO - Running pre-action listener: _resource_record_pre_action 10:15:10 INFO - Running main action method: run_tests 10:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:15:10 INFO - Python 2.7.3 10:15:10 INFO - Return code: 0 10:15:10 INFO - grabbing minidump binary from tooltool 10:15:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:10 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 0x11473b0>, '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 0x11482b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1148740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:15:10 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 10:15:10 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 10:15:10 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 10:15:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:15:10 INFO - Return code: 0 10:15:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:15:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:15:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:15:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:15:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:15:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 10:15:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-048 --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 10:15:10 INFO - Using env: {'DISPLAY': ':0', 10:15:10 INFO - 'HOME': '/home/cltbld', 10:15:10 INFO - 'LANG': 'en_US.UTF-8', 10:15:10 INFO - 'LANGUAGE': 'en_US:en', 10:15:10 INFO - 'LOGNAME': 'cltbld', 10:15:10 INFO - 'MAIL': '/var/mail/cltbld', 10:15:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:15:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:15:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:10 INFO - 'MOZ_NO_REMOTE': '1', 10:15:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:15:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:10 INFO - 'NO_EM_RESTART': '1', 10:15:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:10 INFO - 'PWD': '/builds/slave/test', 10:15:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:15:10 INFO - 'SHELL': '/bin/bash', 10:15:10 INFO - 'SHLVL': '1', 10:15:10 INFO - 'TERM': 'linux', 10:15:10 INFO - 'TMOUT': '86400', 10:15:10 INFO - 'USER': 'cltbld', 10:15:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370', 10:15:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:10 INFO - '_': '/tools/buildbot/bin/python'} 10:15:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--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 10:15:10 INFO - mozversion application_buildid: 20160711094226 10:15:10 INFO - mozversion application_changeset: d13afbb70d7b600ccf688ac62e9c2871c7e87850 10:15:10 INFO - mozversion application_display_name: Nightly 10:15:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:15:10 INFO - mozversion application_name: Firefox 10:15:10 INFO - mozversion application_remotingname: firefox 10:15:10 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:15:10 INFO - mozversion application_vendor: Mozilla 10:15:10 INFO - mozversion application_version: 50.0a1 10:15:10 INFO - mozversion platform_buildid: 20160711094226 10:15:10 INFO - mozversion platform_changeset: d13afbb70d7b600ccf688ac62e9c2871c7e87850 10:15:10 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:15:10 INFO - mozversion platform_version: 50.0a1 10:15:10 INFO - using testdate: 1468257310 10:15:10 INFO - actual date: 1468257310 10:15:10 INFO - starting webserver on 'localhost:37843' 10:15:10 INFO - SUITE-START | Running 2 tests 10:15:10 INFO - TEST-START | dromaeo_css 10:15:10 INFO - operating with platform_type : linux_ 10:15:10 INFO - Initialising browser for dromaeo_css test... 10:15:10 INFO - TEST-INFO | started process 3316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXsjNC7/profile http://localhost:37843/getInfo.html) 10:15:17 INFO - PROCESS | 3316 | __metrics Screen width/height:1600/1200 10:15:17 INFO - PROCESS | 3316 | colorDepth:24 10:15:17 INFO - PROCESS | 3316 | Browser inner width/height: 1024/697 10:15:17 INFO - PROCESS | 3316 | __metrics 10:15:18 INFO - PROCESS | 3316 | 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" 10:15:18 INFO - PROCESS | 3316 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:15:20 INFO - PROCESS | 3316 | console.error: PushService: 10:15:20 INFO - PROCESS | 3316 | stateChangeProcessEnqueue: Error transitioning state 10:15:20 INFO - PROCESS | 3316 | UnknownError 10:15:21 INFO - TEST-INFO | 3316: exit 0 10:15:21 INFO - Browser initialized. 10:15:21 INFO - Running cycle 1/1 for dromaeo_css test... 10:15:21 INFO - TEST-INFO | started process 3402 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXsjNC7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:15:33 INFO - PROCESS | 3402 | RSS: Main: 158810112 10:15:33 INFO - PROCESS | 3402 | 10:16:24 INFO - PROCESS | 3402 | 1468257384421 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] 10:18:37 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37843/tests/dromaeo/cssquery-ext.html) 10:18:38 INFO - PROCESS | 3402 | RSS: Main: 267640832 10:18:38 INFO - PROCESS | 3402 | 10:21:41 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-ext.html (next: http://localhost:37843/tests/dromaeo/cssquery-jquery.html) 10:21:41 INFO - PROCESS | 3402 | RSS: Main: 237109248 10:21:41 INFO - PROCESS | 3402 | 10:24:44 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37843/tests/dromaeo/cssquery-mootools.html) 10:24:44 INFO - PROCESS | 3402 | RSS: Main: 234176512 10:24:44 INFO - PROCESS | 3402 | 10:27:46 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37843/tests/dromaeo/cssquery-prototype.html) 10:27:47 INFO - PROCESS | 3402 | RSS: Main: 236838912 10:27:47 INFO - PROCESS | 3402 | 10:30:50 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37843/tests/dromaeo/cssquery-yui.html) 10:30:51 INFO - PROCESS | 3402 | RSS: Main: 210063360 10:30:51 INFO - PROCESS | 3402 | 10:33:53 INFO - PROCESS | 3402 | Cycle 1(1): loaded http://localhost:37843/tests/dromaeo/cssquery-yui.html (next: http://localhost:37843/tests/dromaeo/cssquery-dojo.html) 10:33:53 INFO - PROCESS | 3402 | RSS: Main: 288751616 10:33:53 INFO - PROCESS | 3402 | 10:33:53 INFO - PROCESS | 3402 | __start_tp_report 10:33:53 INFO - PROCESS | 3402 | _x_x_mozilla_page_load 10:33:53 INFO - PROCESS | 3402 | _x_x_mozilla_page_load_details 10:33:53 INFO - PROCESS | 3402 | |i|pagename|runs| 10:33:53 INFO - PROCESS | 3402 | |0;dojo.html;2645.629611854342;2646.6956300025495;2687.4893770183676;2690.4350086481836;2691.905783297585;4557.111363284161;4679.415073115861;4715.127701375243;4806.134895718765;4846.12769701454;4652.139354219472;4706.505816889228;4726.787294571744;4734.7869345879435;4734.90530189396;4346.695731298811;4365.759883206422;4382.868513944587;4393.7803109844535;4459.799309031086;4393.978030109845;4428.1807865544815;4435.534268901767;4465.553444655541;4493.46078470584;4378.970941828699;4407.933880991788;4427.88930276744;4433.9113217735785;4458.996725736716;4260.637845783112;4299.247631664446;4329.826806927719;4351.891202719926;4358.411614432074;4323.978380108111;4349.064951035511;4381.934270985906;4396.450443694538;4404.96483326418;4827.879303017417;4833;4835.975820120912;4843.4430040545085;4863.148948933923;4926.679765815211;5043.041822053798;5116.590672746172;5131.948680513185;5201.037808005531;5174.689518628857;5185.61107916904;5190.273361729361;5201.375834899798;5214.45248248936;4562.88592785183;4782.258749893772;4789.30555069513;4823.493533179001;4829.975850120797;5207.635465517377;5251.501107394792;5262.815801446931;5275.366955965309;5344.518993290622;5048.242763585492;5063.721495317793;5116.258142569307;5118.744062796845;5119.1553393690365;4929.556339929423;5083.542481176712;5155.664881782672;5199.064168449715;5207.6875387476875;5061.974690126526;5083.085044691991;5097.923531147036;5100.464451232567;5153.304303918998;5067.442581316052;5076.543111119943;5079.238114282887;5082.872928176826;5131.7434128293435;4240.363945408213;4251.914961700749;4274.316109422478;4408.184485870124;4451.287793952952;3742.5134732484603;3754.680852127545;3765.6234376562675;3807.2385522895534;3825.3496905526126;3980.6218409251073;3988.8404463821703;4023;4025.5571887092397;4034.919301613951;4817.301491283744;4866.197077482176;4940.777665005084;4940.975295123501;4960.851174464772;4006.1787333596544;4033.1127152026506;4034.8386064557676;4075.919881231476;4076.7146299759324;4425.3140763181755;4438.533953934791;4455.1757924784015;4468.843590474317;4493.236149854532;4515.729056256635;4690.648201384842;4709.858704238878;4741.810327586858;4763.54746299101;5017.67385119966;5035.899282014412;5041.117804384291;5077.187649976134;5082.695038297714;4764.404449443819;4769.236922092448;4777.402824646919;4780.68925519854;4823.710577365369;4817.590504806991;4975.776090076028;5008.073506401327;5030.9245361320345;5070.8225212117395;5045.798168073383;5063.670861393997;5069.847904562869;5073.086844367902;5101.515356041318;4938.777755001105;4939.678920870132;4940.061388336205;4942.28336891156;4969.850904472727;4694.413198350207;4894.412670479565;4929.852104436873;4937.086638971658;4961.975190124026;4839.104765618372;4856.1987272099705;4856.78144483492;4898.853034408973;4902.754862256944;4979.975100124476;5014.222795466709;5018.473060328759;5019.799208031638;5070.847874563769;4697.342372067845;4807.110684523374;4843.0313937211995;4866.975665121652;4877.634177436636 10:33:53 INFO - PROCESS | 3402 | |1;ext.html;537.7680783078721;587.6356658871499;595.2975488923071;596.8239369386031;602.1900543768633;26748.93004279829;40123.39814902779;40689.79655101728;40697.59302406975;40852.978675533086;41103;41447.79276103623;41483.17033659325;41630.16739665213;41661;7833.060032796073;7949.721759738411;7970.721024764134;7975.7208497702595;7980.76298173784;7849.843003139934;7877.330426913719;7931.881021784678;7932.960335198316;7936.127026027132;7957.124716281204;7986.6805327786815;7993.920060799404;7995.720149794758;8011.479253848511;7953.085395179542;7975.202479751978;7976.282134607914;7981.561014144219;7993.240642138988;7903.960480197619;7936.4047696423;7986.361091112697;7987.960060199662;7999.920000800034;37811.4328285076;38163.42754858679;38175.427368589495;38250;38253.0436739081;2865.2981115533466;3141.8114913105287;3221.4523530999554;3227.289996200832;3354.4569498030937;29208;29229.853850730822;29334.70665293341;29463.263418414495;30044.699553004626;3112.4553203189353;3120.063980805749;3154.8895788647287;3160.0361889623655;3192.9361412771846;299640;304288;307639;413437;414888.9255553733;53626.19560706592;54475.72762136164;54593.727031365386;54597.45402546003;54636;33052.1736956578;33904.49143262853;33978.66021339804;58069.70965145147;58403.4159658398;13742.869855172265;13998.160110393408;13998.51005214833;14005.439782408794;14006.159630422208;10033.14718248957;10050.64822731201;10073.647422340184;10081.445520496296;10084;18175.36386226502;18183.45449636513;18203.63592728138;18224.726629100573;18250.817491824913;7041.929580704127;7072.575645461289;7106.644667766591;7136.750213742494;7149.677309697722;801.1427772283718;873.7902903303288;879.147227189625;882.955852207387;886.3485338276362;25234.74765252324;25347;25641.48717025649;25652.8717356412;25653.23040308794;872.4852337121002;914.8124634449922;919.6781126605769;930.3394589841154;986.1716158426956;14452.710945781026;15016.24918754058;15022.24888755558;15312.923435382974;15340.232988350537;382618;383046;384286;384863;385248;48796.5120348792;49316;49346.75326623344;49363.25955110676;49428;1071.1377341240377;1122.1639878290725;1153.2388623508612;1171.7480741640588;1178.5580407347245;26211.344716382242;28780.712192877803;29117.272068198465;29404.043316992083;29636.555451668675;40979;41307.58692413037;41388;41419.58580414157;41624.79187604043;311047;311821;312814;313453;314120;22169.22407715722;24506.50986980286;24909.750902490745;25310.74689253084;25386.873065634554;40756.18487630171;41539.7923010383;41994.58005420029;42148;42400;35446.29107417889;35651.82174089113;36129.638703612625;36175.63824361723;36314.273714525036;35990.8200458996;36029.45955810612;36261.63738362583;36388.636113639586;36597.26805463929;34622.480662789574;35365;35388.46917296191;35582.64417355897;35675;31280.68719312778;32340;32996.17509562184;32997.17507062342;33035;24786.752132478443;24816.379590510383;25263.87368063148;25491.617625735256;25689.35776605525 10:33:53 INFO - PROCESS | 3402 | |2;jquery.html;355.2894211576846;360.8736942070277;362.9419292913134;368.8506155007223;372.5436340482907;16571.420000299993;17302.82697173028;18314.450566482992;18322.083895805223;18355.724664130048;17173.570660733487;17421.564460888483;18021.729674054866;18027.27890884363;18029.63940721185;4994.875128121808;5150.459201783815;5177.48225177483;5201.167813149897;5212;3781.092537790938;3985.7010724195657;5149.279100925854;5812.564057695668;6077.179580756608;6117.5717699761035;6140.293866205398;6160.722767475474;6194.96902515489;6197.659128747917;5865.237519122508;6026;6029.035354343306;6032.788852390146;6041.667708276043;3387.6781705737917;5049.419316778581;5287.154055351164;5315.548178404841;5319.654222475566;21610.89194554017;21793.67309490359;21818.236361727264;21948.45128871775;22218.777812221833;2086.2405805191224;2189.211883721859;2350.048230466664;2392.413858604653;2438.719547252071;9480.715578532587;11866.703332416759;12894.742105157939;13172.670683232996;14372.496962606363;1656.685229806333;1658.5687721192576;1728.0236666283636;1757.9472615821546;1801.9819801801946;63017;69239;72884.6355768223;72908;72991.27008729898;9992.500374981222;10048.447335396624;10395.94802026;10407.895921040692;10427.739306517245;14130.293485325692;14216.075955062888;14218.85781142196;14264.144151350953;14266.215358155194;6988.580685158907;7212.3869471094495;7307.561546307238;7368.226336234618;7391.741289054858;6853.725850966005;6888.862222755617;6992.2658120897595;7021.789346319619;7054.188768291712;4419.226635338803;4424.955750442518;4437.245668236343;4497.190505708938;4536.319552067151;1703.0973584000499;1750.571110078039;1782.1801971093182;1785.2501949181376;1832.569346203641;733.0543598757649;791.5962858941866;822.116225058065;842.4103127810557;905.248643625789;16988.589975905456;17313.653726925644;17379.826201738073;17860.55348616295;18128.365507207185;794.682127149145;817.3747083481142;819.2053707903324;852.4033176776281;863.6459051788736;9350.485723285285;9707.563159657833;9926.602935882484;9949.154321882575;10158.847617285746;367223;367295;377072;377424;377891;51154;60802;80452;89780.5510972441;90553;926.8656044873455;944.1172503709054;955.3551352836807;971.0726256425097;972.0619602084023;12488.937555312164;16731.49805505788;17020.574485637957;17066.14669266507;17315.7402638958;37289.81355093207;39245.41131882967;39862.40206396965;40292.1941561173;40430;58591.70704146452;59032.409675902694;59881;60237.69881150566;60808.695956519936;7405.2224516425;7631.236876312324;7665.501742386727;7689.115751688628;7919.12889582157;7777.72777952769;8458.53478058688;8531.914680853111;8584;12112.757744844877;7289.489735718661;7575.886361704469;7774.067111946602;7820.648070836713;8132.2680958714;7817.140114587277;7936.206379362017;7938.801529961797;8035.758927232192;8180.977377827771;7559.697612095454;7599.886001709868;7940.0471943367165;8266.958665206635;8283.95858020706;11590.88409115898;11679.357635330138;11826.34955077479;12041.939790300992;12384.876151238732;10777.541887191053;11249.943750281196;11307.208495405243;11461.255018423775;11537.480813363587 10:33:53 INFO - PROCESS | 3402 | |3;mootools.html;1353.3098119958818;1392.6518370407398;1443.4731323067083;1663.8585720213782;1702.089382180533;7197.71209151634;7590.240975902407;7623.047119110111;7701.807454813626;7707.845843083135;6335.398137176972;6532.902006469895;6544.214694236698;6668.466522678174;7555.017847679807;2076.2836821296664;2167.5773224221284;2167.880766557839;2187.9015444304964;2188;2200;2215.8448908576406;2229.409206560255;2246.292417888368;2246.550689862026;1871.9438416847515;2108.4834215617198;2208.1719355241785;2211.8783466909313;2220.378294077661;2146.785321467856;2174.4455163933253;2175.8476906616543;2186.9234576789895;2187.58435897179;2070.710100585919;2085.384811480617;2092.9476763081043;2109.683547467877;2110.567333696604;7367.079115110611;7417.5549467031615;7440.069991251094;7446.627668616602;7447;4446.155230506193;4479.888002799924;4497.820087196541;4511.6165125964335;4562.8364766984205;2733.3439974406197;2762.5303698371326;2785.1087651951384;2828.5191517442086;2843.4170994945985;858.4548811504677;870.0777176193255;886.1537231943479;901.4095767272447;901.9594118264694;9936.652217172365;9937.70186894387;9952.701418957442;9953;9960.203183745356;3825.827837747308;4015.5984401560195;4194.517630472474;4199.853005144805;4206.369044643328;8425.789355266168;8440.62017209227;8443.113473085361;8456.40805143634;8477.109903460048;4430.13612345596;4446.044100518404;4452.30989196675;4452.354408610733;4455.086707225076;3670.522832031819;4030.6573941215324;4048.352263637804;4048.8785336439955;4050.4734384529825;3424.931501369959;3571.1786289153642;3574.6782789549065;3582.9967609069504;3639.3994990826745;1123.4495097402378;1172.5778719660916;1178.4932479033926;1180.6517077461997;1191.5293459083614;801.6512816924657;808.706712661651;834.5618550261162;840.0675250471971;850.5747126436781;4994.200927851599;5035.16919708244;5065.468125846733;5085.338905942203;5094.592432605383;834.983300334002;880.9515476648846;888.7733627924838;892.5894088719132;894.0701670262983;3376.69609735125;3492.4935884296633;3543.805090720035;3547.379208638478;3600.369935261319;8609.91390086091;8761.693340733043;8896.510691912006;8917.509536975398;8921.375503714808;8814.074522175208;8820.779480513038;8834.95582522096;8841.336899732545;8849.292056635453;6899.103116594811;6959.791206263821;7031.613261270679;7047.859042819115;7050.823729406806;4884.389451318585;4906.705597664151;4976.576990955809;4991.101601711727;5016.172331565251;8154.347652187929;8174.591270436335;8432.45189062709;8436.493810371398;8475.533845638549;8173.877391839008;8611.13888611134;8624.913750862412;8626.309895208493;8627;5769.653820770767;6219.0982307564245;6442.484601231984;6445.129907462432;6448.613083215022;6370.8088757337355;6538.280789113289;6542;6547.934520654923;6741.764038258833;6155.1382806406245;6500.414962653384;6609.441634925263;6661.4337781287195;6839.384455399038;6590.7693230736695;6639;6707.3628005339415;6715.5299129060495;6761.864762704817;5904;5974.37269086757;5977.940220597912;5979.730912109053;5996;4413.977930110329;4506.41416615851;4529.433820772403;4561.794719237709;4665.136949664323;4540.545945405433;4545.363649089064;4575.450945886515;4615.953840461552;4636.281376386665 10:33:53 INFO - PROCESS | 3402 | |4;prototype.html;298.8296670897589;305.79664523092146;307.24724425158365;307.6646455363653;310.63500387045224;4878.829240976566;4891.902161956758;4893.287349427703;4899.43656479505;4916.164252077147;4733.1601039376355;4771.8807029824275;4810.206315957863;4867.805287788484;4868.951310486894;3841.635044670759;3852.8266228019666;3881.340172170738;3885.572587015426;3917.138229589486;3777.172695640927;3805.847766089353;3855.57588665248;3912.471816304805;3914.7063970202207;3752.3245815753153;3794.7153963452715;3815.961840381602;3820.866269680562;3825.234953009395;3795.7722536647752;3798.8670396536263;3807.6573108420375;3810.90472738181;3822.541295044585;3177.809331440121;3283;3388.3232246525217;3390.338883917637;3422.058933793202;4686.859394218179;4699.130660827724;4709.9764501177615;4711.599514041311;4713.410823647044;4356.43366362374;4367.563243675639;4370.191514569815;4374.606285434326;4375.496817865923;4841.830535931225;4876.683015603974;5008.474110218447;5043.899122017539;5077.365329333833;3689.0777305673582;3695.4641576971458;3710.1837595729166;3713.350163721365;3721.79530125843;5242.580593552545;5248.160294352885;5280.125555427845;5301.072312345363;5324;3626.5285512883156;3749.3063783200196;3755.8122093895195;3758.0980564664283;3779.905502362463;3810.8278281379903;3831.1762970961377;3834.5973672764517;3836.48207491985;3839.9616003839606;4343.457067866517;4350.434443522385;4352.717073390219;4352.868254253854;4358.65130789536;4814.9518504814505;5016;5058.595312375001;5121.308623335876;5161.406438259648;1356.8236129303127;1366.781314989597;1368.50733735855;1370.5545697648304;1373.8420081690733;879.2350654930252;899.7030979776658;904.6064961741663;917.1333090229668;919.8988111307751;3783.791891445942;3792.62960649594;3796.981015094907;3803.8478460861256;3813.1801662642665;4562.448767419093;4564.406627138517;4576.519465456146;4584.386899467272;4611.930821037688;3757.759939220051;3767.773933563995;3781.619708806321;3814.6185381461632;3855.845766169322;2329.590597688408;2395.7125144982715;2415.2972154630943;2576.6392705021312;2655.614935834293;4735.881602959885;4764.904701906012;4783.258594917794;4784.354112194878;4795;5269.077911365495;5313.149896016619;5319.441458646864;5327.866803329948;5350.705711185844;4676.766161691902;4839.708997881404;4855.562999330006;4855.562999330077;4891;4951.480094590161;4980.252962055576;4988.376452943382;5002.024605202097;5012.922221722347;5059.571405725346;5061.367329083864;5061.519155680205;5076.441591424867;5093.745312734274;4742;4760.818464040894;4852.927206091841;4862.562369386772;4879.658423910434;3817.4273858921383;3836.194399176204;3844.38489841624;3849.6150384962402;3874.573796882284;5184.533391994739;5196.116660167705;5207.869803254797;5222.451642577626;5233.450487698737;4780.95219047805;4977.800887964441;5024.824131155538;5025.422076461107;5033.395992480926;4934.55588996992;4968.453470118357;4989.575886049726;5001.324821149244;5008.398992120969;4850.345203397496;4864.464908860094;4872.853814385574;4881.267809828554;4913.975430122827;4777.474477807508;5031.270465782368;5033.245013248042;5036.748162591929;5039.672421292605;4904.730239836843;4916.606671466346;4938.975305123451;4940.654154209171;4940.851774446773 10:33:53 INFO - PROCESS | 3402 | |5;yui.html;657.0768070860443;660.6003367962383;669.9531032827701;732.2933369298628;735.6763024269321;11541.249818761775;12007.759844803099;12025.398730063494;12068.155229133954;12073.758524829498;10481.528331225094;11733.413329333542;11845.111616628767;11857.347845868473;11878.287302761819;772.2624893226969;785.6386062411298;789.6288744290204;789.9565523896183;792.065362871811;791.4578513718121;793.1592511937365;794.7774623105539;795.9442839001272;795.9920400795976;819.9508029518248;821.6836517940576;822.5434883639577;824.5671022713094;824.5671022713094;810.5258423822071;810.667626273228;811.2698571285861;811.3063330852095;811.3265989228926;596.189182711512;597.1967703438868;597.2504506843883;597.3429227849331;597.3936454498687;10632.468376581217;10649.414282214553;10672.199585031154;10698.625548105856;10726.785464290671;10277.845832312447;10738.355698658106;10802.51388687511;11084.667459976214;11111.888881111247;9975.551100200508;10010.799784004352;10240.28318017739;10253.743656408575;10281.794364112677;3233.919152021195;3262.5758651375168;3296.3572103439838;3298.884539041122;3375.2911888503445;57672;57982.71008644972;58393.41606583922;58422.12366814501;59045;7750.341220996278;7788.844223115506;7848.293653571206;7850.725224617111;7928.4450088494405;15463.072215667096;15493.457728979656;15520.611984700472;15544.222788860512;15579.065256084445;6614.404703576702;6645.534812563074;6670.299618539983;6848.14398200225;6854.5201835872;3224.8548815303366;3249.220187155113;3252.7723059385617;3266.852991615383;3295.7692961492467;2676.3175390275746;2777.8194417362806;2778.0415756563953;2778.3887544740123;2781.777457803371;443.78476438927095;460.7673125071884;468.19470510721504;471.53318214966936;472.7848828782896;539.6627108057464;600.3366280260336;603.7464265008707;622.0327390907182;633.6071635585874;7722.45942784011;8073.596320183968;8179.345652347798;9078.319126065571;9381.577828997712;506.344284152024;523.5340546913251;553.2310088976326;571.8370264474605;625.5714835337808;3856.2865869814173;4028.234635419261;4050.7974601270407;4143.6892233082035;4310.374995625617;49576;50139;50146.24780628293;50381.49618503768;89169;82727.5863620678;85538;86373.56813215894;86450.13549864547;86539.56730216308;72911.63544182351;74488.62755686295;75859.24140758632;76083.23916760762;76449.617751912;7537.623118844145;7667.468564767783;7676.309132178131;7828.921710782819;7879;30622.540661889645;41840.16319673529;42300;42886;44610.77694611506;59839;65017.34982650302;65460.36349091311;65593;66579;9899.901000990187;10010.949945250228;10038.447885366375;10100.84848727255;10143.49282535885;11597.420128993685;11626.302421854716;11680;11800.173987821114;11807.350595717318;10585;10720.410377429316;10820.458977051274;10970.506327215135;11086.501107450345;10480.580776768844;10560;10596.258261921592;11017.11863050938;11230;10653.467326633792;10798.514066867167;10833.837492437777;10883.28154380977;11070.557177713123;8954.882924043559;9073.591688373906;9247.72256832296;9353.485558294358;9458.668946586837;8969.14793094655;9021.548922553977;9070.274378049871;9209.447433154031;9217.170454659114 10:33:53 INFO - PROCESS | 3402 | __end_tp_report 10:33:53 INFO - PROCESS | 3402 | __start_cc_report 10:33:53 INFO - PROCESS | 3402 | _x_x_mozilla_cycle_collect,1012 10:33:53 INFO - PROCESS | 3402 | __end_cc_report 10:33:53 INFO - PROCESS | 3402 | __startTimestamp1468258433758__endTimestamp 10:33:53 INFO - PROCESS | 3402 | 10:33:53 INFO - PROCESS | 3402 | ------- Summary: start ------- 10:33:53 INFO - PROCESS | 3402 | Number of tests: 6 10:33:53 INFO - PROCESS | 3402 | 10:33:53 INFO - PROCESS | 3402 | [#0] dojo.html Cycles:165 Average:4673.34 Median:4823.71 stddev:512.97 (10.6%) stddev-sans-first:489.26 10:33:53 INFO - PROCESS | 3402 | Values: 2645.6 2646.7 2687.5 2690.4 2691.9 4557.1 4679.4 4715.1 4806.1 4846.1 4652.1 4706.5 4726.8 4734.8 4734.9 4346.7 4365.8 4382.9 4393.8 4459.8 4394.0 4428.2 4435.5 4465.6 4493.5 4379.0 4407.9 4427.9 4433.9 4459.0 4260.6 4299.2 4329.8 4351.9 4358.4 4324.0 4349.1 4381.9 4396.5 4405.0 4827.9 4833.0 4836.0 4843.4 4863.1 4926.7 5043.0 5116.6 5131.9 5201.0 5174.7 5185.6 5190.3 5201.4 5214.5 4562.9 4782.3 4789.3 4823.5 4830.0 5207.6 5251.5 5262.8 5275.4 5344.5 5048.2 5063.7 5116.3 5118.7 5119.2 4929.6 5083.5 5155.7 5199.1 5207.7 5062.0 5083.1 5097.9 5100.5 5153.3 5067.4 5076.5 5079.2 5082.9 5131.7 4240.4 4251.9 4274.3 4408.2 4451.3 3742.5 3754.7 3765.6 3807.2 3825.3 3980.6 3988.8 4023.0 4025.6 4034.9 4817.3 4866.2 4940.8 4941.0 4960.9 4006.2 4033.1 4034.8 4075.9 4076.7 4425.3 4438.5 4455.2 4468.8 4493.2 4515.7 4690.6 4709.9 4741.8 4763.5 5017.7 5035.9 5041.1 5077.2 5082.7 4764.4 4769.2 4777.4 4780.7 4823.7 4817.6 4975.8 5008.1 5030.9 5070.8 5045.8 5063.7 5069.8 5073.1 5101.5 4938.8 4939.7 4940.1 4942.3 4969.9 4694.4 4894.4 4929.9 4937.1 4962.0 4839.1 4856.2 4856.8 4898.9 4902.8 4980.0 5014.2 5018.5 5019.8 5070.8 4697.3 4807.1 4843.0 4867.0 4877.6 10:33:53 INFO - PROCESS | 3402 | 10:33:53 INFO - PROCESS | 3402 | [#1] ext.html Cycles:180 Average:49432.00 Median:36492.95 stddev:92529.20 (253.6%) stddev-sans-first:92715.95 10:33:53 INFO - PROCESS | 3402 | Values: 537.8 587.6 595.3 596.8 602.2 26748.9 40123.4 40689.8 40697.6 40853.0 41103.0 41447.8 41483.2 41630.2 41661.0 7833.1 7949.7 7970.7 7975.7 7980.8 7849.8 7877.3 7931.9 7933.0 7936.1 7957.1 7986.7 7993.9 7995.7 8011.5 7953.1 7975.2 7976.3 7981.6 7993.2 7904.0 7936.4 7986.4 7988.0 7999.9 37811.4 38163.4 38175.4 38250.0 38253.0 2865.3 3141.8 3221.5 3227.3 3354.5 29208.0 29229.9 29334.7 29463.3 30044.7 3112.5 3120.1 3154.9 3160.0 3192.9 299640.0 304288.0 307639.0 413437.0 414888.9 53626.2 54475.7 54593.7 54597.5 54636.0 33052.2 33904.5 33978.7 58069.7 58403.4 13742.9 13998.2 13998.5 14005.4 14006.2 10033.1 10050.6 10073.6 10081.4 10084.0 18175.4 18183.5 18203.6 18224.7 18250.8 7041.9 7072.6 7106.6 7136.8 7149.7 801.1 873.8 879.1 883.0 886.3 25234.7 25347.0 25641.5 25652.9 25653.2 872.5 914.8 919.7 930.3 986.2 14452.7 15016.2 15022.2 15312.9 15340.2 382618.0 383046.0 384286.0 384863.0 385248.0 48796.5 49316.0 49346.8 49363.3 49428.0 1071.1 1122.2 1153.2 1171.7 1178.6 26211.3 28780.7 29117.3 29404.0 29636.6 40979.0 41307.6 41388.0 41419.6 41624.8 311047.0 311821.0 312814.0 313453.0 314120.0 22169.2 24506.5 24909.8 25310.7 25386.9 40756.2 41539.8 41994.6 42148.0 42400.0 35446.3 35651.8 36129.6 36175.6 36314.3 35990.8 36029.5 36261.6 36388.6 36597.3 34622.5 35365.0 35388.5 35582.6 35675.0 31280.7 32340.0 32996.2 32997.2 33035.0 24786.8 24816.4 25263.9 25491.6 25689.4 10:33:53 INFO - PROCESS | 3402 | 10:33:53 INFO - PROCESS | 3402 | [#2] jquery.html Cycles:180 Average:24252.56 Median:28151.64 stddev:61920.53 (220.0%) stddev-sans-first:62068.24 10:33:53 INFO - PROCESS | 3402 | Values: 355.3 360.9 362.9 368.9 372.5 16571.4 17302.8 18314.5 18322.1 18355.7 17173.6 17421.6 18021.7 18027.3 18029.6 4994.9 5150.5 5177.5 5201.2 5212.0 3781.1 3985.7 5149.3 5812.6 6077.2 6117.6 6140.3 6160.7 6195.0 6197.7 5865.2 6026.0 6029.0 6032.8 6041.7 3387.7 5049.4 5287.2 5315.5 5319.7 21610.9 21793.7 21818.2 21948.5 22218.8 2086.2 2189.2 2350.0 2392.4 2438.7 9480.7 11866.7 12894.7 13172.7 14372.5 1656.7 1658.6 1728.0 1757.9 1802.0 63017.0 69239.0 72884.6 72908.0 72991.3 9992.5 10048.4 10395.9 10407.9 10427.7 14130.3 14216.1 14218.9 14264.1 14266.2 6988.6 7212.4 7307.6 7368.2 7391.7 6853.7 6888.9 6992.3 7021.8 7054.2 4419.2 4425.0 4437.2 4497.2 4536.3 1703.1 1750.6 1782.2 1785.3 1832.6 733.1 791.6 822.1 842.4 905.2 16988.6 17313.7 17379.8 17860.6 18128.4 794.7 817.4 819.2 852.4 863.6 9350.5 9707.6 9926.6 9949.2 10158.8 367223.0 367295.0 377072.0 377424.0 377891.0 51154.0 60802.0 80452.0 89780.6 90553.0 926.9 944.1 955.4 971.1 972.1 12488.9 16731.5 17020.6 17066.1 17315.7 37289.8 39245.4 39862.4 40292.2 40430.0 58591.7 59032.4 59881.0 60237.7 60808.7 7405.2 7631.2 7665.5 7689.1 7919.1 7777.7 8458.5 8531.9 8584.0 12112.8 7289.5 7575.9 7774.1 7820.6 8132.3 7817.1 7936.2 7938.8 8035.8 8181.0 7559.7 7599.9 7940.0 8267.0 8284.0 11590.9 11679.4 11826.3 12041.9 12384.9 10777.5 11249.9 11307.2 11461.3 11537.5 10:33:53 INFO - PROCESS | 3402 | 10:33:53 INFO - PROCESS | 3402 | [#3] mootools.html Cycles:180 Average:4880.20 Median:5836.83 stddev:2640.27 (45.2%) stddev-sans-first:2634.38 10:33:53 INFO - PROCESS | 3402 | Values: 1353.3 1392.7 1443.5 1663.9 1702.1 7197.7 7590.2 7623.0 7701.8 7707.8 6335.4 6532.9 6544.2 6668.5 7555.0 2076.3 2167.6 2167.9 2187.9 2188.0 2200.0 2215.8 2229.4 2246.3 2246.6 1871.9 2108.5 2208.2 2211.9 2220.4 2146.8 2174.4 2175.8 2186.9 2187.6 2070.7 2085.4 2092.9 2109.7 2110.6 7367.1 7417.6 7440.1 7446.6 7447.0 4446.2 4479.9 4497.8 4511.6 4562.8 2733.3 2762.5 2785.1 2828.5 2843.4 858.5 870.1 886.2 901.4 902.0 9936.7 9937.7 9952.7 9953.0 9960.2 3825.8 4015.6 4194.5 4199.9 4206.4 8425.8 8440.6 8443.1 8456.4 8477.1 4430.1 4446.0 4452.3 4452.4 4455.1 3670.5 4030.7 4048.4 4048.9 4050.5 3424.9 3571.2 3574.7 3583.0 3639.4 1123.4 1172.6 1178.5 1180.7 1191.5 801.7 808.7 834.6 840.1 850.6 4994.2 5035.2 5065.5 5085.3 5094.6 835.0 881.0 888.8 892.6 894.1 3376.7 3492.5 3543.8 3547.4 3600.4 8609.9 8761.7 8896.5 8917.5 8921.4 8814.1 8820.8 8835.0 8841.3 8849.3 6899.1 6959.8 7031.6 7047.9 7050.8 4884.4 4906.7 4976.6 4991.1 5016.2 8154.3 8174.6 8432.5 8436.5 8475.5 8173.9 8611.1 8624.9 8626.3 8627.0 5769.7 6219.1 6442.5 6445.1 6448.6 6370.8 6538.3 6542.0 6547.9 6741.8 6155.1 6500.4 6609.4 6661.4 6839.4 6590.8 6639.0 6707.4 6715.5 6761.9 5904.0 5974.4 5977.9 5979.7 5996.0 4414.0 4506.4 4529.4 4561.8 4665.1 4540.5 4545.4 4575.5 4616.0 4636.3 10:33:53 INFO - PROCESS | 3402 | 10:33:53 INFO - PROCESS | 3402 | [#4] prototype.html Cycles:180 Average:4143.36 Median:4723.29 stddev:1189.44 (25.2%) stddev-sans-first:1157.25 10:33:53 INFO - PROCESS | 3402 | Values: 298.8 305.8 307.2 307.7 310.6 4878.8 4891.9 4893.3 4899.4 4916.2 4733.2 4771.9 4810.2 4867.8 4869.0 3841.6 3852.8 3881.3 3885.6 3917.1 3777.2 3805.8 3855.6 3912.5 3914.7 3752.3 3794.7 3816.0 3820.9 3825.2 3795.8 3798.9 3807.7 3810.9 3822.5 3177.8 3283.0 3388.3 3390.3 3422.1 4686.9 4699.1 4710.0 4711.6 4713.4 4356.4 4367.6 4370.2 4374.6 4375.5 4841.8 4876.7 5008.5 5043.9 5077.4 3689.1 3695.5 3710.2 3713.4 3721.8 5242.6 5248.2 5280.1 5301.1 5324.0 3626.5 3749.3 3755.8 3758.1 3779.9 3810.8 3831.2 3834.6 3836.5 3840.0 4343.5 4350.4 4352.7 4352.9 4358.7 4815.0 5016.0 5058.6 5121.3 5161.4 1356.8 1366.8 1368.5 1370.6 1373.8 879.2 899.7 904.6 917.1 919.9 3783.8 3792.6 3797.0 3803.8 3813.2 4562.4 4564.4 4576.5 4584.4 4611.9 3757.8 3767.8 3781.6 3814.6 3855.8 2329.6 2395.7 2415.3 2576.6 2655.6 4735.9 4764.9 4783.3 4784.4 4795.0 5269.1 5313.1 5319.4 5327.9 5350.7 4676.8 4839.7 4855.6 4855.6 4891.0 4951.5 4980.3 4988.4 5002.0 5012.9 5059.6 5061.4 5061.5 5076.4 5093.7 4742.0 4760.8 4852.9 4862.6 4879.7 3817.4 3836.2 3844.4 3849.6 3874.6 5184.5 5196.1 5207.9 5222.5 5233.5 4781.0 4977.8 5024.8 5025.4 5033.4 4934.6 4968.5 4989.6 5001.3 5008.4 4850.3 4864.5 4872.9 4881.3 4914.0 4777.5 5031.3 5033.2 5036.7 5039.7 4904.7 4916.6 4939.0 4940.7 4940.9 10:33:53 INFO - PROCESS | 3402 | 10:33:53 INFO - PROCESS | 3402 | [#5] yui.html Cycles:180 Average:15979.57 Median:562.53 stddev:22728.23 (4040.3%) stddev-sans-first:22762.87 10:33:53 INFO - PROCESS | 3402 | Values: 657.1 660.6 670.0 732.3 735.7 11541.2 12007.8 12025.4 12068.2 12073.8 10481.5 11733.4 11845.1 11857.3 11878.3 772.3 785.6 789.6 790.0 792.1 791.5 793.2 794.8 795.9 796.0 820.0 821.7 822.5 824.6 824.6 810.5 810.7 811.3 811.3 811.3 596.2 597.2 597.3 597.3 597.4 10632.5 10649.4 10672.2 10698.6 10726.8 10277.8 10738.4 10802.5 11084.7 11111.9 9975.6 10010.8 10240.3 10253.7 10281.8 3233.9 3262.6 3296.4 3298.9 3375.3 57672.0 57982.7 58393.4 58422.1 59045.0 7750.3 7788.8 7848.3 7850.7 7928.4 15463.1 15493.5 15520.6 15544.2 15579.1 6614.4 6645.5 6670.3 6848.1 6854.5 3224.9 3249.2 3252.8 3266.9 3295.8 2676.3 2777.8 2778.0 2778.4 2781.8 443.8 460.8 468.2 471.5 472.8 539.7 600.3 603.7 622.0 633.6 7722.5 8073.6 8179.3 9078.3 9381.6 506.3 523.5 553.2 571.8 625.6 3856.3 4028.2 4050.8 4143.7 4310.4 49576.0 50139.0 50146.2 50381.5 89169.0 82727.6 85538.0 86373.6 86450.1 86539.6 72911.6 74488.6 75859.2 76083.2 76449.6 7537.6 7667.5 7676.3 7828.9 7879.0 30622.5 41840.2 42300.0 42886.0 44610.8 59839.0 65017.3 65460.4 65593.0 66579.0 9899.9 10010.9 10038.4 10100.8 10143.5 11597.4 11626.3 11680.0 11800.2 11807.4 10585.0 10720.4 10820.5 10970.5 11086.5 10480.6 10560.0 10596.3 11017.1 11230.0 10653.5 10798.5 10833.8 10883.3 11070.6 8954.9 9073.6 9247.7 9353.5 9458.7 8969.1 9021.5 9070.3 9209.4 9217.2 10:33:53 INFO - PROCESS | 3402 | -------- Summary: end -------- 10:33:53 INFO - PROCESS | 3402 | 10:33:54 INFO - TEST-INFO | 3402: exit 0 10:33:54 INFO - TEST-OK | dromaeo_css | took 1123647ms 10:33:54 INFO - TEST-START | kraken 10:33:54 INFO - operating with platform_type : linux_ 10:33:54 INFO - Initialising browser for kraken test... 10:33:54 INFO - TEST-INFO | started process 3595 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpibL4Gx/profile http://localhost:37843/getInfo.html) 10:33:59 INFO - PROCESS | 3595 | __metrics Screen width/height:1600/1200 10:33:59 INFO - PROCESS | 3595 | colorDepth:24 10:33:59 INFO - PROCESS | 3595 | Browser inner width/height: 1024/697 10:33:59 INFO - PROCESS | 3595 | __metrics 10:34:00 INFO - PROCESS | 3595 | 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" 10:34:00 INFO - PROCESS | 3595 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:34:01 INFO - TEST-INFO | 3595: exit 0 10:34:01 INFO - Browser initialized. 10:34:01 INFO - Running cycle 1/1 for kraken test... 10:34:01 INFO - TEST-INFO | started process 3677 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpibL4Gx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:13 INFO - PROCESS | 3677 | RSS: Main: 159600640 10:34:13 INFO - PROCESS | 3677 | 10:34:15 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37843/tests/kraken/driver.html?testName=audio-beat-detection) 10:34:16 INFO - PROCESS | 3677 | RSS: Main: 217264128 10:34:16 INFO - PROCESS | 3677 | 10:34:19 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37843/tests/kraken/driver.html?testName=audio-dft) 10:34:19 INFO - PROCESS | 3677 | RSS: Main: 203812864 10:34:19 INFO - PROCESS | 3677 | 10:34:23 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37843/tests/kraken/driver.html?testName=audio-fft) 10:34:23 INFO - PROCESS | 3677 | RSS: Main: 271179776 10:34:23 INFO - PROCESS | 3677 | 10:34:25 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37843/tests/kraken/driver.html?testName=audio-oscillator) 10:34:26 INFO - PROCESS | 3677 | RSS: Main: 181268480 10:34:26 INFO - PROCESS | 3677 | 10:34:28 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37843/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:34:29 INFO - PROCESS | 3677 | RSS: Main: 185638912 10:34:29 INFO - PROCESS | 3677 | 10:34:32 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37843/tests/kraken/driver.html?testName=imaging-darkroom) 10:34:33 INFO - PROCESS | 3677 | RSS: Main: 221757440 10:34:33 INFO - PROCESS | 3677 | 10:34:36 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37843/tests/kraken/driver.html?testName=imaging-desaturate) 10:34:37 INFO - PROCESS | 3677 | RSS: Main: 217808896 10:34:37 INFO - PROCESS | 3677 | 10:34:40 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37843/tests/kraken/driver.html?testName=json-parse-financial) 10:34:40 INFO - PROCESS | 3677 | RSS: Main: 220323840 10:34:40 INFO - PROCESS | 3677 | 10:34:42 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37843/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:34:43 INFO - PROCESS | 3677 | RSS: Main: 206929920 10:34:43 INFO - PROCESS | 3677 | 10:34:45 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:34:45 INFO - PROCESS | 3677 | RSS: Main: 213241856 10:34:45 INFO - PROCESS | 3677 | 10:34:47 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:34:48 INFO - PROCESS | 3677 | RSS: Main: 211316736 10:34:48 INFO - PROCESS | 3677 | 10:34:51 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:34:51 INFO - PROCESS | 3677 | RSS: Main: 224804864 10:34:51 INFO - PROCESS | 3677 | 10:34:54 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:34:55 INFO - PROCESS | 3677 | RSS: Main: 224534528 10:34:55 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | Cycle 1(1): loaded http://localhost:37843/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37843/tests/kraken/driver.html?testName=ai-astar) 10:34:57 INFO - PROCESS | 3677 | RSS: Main: 267038720 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | __start_tp_report 10:34:57 INFO - PROCESS | 3677 | _x_x_mozilla_page_load 10:34:57 INFO - PROCESS | 3677 | _x_x_mozilla_page_load_details 10:34:57 INFO - PROCESS | 3677 | |i|pagename|runs| 10:34:57 INFO - PROCESS | 3677 | |0;ai-astar;105;115;114;113;114;115;116;114;114;115 10:34:57 INFO - PROCESS | 3677 | |1;audio-beat-detection;146;122;122;169;125;125;146;124;191;124 10:34:57 INFO - PROCESS | 3677 | |2;audio-dft;162;162;162;161;162;162;162;162;162;172 10:34:57 INFO - PROCESS | 3677 | |3;audio-fft;75;75;76;121;76;75;75;75;103;75 10:34:57 INFO - PROCESS | 3677 | |4;audio-oscillator;85;85;122;84;85;86;127;85;85;129 10:34:57 INFO - PROCESS | 3677 | |5;imaging-gaussian-blur;116;117;117;117;118;118;118;118;117;116 10:34:57 INFO - PROCESS | 3677 | |6;imaging-darkroom;146;147;147;146;147;147;146;145;146;146 10:34:57 INFO - PROCESS | 3677 | |7;imaging-desaturate;95;95;95;95;95;94;95;94;95;94 10:34:57 INFO - PROCESS | 3677 | |8;json-parse-financial;63;63;63;63;63;63;63;63;63;64 10:34:57 INFO - PROCESS | 3677 | |9;json-stringify-tinderbox;65;64;64;64;65;65;65;65;65;65 10:34:57 INFO - PROCESS | 3677 | |10;stanford-crypto-aes;79;81;78;78;79;85;82;78;86;90 10:34:57 INFO - PROCESS | 3677 | |11;stanford-crypto-ccm;129;132;128;131;126;125;128;131;164;144 10:34:57 INFO - PROCESS | 3677 | |12;stanford-crypto-pbkdf2;167;166;165;166;166;171;167;164;164;166 10:34:57 INFO - PROCESS | 3677 | |13;stanford-crypto-sha256-iterative;67;66;67;67;65;66;66;67;65;67 10:34:57 INFO - PROCESS | 3677 | __end_tp_report 10:34:57 INFO - PROCESS | 3677 | __start_cc_report 10:34:57 INFO - PROCESS | 3677 | _x_x_mozilla_cycle_collect,1909 10:34:57 INFO - PROCESS | 3677 | __end_cc_report 10:34:57 INFO - PROCESS | 3677 | __startTimestamp1468258497359__endTimestamp 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | ------- Summary: start ------- 10:34:57 INFO - PROCESS | 3677 | Number of tests: 14 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.50 stddev:3.10 (2.7%) stddev-sans-first:0.88 10:34:57 INFO - PROCESS | 3677 | Values: 105.0 115.0 114.0 113.0 114.0 115.0 116.0 114.0 114.0 115.0 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:135.50 stddev:23.85 (17.6%) stddev-sans-first:25.18 10:34:57 INFO - PROCESS | 3677 | Values: 146.0 122.0 122.0 169.0 125.0 125.0 146.0 124.0 191.0 124.0 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#2] audio-dft Cycles:10 Average:162.90 Median:162.00 stddev:3.21 (2.0%) stddev-sans-first:3.39 10:34:57 INFO - PROCESS | 3677 | Values: 162.0 162.0 162.0 161.0 162.0 162.0 162.0 162.0 162.0 172.0 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.00 stddev:16.07 (21.4%) stddev-sans-first:16.81 10:34:57 INFO - PROCESS | 3677 | Values: 75.0 75.0 76.0 121.0 76.0 75.0 75.0 75.0 103.0 75.0 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#4] audio-oscillator Cycles:10 Average:97.30 Median:85.00 stddev:19.88 (23.4%) stddev-sans-first:20.59 10:34:57 INFO - PROCESS | 3677 | Values: 85.0 85.0 122.0 84.0 85.0 86.0 127.0 85.0 85.0 129.0 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:0.79 (0.7%) stddev-sans-first:0.71 10:34:57 INFO - PROCESS | 3677 | Values: 116.0 117.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 116.0 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 10:34:57 INFO - PROCESS | 3677 | Values: 146.0 147.0 147.0 146.0 147.0 147.0 146.0 145.0 146.0 146.0 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 10:34:57 INFO - PROCESS | 3677 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 95.0 94.0 95.0 94.0 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#8] json-parse-financial Cycles:10 Average:63.10 Median:63.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 10:34:57 INFO - PROCESS | 3677 | Values: 63.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 63.0 64.0 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 10:34:57 INFO - PROCESS | 3677 | Values: 65.0 64.0 64.0 64.0 65.0 65.0 65.0 65.0 65.0 65.0 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:81.50 stddev:4.14 (5.1%) stddev-sans-first:4.28 10:34:57 INFO - PROCESS | 3677 | Values: 79.0 81.0 78.0 78.0 79.0 85.0 82.0 78.0 86.0 90.0 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#11] stanford-crypto-ccm Cycles:10 Average:133.80 Median:131.00 stddev:11.85 (9.0%) stddev-sans-first:12.44 10:34:57 INFO - PROCESS | 3677 | Values: 129.0 132.0 128.0 131.0 126.0 125.0 128.0 131.0 164.0 144.0 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:166.00 stddev:1.99 (1.2%) stddev-sans-first:2.09 10:34:57 INFO - PROCESS | 3677 | Values: 167.0 166.0 165.0 166.0 166.0 171.0 167.0 164.0 164.0 166.0 10:34:57 INFO - PROCESS | 3677 | 10:34:57 INFO - PROCESS | 3677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 10:34:57 INFO - PROCESS | 3677 | Values: 67.0 66.0 67.0 67.0 65.0 66.0 66.0 67.0 65.0 67.0 10:34:57 INFO - PROCESS | 3677 | -------- Summary: end -------- 10:34:57 INFO - PROCESS | 3677 | 10:34:58 INFO - TEST-INFO | 3677: exit 0 10:34:58 INFO - TEST-OK | kraken | took 63864ms 10:34:58 INFO - SUITE-END | took 1187s 10:34:58 INFO - Completed test suite (00:19:47) 10:34:58 INFO - javascript benchmark 10:34:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2645.629611854342, 2646.6956300025495, 2687.4893770183676, 2690.4350086481836, 2691.905783297585, 4557.111363284161, 4679.415073115861, 4715.127701375243, 4806.134895718765, 4846.12769701454, 4652.139354219472, 4706.505816889228, 4726.787294571744, 4734.7869345879435, 4734.90530189396, 4346.695731298811, 4365.759883206422, 4382.868513944587, 4393.7803109844535, 4459.799309031086, 4393.978030109845, 4428.1807865544815, 4435.534268901767, 4465.553444655541, 4493.46078470584, 4378.970941828699, 4407.933880991788, 4427.88930276744, 4433.9113217735785, 4458.996725736716, 4260.637845783112, 4299.247631664446, 4329.826806927719, 4351.891202719926, 4358.411614432074, 4323.978380108111, 4349.064951035511, 4381.934270985906, 4396.450443694538, 4404.96483326418, 4827.879303017417, 4833.0, 4835.975820120912, 4843.4430040545085, 4863.148948933923, 4926.679765815211, 5043.041822053798, 5116.590672746172, 5131.948680513185, 5201.037808005531, 5174.689518628857, 5185.61107916904, 5190.273361729361, 5201.375834899798, 5214.45248248936, 4562.88592785183, 4782.258749893772, 4789.30555069513, 4823.493533179001, 4829.975850120797, 5207.635465517377, 5251.501107394792, 5262.815801446931, 5275.366955965309, 5344.518993290622, 5048.242763585492, 5063.721495317793, 5116.258142569307, 5118.744062796845, 5119.1553393690365, 4929.556339929423, 5083.542481176712, 5155.664881782672, 5199.064168449715, 5207.6875387476875, 5061.974690126526, 5083.085044691991, 5097.923531147036, 5100.464451232567, 5153.304303918998, 5067.442581316052, 5076.543111119943, 5079.238114282887, 5082.872928176826, 5131.7434128293435, 4240.363945408213, 4251.914961700749, 4274.316109422478, 4408.184485870124, 4451.287793952952, 3742.5134732484603, 3754.680852127545, 3765.6234376562675, 3807.2385522895534, 3825.3496905526126, 3980.6218409251073, 3988.8404463821703, 4023.0, 4025.5571887092397, 4034.919301613951, 4817.301491283744, 4866.197077482176, 4940.777665005084, 4940.975295123501, 4960.851174464772, 4006.1787333596544, 4033.1127152026506, 4034.8386064557676, 4075.919881231476, 4076.7146299759324, 4425.3140763181755, 4438.533953934791, 4455.1757924784015, 4468.843590474317, 4493.236149854532, 4515.729056256635, 4690.648201384842, 4709.858704238878, 4741.810327586858, 4763.54746299101, 5017.67385119966, 5035.899282014412, 5041.117804384291, 5077.187649976134, 5082.695038297714, 4764.404449443819, 4769.236922092448, 4777.402824646919, 4780.68925519854, 4823.710577365369, 4817.590504806991, 4975.776090076028, 5008.073506401327, 5030.9245361320345, 5070.8225212117395, 5045.798168073383, 5063.670861393997, 5069.847904562869, 5073.086844367902, 5101.515356041318, 4938.777755001105, 4939.678920870132, 4940.061388336205, 4942.28336891156, 4969.850904472727, 4694.413198350207, 4894.412670479565, 4929.852104436873, 4937.086638971658, 4961.975190124026, 4839.104765618372, 4856.1987272099705, 4856.78144483492, 4898.853034408973, 4902.754862256944, 4979.975100124476, 5014.222795466709, 5018.473060328759, 5019.799208031638, 5070.847874563769, 4697.342372067845, 4807.110684523374, 4843.0313937211995, 4866.975665121652, 4877.634177436636], "value": 4639.934041948407, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.7680783078721, 587.6356658871499, 595.2975488923071, 596.8239369386031, 602.1900543768633, 26748.93004279829, 40123.39814902779, 40689.79655101728, 40697.59302406975, 40852.978675533086, 41103.0, 41447.79276103623, 41483.17033659325, 41630.16739665213, 41661.0, 7833.060032796073, 7949.721759738411, 7970.721024764134, 7975.7208497702595, 7980.76298173784, 7849.843003139934, 7877.330426913719, 7931.881021784678, 7932.960335198316, 7936.127026027132, 7957.124716281204, 7986.6805327786815, 7993.920060799404, 7995.720149794758, 8011.479253848511, 7953.085395179542, 7975.202479751978, 7976.282134607914, 7981.561014144219, 7993.240642138988, 7903.960480197619, 7936.4047696423, 7986.361091112697, 7987.960060199662, 7999.920000800034, 37811.4328285076, 38163.42754858679, 38175.427368589495, 38250.0, 38253.0436739081, 2865.2981115533466, 3141.8114913105287, 3221.4523530999554, 3227.289996200832, 3354.4569498030937, 29208.0, 29229.853850730822, 29334.70665293341, 29463.263418414495, 30044.699553004626, 3112.4553203189353, 3120.063980805749, 3154.8895788647287, 3160.0361889623655, 3192.9361412771846, 299640.0, 304288.0, 307639.0, 413437.0, 414888.9255553733, 53626.19560706592, 54475.72762136164, 54593.727031365386, 54597.45402546003, 54636.0, 33052.1736956578, 33904.49143262853, 33978.66021339804, 58069.70965145147, 58403.4159658398, 13742.869855172265, 13998.160110393408, 13998.51005214833, 14005.439782408794, 14006.159630422208, 10033.14718248957, 10050.64822731201, 10073.647422340184, 10081.445520496296, 10084.0, 18175.36386226502, 18183.45449636513, 18203.63592728138, 18224.726629100573, 18250.817491824913, 7041.929580704127, 7072.575645461289, 7106.644667766591, 7136.750213742494, 7149.677309697722, 801.1427772283718, 873.7902903303288, 879.147227189625, 882.955852207387, 886.3485338276362, 25234.74765252324, 25347.0, 25641.48717025649, 25652.8717356412, 25653.23040308794, 872.4852337121002, 914.8124634449922, 919.6781126605769, 930.3394589841154, 986.1716158426956, 14452.710945781026, 15016.24918754058, 15022.24888755558, 15312.923435382974, 15340.232988350537, 382618.0, 383046.0, 384286.0, 384863.0, 385248.0, 48796.5120348792, 49316.0, 49346.75326623344, 49363.25955110676, 49428.0, 1071.1377341240377, 1122.1639878290725, 1153.2388623508612, 1171.7480741640588, 1178.5580407347245, 26211.344716382242, 28780.712192877803, 29117.272068198465, 29404.043316992083, 29636.555451668675, 40979.0, 41307.58692413037, 41388.0, 41419.58580414157, 41624.79187604043, 311047.0, 311821.0, 312814.0, 313453.0, 314120.0, 22169.22407715722, 24506.50986980286, 24909.750902490745, 25310.74689253084, 25386.873065634554, 40756.18487630171, 41539.7923010383, 41994.58005420029, 42148.0, 42400.0, 35446.29107417889, 35651.82174089113, 36129.638703612625, 36175.63824361723, 36314.273714525036, 35990.8200458996, 36029.45955810612, 36261.63738362583, 36388.636113639586, 36597.26805463929, 34622.480662789574, 35365.0, 35388.46917296191, 35582.64417355897, 35675.0, 31280.68719312778, 32340.0, 32996.17509562184, 32997.17507062342, 33035.0, 24786.752132478443, 24816.379590510383, 25263.87368063148, 25491.617625735256, 25689.35776605525], "value": 17404.97153142802, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.2894211576846, 360.8736942070277, 362.9419292913134, 368.8506155007223, 372.5436340482907, 16571.420000299993, 17302.82697173028, 18314.450566482992, 18322.083895805223, 18355.724664130048, 17173.570660733487, 17421.564460888483, 18021.729674054866, 18027.27890884363, 18029.63940721185, 4994.875128121808, 5150.459201783815, 5177.48225177483, 5201.167813149897, 5212.0, 3781.092537790938, 3985.7010724195657, 5149.279100925854, 5812.564057695668, 6077.179580756608, 6117.5717699761035, 6140.293866205398, 6160.722767475474, 6194.96902515489, 6197.659128747917, 5865.237519122508, 6026.0, 6029.035354343306, 6032.788852390146, 6041.667708276043, 3387.6781705737917, 5049.419316778581, 5287.154055351164, 5315.548178404841, 5319.654222475566, 21610.89194554017, 21793.67309490359, 21818.236361727264, 21948.45128871775, 22218.777812221833, 2086.2405805191224, 2189.211883721859, 2350.048230466664, 2392.413858604653, 2438.719547252071, 9480.715578532587, 11866.703332416759, 12894.742105157939, 13172.670683232996, 14372.496962606363, 1656.685229806333, 1658.5687721192576, 1728.0236666283636, 1757.9472615821546, 1801.9819801801946, 63017.0, 69239.0, 72884.6355768223, 72908.0, 72991.27008729898, 9992.500374981222, 10048.447335396624, 10395.94802026, 10407.895921040692, 10427.739306517245, 14130.293485325692, 14216.075955062888, 14218.85781142196, 14264.144151350953, 14266.215358155194, 6988.580685158907, 7212.3869471094495, 7307.561546307238, 7368.226336234618, 7391.741289054858, 6853.725850966005, 6888.862222755617, 6992.2658120897595, 7021.789346319619, 7054.188768291712, 4419.226635338803, 4424.955750442518, 4437.245668236343, 4497.190505708938, 4536.319552067151, 1703.0973584000499, 1750.571110078039, 1782.1801971093182, 1785.2501949181376, 1832.569346203641, 733.0543598757649, 791.5962858941866, 822.116225058065, 842.4103127810557, 905.248643625789, 16988.589975905456, 17313.653726925644, 17379.826201738073, 17860.55348616295, 18128.365507207185, 794.682127149145, 817.3747083481142, 819.2053707903324, 852.4033176776281, 863.6459051788736, 9350.485723285285, 9707.563159657833, 9926.602935882484, 9949.154321882575, 10158.847617285746, 367223.0, 367295.0, 377072.0, 377424.0, 377891.0, 51154.0, 60802.0, 80452.0, 89780.5510972441, 90553.0, 926.8656044873455, 944.1172503709054, 955.3551352836807, 971.0726256425097, 972.0619602084023, 12488.937555312164, 16731.49805505788, 17020.574485637957, 17066.14669266507, 17315.7402638958, 37289.81355093207, 39245.41131882967, 39862.40206396965, 40292.1941561173, 40430.0, 58591.70704146452, 59032.409675902694, 59881.0, 60237.69881150566, 60808.695956519936, 7405.2224516425, 7631.236876312324, 7665.501742386727, 7689.115751688628, 7919.12889582157, 7777.72777952769, 8458.53478058688, 8531.914680853111, 8584.0, 12112.757744844877, 7289.489735718661, 7575.886361704469, 7774.067111946602, 7820.648070836713, 8132.2680958714, 7817.140114587277, 7936.206379362017, 7938.801529961797, 8035.758927232192, 8180.977377827771, 7559.697612095454, 7599.886001709868, 7940.0471943367165, 8266.958665206635, 8283.95858020706, 11590.88409115898, 11679.357635330138, 11826.34955077479, 12041.939790300992, 12384.876151238732, 10777.541887191053, 11249.943750281196, 11307.208495405243, 11461.255018423775, 11537.480813363587], "value": 8304.370991697717, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.3098119958818, 1392.6518370407398, 1443.4731323067083, 1663.8585720213782, 1702.089382180533, 7197.71209151634, 7590.240975902407, 7623.047119110111, 7701.807454813626, 7707.845843083135, 6335.398137176972, 6532.902006469895, 6544.214694236698, 6668.466522678174, 7555.017847679807, 2076.2836821296664, 2167.5773224221284, 2167.880766557839, 2187.9015444304964, 2188.0, 2200.0, 2215.8448908576406, 2229.409206560255, 2246.292417888368, 2246.550689862026, 1871.9438416847515, 2108.4834215617198, 2208.1719355241785, 2211.8783466909313, 2220.378294077661, 2146.785321467856, 2174.4455163933253, 2175.8476906616543, 2186.9234576789895, 2187.58435897179, 2070.710100585919, 2085.384811480617, 2092.9476763081043, 2109.683547467877, 2110.567333696604, 7367.079115110611, 7417.5549467031615, 7440.069991251094, 7446.627668616602, 7447.0, 4446.155230506193, 4479.888002799924, 4497.820087196541, 4511.6165125964335, 4562.8364766984205, 2733.3439974406197, 2762.5303698371326, 2785.1087651951384, 2828.5191517442086, 2843.4170994945985, 858.4548811504677, 870.0777176193255, 886.1537231943479, 901.4095767272447, 901.9594118264694, 9936.652217172365, 9937.70186894387, 9952.701418957442, 9953.0, 9960.203183745356, 3825.827837747308, 4015.5984401560195, 4194.517630472474, 4199.853005144805, 4206.369044643328, 8425.789355266168, 8440.62017209227, 8443.113473085361, 8456.40805143634, 8477.109903460048, 4430.13612345596, 4446.044100518404, 4452.30989196675, 4452.354408610733, 4455.086707225076, 3670.522832031819, 4030.6573941215324, 4048.352263637804, 4048.8785336439955, 4050.4734384529825, 3424.931501369959, 3571.1786289153642, 3574.6782789549065, 3582.9967609069504, 3639.3994990826745, 1123.4495097402378, 1172.5778719660916, 1178.4932479033926, 1180.6517077461997, 1191.5293459083614, 801.6512816924657, 808.706712661651, 834.5618550261162, 840.0675250471971, 850.5747126436781, 4994.200927851599, 5035.16919708244, 5065.468125846733, 5085.338905942203, 5094.592432605383, 834.983300334002, 880.9515476648846, 888.7733627924838, 892.5894088719132, 894.0701670262983, 3376.69609735125, 3492.4935884296633, 3543.805090720035, 3547.379208638478, 3600.369935261319, 8609.91390086091, 8761.693340733043, 8896.510691912006, 8917.509536975398, 8921.375503714808, 8814.074522175208, 8820.779480513038, 8834.95582522096, 8841.336899732545, 8849.292056635453, 6899.103116594811, 6959.791206263821, 7031.613261270679, 7047.859042819115, 7050.823729406806, 4884.389451318585, 4906.705597664151, 4976.576990955809, 4991.101601711727, 5016.172331565251, 8154.347652187929, 8174.591270436335, 8432.45189062709, 8436.493810371398, 8475.533845638549, 8173.877391839008, 8611.13888611134, 8624.913750862412, 8626.309895208493, 8627.0, 5769.653820770767, 6219.0982307564245, 6442.484601231984, 6445.129907462432, 6448.613083215022, 6370.8088757337355, 6538.280789113289, 6542.0, 6547.934520654923, 6741.764038258833, 6155.1382806406245, 6500.414962653384, 6609.441634925263, 6661.4337781287195, 6839.384455399038, 6590.7693230736695, 6639.0, 6707.3628005339415, 6715.5299129060495, 6761.864762704817, 5904.0, 5974.37269086757, 5977.940220597912, 5979.730912109053, 5996.0, 4413.977930110329, 4506.41416615851, 4529.433820772403, 4561.794719237709, 4665.136949664323, 4540.545945405433, 4545.363649089064, 4575.450945886515, 4615.953840461552, 4636.281376386665], "value": 3984.7205299811662, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.8296670897589, 305.79664523092146, 307.24724425158365, 307.6646455363653, 310.63500387045224, 4878.829240976566, 4891.902161956758, 4893.287349427703, 4899.43656479505, 4916.164252077147, 4733.1601039376355, 4771.8807029824275, 4810.206315957863, 4867.805287788484, 4868.951310486894, 3841.635044670759, 3852.8266228019666, 3881.340172170738, 3885.572587015426, 3917.138229589486, 3777.172695640927, 3805.847766089353, 3855.57588665248, 3912.471816304805, 3914.7063970202207, 3752.3245815753153, 3794.7153963452715, 3815.961840381602, 3820.866269680562, 3825.234953009395, 3795.7722536647752, 3798.8670396536263, 3807.6573108420375, 3810.90472738181, 3822.541295044585, 3177.809331440121, 3283.0, 3388.3232246525217, 3390.338883917637, 3422.058933793202, 4686.859394218179, 4699.130660827724, 4709.9764501177615, 4711.599514041311, 4713.410823647044, 4356.43366362374, 4367.563243675639, 4370.191514569815, 4374.606285434326, 4375.496817865923, 4841.830535931225, 4876.683015603974, 5008.474110218447, 5043.899122017539, 5077.365329333833, 3689.0777305673582, 3695.4641576971458, 3710.1837595729166, 3713.350163721365, 3721.79530125843, 5242.580593552545, 5248.160294352885, 5280.125555427845, 5301.072312345363, 5324.0, 3626.5285512883156, 3749.3063783200196, 3755.8122093895195, 3758.0980564664283, 3779.905502362463, 3810.8278281379903, 3831.1762970961377, 3834.5973672764517, 3836.48207491985, 3839.9616003839606, 4343.457067866517, 4350.434443522385, 4352.717073390219, 4352.868254253854, 4358.65130789536, 4814.9518504814505, 5016.0, 5058.595312375001, 5121.308623335876, 5161.406438259648, 1356.8236129303127, 1366.781314989597, 1368.50733735855, 1370.5545697648304, 1373.8420081690733, 879.2350654930252, 899.7030979776658, 904.6064961741663, 917.1333090229668, 919.8988111307751, 3783.791891445942, 3792.62960649594, 3796.981015094907, 3803.8478460861256, 3813.1801662642665, 4562.448767419093, 4564.406627138517, 4576.519465456146, 4584.386899467272, 4611.930821037688, 3757.759939220051, 3767.773933563995, 3781.619708806321, 3814.6185381461632, 3855.845766169322, 2329.590597688408, 2395.7125144982715, 2415.2972154630943, 2576.6392705021312, 2655.614935834293, 4735.881602959885, 4764.904701906012, 4783.258594917794, 4784.354112194878, 4795.0, 5269.077911365495, 5313.149896016619, 5319.441458646864, 5327.866803329948, 5350.705711185844, 4676.766161691902, 4839.708997881404, 4855.562999330006, 4855.562999330077, 4891.0, 4951.480094590161, 4980.252962055576, 4988.376452943382, 5002.024605202097, 5012.922221722347, 5059.571405725346, 5061.367329083864, 5061.519155680205, 5076.441591424867, 5093.745312734274, 4742.0, 4760.818464040894, 4852.927206091841, 4862.562369386772, 4879.658423910434, 3817.4273858921383, 3836.194399176204, 3844.38489841624, 3849.6150384962402, 3874.573796882284, 5184.533391994739, 5196.116660167705, 5207.869803254797, 5222.451642577626, 5233.450487698737, 4780.95219047805, 4977.800887964441, 5024.824131155538, 5025.422076461107, 5033.395992480926, 4934.55588996992, 4968.453470118357, 4989.575886049726, 5001.324821149244, 5008.398992120969, 4850.345203397496, 4864.464908860094, 4872.853814385574, 4881.267809828554, 4913.975430122827, 4777.474477807508, 5031.270465782368, 5033.245013248042, 5036.748162591929, 5039.672421292605, 4904.730239836843, 4916.606671466346, 4938.975305123451, 4940.654154209171, 4940.851774446773], "value": 3774.2070157758903, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [657.0768070860443, 660.6003367962383, 669.9531032827701, 732.2933369298628, 735.6763024269321, 11541.249818761775, 12007.759844803099, 12025.398730063494, 12068.155229133954, 12073.758524829498, 10481.528331225094, 11733.413329333542, 11845.111616628767, 11857.347845868473, 11878.287302761819, 772.2624893226969, 785.6386062411298, 789.6288744290204, 789.9565523896183, 792.065362871811, 791.4578513718121, 793.1592511937365, 794.7774623105539, 795.9442839001272, 795.9920400795976, 819.9508029518248, 821.6836517940576, 822.5434883639577, 824.5671022713094, 824.5671022713094, 810.5258423822071, 810.667626273228, 811.2698571285861, 811.3063330852095, 811.3265989228926, 596.189182711512, 597.1967703438868, 597.2504506843883, 597.3429227849331, 597.3936454498687, 10632.468376581217, 10649.414282214553, 10672.199585031154, 10698.625548105856, 10726.785464290671, 10277.845832312447, 10738.355698658106, 10802.51388687511, 11084.667459976214, 11111.888881111247, 9975.551100200508, 10010.799784004352, 10240.28318017739, 10253.743656408575, 10281.794364112677, 3233.919152021195, 3262.5758651375168, 3296.3572103439838, 3298.884539041122, 3375.2911888503445, 57672.0, 57982.71008644972, 58393.41606583922, 58422.12366814501, 59045.0, 7750.341220996278, 7788.844223115506, 7848.293653571206, 7850.725224617111, 7928.4450088494405, 15463.072215667096, 15493.457728979656, 15520.611984700472, 15544.222788860512, 15579.065256084445, 6614.404703576702, 6645.534812563074, 6670.299618539983, 6848.14398200225, 6854.5201835872, 3224.8548815303366, 3249.220187155113, 3252.7723059385617, 3266.852991615383, 3295.7692961492467, 2676.3175390275746, 2777.8194417362806, 2778.0415756563953, 2778.3887544740123, 2781.777457803371, 443.78476438927095, 460.7673125071884, 468.19470510721504, 471.53318214966936, 472.7848828782896, 539.6627108057464, 600.3366280260336, 603.7464265008707, 622.0327390907182, 633.6071635585874, 7722.45942784011, 8073.596320183968, 8179.345652347798, 9078.319126065571, 9381.577828997712, 506.344284152024, 523.5340546913251, 553.2310088976326, 571.8370264474605, 625.5714835337808, 3856.2865869814173, 4028.234635419261, 4050.7974601270407, 4143.6892233082035, 4310.374995625617, 49576.0, 50139.0, 50146.24780628293, 50381.49618503768, 89169.0, 82727.5863620678, 85538.0, 86373.56813215894, 86450.13549864547, 86539.56730216308, 72911.63544182351, 74488.62755686295, 75859.24140758632, 76083.23916760762, 76449.617751912, 7537.623118844145, 7667.468564767783, 7676.309132178131, 7828.921710782819, 7879.0, 30622.540661889645, 41840.16319673529, 42300.0, 42886.0, 44610.77694611506, 59839.0, 65017.34982650302, 65460.36349091311, 65593.0, 66579.0, 9899.901000990187, 10010.949945250228, 10038.447885366375, 10100.84848727255, 10143.49282535885, 11597.420128993685, 11626.302421854716, 11680.0, 11800.173987821114, 11807.350595717318, 10585.0, 10720.410377429316, 10820.458977051274, 10970.506327215135, 11086.501107450345, 10480.580776768844, 10560.0, 10596.258261921592, 11017.11863050938, 11230.0, 10653.467326633792, 10798.514066867167, 10833.837492437777, 10883.28154380977, 11070.557177713123, 8954.882924043559, 9073.591688373906, 9247.72256832296, 9353.485558294358, 9458.668946586837, 8969.14793094655, 9021.548922553977, 9070.274378049871, 9209.447433154031, 9217.170454659114], "value": 6109.904028650367, "unit": "score"}], "name": "dromaeo_css", "value": 6284.926472015568, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 113.0, 114.0, 115.0, 116.0, 114.0, 114.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 122.0, 122.0, 169.0, 125.0, 125.0, 146.0, 124.0, 191.0, 124.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 161.0, 162.0, 162.0, 162.0, 162.0, 162.0, 172.0], "value": 162.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 121.0, 76.0, 75.0, 75.0, 75.0, 103.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 122.0, 84.0, 85.0, 86.0, 127.0, 85.0, 85.0, 129.0], "value": 97.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 116.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 145.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 63.0, 64.0], "value": 63.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 81.0, 78.0, 78.0, 79.0, 85.0, 82.0, 78.0, 86.0, 90.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 132.0, 128.0, 131.0, 126.0, 125.0, 128.0, 131.0, 164.0, 144.0], "value": 133.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 166.0, 165.0, 166.0, 166.0, 171.0, 167.0, 164.0, 164.0, 166.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 67.0, 65.0, 66.0, 66.0, 67.0, 65.0, 67.0], "value": 66.3, "unit": "score"}], "name": "kraken", "value": 1529.6, "alertThreshold": 2.0}]} 10:34:58 INFO - Return code: 0 10:34:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:34:58 INFO - # TBPL SUCCESS # 10:34:58 INFO - Running post-action listener: _resource_record_post_action 10:34:58 INFO - ##### 10:34:58 INFO - ##### Finished run-tests step (success) 10:34:58 INFO - ##### 10:34:58 INFO - Running post-run listener: _resource_record_post_run 10:34:58 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 7802880; Write bytes: 289447936; Read time: 1464; Write time: 323644 10:34:58 INFO - TinderboxPrint: CPU usage
13.0% 10:34:58 INFO - TinderboxPrint: I/O read bytes / time
7,802,880 / 1,464 10:34:58 INFO - TinderboxPrint: I/O write bytes / time
289,447,936 / 323,644 10:34:58 INFO - TinderboxPrint: CPU idle
8,362.0 (87.0%) 10:34:58 INFO - TinderboxPrint: CPU user
1,202.4 (12.5%) 10:34:58 INFO - TinderboxPrint: Swap in / out
0 / 0 10:34:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 5197824; Read time: 0; Write time: 328 10:34:58 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 5591040; Write bytes: 284250112; Read time: 1332; Write time: 323316 10:34:59 INFO - Running post-run listener: _upload_blobber_files 10:34:59 INFO - Blob upload gear active. 10:34:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:34:59 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 10:34:59 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:34:59 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:34:59 INFO - (blobuploader) - INFO - Open directory for files ... 10:34:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:34:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:34:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:35:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:03 INFO - (blobuploader) - INFO - Done attempting. 10:35:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:35:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:35:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:04 INFO - (blobuploader) - INFO - Done attempting. 10:35:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:35:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:35:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:04 INFO - (blobuploader) - INFO - Done attempting. 10:35:04 INFO - (blobuploader) - INFO - Iteration through files over. 10:35:05 INFO - Return code: 0 10:35:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:35:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:35:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/48f1cd2999df2d8d041331a7929fec53a1c0d12eedf9b042ed1e5c487e6159fbaee61bf2dcba567c8a894b11a71d9b5792d01f86402079d9f53dde3ac34504a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4f885181b4767be512f4645aa05bc8bfeba2633b31fbdaadefdfed33b100b8c316802b166be7243453f85d218492a11c7971085e8a78cbf03bd51ea26f5227f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdf058722c3b418bc6fe375d11f6c18e7778a4441158a25221b1b2a3732a3abff71becfd16a104983fa63449e99c03f7b4860d1f42ae0bb98f1ad1a4e085e7c7"} 10:35:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:35:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:35:05 INFO - Contents: 10:35:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/48f1cd2999df2d8d041331a7929fec53a1c0d12eedf9b042ed1e5c487e6159fbaee61bf2dcba567c8a894b11a71d9b5792d01f86402079d9f53dde3ac34504a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4f885181b4767be512f4645aa05bc8bfeba2633b31fbdaadefdfed33b100b8c316802b166be7243453f85d218492a11c7971085e8a78cbf03bd51ea26f5227f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdf058722c3b418bc6fe375d11f6c18e7778a4441158a25221b1b2a3732a3abff71becfd16a104983fa63449e99c03f7b4860d1f42ae0bb98f1ad1a4e085e7c7"} 10:35:05 INFO - Running post-run listener: copy_logs_to_upload_dir 10:35:05 INFO - Copying logs to upload dir... 10:35:05 INFO - mkdir: /builds/slave/test/build/upload/logs 10:35:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.855971 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-07-11 10:35:04.998789) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 10:35:05.001928) ========= 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=fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/48f1cd2999df2d8d041331a7929fec53a1c0d12eedf9b042ed1e5c487e6159fbaee61bf2dcba567c8a894b11a71d9b5792d01f86402079d9f53dde3ac34504a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4f885181b4767be512f4645aa05bc8bfeba2633b31fbdaadefdfed33b100b8c316802b166be7243453f85d218492a11c7971085e8a78cbf03bd51ea26f5227f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdf058722c3b418bc6fe375d11f6c18e7778a4441158a25221b1b2a3732a3abff71becfd16a104983fa63449e99c03f7b4860d1f42ae0bb98f1ad1a4e085e7c7"} build_url:https://queue.taskcluster.net/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/G_lkVJfOTT6-FNSE6gNU4Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/48f1cd2999df2d8d041331a7929fec53a1c0d12eedf9b042ed1e5c487e6159fbaee61bf2dcba567c8a894b11a71d9b5792d01f86402079d9f53dde3ac34504a9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b4f885181b4767be512f4645aa05bc8bfeba2633b31fbdaadefdfed33b100b8c316802b166be7243453f85d218492a11c7971085e8a78cbf03bd51ea26f5227f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bdf058722c3b418bc6fe375d11f6c18e7778a4441158a25221b1b2a3732a3abff71becfd16a104983fa63449e99c03f7b4860d1f42ae0bb98f1ad1a4e085e7c7"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-11 10:35:05.031648) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:35:05.032348) ========= 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=fa44defc139c4ba8574fe040000001db-1468255692.369803-591397370 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004408 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-11 10:35:05.114634) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 10:35:05.114963) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-11 10:35:05.115264) ========= ========= Total master_lag: 0.21 =========