builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1467735551.22 results: success (0) buildid: 20160702023007 builduid: 401ed72a5741489e81ed84e37d93caf4 revision: 39dffbba764210b25bfc1e749b4f16db77fa0d46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:11.223229) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:11.224338) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:11.224980) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:11.241168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:11.241478) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 09:19:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 6.17M=0.002s 2016-07-05 09:19:11 (6.17 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.087919 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:11.347682) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:11.348235) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021343 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:11.399176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:11.399703) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 39dffbba764210b25bfc1e749b4f16db77fa0d46 --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 39dffbba764210b25bfc1e749b4f16db77fa0d46 --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=edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 09:19:11,801 truncating revision to first 12 chars 2016-07-05 09:19:11,801 Setting DEBUG logging. 2016-07-05 09:19:11,801 attempt 1/10 2016-07-05 09:19:11,801 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/39dffbba7642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 09:19:12,103 unpacking tar archive at: fx-team-39dffbba7642/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653615 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:12.072624) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:12.073376) ========= script_repo_revision: 39dffbba764210b25bfc1e749b4f16db77fa0d46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:12.074367) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:12.075063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 09:19:12.087102) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-05 09:19:12.087424) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:19:12 INFO - MultiFileLogger online at 20160705 09:19:12 in /builds/slave/test 09:19:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:19:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:19:12 INFO - {'append_to_log': False, 09:19:12 INFO - 'base_work_dir': '/builds/slave/test', 09:19:12 INFO - 'blob_upload_branch': 'Fx-Team', 09:19:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:19:12 INFO - 'branch': 'Fx-Team', 09:19:12 INFO - 'buildbot_json_path': 'buildprops.json', 09:19:12 INFO - 'config_files': ('talos/linux_config.py',), 09:19:12 INFO - 'default_actions': ('clobber', 09:19:12 INFO - 'read-buildbot-config', 09:19:12 INFO - 'download-and-extract', 09:19:12 INFO - 'populate-webroot', 09:19:12 INFO - 'create-virtualenv', 09:19:12 INFO - 'install', 09:19:12 INFO - 'run-tests'), 09:19:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:19:12 INFO - 'download_minidump_stackwalk': True, 09:19:12 INFO - 'download_symbols': 'ondemand', 09:19:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:19:12 INFO - 'tooltool.py': '/tools/tooltool.py', 09:19:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:19:12 INFO - '/tools/misc-python/virtualenv.py')}, 09:19:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:19:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:19:12 INFO - 'installer_path': 'installer.exe', 09:19:12 INFO - 'log_level': 'info', 09:19:12 INFO - 'log_name': 'talos', 09:19:12 INFO - 'log_to_console': True, 09:19:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:19:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:19:12 INFO - 'opt_config_files': (), 09:19:12 INFO - 'pip_index': False, 09:19:12 INFO - 'sps_profile': False, 09:19:12 INFO - 'sps_profile_interval': 0, 09:19:12 INFO - 'suite': 'dromaeojs', 09:19:12 INFO - 'system_bits': '32', 09:19:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:19:12 INFO - 'title': 'talos-linux64-ix-033', 09:19:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:19:12 INFO - 'use_talos_json': True, 09:19:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:19:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:19:12 INFO - 'work_dir': 'build'} 09:19:12 INFO - ##### 09:19:12 INFO - ##### Running clobber step. 09:19:12 INFO - ##### 09:19:12 INFO - Running pre-action listener: _resource_record_pre_action 09:19:12 INFO - Running main action method: clobber 09:19:12 INFO - rmtree: /builds/slave/test/build 09:19:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:19:13 INFO - Running post-action listener: _resource_record_post_action 09:19:13 INFO - ##### 09:19:13 INFO - ##### Finished clobber step (success) 09:19:13 INFO - ##### 09:19:13 INFO - ##### 09:19:13 INFO - ##### Running read-buildbot-config step. 09:19:13 INFO - ##### 09:19:13 INFO - Running pre-action listener: _resource_record_pre_action 09:19:13 INFO - Running main action method: read_buildbot_config 09:19:13 INFO - Using buildbot properties: 09:19:13 INFO - { 09:19:13 INFO - "project": "", 09:19:13 INFO - "product": "firefox", 09:19:13 INFO - "script_repo_revision": "production", 09:19:13 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:19:13 INFO - "repository": "", 09:19:13 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 09:19:13 INFO - "buildid": "20160702023007", 09:19:13 INFO - "pgo_build": "True", 09:19:13 INFO - "basedir": "/builds/slave/test", 09:19:13 INFO - "buildnumber": 859, 09:19:13 INFO - "slavename": "talos-linux64-ix-033", 09:19:13 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:19:13 INFO - "platform": "ubuntu64_hw", 09:19:13 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 09:19:13 INFO - "branch": "fx-team", 09:19:13 INFO - "repo_path": "integration/fx-team", 09:19:13 INFO - "revision": "39dffbba764210b25bfc1e749b4f16db77fa0d46", 09:19:13 INFO - "stage_platform": "linux64-pgo", 09:19:13 INFO - "builduid": "401ed72a5741489e81ed84e37d93caf4", 09:19:13 INFO - "slavebuilddir": "test" 09:19:13 INFO - } 09:19:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:19:13 INFO - Running post-action listener: _resource_record_post_action 09:19:13 INFO - ##### 09:19:13 INFO - ##### Finished read-buildbot-config step (success) 09:19:13 INFO - ##### 09:19:13 INFO - ##### 09:19:13 INFO - ##### Running download-and-extract step. 09:19:13 INFO - ##### 09:19:13 INFO - Running pre-action listener: _resource_record_pre_action 09:19:13 INFO - Running main action method: download_and_extract 09:19:13 INFO - mkdir: /builds/slave/test/build/tests 09:19:13 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')]} 09:19:13 INFO - https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:19:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:19:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:19:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/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 09:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/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 09:19:13 INFO - Downloaded 1361 bytes. 09:19:13 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:19:13 INFO - Using the following test package requirements: 09:19:13 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:19:13 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:19:13 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:19:13 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:13 INFO - u'jsshell-linux-x86_64.zip'], 09:19:13 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:19:13 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:19:13 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:19:13 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:19:13 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:19:13 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:13 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:19:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:19:13 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')]} 09:19:13 INFO - https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:19:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:19:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:19:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/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 09:19:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/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 09:19:14 INFO - Downloaded 24272920 bytes. 09:19:14 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'] 09:19:14 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 09:19:16 INFO - Return code: 0 09:19:16 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 09:19:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:19:16 INFO - https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:19:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:19:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:19:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/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 09:19:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/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 09:19:17 INFO - Downloaded 24272920 bytes. 09:19:17 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'] 09:19:17 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 09:19:18 INFO - Return code: 0 09:19:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:19:18 INFO - https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:19:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:19:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:19:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/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 09:19:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/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 09:19:19 INFO - Downloaded 14405327 bytes. 09:19:19 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'] 09:19:19 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 09:19:19 INFO - Return code: 0 09:19:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:19:19 INFO - https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:19:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:19:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:19:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/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 09:19:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TSsXmBL_TP-IfV9s7riA4w/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 09:19:21 INFO - Downloaded 60349372 bytes. 09:19:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:19:21 INFO - mkdir: /builds/slave/test/properties 09:19:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:21 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:21 INFO - Contents: 09:19:21 INFO - build_url:https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:19:21 INFO - Running post-action listener: _resource_record_post_action 09:19:22 INFO - Running post-action listener: set_extra_try_arguments 09:19:22 INFO - ##### 09:19:22 INFO - ##### Finished download-and-extract step (success) 09:19:22 INFO - ##### 09:19:22 INFO - ##### 09:19:22 INFO - ##### Running populate-webroot step. 09:19:22 INFO - ##### 09:19:22 INFO - Running pre-action listener: _resource_record_pre_action 09:19:22 INFO - Running main action method: populate_webroot 09:19:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:22 INFO - '--tppagecycles', 09:19:22 INFO - '7'], 09:19:22 INFO - 'tests': ['tsvgm']}}, 09:19:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:19:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:19:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:22 INFO - 'talos_options': ['--disable-e10s'], 09:19:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:22 INFO - 'talos_options': ['--disable-e10s'], 09:19:22 INFO - 'tests': ['damp', 'tps']}, 09:19:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:22 INFO - 'tests': ['damp', 'tps']}, 09:19:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:22 INFO - 'tests': ['dromaeo_dom']}, 09:19:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:22 INFO - 'tests': ['basic_compositor_video']}, 09:19:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:19:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:22 INFO - 'tests': ['a11yr', 09:19:22 INFO - 'ts_paint', 09:19:22 INFO - 'tpaint', 09:19:22 INFO - 'sessionrestore', 09:19:22 INFO - 'sessionrestore_no_auto_restore', 09:19:22 INFO - 'tabpaint']}, 09:19:22 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:22 INFO - 'ts_paint', 09:19:22 INFO - 'tpaint', 09:19:22 INFO - 'sessionrestore', 09:19:22 INFO - 'sessionrestore_no_auto_restore', 09:19:22 INFO - 'tabpaint']}, 09:19:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:22 INFO - 'ts_paint', 09:19:22 INFO - 'tpaint', 09:19:22 INFO - 'sessionrestore', 09:19:22 INFO - 'sessionrestore_no_auto_restore', 09:19:22 INFO - 'tabpaint']}, 09:19:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:22 INFO - 'ts_paint', 09:19:22 INFO - 'tpaint', 09:19:22 INFO - 'sessionrestore', 09:19:22 INFO - 'sessionrestore_no_auto_restore', 09:19:22 INFO - 'tabpaint']}, 09:19:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:22 INFO - 'tests': ['a11yr', 09:19:22 INFO - 'ts_paint', 09:19:22 INFO - 'tpaint', 09:19:22 INFO - 'sessionrestore', 09:19:22 INFO - 'sessionrestore_no_auto_restore', 09:19:22 INFO - 'tabpaint']}, 09:19:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:22 INFO - 'tests': ['a11yr', 09:19:22 INFO - 'ts_paint', 09:19:22 INFO - 'tpaint', 09:19:22 INFO - 'sessionrestore', 09:19:22 INFO - 'sessionrestore_no_auto_restore', 09:19:22 INFO - 'tabpaint']}, 09:19:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:22 INFO - 'tests': ['tsvgx', 09:19:22 INFO - 'tsvgr_opacity', 09:19:22 INFO - 'tart', 09:19:22 INFO - 'tscrollx', 09:19:22 INFO - 'cart']}, 09:19:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:22 INFO - 'tsvgr_opacity', 09:19:22 INFO - 'tart', 09:19:22 INFO - 'tscrollx', 09:19:22 INFO - 'cart']}, 09:19:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:22 INFO - 'talos_options': ['--disable-e10s'], 09:19:22 INFO - 'tests': ['tp5o']}, 09:19:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:22 INFO - 'tests': ['tp5o']}, 09:19:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:22 INFO - 'talos_options': ['--disable-e10s', 09:19:22 INFO - '--xperf_path', 09:19:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:22 INFO - 'tests': ['tp5n']}, 09:19:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:22 INFO - 'talos_options': ['--xperf_path', 09:19:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:22 INFO - 'tests': ['tp5n']}}, 09:19:22 INFO - 'talos.zip': {'path': '', 09:19:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:22 INFO - Running post-action listener: _resource_record_post_action 09:19:22 INFO - ##### 09:19:22 INFO - ##### Finished populate-webroot step (success) 09:19:22 INFO - ##### 09:19:22 INFO - ##### 09:19:22 INFO - ##### Running create-virtualenv step. 09:19:22 INFO - ##### 09:19:22 INFO - Running pre-action listener: _resource_record_pre_action 09:19:22 INFO - Running main action method: create_virtualenv 09:19:22 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:22 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:19:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:22 INFO - Using real prefix '/usr' 09:19:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:22 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:24 INFO - Installing pip.................done. 09:19:24 INFO - Return code: 0 09:19:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:24 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')]} 09:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:24 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')]} 09:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:24 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290e3b0>, '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 0x290f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290f740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', '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 09:19:24 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 09:19:24 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 09:19:24 INFO - Using env: {'DISPLAY': ':0', 09:19:24 INFO - 'HOME': '/home/cltbld', 09:19:24 INFO - 'LANG': 'en_US.UTF-8', 09:19:24 INFO - 'LANGUAGE': 'en_US:en', 09:19:24 INFO - 'LOGNAME': 'cltbld', 09:19:24 INFO - 'MAIL': '/var/mail/cltbld', 09:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:24 INFO - 'MOZ_NO_REMOTE': '1', 09:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:24 INFO - 'NO_EM_RESTART': '1', 09:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:24 INFO - 'PWD': '/builds/slave/test', 09:19:24 INFO - 'SHELL': '/bin/bash', 09:19:24 INFO - 'SHLVL': '1', 09:19:24 INFO - 'TERM': 'linux', 09:19:24 INFO - 'TMOUT': '86400', 09:19:24 INFO - 'USER': 'cltbld', 09:19:24 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', 09:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:24 INFO - '_': '/tools/buildbot/bin/python'} 09:19:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:24 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 09:19:24 INFO - Cleaning up... 09:19:24 INFO - Return code: 0 09:19:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:24 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')]} 09:19:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:24 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')]} 09:19:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:24 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290e3b0>, '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 0x290f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290f740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', '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 09:19:24 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 09:19:24 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 09:19:24 INFO - Using env: {'DISPLAY': ':0', 09:19:24 INFO - 'HOME': '/home/cltbld', 09:19:24 INFO - 'LANG': 'en_US.UTF-8', 09:19:24 INFO - 'LANGUAGE': 'en_US:en', 09:19:24 INFO - 'LOGNAME': 'cltbld', 09:19:24 INFO - 'MAIL': '/var/mail/cltbld', 09:19:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:24 INFO - 'MOZ_NO_REMOTE': '1', 09:19:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:24 INFO - 'NO_EM_RESTART': '1', 09:19:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:24 INFO - 'PWD': '/builds/slave/test', 09:19:24 INFO - 'SHELL': '/bin/bash', 09:19:24 INFO - 'SHLVL': '1', 09:19:24 INFO - 'TERM': 'linux', 09:19:24 INFO - 'TMOUT': '86400', 09:19:24 INFO - 'USER': 'cltbld', 09:19:24 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', 09:19:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:24 INFO - '_': '/tools/buildbot/bin/python'} 09:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:25 INFO - Downloading/unpacking psutil>=3.1.1 09:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:27 INFO - Installing collected packages: psutil 09:19:27 INFO - Running setup.py install for psutil 09:19:27 INFO - building 'psutil._psutil_linux' extension 09:19:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:19:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:19:27 INFO - building 'psutil._psutil_posix' extension 09:19:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:19:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:19:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:27 INFO - Successfully installed psutil 09:19:27 INFO - Cleaning up... 09:19:27 INFO - Return code: 0 09:19:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19: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')]} 09:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19: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')]} 09:19:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:27 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290e3b0>, '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 0x290f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290f740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', '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 09:19:27 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 09:19:27 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 09:19:27 INFO - Using env: {'DISPLAY': ':0', 09:19:27 INFO - 'HOME': '/home/cltbld', 09:19:27 INFO - 'LANG': 'en_US.UTF-8', 09:19:27 INFO - 'LANGUAGE': 'en_US:en', 09:19:27 INFO - 'LOGNAME': 'cltbld', 09:19:27 INFO - 'MAIL': '/var/mail/cltbld', 09:19:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:27 INFO - 'MOZ_NO_REMOTE': '1', 09:19:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:27 INFO - 'NO_EM_RESTART': '1', 09:19:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:27 INFO - 'PWD': '/builds/slave/test', 09:19:27 INFO - 'SHELL': '/bin/bash', 09:19:27 INFO - 'SHLVL': '1', 09:19:27 INFO - 'TERM': 'linux', 09:19:27 INFO - 'TMOUT': '86400', 09:19:27 INFO - 'USER': 'cltbld', 09:19:27 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', 09:19:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:27 INFO - '_': '/tools/buildbot/bin/python'} 09:19:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:19:29 INFO - Installing collected packages: mozsystemmonitor 09:19:29 INFO - Running setup.py install for mozsystemmonitor 09:19:29 INFO - Successfully installed mozsystemmonitor 09:19:29 INFO - Cleaning up... 09:19:30 INFO - Return code: 0 09:19:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:19:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290e3b0>, '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 0x290f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290f740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', '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 09:19:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:19:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:19:30 INFO - Using env: {'DISPLAY': ':0', 09:19:30 INFO - 'HOME': '/home/cltbld', 09:19:30 INFO - 'LANG': 'en_US.UTF-8', 09:19:30 INFO - 'LANGUAGE': 'en_US:en', 09:19:30 INFO - 'LOGNAME': 'cltbld', 09:19:30 INFO - 'MAIL': '/var/mail/cltbld', 09:19:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:30 INFO - 'MOZ_NO_REMOTE': '1', 09:19:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:30 INFO - 'NO_EM_RESTART': '1', 09:19:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:30 INFO - 'PWD': '/builds/slave/test', 09:19:30 INFO - 'SHELL': '/bin/bash', 09:19:30 INFO - 'SHLVL': '1', 09:19:30 INFO - 'TERM': 'linux', 09:19:30 INFO - 'TMOUT': '86400', 09:19:30 INFO - 'USER': 'cltbld', 09:19:30 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', 09:19:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:30 INFO - '_': '/tools/buildbot/bin/python'} 09:19:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:30 INFO - Downloading/unpacking jsonschema==2.5.1 09:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:32 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:32 INFO - warning: no files found matching '*.txt' 09:19:32 INFO - no previously-included directories found matching 'build' 09:19:32 INFO - no previously-included directories found matching 'dist' 09:19:32 INFO - no previously-included directories found matching '.git*' 09:19:32 INFO - Installing collected packages: jsonschema, functools32 09:19:32 INFO - Running setup.py install for functools32 09:19:32 INFO - warning: no files found matching '*.txt' 09:19:32 INFO - no previously-included directories found matching 'build' 09:19:32 INFO - no previously-included directories found matching 'dist' 09:19:32 INFO - no previously-included directories found matching '.git*' 09:19:32 INFO - Successfully installed jsonschema functools32 09:19:32 INFO - Cleaning up... 09:19:32 INFO - Return code: 0 09:19:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19:32 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')]} 09:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:32 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')]} 09:19:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:32 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290e3b0>, '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 0x290f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290f740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', '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 09:19:32 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 09:19:32 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 09:19:32 INFO - Using env: {'DISPLAY': ':0', 09:19:32 INFO - 'HOME': '/home/cltbld', 09:19:32 INFO - 'LANG': 'en_US.UTF-8', 09:19:32 INFO - 'LANGUAGE': 'en_US:en', 09:19:32 INFO - 'LOGNAME': 'cltbld', 09:19:32 INFO - 'MAIL': '/var/mail/cltbld', 09:19:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:32 INFO - 'MOZ_NO_REMOTE': '1', 09:19:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:32 INFO - 'NO_EM_RESTART': '1', 09:19:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:32 INFO - 'PWD': '/builds/slave/test', 09:19:32 INFO - 'SHELL': '/bin/bash', 09:19:32 INFO - 'SHLVL': '1', 09:19:32 INFO - 'TERM': 'linux', 09:19:32 INFO - 'TMOUT': '86400', 09:19:32 INFO - 'USER': 'cltbld', 09:19:32 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', 09:19:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:32 INFO - '_': '/tools/buildbot/bin/python'} 09:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:32 INFO - Downloading/unpacking blobuploader==1.2.4 09:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:34 INFO - Downloading blobuploader-1.2.4.tar.gz 09:19:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:35 INFO - Downloading docopt-0.6.1.tar.gz 09:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:35 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:35 INFO - Running setup.py install for blobuploader 09:19:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:35 INFO - Running setup.py install for requests 09:19:35 INFO - Running setup.py install for docopt 09:19:36 INFO - Successfully installed blobuploader requests docopt 09:19:36 INFO - Cleaning up... 09:19:36 INFO - Return code: 0 09:19:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:36 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')]} 09:19:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:36 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')]} 09:19:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:36 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290e3b0>, '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 0x290f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290f740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', '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 09:19:36 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 09:19:36 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 09:19:36 INFO - Using env: {'DISPLAY': ':0', 09:19:36 INFO - 'HOME': '/home/cltbld', 09:19:36 INFO - 'LANG': 'en_US.UTF-8', 09:19:36 INFO - 'LANGUAGE': 'en_US:en', 09:19:36 INFO - 'LOGNAME': 'cltbld', 09:19:36 INFO - 'MAIL': '/var/mail/cltbld', 09:19:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:36 INFO - 'MOZ_NO_REMOTE': '1', 09:19:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:36 INFO - 'NO_EM_RESTART': '1', 09:19:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:36 INFO - 'PWD': '/builds/slave/test', 09:19:36 INFO - 'SHELL': '/bin/bash', 09:19:36 INFO - 'SHLVL': '1', 09:19:36 INFO - 'TERM': 'linux', 09:19:36 INFO - 'TMOUT': '86400', 09:19:36 INFO - 'USER': 'cltbld', 09:19:36 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', 09:19:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:36 INFO - '_': '/tools/buildbot/bin/python'} 09:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:36 INFO - Running setup.py (path:/tmp/pip-DVgGCI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:36 INFO - Running setup.py (path:/tmp/pip-3_LRwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:36 INFO - Running setup.py (path:/tmp/pip-1lEjNY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:36 INFO - Running setup.py (path:/tmp/pip-LHGpOO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:36 INFO - Running setup.py (path:/tmp/pip-IleeaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:36 INFO - Running setup.py (path:/tmp/pip-t5UN8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:36 INFO - Running setup.py (path:/tmp/pip-X6j2sG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:36 INFO - Running setup.py (path:/tmp/pip-VseO98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:36 INFO - Running setup.py (path:/tmp/pip-em2K_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:36 INFO - Running setup.py (path:/tmp/pip-KiPxmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:37 INFO - Running setup.py (path:/tmp/pip-BeFkM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:37 INFO - Running setup.py (path:/tmp/pip-2NUl8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:37 INFO - Running setup.py (path:/tmp/pip-c7rqtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:37 INFO - Running setup.py (path:/tmp/pip-bMJE3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:37 INFO - Running setup.py (path:/tmp/pip-QFlCiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:37 INFO - Running setup.py (path:/tmp/pip-uRhJ9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:37 INFO - Running setup.py (path:/tmp/pip-x3LRYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:37 INFO - Running setup.py install for manifestparser 09:19:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozcrash 09:19:37 INFO - Running setup.py install for mozdebug 09:19:37 INFO - Running setup.py install for mozdevice 09:19:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:37 INFO - Running setup.py install for mozfile 09:19:38 INFO - Running setup.py install for mozhttpd 09:19:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozinfo 09:19:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozInstall 09:19:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozleak 09:19:38 INFO - Running setup.py install for mozlog 09:19:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for moznetwork 09:19:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozprocess 09:19:38 INFO - Running setup.py install for mozprofile 09:19:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:38 INFO - Running setup.py install for mozrunner 09:19:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:39 INFO - Running setup.py install for mozscreenshot 09:19:39 INFO - Running setup.py install for moztest 09:19:39 INFO - Running setup.py install for mozversion 09:19:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:39 INFO - Cleaning up... 09:19:39 INFO - Return code: 0 09:19:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:39 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')]} 09:19:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:39 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')]} 09:19:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:39 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290e3b0>, '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 0x290f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290f740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', '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 09:19:39 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 09:19:39 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 09:19:39 INFO - Using env: {'DISPLAY': ':0', 09:19:39 INFO - 'HOME': '/home/cltbld', 09:19:39 INFO - 'LANG': 'en_US.UTF-8', 09:19:39 INFO - 'LANGUAGE': 'en_US:en', 09:19:39 INFO - 'LOGNAME': 'cltbld', 09:19:39 INFO - 'MAIL': '/var/mail/cltbld', 09:19:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:39 INFO - 'MOZ_NO_REMOTE': '1', 09:19:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:39 INFO - 'NO_EM_RESTART': '1', 09:19:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:39 INFO - 'PWD': '/builds/slave/test', 09:19:39 INFO - 'SHELL': '/bin/bash', 09:19:39 INFO - 'SHLVL': '1', 09:19:39 INFO - 'TERM': 'linux', 09:19:39 INFO - 'TMOUT': '86400', 09:19:39 INFO - 'USER': 'cltbld', 09:19:39 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', 09:19:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:39 INFO - '_': '/tools/buildbot/bin/python'} 09:19:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:39 INFO - Running setup.py (path:/tmp/pip-EB2dP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:39 INFO - Running setup.py (path:/tmp/pip-MDqYP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:39 INFO - Running setup.py (path:/tmp/pip-P2XJxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:39 INFO - Running setup.py (path:/tmp/pip-6Mnysx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:39 INFO - Running setup.py (path:/tmp/pip-upTpk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:39 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)) 09:19:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:39 INFO - Running setup.py (path:/tmp/pip-CJRbxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:40 INFO - Running setup.py (path:/tmp/pip-Hs7tYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:40 INFO - Running setup.py (path:/tmp/pip-tkFvW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:40 INFO - Running setup.py (path:/tmp/pip-BOevmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:40 INFO - Running setup.py (path:/tmp/pip-_cHc4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:40 INFO - Running setup.py (path:/tmp/pip-QBT7tC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:40 INFO - Running setup.py (path:/tmp/pip-Q5XP_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:40 INFO - Running setup.py (path:/tmp/pip-2TKHuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:40 INFO - Running setup.py (path:/tmp/pip-cdER2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:40 INFO - Running setup.py (path:/tmp/pip-c9xPQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:40 INFO - Running setup.py (path:/tmp/pip-op4AXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:40 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)) 09:19:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:40 INFO - Running setup.py (path:/tmp/pip-4_eUie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 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)) 09:19:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19: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 09:19:42 INFO - Downloading blessings-1.6.tar.gz 09:19:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:42 INFO - Installing collected packages: blessings 09:19:42 INFO - Running setup.py install for blessings 09:19:42 INFO - Successfully installed blessings 09:19:42 INFO - Cleaning up... 09:19:43 INFO - Return code: 0 09:19:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:43 INFO - Reading from file tmpfile_stdout 09:19:43 INFO - Current package versions: 09:19:43 INFO - argparse == 1.2.1 09:19:43 INFO - blessings == 1.6 09:19:43 INFO - blobuploader == 1.2.4 09:19:43 INFO - docopt == 0.6.1 09:19:43 INFO - functools32 == 3.2.3-2 09:19:43 INFO - jsonschema == 2.5.1 09:19:43 INFO - manifestparser == 1.1 09:19:43 INFO - mozInstall == 1.12 09:19:43 INFO - mozcrash == 0.17 09:19:43 INFO - mozdebug == 0.1 09:19:43 INFO - mozdevice == 0.48 09:19:43 INFO - mozfile == 1.2 09:19:43 INFO - mozhttpd == 0.7 09:19:43 INFO - mozinfo == 0.9 09:19:43 INFO - mozleak == 0.1 09:19:43 INFO - mozlog == 3.2 09:19:43 INFO - moznetwork == 0.27 09:19:43 INFO - mozprocess == 0.22 09:19:43 INFO - mozprofile == 0.28 09:19:43 INFO - mozrunner == 6.11 09:19:43 INFO - mozscreenshot == 0.1 09:19:43 INFO - mozsystemmonitor == 0.3 09:19:43 INFO - moztest == 0.7 09:19:43 INFO - mozversion == 1.4 09:19:43 INFO - psutil == 3.1.1 09:19:43 INFO - requests == 1.2.3 09:19:43 INFO - wsgiref == 0.1.2 09:19:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:43 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')]} 09:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:43 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')]} 09:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:43 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290e3b0>, '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 0x290f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290f740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', '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 09:19:43 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 09:19:43 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 09:19:43 INFO - Using env: {'DISPLAY': ':0', 09:19:43 INFO - 'HOME': '/home/cltbld', 09:19:43 INFO - 'LANG': 'en_US.UTF-8', 09:19:43 INFO - 'LANGUAGE': 'en_US:en', 09:19:43 INFO - 'LOGNAME': 'cltbld', 09:19:43 INFO - 'MAIL': '/var/mail/cltbld', 09:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:43 INFO - 'MOZ_NO_REMOTE': '1', 09:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:43 INFO - 'NO_EM_RESTART': '1', 09:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:43 INFO - 'PWD': '/builds/slave/test', 09:19:43 INFO - 'SHELL': '/bin/bash', 09:19:43 INFO - 'SHLVL': '1', 09:19:43 INFO - 'TERM': 'linux', 09:19:43 INFO - 'TMOUT': '86400', 09:19:43 INFO - 'USER': 'cltbld', 09:19:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', 09:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:43 INFO - '_': '/tools/buildbot/bin/python'} 09:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 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)) 09:19:43 INFO - Cleaning up... 09:19:43 INFO - Return code: 0 09:19:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:19:43 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')]} 09:19:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:43 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')]} 09:19:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:43 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 0x264f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2910180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290e3b0>, '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 0x290f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290f740>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', '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 09:19:43 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 09:19:43 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 09:19:43 INFO - Using env: {'DISPLAY': ':0', 09:19:43 INFO - 'HOME': '/home/cltbld', 09:19:43 INFO - 'LANG': 'en_US.UTF-8', 09:19:43 INFO - 'LANGUAGE': 'en_US:en', 09:19:43 INFO - 'LOGNAME': 'cltbld', 09:19:43 INFO - 'MAIL': '/var/mail/cltbld', 09:19:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:43 INFO - 'MOZ_NO_REMOTE': '1', 09:19:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:43 INFO - 'NO_EM_RESTART': '1', 09:19:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:43 INFO - 'PWD': '/builds/slave/test', 09:19:43 INFO - 'SHELL': '/bin/bash', 09:19:43 INFO - 'SHLVL': '1', 09:19:43 INFO - 'TERM': 'linux', 09:19:43 INFO - 'TMOUT': '86400', 09:19:43 INFO - 'USER': 'cltbld', 09:19:43 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', 09:19:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:43 INFO - '_': '/tools/buildbot/bin/python'} 09:19:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:43 INFO - Cleaning up... 09:19:43 INFO - Return code: 0 09:19:43 INFO - Running post-action listener: _resource_record_post_action 09:19:43 INFO - Running post-action listener: _start_resource_monitoring 09:19:43 INFO - Starting resource monitoring. 09:19:43 INFO - ##### 09:19:43 INFO - ##### Finished create-virtualenv step (success) 09:19:43 INFO - ##### 09:19:43 INFO - ##### 09:19:43 INFO - ##### Running install step. 09:19:43 INFO - ##### 09:19:43 INFO - Running pre-action listener: _resource_record_pre_action 09:19:43 INFO - Running main action method: install 09:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:43 INFO - Reading from file tmpfile_stdout 09:19:43 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:44 INFO - Reading from file tmpfile_stdout 09:19:44 INFO - Output received: 09:19:44 INFO - Usage: mozinstall [options] installer 09:19:44 INFO - Options: 09:19:44 INFO - -h, --help show this help message and exit 09:19:44 INFO - -d DEST, --destination=DEST 09:19:44 INFO - Directory to install application into. [default: 09:19:44 INFO - "/builds/slave/test"] 09:19:44 INFO - --app=APP Application being installed. [default: firefox] 09:19:44 INFO - mkdir: /builds/slave/test/build/application 09:19:44 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'] 09:19:44 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 09:20:01 INFO - Reading from file tmpfile_stdout 09:20:01 INFO - Output received: 09:20:01 INFO - /builds/slave/test/build/application/firefox/firefox 09:20:01 INFO - Running post-action listener: _resource_record_post_action 09:20:01 INFO - ##### 09:20:01 INFO - ##### Finished install step (success) 09:20:01 INFO - ##### 09:20:01 INFO - ##### 09:20:01 INFO - ##### Running run-tests step. 09:20:01 INFO - ##### 09:20:01 INFO - Running pre-action listener: _resource_record_pre_action 09:20:01 INFO - Running main action method: run_tests 09:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:20:01 INFO - Python 2.7.3 09:20:01 INFO - Return code: 0 09:20:01 INFO - grabbing minidump binary from tooltool 09:20:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 09:20:01 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x290e3b0>, '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 0x290f2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x290f740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:20:01 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:20:01 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:20:01 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:20:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:20:01 INFO - Return code: 0 09:20:01 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:20:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:20:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:20:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:20:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:20:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 09:20:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 09:20:01 INFO - Using env: {'DISPLAY': ':0', 09:20:01 INFO - 'HOME': '/home/cltbld', 09:20:01 INFO - 'LANG': 'en_US.UTF-8', 09:20:01 INFO - 'LANGUAGE': 'en_US:en', 09:20:01 INFO - 'LOGNAME': 'cltbld', 09:20:01 INFO - 'MAIL': '/var/mail/cltbld', 09:20:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:20:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:20:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:01 INFO - 'MOZ_NO_REMOTE': '1', 09:20:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:20:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:20:01 INFO - 'NO_EM_RESTART': '1', 09:20:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:20:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:01 INFO - 'PWD': '/builds/slave/test', 09:20:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:20:01 INFO - 'SHELL': '/bin/bash', 09:20:01 INFO - 'SHLVL': '1', 09:20:01 INFO - 'TERM': 'linux', 09:20:01 INFO - 'TMOUT': '86400', 09:20:01 INFO - 'USER': 'cltbld', 09:20:01 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777', 09:20:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:01 INFO - '_': '/tools/buildbot/bin/python'} 09:20:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 09:20:01 INFO - mozversion application_buildid: 20160702023007 09:20:01 INFO - mozversion application_changeset: 39dffbba764210b25bfc1e749b4f16db77fa0d46 09:20:01 INFO - mozversion application_display_name: Nightly 09:20:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:20:01 INFO - mozversion application_name: Firefox 09:20:01 INFO - mozversion application_remotingname: firefox 09:20:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:20:01 INFO - mozversion application_vendor: Mozilla 09:20:01 INFO - mozversion application_version: 50.0a1 09:20:01 INFO - mozversion platform_buildid: 20160702023007 09:20:01 INFO - mozversion platform_changeset: 39dffbba764210b25bfc1e749b4f16db77fa0d46 09:20:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:20:01 INFO - mozversion platform_version: 50.0a1 09:20:01 INFO - using testdate: 1467735601 09:20:01 INFO - actual date: 1467735601 09:20:01 INFO - starting webserver on 'localhost:42599' 09:20:01 INFO - SUITE-START | Running 2 tests 09:20:01 INFO - TEST-START | dromaeo_css 09:20:01 INFO - operating with platform_type : linux_ 09:20:01 INFO - Initialising browser for dromaeo_css test... 09:20:01 INFO - TEST-INFO | started process 624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjCSooK/profile http://localhost:42599/getInfo.html) 09:20:06 INFO - PROCESS | 624 | __metrics Screen width/height:1600/1200 09:20:06 INFO - PROCESS | 624 | colorDepth:24 09:20:06 INFO - PROCESS | 624 | Browser inner width/height: 1024/697 09:20:06 INFO - PROCESS | 624 | __metrics 09:20:07 INFO - PROCESS | 624 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:20:08 INFO - TEST-INFO | 624: exit 0 09:20:08 INFO - Browser initialized. 09:20:08 INFO - Running cycle 1/1 for dromaeo_css test... 09:20:08 INFO - TEST-INFO | started process 707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjCSooK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:19 INFO - PROCESS | 707 | RSS: Main: 157515776 09:20:19 INFO - PROCESS | 707 | 09:21:10 INFO - PROCESS | 707 | 1467735670741 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:23:19 INFO - PROCESS | 707 | Cycle 1(1): loaded http://localhost:42599/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42599/tests/dromaeo/cssquery-ext.html) 09:23:21 INFO - PROCESS | 707 | RSS: Main: 284155904 09:23:21 INFO - PROCESS | 707 | 09:26:23 INFO - PROCESS | 707 | Cycle 1(1): loaded http://localhost:42599/tests/dromaeo/cssquery-ext.html (next: http://localhost:42599/tests/dromaeo/cssquery-jquery.html) 09:26:24 INFO - PROCESS | 707 | RSS: Main: 244396032 09:26:24 INFO - PROCESS | 707 | 09:29:26 INFO - PROCESS | 707 | Cycle 1(1): loaded http://localhost:42599/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42599/tests/dromaeo/cssquery-mootools.html) 09:29:26 INFO - PROCESS | 707 | RSS: Main: 246575104 09:29:26 INFO - PROCESS | 707 | 09:32:28 INFO - PROCESS | 707 | Cycle 1(1): loaded http://localhost:42599/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42599/tests/dromaeo/cssquery-prototype.html) 09:32:29 INFO - PROCESS | 707 | RSS: Main: 234057728 09:32:29 INFO - PROCESS | 707 | 09:35:32 INFO - PROCESS | 707 | Cycle 1(1): loaded http://localhost:42599/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42599/tests/dromaeo/cssquery-yui.html) 09:35:32 INFO - PROCESS | 707 | RSS: Main: 221065216 09:35:32 INFO - PROCESS | 707 | 09:38:35 INFO - PROCESS | 707 | Cycle 1(1): loaded http://localhost:42599/tests/dromaeo/cssquery-yui.html (next: http://localhost:42599/tests/dromaeo/cssquery-dojo.html) 09:38:35 INFO - PROCESS | 707 | RSS: Main: 292274176 09:38:35 INFO - PROCESS | 707 | 09:38:35 INFO - PROCESS | 707 | __start_tp_report 09:38:35 INFO - PROCESS | 707 | _x_x_mozilla_page_load 09:38:35 INFO - PROCESS | 707 | _x_x_mozilla_page_load_details 09:38:35 INFO - PROCESS | 707 | |i|pagename|runs| 09:38:35 INFO - PROCESS | 707 | |0;dojo.html;3099.302656902197;3120.6567277599474;3135.2005238664137;3151.653318135006;3173.9365212695748;5244;5308.628396012281;5342.278792363029;5405.54052905503;5417.079096553591;5363.570914326854;5420.268263784388;5437.782488700457;5443.428440013801;5548.334199896008;4874.2688596710595;4874.366332376804;4876.512348765131;4979.302897594331;5006.5744411725045;4917.237828136645;4975.626827987898;5074.2895994560795;5093.032323858473;5094.235864620318;4870.293807397943;4993.575546078551;5008.774605142778;5052.393712754475;5080.339555857733;4854.927176092326;4898.314236006926;4908.9754551227015;4932.80268789248;4951.603871690256;4888.535589119028;4904.0437114762635;4966.87582810429;4973.875653108665;5024.045431368028;5256.526912577886;5468.835934921959;5488.69812160331;5511.889762204773;5512.614117011811;5789.971050144764;5828.300603927556;5848.3274423441;5893.705314734246;5950.464458198783;5922.318933322636;5938.079597662369;5964.821055368346;5979.0134627786365;5995.340512543617;5301.284326615934;5424.918626220609;5553.000459917213;5559;5559.110542313251;5969.611975221596;6091.482224011009;6091.604045737013;6094.421030002142;6097.085437184369;5792.333881603585;5793.710314484259;5795.594308398456;5845.88308233833;5855.209546711225;5601.411851755588;5614.63504872182;5742.712864356849;5795.88408231833;5858.94141058584;5749.7700091996685;5768.971155144198;5769.68266745333;5770.971145144247;5812.447817457335;5738.426157384311;5754.1944127822135;5782.190493330937;5786.392428795;5789.623674461147;4276.144771045803;4303.160883627663;4356.934645980313;4392.604665580113;4430.579094985971;3909.042284640281;3927.8036098194975;3928.1554465789422;3951.7036222283446;3985.5815139410524;5431.511163995259;5469.042917489423;5474.972625136928;5475.123980163155;5522.199281104297;5619.775208991595;5720.799772007959;5773.39379365169;5787.102999035156;5894.793682221101;5429.158480435539;5431.972840135853;5455.290812194468;5458.563314934796;5468.097763868917;4872.269159626085;4873.463918968911;4877.6341774367065;4880.341153944172;4914.975425122923;5808.82573522795;5964.582479226413;5982.4017598239825;6053.122297266872;6053.303870055;5924.8815023700145;5930.733117009831;5936.257967754031;5938.8218353449465;5938.910916336172;6063.757449701962;6072.483838873745;6073.757049717962;6074.878502430015;6095.664738439428;5526.50261476469;5706.914396284142;5715.085586306171;5777.971110144423;5799.536037117105;5877.735501902339;5908.675022873783;5924.437178468039;5930.584859059824;5931.110333449845;5592.3009623797025;5721.971390143022;5772.307323121252;5776.364599893925;5788.218590490398;5538.584606154474;5556.555475561864;5583.2462617547735;5624.184493248538;5639.8590035249445;5586.832395028156;5590.916136257878;5590.944090559043;5591;5591.580631452576;5584;5593.468620481048;5646.548276137817;5652.3217213934595;5714;5430.592705547178;5462.508374246178;5482.451754824486;5528.668279903058;5587.357453892854 09:38:35 INFO - PROCESS | 707 | |1;ext.html;592.7391947543081;602.6444397805294;614.7141579165689;624.7219987105734;643.8422586466313;33229.83385083074;33858;33892.4916126258;43354.56645433545;44921;45404.77297613507;45909.31136032962;46076.769616151956;46116;46134.76932615341;9020.909790902106;9151.954240228823;9161.633534658638;9167.679131230409;9170.86243706345;8205.548694821782;8944.955275223614;10627.41549214793;10781.730456738605;10815.67552973412;11156.330620162817;11203.495842687098;11208.159388045888;11215.551377944872;11239.325640461557;8176.3458923286;10836.349819010846;10869.076128529085;10889.292196007313;10897.019268265854;10480.109190718798;10990.17573681977;10991.340519568852;11001;11280.548778048867;41806.581934180576;42373.78813105945;44479.33281000787;44730.552694472965;44747.21011159582;3580.2660454606744;3621.4205727083804;3641.14433108222;3716.7026637868908;3925.6332188896854;32715.50926736101;33515.99452016444;33884.49173262403;33917.49123763145;33981;4248.490181178247;4297.699161058727;4306.80619372129;4478.283474644074;4506.436695413074;388325;388718;391184;391504;394440.02779986203;65757.34242657608;66254;66296;66340;66347;68582.31417685859;69764;69977;70116;70170.29829701739;17154.313827446764;17314.30742770275;17325.913370433067;17329.873558218675;17360.39238626642;12511.812322815165;12570.308633025272;12601.495940162475;12626.368681565886;13688.247146407044;19270.49518975385;20071.799282007287;20299.695504567444;20356;20391.898040509703;7133.571985680772;7242.565446073252;7332.560046397233;7425.1461081975185;7704.691812327556;953.2945620241111;1019.7909428567126;1056.4189695667353;1063.7340664833791;1111.77208672222;31952.520712189336;32602.673973259964;32610.673893260762;32721.509177362357;33156.83421582876;1059.0838924330399;1072.667473083331;1099.4997276239292;1100.8238681810872;1119.8936101070385;17006;17361.30554777795;17475.82524174742;17518.757982119958;17522.21150048251;157195;157412;157881;159287;159633.2018339924;58591.70704146537;58770.70614646985;58809.11786323209;58867.70566147142;59019;1182.8462299900957;1337.4315915735774;1360.6598350412396;1380.4064252371577;1390.2978995606952;32492.83753581217;33912;33923.49114763231;34096.31807363888;34121.65878341185;45688.54311456843;45814;45869.54130458653;45894.541054590365;45930;379800;388134;388302;388706;389155;36520.63479365173;46063.01180846468;46698.53301467078;47885.5211447895;48451.75774121107;48758;49063.50936490589;49183.26225106555;49448.50551494439;50329.49670503248;41828.51657993016;42032;42702.359464607434;43422.34866476942;43500;42062.84528660301;42179;42406.78796605997;42417.36373954331;42798;41535;41732.58267417408;42089;42154.578454216295;42198.78900605477;34492.82753586216;36547.45178822373;36698.8165059173;37058.54763544205;37627.62372376351;28162.524922920322;28280.598356766146;28326.291842704097;28466.57300140458;28479 09:38:35 INFO - PROCESS | 707 | |2;jquery.html;386.6732610943755;396.4766508209165;409.66816878328547;417.5886751549724;424.29143330637834;13519.139700078922;19740.703889441633;19799.901000494996;19816;20712.378628641127;12639;12822.871771282284;12961.481540738383;12966.740665186691;12975.93512032441;4027.9798601006955;5387.78448862046;5539.169124631298;5540.196671482632;7354.154272258678;7686.769396918074;7737.41969352298;7784.844303113934;7917.247861453182;7941.16617755136;7818.843623127563;7860.567668778215;7868.134505204423;7873.488223265469;7874.251946065143;7473.887891681602;7780.8832867507035;7781.455298129134;7797.766067017942;7812.6093695315;6642.667866606698;7076.9292307076785;7502.887456688154;7515.586642734647;7547.32074113327;27761.86119069412;28142.859285703646;28195;28712.138635840958;28761.71238287632;2657.5349313869997;2692.421129457176;2784.763295119917;3137.1843320736543;3345.414552453311;16220.756688649679;16516.669666606602;16581.419650312302;16718.66562668752;17209.827901720946;2088.571842772228;2113.926012589552;2156.0836644426213;2166.880821554814;2185.7651670414084;102579;106448;107707.46146269297;107734.46132769286;109366;18284;18510.722339164924;18574.641411364668;18883.80695308801;20490;33728.66271337255;33856.49215261773;34026.48960265598;34244.82877585646;34333.82833085819;9908.256880733974;10321.17090071556;10328.793424131476;10417.791644167075;10673.039426451502;8615.61229744663;8677.652893884175;8751.168638979287;8855.114488551093;9193.126652967958;8927.33045021626;9080.22818060459;9166.49584272858;9219.953900230455;9233.53832308382;3148.795328303653;3411.658834116618;3546.8226588670977;3645.927081458356;3679.2273622539565;873.7771868173575;876.9693060742843;963.5423173992438;992.98715310383;1052.5368837711535;19164.8083519163;19827.60344793096;19948;20121.896388070025;20269.695954560695;1011.2062031305537;1032.256775121911;1050.7583255851043;1068.2628985999636;1070.7858428314369;10562.841557376645;11078.556857725762;11120.555177792798;11151.052160566443;11158.107351411867;495627;499557;505811;507745;508352;101101;101941.49029254806;104039.86883672584;104986;105165;961.624966263158;981.3621146254991;994.4629899854142;999.6751055906859;1033.188946676855;17117.400890968755;17325.74011389805;17544.473665790047;17564.91217543904;17598.38405655796;42939.570604293556;43674.56325436705;43695.781521093464;45001.32498012598;46021.53978460172;61954.38045619666;62435.37564624296;62738.445110845954;63386.366136338045;63543.364566353746;7821.178776228641;9035.232005279624;9135.132162444557;9179.954100229455;9290.442573445345;12503.124781265224;14341.139531628136;14491.78262326087;14674.633134171305;14799.408023678932;12277.570285039981;12635.87364126347;12636.431360588611;12781.424835882222;12824.679383015125;12198.268103913439;12487.687807804878;12495.750084998432;12626.305553194663;12630.621081367573;12728.427220774902;12820.871791281968;12829.807552886901;12876.871231287567;12920.22478651284;8375.748727538183;8393.748187554384;8415.326773857954;8437.325013998989;8571.914280857112;9305.395149315273;12196.695082623006;12783.16909400886;12840.871591283967;12851.742965140458 09:38:35 INFO - PROCESS | 707 | |3;mootools.html;1471.4261438039166;1512.8487151284871;1586.9523914282568;1715.6054107555262;1723.2073246306697;9163.862542061866;9686.079822416878;9753;9766.414015159087;9781.7554561136;8186.54973976431;8422.241998220159;8426.705065322714;8650.178233067849;9579.616815327396;2337.2871274261342;2439.6462512935614;2447.596146635803;2453.950920981579;2463.1379017343966;2475.517274131545;2487.2413913756295;2499.3626625210636;2503.987480062597;2526.823122381434;2103.57928414317;2371.312319427364;2459.963100553493;2477.318737347226;2477.4549599088173;2440.3045132137345;2449.497852940161;2472.4807790364043;2478.1945867592926;2480;2412.19191570824;2483.0688491815567;2484.4534202475425;2485.0805202075167;2485.3538080099124;9293.674721384787;9357.76605584859;9358.812823743556;9361.297902657328;9362.157405833439;5564;5623.915641265385;5704.629199102045;5713.114467257582;5733.569982251348;3422.7261819054415;3429.4684323929832;3493.2664140530264;3540.2388486475274;3550.414181660023;1148.9597864074717;1161.5760247509597;1162.0773754008676;1162.8197629367462;1179.9233049851732;13221;13338.799918001238;13433.529826456124;13441.395137218946;13445.126066805626;4944.381952255968;5019.648624596316;5129.512696293846;5136.203888397305;5167.9224811627855;11321.037711794424;11330.886691132982;11332.546698132148;11337.603183888525;11350.09199264057;5662.716864156858;5664.830055098354;5671.801486948019;5672.461116193955;5673.659580425187;5072.873178170576;5100.821471248489;5177.844664660066;5188.870278243074;5256.237845512455;4169.395437661522;4189.4344263524035;4192.895177620523;4387.451568553931;4387.890302742457;1304.4260525368807;1317.5586178630074;1328.4022190014532;1337.6321511584392;1340.9664758380923;990.9554070066864;998.4109375468508;1005.1255407795265;1007.9798404031878;1010.2372708605103;6231.127642130105;6295.905561416583;6307.400796924285;6424.229092508929;6504.869902601921;456.39983421800224;463.10158292911643;481.9662623616313;488.6237597050251;493.5631965710372;4180.749155050707;4295.763732994653;4351.129774045204;4487.910241795211;4528.980979279636;11580.478878450322;11948.701282468008;11968.521259149536;11977.101717371057;12007.579734709243;11352.14858885587;11780.175387722777;11793.351365674971;12187.756244875052;12197.817032744517;8605.65577376898;8791.956040219886;8806.86789698155;8808.999999999873;8813.471191728517;6173.135760993375;6380.808575742735;6443.291237963914;6526.4452521536205;6534.052562378523;10708.518116684612;10842.78314433691;10863.456827158452;10973.780524389627;11094.278871873303;9841.803163936538;10614.89385106139;11277.266977646426;11291.153163512934;11446.484908179318;8077.394195435249;8122.796930076795;8557.657693692183;8559.486430814171;8563.48619082832;9205.30960177976;9413.435193888388;9453.669121580986;9491.193248573949;9503.097205765442;8053.1946805319;8154.184581542036;8240.711575094843;8249.29880960125;8636.913630863863;8132.3494120471405;8183.304419124441;8245.917540824756;8449.23956843887;8482.236598706146;7590.582517961565;7624.618769061635;7649.273319034683;7650.387968962581;7715.961420192863;5382.407935127055;5492.148716948879;5523.530499907552;5591.440855914539;5655.066913959316;5579.69311687861;5731.971340143439;5752.539796816328;5761.798337058183;5771.797987070432 09:38:35 INFO - PROCESS | 707 | |4;prototype.html;330.10212222754103;341.09779632871056;350.85439542589825;351.497358776949;351.8997085830539;5325.973370133144;5431.212474191249;5457.372402173752;5499.285092937913;5538.280023596932;5345.305110335651;5375.817320189552;5389.973050134754;5402.432744561824;5421.728913554326;4240.32154855224;4267.935980960288;4291.656667466611;4292.120115376356;4320.07118469529;4055.756654600719;4092.5498195198506;4283.614474697277;4302.505211900624;4309.396684464177;4247.235497610429;4270.996315865769;4277.828886844538;4283.550227226143;4292.570742925698;4261.914761704764;4287.8284868605215;4295.162443323553;4301;4308.4399028126145;3696.0020794385364;3809.142942837867;3834.6740527055235;3847.172857835551;3847.5960024197334;5222.32109825724;5222.582193424517;5226.634135610509;5230.913760881099;5250.18622113573;4882.584980276681;4884.7069175849565;4885.951140488585;4886.267059941002;4889.242167464049;5441.891162176774;5623.26897503326;5647.830565083054;5654.293213348332;5661.547076233933;4037.759043730728;4059.553449120624;4063.553009168989;4076.8369265229653;4100.138970816132;5884.440268483224;5912.14273930282;5947.316058653267;5954.374790646963;5960.731767070492;3974.503187101612;4161.91676166475;4166.7708276045105;4183.6234738873645;4197.958020419818;4230.61924426803;4235.919840440668;4242.936355954663;4248.044190057212;4255.510616279105;4842.878928026827;4856.198727210041;4869.853904382874;4869.9513004870205;4876.634252431082;5569.136783798518;5708.514776243983;5715.714214289269;5721.427857214246;5787.218725472091;1371.2389623758909;1403.7964495148146;1409.4503143773936;1419.9432022718975;1426.543506078045;987.0327079462168;1004.4029992312259;1007.2495990487134;1009.3893194617298;1012.8227560176939;5153.7165455900285;5376.91934620981;5434.212039254286;5439.945600544023;5451.345838499326;5727.684977326204;5734.799282025109;5776.191333213354;5791.044477661223;5811.535077193815;5152.948470515322;5377.467421784772;5398.433164517748;5403.810866619728;5411.83764487066;2692.990128701737;2721.333273348003;2728.31792051987;2732.194002769188;2733.8906443742426;5141.871453213699;5229.712365819916;5278.445763194886;5287.259783630295;5289.3652761668845;5203.8178663746585;5224.791008359699;5248.606354523426;5572.60991730575;6000.189974353494;5990.460858522754;6007.339192688801;6014.368491308524;6038.365971572922;6047.969760151259;5823.8835223294445;5846.386129456346;5855.214159681338;5902.144189092472;5911.9012750474685;5570.415106413769;5807.738651760766;5845.912311315419;5850.297964244318;5862.915360658292;5970.611910225822;5984.491318237824;5986.88026239464;5988.640681559121;6010.158577799024;3969.503812023497;4204.579542045771;4215.451991241119;4220.957790422057;4225.788710564521;5819.312399404294;5828.542864283929;5839.182514448065;5842.006858833924;5880.882382352414;5473.2063850742215;5508.44915508462;5684.289463817023;5684.9431505684415;5706.229658996149;5620.8032718856275;5635.4496667099465;5638.182463542681;5639.661620302795;5652.689102099424;5333.266688326387;5581.581381396492;5631.408702086386;5676.51749601272;5709.286339207599;5728.8567785804025;5751.763370875282;5763.567732420001;5782.826515204551;5793.768249269982;5601.7759289629585;5607.130894711327;5641.887162256814;5691.743871525874;5698.430156984268 09:38:35 INFO - PROCESS | 707 | |5;yui.html;716.4197000429652;726.4878260826118;731.7694926098279;747.1669088965798;750.504666919833;15610.297536610851;16056.678866422664;16704.248308826103;16735.916320418397;16842.157892105377;14353;14593.562193134223;14608;14610.780838287434;14635.92682036591;655.6426747422666;800.0559339978852;802.3180296747762;821.876718492228;827.1728271728272;820.9302209312216;828.1470085811624;830.1698301698302;830.2071521696795;831.0442990560842;861.1646702698404;864.1574464896738;865.9783505412352;869.7303835810887;870.0081906626451;691.1050190003932;836.3601844588894;862.2670729879615;864.2394692670441;864.8789169516273;632.2539403503864;632.9905051424232;633.3191818794814;633.9175907132043;634.742929113705;14690.045147065406;14796.40814367424;14820.184889831055;14823.77764333536;14827.555173344817;13918.512852050231;14436;14492.637684057878;14523.419063237458;14709.632259193606;12586.622401327975;12587.622371328875;12740.617781466479;12898.87101128986;13205.47178112884;4380.277254253045;4406.515283318832;4483.887902802423;4519.457665080178;4622.838200662961;73717.6314118426;73748.26251737468;74118.62940685262;74664.25335746627;78036;10206.234532410099;10281.897181028244;10378.169746420268;10462.319949203278;10524.842127368096;19089;19100;19102.80897191038;19138.904305478383;19180.520486987938;8618.612162452704;8711.956440217886;8863.911360886437;8903.053764293569;9174.220191283815;4895.853124406273;5011.498850115032;5046.369203849519;5073.822416215415;5105.540501354822;3543.875964341236;3663.5420572428447;3677.3380791457794;3682.6317368262958;3685.299793039314;606.3178923710825;617.102116420607;617.200725061047;624.6064979063161;627.1502114634695;605.797057985571;641.6374748267214;645.8062581225613;657.7380952380952;674.6188403551978;8249.628766705513;8603.225709686158;8796.780080498038;8892.610758862687;9207.677731279373;496.39687779348264;588.5468189494065;593.3502814418205;597.4413922981939;616.7717944360616;4162.188373267184;4175.54069052404;4216.494020717533;4227.8097485613225;4330.328799036154;111698;112248;113656.43171784088;115358.42320788342;116543.41728291474;99749.50125249327;100289.49855250678;100865.49567252117;101139.49430252802;101820;58167.709161453924;87881;88428;89064;89273.55363223272;7890.526568405914;7964.283214510722;8002.479838810459;8115.634796434293;8163.510189388656;37489.12554372216;48372.758136210505;50588.74705626448;52198;52323.47676523186;69680.30319696738;70399;77662.6116869412;78654.606726966;79664;10510.527026283988;10520.579176832842;10777.892221078002;10892.292001019909;11191.832122518332;11292.774144517229;11418.771624567296;11494.527482044441;11649.650510484698;12070.879291206975;10895.564177432814;11136.554537818396;11332.6033588824;11336.703982199677;11367.829482557934;11032.779344413228;11070.335779853234;11207.943960280147;11383.601573944872;11475;10714.303570267908;10890.78218435611;10898.291611045257;11133.665990020312;11261.380624065756;9310.48792316402;9476.905230947603;9762.316637835283;9987.950060249943;10029.29794914349;9050.592723327334;9288.95355523245;9310.674126405544;9336.673216437392;9394.16872460775 09:38:35 INFO - PROCESS | 707 | __end_tp_report 09:38:35 INFO - PROCESS | 707 | __start_cc_report 09:38:35 INFO - PROCESS | 707 | _x_x_mozilla_cycle_collect,1062 09:38:35 INFO - PROCESS | 707 | __end_cc_report 09:38:35 INFO - PROCESS | 707 | __startTimestamp1467736715902__endTimestamp 09:38:35 INFO - PROCESS | 707 | 09:38:35 INFO - PROCESS | 707 | ------- Summary: start ------- 09:38:35 INFO - PROCESS | 707 | Number of tests: 6 09:38:35 INFO - PROCESS | 707 | 09:38:35 INFO - PROCESS | 707 | [#0] dojo.html Cycles:165 Average:5398.34 Median:5583.25 stddev:630.70 (11.3%) stddev-sans-first:606.30 09:38:35 INFO - PROCESS | 707 | Values: 3099.3 3120.7 3135.2 3151.7 3173.9 5244.0 5308.6 5342.3 5405.5 5417.1 5363.6 5420.3 5437.8 5443.4 5548.3 4874.3 4874.4 4876.5 4979.3 5006.6 4917.2 4975.6 5074.3 5093.0 5094.2 4870.3 4993.6 5008.8 5052.4 5080.3 4854.9 4898.3 4909.0 4932.8 4951.6 4888.5 4904.0 4966.9 4973.9 5024.0 5256.5 5468.8 5488.7 5511.9 5512.6 5790.0 5828.3 5848.3 5893.7 5950.5 5922.3 5938.1 5964.8 5979.0 5995.3 5301.3 5424.9 5553.0 5559.0 5559.1 5969.6 6091.5 6091.6 6094.4 6097.1 5792.3 5793.7 5795.6 5845.9 5855.2 5601.4 5614.6 5742.7 5795.9 5858.9 5749.8 5769.0 5769.7 5771.0 5812.4 5738.4 5754.2 5782.2 5786.4 5789.6 4276.1 4303.2 4356.9 4392.6 4430.6 3909.0 3927.8 3928.2 3951.7 3985.6 5431.5 5469.0 5475.0 5475.1 5522.2 5619.8 5720.8 5773.4 5787.1 5894.8 5429.2 5432.0 5455.3 5458.6 5468.1 4872.3 4873.5 4877.6 4880.3 4915.0 5808.8 5964.6 5982.4 6053.1 6053.3 5924.9 5930.7 5936.3 5938.8 5938.9 6063.8 6072.5 6073.8 6074.9 6095.7 5526.5 5706.9 5715.1 5778.0 5799.5 5877.7 5908.7 5924.4 5930.6 5931.1 5592.3 5722.0 5772.3 5776.4 5788.2 5538.6 5556.6 5583.2 5624.2 5639.9 5586.8 5590.9 5590.9 5591.0 5591.6 5584.0 5593.5 5646.5 5652.3 5714.0 5430.6 5462.5 5482.5 5528.7 5587.4 09:38:35 INFO - PROCESS | 707 | 09:38:35 INFO - PROCESS | 707 | [#1] ext.html Cycles:180 Average:50797.58 Median:388218.00 stddev:87159.76 (22.5%) stddev-sans-first:87322.75 09:38:35 INFO - PROCESS | 707 | Values: 592.7 602.6 614.7 624.7 643.8 33229.8 33858.0 33892.5 43354.6 44921.0 45404.8 45909.3 46076.8 46116.0 46134.8 9020.9 9152.0 9161.6 9167.7 9170.9 8205.5 8945.0 10627.4 10781.7 10815.7 11156.3 11203.5 11208.2 11215.6 11239.3 8176.3 10836.3 10869.1 10889.3 10897.0 10480.1 10990.2 10991.3 11001.0 11280.5 41806.6 42373.8 44479.3 44730.6 44747.2 3580.3 3621.4 3641.1 3716.7 3925.6 32715.5 33516.0 33884.5 33917.5 33981.0 4248.5 4297.7 4306.8 4478.3 4506.4 388325.0 388718.0 391184.0 391504.0 394440.0 65757.3 66254.0 66296.0 66340.0 66347.0 68582.3 69764.0 69977.0 70116.0 70170.3 17154.3 17314.3 17325.9 17329.9 17360.4 12511.8 12570.3 12601.5 12626.4 13688.2 19270.5 20071.8 20299.7 20356.0 20391.9 7133.6 7242.6 7332.6 7425.1 7704.7 953.3 1019.8 1056.4 1063.7 1111.8 31952.5 32602.7 32610.7 32721.5 33156.8 1059.1 1072.7 1099.5 1100.8 1119.9 17006.0 17361.3 17475.8 17518.8 17522.2 157195.0 157412.0 157881.0 159287.0 159633.2 58591.7 58770.7 58809.1 58867.7 59019.0 1182.8 1337.4 1360.7 1380.4 1390.3 32492.8 33912.0 33923.5 34096.3 34121.7 45688.5 45814.0 45869.5 45894.5 45930.0 379800.0 388134.0 388302.0 388706.0 389155.0 36520.6 46063.0 46698.5 47885.5 48451.8 48758.0 49063.5 49183.3 49448.5 50329.5 41828.5 42032.0 42702.4 43422.3 43500.0 42062.8 42179.0 42406.8 42417.4 42798.0 41535.0 41732.6 42089.0 42154.6 42198.8 34492.8 36547.5 36698.8 37058.5 37627.6 28162.5 28280.6 28326.3 28466.6 28479.0 09:38:35 INFO - PROCESS | 707 | 09:38:35 INFO - PROCESS | 707 | [#2] jquery.html Cycles:180 Average:32123.89 Median:28453.57 stddev:83532.69 (293.6%) stddev-sans-first:83733.03 09:38:35 INFO - PROCESS | 707 | Values: 386.7 396.5 409.7 417.6 424.3 13519.1 19740.7 19799.9 19816.0 20712.4 12639.0 12822.9 12961.5 12966.7 12975.9 4028.0 5387.8 5539.2 5540.2 7354.2 7686.8 7737.4 7784.8 7917.2 7941.2 7818.8 7860.6 7868.1 7873.5 7874.3 7473.9 7780.9 7781.5 7797.8 7812.6 6642.7 7076.9 7502.9 7515.6 7547.3 27761.9 28142.9 28195.0 28712.1 28761.7 2657.5 2692.4 2784.8 3137.2 3345.4 16220.8 16516.7 16581.4 16718.7 17209.8 2088.6 2113.9 2156.1 2166.9 2185.8 102579.0 106448.0 107707.5 107734.5 109366.0 18284.0 18510.7 18574.6 18883.8 20490.0 33728.7 33856.5 34026.5 34244.8 34333.8 9908.3 10321.2 10328.8 10417.8 10673.0 8615.6 8677.7 8751.2 8855.1 9193.1 8927.3 9080.2 9166.5 9220.0 9233.5 3148.8 3411.7 3546.8 3645.9 3679.2 873.8 877.0 963.5 993.0 1052.5 19164.8 19827.6 19948.0 20121.9 20269.7 1011.2 1032.3 1050.8 1068.3 1070.8 10562.8 11078.6 11120.6 11151.1 11158.1 495627.0 499557.0 505811.0 507745.0 508352.0 101101.0 101941.5 104039.9 104986.0 105165.0 961.6 981.4 994.5 999.7 1033.2 17117.4 17325.7 17544.5 17564.9 17598.4 42939.6 43674.6 43695.8 45001.3 46021.5 61954.4 62435.4 62738.4 63386.4 63543.4 7821.2 9035.2 9135.1 9180.0 9290.4 12503.1 14341.1 14491.8 14674.6 14799.4 12277.6 12635.9 12636.4 12781.4 12824.7 12198.3 12487.7 12495.8 12626.3 12630.6 12728.4 12820.9 12829.8 12876.9 12920.2 8375.7 8393.7 8415.3 8437.3 8571.9 9305.4 12196.7 12783.2 12840.9 12851.7 09:38:35 INFO - PROCESS | 707 | 09:38:35 INFO - PROCESS | 707 | [#3] mootools.html Cycles:180 Average:6227.10 Median:491.09 stddev:3608.39 (734.8%) stddev-sans-first:3600.81 09:38:35 INFO - PROCESS | 707 | Values: 1471.4 1512.8 1587.0 1715.6 1723.2 9163.9 9686.1 9753.0 9766.4 9781.8 8186.5 8422.2 8426.7 8650.2 9579.6 2337.3 2439.6 2447.6 2454.0 2463.1 2475.5 2487.2 2499.4 2504.0 2526.8 2103.6 2371.3 2460.0 2477.3 2477.5 2440.3 2449.5 2472.5 2478.2 2480.0 2412.2 2483.1 2484.5 2485.1 2485.4 9293.7 9357.8 9358.8 9361.3 9362.2 5564.0 5623.9 5704.6 5713.1 5733.6 3422.7 3429.5 3493.3 3540.2 3550.4 1149.0 1161.6 1162.1 1162.8 1179.9 13221.0 13338.8 13433.5 13441.4 13445.1 4944.4 5019.6 5129.5 5136.2 5167.9 11321.0 11330.9 11332.5 11337.6 11350.1 5662.7 5664.8 5671.8 5672.5 5673.7 5072.9 5100.8 5177.8 5188.9 5256.2 4169.4 4189.4 4192.9 4387.5 4387.9 1304.4 1317.6 1328.4 1337.6 1341.0 991.0 998.4 1005.1 1008.0 1010.2 6231.1 6295.9 6307.4 6424.2 6504.9 456.4 463.1 482.0 488.6 493.6 4180.7 4295.8 4351.1 4487.9 4529.0 11580.5 11948.7 11968.5 11977.1 12007.6 11352.1 11780.2 11793.4 12187.8 12197.8 8605.7 8792.0 8806.9 8809.0 8813.5 6173.1 6380.8 6443.3 6526.4 6534.1 10708.5 10842.8 10863.5 10973.8 11094.3 9841.8 10614.9 11277.3 11291.2 11446.5 8077.4 8122.8 8557.7 8559.5 8563.5 9205.3 9413.4 9453.7 9491.2 9503.1 8053.2 8154.2 8240.7 8249.3 8636.9 8132.3 8183.3 8245.9 8449.2 8482.2 7590.6 7624.6 7649.3 7650.4 7716.0 5382.4 5492.1 5523.5 5591.4 5655.1 5579.7 5732.0 5752.5 5761.8 5771.8 09:38:35 INFO - PROCESS | 707 | 09:38:35 INFO - PROCESS | 707 | [#4] prototype.html Cycles:180 Average:4748.51 Median:5339.29 stddev:1394.92 (26.1%) stddev-sans-first:1358.84 09:38:35 INFO - PROCESS | 707 | Values: 330.1 341.1 350.9 351.5 351.9 5326.0 5431.2 5457.4 5499.3 5538.3 5345.3 5375.8 5390.0 5402.4 5421.7 4240.3 4267.9 4291.7 4292.1 4320.1 4055.8 4092.5 4283.6 4302.5 4309.4 4247.2 4271.0 4277.8 4283.6 4292.6 4261.9 4287.8 4295.2 4301.0 4308.4 3696.0 3809.1 3834.7 3847.2 3847.6 5222.3 5222.6 5226.6 5230.9 5250.2 4882.6 4884.7 4886.0 4886.3 4889.2 5441.9 5623.3 5647.8 5654.3 5661.5 4037.8 4059.6 4063.6 4076.8 4100.1 5884.4 5912.1 5947.3 5954.4 5960.7 3974.5 4161.9 4166.8 4183.6 4198.0 4230.6 4235.9 4242.9 4248.0 4255.5 4842.9 4856.2 4869.9 4870.0 4876.6 5569.1 5708.5 5715.7 5721.4 5787.2 1371.2 1403.8 1409.5 1419.9 1426.5 987.0 1004.4 1007.2 1009.4 1012.8 5153.7 5376.9 5434.2 5439.9 5451.3 5727.7 5734.8 5776.2 5791.0 5811.5 5152.9 5377.5 5398.4 5403.8 5411.8 2693.0 2721.3 2728.3 2732.2 2733.9 5141.9 5229.7 5278.4 5287.3 5289.4 5203.8 5224.8 5248.6 5572.6 6000.2 5990.5 6007.3 6014.4 6038.4 6048.0 5823.9 5846.4 5855.2 5902.1 5911.9 5570.4 5807.7 5845.9 5850.3 5862.9 5970.6 5984.5 5986.9 5988.6 6010.2 3969.5 4204.6 4215.5 4221.0 4225.8 5819.3 5828.5 5839.2 5842.0 5880.9 5473.2 5508.4 5684.3 5684.9 5706.2 5620.8 5635.4 5638.2 5639.7 5652.7 5333.3 5581.6 5631.4 5676.5 5709.3 5728.9 5751.8 5763.6 5782.8 5793.8 5601.8 5607.1 5641.9 5691.7 5698.4 09:38:35 INFO - PROCESS | 707 | 09:38:35 INFO - PROCESS | 707 | [#5] yui.html Cycles:180 Average:20062.75 Median:27817.56 stddev:29846.73 (107.3%) stddev-sans-first:29895.10 09:38:35 INFO - PROCESS | 707 | Values: 716.4 726.5 731.8 747.2 750.5 15610.3 16056.7 16704.2 16735.9 16842.2 14353.0 14593.6 14608.0 14610.8 14635.9 655.6 800.1 802.3 821.9 827.2 820.9 828.1 830.2 830.2 831.0 861.2 864.2 866.0 869.7 870.0 691.1 836.4 862.3 864.2 864.9 632.3 633.0 633.3 633.9 634.7 14690.0 14796.4 14820.2 14823.8 14827.6 13918.5 14436.0 14492.6 14523.4 14709.6 12586.6 12587.6 12740.6 12898.9 13205.5 4380.3 4406.5 4483.9 4519.5 4622.8 73717.6 73748.3 74118.6 74664.3 78036.0 10206.2 10281.9 10378.2 10462.3 10524.8 19089.0 19100.0 19102.8 19138.9 19180.5 8618.6 8712.0 8863.9 8903.1 9174.2 4895.9 5011.5 5046.4 5073.8 5105.5 3543.9 3663.5 3677.3 3682.6 3685.3 606.3 617.1 617.2 624.6 627.2 605.8 641.6 645.8 657.7 674.6 8249.6 8603.2 8796.8 8892.6 9207.7 496.4 588.5 593.4 597.4 616.8 4162.2 4175.5 4216.5 4227.8 4330.3 111698.0 112248.0 113656.4 115358.4 116543.4 99749.5 100289.5 100865.5 101139.5 101820.0 58167.7 87881.0 88428.0 89064.0 89273.6 7890.5 7964.3 8002.5 8115.6 8163.5 37489.1 48372.8 50588.7 52198.0 52323.5 69680.3 70399.0 77662.6 78654.6 79664.0 10510.5 10520.6 10777.9 10892.3 11191.8 11292.8 11418.8 11494.5 11649.7 12070.9 10895.6 11136.6 11332.6 11336.7 11367.8 11032.8 11070.3 11207.9 11383.6 11475.0 10714.3 10890.8 10898.3 11133.7 11261.4 9310.5 9476.9 9762.3 9988.0 10029.3 9050.6 9289.0 9310.7 9336.7 9394.2 09:38:35 INFO - PROCESS | 707 | -------- Summary: end -------- 09:38:35 INFO - PROCESS | 707 | 09:38:36 INFO - TEST-INFO | 707: exit 0 09:38:36 INFO - TEST-OK | dromaeo_css | took 1115029ms 09:38:36 INFO - TEST-START | kraken 09:38:36 INFO - operating with platform_type : linux_ 09:38:36 INFO - Initialising browser for kraken test... 09:38:36 INFO - TEST-INFO | started process 905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIYfk5q/profile http://localhost:42599/getInfo.html) 09:38:41 INFO - PROCESS | 905 | __metrics Screen width/height:1600/1200 09:38:41 INFO - PROCESS | 905 | colorDepth:24 09:38:41 INFO - PROCESS | 905 | Browser inner width/height: 1024/697 09:38:41 INFO - PROCESS | 905 | __metrics 09:38:42 INFO - PROCESS | 905 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:42 INFO - PROCESS | 905 | console.error: PushService: 09:38:42 INFO - PROCESS | 905 | stateChangeProcessEnqueue: Error transitioning state 09:38:42 INFO - PROCESS | 905 | UnknownError 09:38:43 INFO - TEST-INFO | 905: exit 0 09:38:43 INFO - Browser initialized. 09:38:43 INFO - Running cycle 1/1 for kraken test... 09:38:43 INFO - TEST-INFO | started process 989 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIYfk5q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:55 INFO - PROCESS | 989 | RSS: Main: 157089792 09:38:55 INFO - PROCESS | 989 | 09:38:57 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42599/tests/kraken/driver.html?testName=audio-beat-detection) 09:38:58 INFO - PROCESS | 989 | RSS: Main: 215617536 09:38:58 INFO - PROCESS | 989 | 09:39:01 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42599/tests/kraken/driver.html?testName=audio-dft) 09:39:01 INFO - PROCESS | 989 | RSS: Main: 203321344 09:39:01 INFO - PROCESS | 989 | 09:39:04 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42599/tests/kraken/driver.html?testName=audio-fft) 09:39:05 INFO - PROCESS | 989 | RSS: Main: 270209024 09:39:05 INFO - PROCESS | 989 | 09:39:07 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42599/tests/kraken/driver.html?testName=audio-oscillator) 09:39:07 INFO - PROCESS | 989 | RSS: Main: 180158464 09:39:07 INFO - PROCESS | 989 | 09:39:10 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42599/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:39:10 INFO - PROCESS | 989 | RSS: Main: 184135680 09:39:10 INFO - PROCESS | 989 | 09:39:13 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42599/tests/kraken/driver.html?testName=imaging-darkroom) 09:39:14 INFO - PROCESS | 989 | RSS: Main: 220512256 09:39:14 INFO - PROCESS | 989 | 09:39:17 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42599/tests/kraken/driver.html?testName=imaging-desaturate) 09:39:18 INFO - PROCESS | 989 | RSS: Main: 221888512 09:39:18 INFO - PROCESS | 989 | 09:39:20 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42599/tests/kraken/driver.html?testName=json-parse-financial) 09:39:21 INFO - PROCESS | 989 | RSS: Main: 221511680 09:39:21 INFO - PROCESS | 989 | 09:39:23 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42599/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:39:23 INFO - PROCESS | 989 | RSS: Main: 208572416 09:39:23 INFO - PROCESS | 989 | 09:39:25 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42599/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:39:25 INFO - PROCESS | 989 | RSS: Main: 213909504 09:39:25 INFO - PROCESS | 989 | 09:39:27 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42599/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:28 INFO - PROCESS | 989 | RSS: Main: 212123648 09:39:28 INFO - PROCESS | 989 | 09:39:31 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42599/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:31 INFO - PROCESS | 989 | RSS: Main: 223940608 09:39:31 INFO - PROCESS | 989 | 09:39:34 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42599/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:35 INFO - PROCESS | 989 | RSS: Main: 225169408 09:39:35 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | Cycle 1(1): loaded http://localhost:42599/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42599/tests/kraken/driver.html?testName=ai-astar) 09:39:36 INFO - PROCESS | 989 | RSS: Main: 267579392 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | __start_tp_report 09:39:36 INFO - PROCESS | 989 | _x_x_mozilla_page_load 09:39:36 INFO - PROCESS | 989 | _x_x_mozilla_page_load_details 09:39:36 INFO - PROCESS | 989 | |i|pagename|runs| 09:39:36 INFO - PROCESS | 989 | |0;ai-astar;103;113;110;110;111;110;111;111;111;111 09:39:36 INFO - PROCESS | 989 | |1;audio-beat-detection;157;117;119;167;122;117;145;121;153;124 09:39:36 INFO - PROCESS | 989 | |2;audio-dft;162;162;162;160;161;162;160;161;162;162 09:39:36 INFO - PROCESS | 989 | |3;audio-fft;75;74;75;122;74;80;76;76;99;75 09:39:36 INFO - PROCESS | 989 | |4;audio-oscillator;86;84;111;84;84;84;116;83;83;126 09:39:36 INFO - PROCESS | 989 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;116;116 09:39:36 INFO - PROCESS | 989 | |6;imaging-darkroom;146;146;146;146;147;145;146;146;145;145 09:39:36 INFO - PROCESS | 989 | |7;imaging-desaturate;95;96;95;96;95;95;95;95;96;95 09:39:36 INFO - PROCESS | 989 | |8;json-parse-financial;53;52;53;52;51;53;53;53;51;53 09:39:36 INFO - PROCESS | 989 | |9;json-stringify-tinderbox;60;61;61;61;60;61;61;61;60;61 09:39:36 INFO - PROCESS | 989 | |10;stanford-crypto-aes;79;75;80;84;74;75;77;75;74;84 09:39:36 INFO - PROCESS | 989 | |11;stanford-crypto-ccm;123;121;120;116;127;120;144;120;159;119 09:39:36 INFO - PROCESS | 989 | |12;stanford-crypto-pbkdf2;159;161;158;154;154;161;157;161;154;154 09:39:36 INFO - PROCESS | 989 | |13;stanford-crypto-sha256-iterative;63;63;64;62;62;61;64;66;62;61 09:39:36 INFO - PROCESS | 989 | __end_tp_report 09:39:36 INFO - PROCESS | 989 | __start_cc_report 09:39:36 INFO - PROCESS | 989 | _x_x_mozilla_cycle_collect,1618 09:39:36 INFO - PROCESS | 989 | __end_cc_report 09:39:36 INFO - PROCESS | 989 | __startTimestamp1467736776951__endTimestamp 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | ------- Summary: start ------- 09:39:36 INFO - PROCESS | 989 | Number of tests: 14 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.64 (2.4%) stddev-sans-first:0.93 09:39:36 INFO - PROCESS | 989 | Values: 103.0 113.0 110.0 110.0 111.0 110.0 111.0 111.0 111.0 111.0 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:134.50 stddev:19.19 (14.3%) stddev-sans-first:18.50 09:39:36 INFO - PROCESS | 989 | Values: 157.0 117.0 119.0 167.0 122.0 117.0 145.0 121.0 153.0 124.0 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 09:39:36 INFO - PROCESS | 989 | Values: 162.0 162.0 162.0 160.0 161.0 162.0 160.0 161.0 162.0 162.0 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#3] audio-fft Cycles:10 Average:82.60 Median:75.50 stddev:15.76 (20.9%) stddev-sans-first:16.48 09:39:36 INFO - PROCESS | 989 | Values: 75.0 74.0 75.0 122.0 74.0 80.0 76.0 76.0 99.0 75.0 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:84.00 stddev:16.68 (19.9%) stddev-sans-first:17.43 09:39:36 INFO - PROCESS | 989 | Values: 86.0 84.0 111.0 84.0 84.0 84.0 116.0 83.0 83.0 126.0 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:39:36 INFO - PROCESS | 989 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 116.0 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 09:39:36 INFO - PROCESS | 989 | Values: 146.0 146.0 146.0 146.0 147.0 145.0 146.0 146.0 145.0 145.0 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:39:36 INFO - PROCESS | 989 | Values: 95.0 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#8] json-parse-financial Cycles:10 Average:52.40 Median:53.00 stddev:0.84 (1.6%) stddev-sans-first:0.87 09:39:36 INFO - PROCESS | 989 | Values: 53.0 52.0 53.0 52.0 51.0 53.0 53.0 53.0 51.0 53.0 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:61.00 stddev:0.48 (0.8%) stddev-sans-first:0.44 09:39:36 INFO - PROCESS | 989 | Values: 60.0 61.0 61.0 61.0 60.0 61.0 61.0 61.0 60.0 61.0 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:78.00 stddev:3.89 (5.0%) stddev-sans-first:4.10 09:39:36 INFO - PROCESS | 989 | Values: 79.0 75.0 80.0 84.0 74.0 75.0 77.0 75.0 74.0 84.0 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:122.00 stddev:13.73 (11.3%) stddev-sans-first:14.49 09:39:36 INFO - PROCESS | 989 | Values: 123.0 121.0 120.0 116.0 127.0 120.0 144.0 120.0 159.0 119.0 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.30 Median:158.50 stddev:3.13 (2.0%) stddev-sans-first:3.26 09:39:36 INFO - PROCESS | 989 | Values: 159.0 161.0 158.0 154.0 154.0 161.0 157.0 161.0 154.0 154.0 09:39:36 INFO - PROCESS | 989 | 09:39:36 INFO - PROCESS | 989 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.55 (2.5%) stddev-sans-first:1.64 09:39:36 INFO - PROCESS | 989 | Values: 63.0 63.0 64.0 62.0 62.0 61.0 64.0 66.0 62.0 61.0 09:39:36 INFO - PROCESS | 989 | -------- Summary: end -------- 09:39:36 INFO - PROCESS | 989 | 09:39:37 INFO - TEST-INFO | 989: exit 0 09:39:37 INFO - TEST-OK | kraken | took 61307ms 09:39:37 INFO - SUITE-END | took 1176s 09:39:38 INFO - Completed test suite (00:19:36) 09:39:38 INFO - javascript benchmark 09:39:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3099.302656902197, 3120.6567277599474, 3135.2005238664137, 3151.653318135006, 3173.9365212695748, 5244.0, 5308.628396012281, 5342.278792363029, 5405.54052905503, 5417.079096553591, 5363.570914326854, 5420.268263784388, 5437.782488700457, 5443.428440013801, 5548.334199896008, 4874.2688596710595, 4874.366332376804, 4876.512348765131, 4979.302897594331, 5006.5744411725045, 4917.237828136645, 4975.626827987898, 5074.2895994560795, 5093.032323858473, 5094.235864620318, 4870.293807397943, 4993.575546078551, 5008.774605142778, 5052.393712754475, 5080.339555857733, 4854.927176092326, 4898.314236006926, 4908.9754551227015, 4932.80268789248, 4951.603871690256, 4888.535589119028, 4904.0437114762635, 4966.87582810429, 4973.875653108665, 5024.045431368028, 5256.526912577886, 5468.835934921959, 5488.69812160331, 5511.889762204773, 5512.614117011811, 5789.971050144764, 5828.300603927556, 5848.3274423441, 5893.705314734246, 5950.464458198783, 5922.318933322636, 5938.079597662369, 5964.821055368346, 5979.0134627786365, 5995.340512543617, 5301.284326615934, 5424.918626220609, 5553.000459917213, 5559.0, 5559.110542313251, 5969.611975221596, 6091.482224011009, 6091.604045737013, 6094.421030002142, 6097.085437184369, 5792.333881603585, 5793.710314484259, 5795.594308398456, 5845.88308233833, 5855.209546711225, 5601.411851755588, 5614.63504872182, 5742.712864356849, 5795.88408231833, 5858.94141058584, 5749.7700091996685, 5768.971155144198, 5769.68266745333, 5770.971145144247, 5812.447817457335, 5738.426157384311, 5754.1944127822135, 5782.190493330937, 5786.392428795, 5789.623674461147, 4276.144771045803, 4303.160883627663, 4356.934645980313, 4392.604665580113, 4430.579094985971, 3909.042284640281, 3927.8036098194975, 3928.1554465789422, 3951.7036222283446, 3985.5815139410524, 5431.511163995259, 5469.042917489423, 5474.972625136928, 5475.123980163155, 5522.199281104297, 5619.775208991595, 5720.799772007959, 5773.39379365169, 5787.102999035156, 5894.793682221101, 5429.158480435539, 5431.972840135853, 5455.290812194468, 5458.563314934796, 5468.097763868917, 4872.269159626085, 4873.463918968911, 4877.6341774367065, 4880.341153944172, 4914.975425122923, 5808.82573522795, 5964.582479226413, 5982.4017598239825, 6053.122297266872, 6053.303870055, 5924.8815023700145, 5930.733117009831, 5936.257967754031, 5938.8218353449465, 5938.910916336172, 6063.757449701962, 6072.483838873745, 6073.757049717962, 6074.878502430015, 6095.664738439428, 5526.50261476469, 5706.914396284142, 5715.085586306171, 5777.971110144423, 5799.536037117105, 5877.735501902339, 5908.675022873783, 5924.437178468039, 5930.584859059824, 5931.110333449845, 5592.3009623797025, 5721.971390143022, 5772.307323121252, 5776.364599893925, 5788.218590490398, 5538.584606154474, 5556.555475561864, 5583.2462617547735, 5624.184493248538, 5639.8590035249445, 5586.832395028156, 5590.916136257878, 5590.944090559043, 5591.0, 5591.580631452576, 5584.0, 5593.468620481048, 5646.548276137817, 5652.3217213934595, 5714.0, 5430.592705547178, 5462.508374246178, 5482.451754824486, 5528.668279903058, 5587.357453892854], "value": 5354.805267731974, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.7391947543081, 602.6444397805294, 614.7141579165689, 624.7219987105734, 643.8422586466313, 33229.83385083074, 33858.0, 33892.4916126258, 43354.56645433545, 44921.0, 45404.77297613507, 45909.31136032962, 46076.769616151956, 46116.0, 46134.76932615341, 9020.909790902106, 9151.954240228823, 9161.633534658638, 9167.679131230409, 9170.86243706345, 8205.548694821782, 8944.955275223614, 10627.41549214793, 10781.730456738605, 10815.67552973412, 11156.330620162817, 11203.495842687098, 11208.159388045888, 11215.551377944872, 11239.325640461557, 8176.3458923286, 10836.349819010846, 10869.076128529085, 10889.292196007313, 10897.019268265854, 10480.109190718798, 10990.17573681977, 10991.340519568852, 11001.0, 11280.548778048867, 41806.581934180576, 42373.78813105945, 44479.33281000787, 44730.552694472965, 44747.21011159582, 3580.2660454606744, 3621.4205727083804, 3641.14433108222, 3716.7026637868908, 3925.6332188896854, 32715.50926736101, 33515.99452016444, 33884.49173262403, 33917.49123763145, 33981.0, 4248.490181178247, 4297.699161058727, 4306.80619372129, 4478.283474644074, 4506.436695413074, 388325.0, 388718.0, 391184.0, 391504.0, 394440.02779986203, 65757.34242657608, 66254.0, 66296.0, 66340.0, 66347.0, 68582.31417685859, 69764.0, 69977.0, 70116.0, 70170.29829701739, 17154.313827446764, 17314.30742770275, 17325.913370433067, 17329.873558218675, 17360.39238626642, 12511.812322815165, 12570.308633025272, 12601.495940162475, 12626.368681565886, 13688.247146407044, 19270.49518975385, 20071.799282007287, 20299.695504567444, 20356.0, 20391.898040509703, 7133.571985680772, 7242.565446073252, 7332.560046397233, 7425.1461081975185, 7704.691812327556, 953.2945620241111, 1019.7909428567126, 1056.4189695667353, 1063.7340664833791, 1111.77208672222, 31952.520712189336, 32602.673973259964, 32610.673893260762, 32721.509177362357, 33156.83421582876, 1059.0838924330399, 1072.667473083331, 1099.4997276239292, 1100.8238681810872, 1119.8936101070385, 17006.0, 17361.30554777795, 17475.82524174742, 17518.757982119958, 17522.21150048251, 157195.0, 157412.0, 157881.0, 159287.0, 159633.2018339924, 58591.70704146537, 58770.70614646985, 58809.11786323209, 58867.70566147142, 59019.0, 1182.8462299900957, 1337.4315915735774, 1360.6598350412396, 1380.4064252371577, 1390.2978995606952, 32492.83753581217, 33912.0, 33923.49114763231, 34096.31807363888, 34121.65878341185, 45688.54311456843, 45814.0, 45869.54130458653, 45894.541054590365, 45930.0, 379800.0, 388134.0, 388302.0, 388706.0, 389155.0, 36520.63479365173, 46063.01180846468, 46698.53301467078, 47885.5211447895, 48451.75774121107, 48758.0, 49063.50936490589, 49183.26225106555, 49448.50551494439, 50329.49670503248, 41828.51657993016, 42032.0, 42702.359464607434, 43422.34866476942, 43500.0, 42062.84528660301, 42179.0, 42406.78796605997, 42417.36373954331, 42798.0, 41535.0, 41732.58267417408, 42089.0, 42154.578454216295, 42198.78900605477, 34492.82753586216, 36547.45178822373, 36698.8165059173, 37058.54763544205, 37627.62372376351, 28162.524922920322, 28280.598356766146, 28326.291842704097, 28466.57300140458, 28479.0], "value": 20411.424864314708, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.6732610943755, 396.4766508209165, 409.66816878328547, 417.5886751549724, 424.29143330637834, 13519.139700078922, 19740.703889441633, 19799.901000494996, 19816.0, 20712.378628641127, 12639.0, 12822.871771282284, 12961.481540738383, 12966.740665186691, 12975.93512032441, 4027.9798601006955, 5387.78448862046, 5539.169124631298, 5540.196671482632, 7354.154272258678, 7686.769396918074, 7737.41969352298, 7784.844303113934, 7917.247861453182, 7941.16617755136, 7818.843623127563, 7860.567668778215, 7868.134505204423, 7873.488223265469, 7874.251946065143, 7473.887891681602, 7780.8832867507035, 7781.455298129134, 7797.766067017942, 7812.6093695315, 6642.667866606698, 7076.9292307076785, 7502.887456688154, 7515.586642734647, 7547.32074113327, 27761.86119069412, 28142.859285703646, 28195.0, 28712.138635840958, 28761.71238287632, 2657.5349313869997, 2692.421129457176, 2784.763295119917, 3137.1843320736543, 3345.414552453311, 16220.756688649679, 16516.669666606602, 16581.419650312302, 16718.66562668752, 17209.827901720946, 2088.571842772228, 2113.926012589552, 2156.0836644426213, 2166.880821554814, 2185.7651670414084, 102579.0, 106448.0, 107707.46146269297, 107734.46132769286, 109366.0, 18284.0, 18510.722339164924, 18574.641411364668, 18883.80695308801, 20490.0, 33728.66271337255, 33856.49215261773, 34026.48960265598, 34244.82877585646, 34333.82833085819, 9908.256880733974, 10321.17090071556, 10328.793424131476, 10417.791644167075, 10673.039426451502, 8615.61229744663, 8677.652893884175, 8751.168638979287, 8855.114488551093, 9193.126652967958, 8927.33045021626, 9080.22818060459, 9166.49584272858, 9219.953900230455, 9233.53832308382, 3148.795328303653, 3411.658834116618, 3546.8226588670977, 3645.927081458356, 3679.2273622539565, 873.7771868173575, 876.9693060742843, 963.5423173992438, 992.98715310383, 1052.5368837711535, 19164.8083519163, 19827.60344793096, 19948.0, 20121.896388070025, 20269.695954560695, 1011.2062031305537, 1032.256775121911, 1050.7583255851043, 1068.2628985999636, 1070.7858428314369, 10562.841557376645, 11078.556857725762, 11120.555177792798, 11151.052160566443, 11158.107351411867, 495627.0, 499557.0, 505811.0, 507745.0, 508352.0, 101101.0, 101941.49029254806, 104039.86883672584, 104986.0, 105165.0, 961.624966263158, 981.3621146254991, 994.4629899854142, 999.6751055906859, 1033.188946676855, 17117.400890968755, 17325.74011389805, 17544.473665790047, 17564.91217543904, 17598.38405655796, 42939.570604293556, 43674.56325436705, 43695.781521093464, 45001.32498012598, 46021.53978460172, 61954.38045619666, 62435.37564624296, 62738.445110845954, 63386.366136338045, 63543.364566353746, 7821.178776228641, 9035.232005279624, 9135.132162444557, 9179.954100229455, 9290.442573445345, 12503.124781265224, 14341.139531628136, 14491.78262326087, 14674.633134171305, 14799.408023678932, 12277.570285039981, 12635.87364126347, 12636.431360588611, 12781.424835882222, 12824.679383015125, 12198.268103913439, 12487.687807804878, 12495.750084998432, 12626.305553194663, 12630.621081367573, 12728.427220774902, 12820.871791281968, 12829.807552886901, 12876.871231287567, 12920.22478651284, 8375.748727538183, 8393.748187554384, 8415.326773857954, 8437.325013998989, 8571.914280857112, 9305.395149315273, 12196.695082623006, 12783.16909400886, 12840.871591283967, 12851.742965140458], "value": 10795.565760656298, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.4261438039166, 1512.8487151284871, 1586.9523914282568, 1715.6054107555262, 1723.2073246306697, 9163.862542061866, 9686.079822416878, 9753.0, 9766.414015159087, 9781.7554561136, 8186.54973976431, 8422.241998220159, 8426.705065322714, 8650.178233067849, 9579.616815327396, 2337.2871274261342, 2439.6462512935614, 2447.596146635803, 2453.950920981579, 2463.1379017343966, 2475.517274131545, 2487.2413913756295, 2499.3626625210636, 2503.987480062597, 2526.823122381434, 2103.57928414317, 2371.312319427364, 2459.963100553493, 2477.318737347226, 2477.4549599088173, 2440.3045132137345, 2449.497852940161, 2472.4807790364043, 2478.1945867592926, 2480.0, 2412.19191570824, 2483.0688491815567, 2484.4534202475425, 2485.0805202075167, 2485.3538080099124, 9293.674721384787, 9357.76605584859, 9358.812823743556, 9361.297902657328, 9362.157405833439, 5564.0, 5623.915641265385, 5704.629199102045, 5713.114467257582, 5733.569982251348, 3422.7261819054415, 3429.4684323929832, 3493.2664140530264, 3540.2388486475274, 3550.414181660023, 1148.9597864074717, 1161.5760247509597, 1162.0773754008676, 1162.8197629367462, 1179.9233049851732, 13221.0, 13338.799918001238, 13433.529826456124, 13441.395137218946, 13445.126066805626, 4944.381952255968, 5019.648624596316, 5129.512696293846, 5136.203888397305, 5167.9224811627855, 11321.037711794424, 11330.886691132982, 11332.546698132148, 11337.603183888525, 11350.09199264057, 5662.716864156858, 5664.830055098354, 5671.801486948019, 5672.461116193955, 5673.659580425187, 5072.873178170576, 5100.821471248489, 5177.844664660066, 5188.870278243074, 5256.237845512455, 4169.395437661522, 4189.4344263524035, 4192.895177620523, 4387.451568553931, 4387.890302742457, 1304.4260525368807, 1317.5586178630074, 1328.4022190014532, 1337.6321511584392, 1340.9664758380923, 990.9554070066864, 998.4109375468508, 1005.1255407795265, 1007.9798404031878, 1010.2372708605103, 6231.127642130105, 6295.905561416583, 6307.400796924285, 6424.229092508929, 6504.869902601921, 456.39983421800224, 463.10158292911643, 481.9662623616313, 488.6237597050251, 493.5631965710372, 4180.749155050707, 4295.763732994653, 4351.129774045204, 4487.910241795211, 4528.980979279636, 11580.478878450322, 11948.701282468008, 11968.521259149536, 11977.101717371057, 12007.579734709243, 11352.14858885587, 11780.175387722777, 11793.351365674971, 12187.756244875052, 12197.817032744517, 8605.65577376898, 8791.956040219886, 8806.86789698155, 8808.999999999873, 8813.471191728517, 6173.135760993375, 6380.808575742735, 6443.291237963914, 6526.4452521536205, 6534.052562378523, 10708.518116684612, 10842.78314433691, 10863.456827158452, 10973.780524389627, 11094.278871873303, 9841.803163936538, 10614.89385106139, 11277.266977646426, 11291.153163512934, 11446.484908179318, 8077.394195435249, 8122.796930076795, 8557.657693692183, 8559.486430814171, 8563.48619082832, 9205.30960177976, 9413.435193888388, 9453.669121580986, 9491.193248573949, 9503.097205765442, 8053.1946805319, 8154.184581542036, 8240.711575094843, 8249.29880960125, 8636.913630863863, 8132.3494120471405, 8183.304419124441, 8245.917540824756, 8449.23956843887, 8482.236598706146, 7590.582517961565, 7624.618769061635, 7649.273319034683, 7650.387968962581, 7715.961420192863, 5382.407935127055, 5492.148716948879, 5523.530499907552, 5591.440855914539, 5655.066913959316, 5579.69311687861, 5731.971340143439, 5752.539796816328, 5761.798337058183, 5771.797987070432], "value": 4860.646479827241, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.10212222754103, 341.09779632871056, 350.85439542589825, 351.497358776949, 351.8997085830539, 5325.973370133144, 5431.212474191249, 5457.372402173752, 5499.285092937913, 5538.280023596932, 5345.305110335651, 5375.817320189552, 5389.973050134754, 5402.432744561824, 5421.728913554326, 4240.32154855224, 4267.935980960288, 4291.656667466611, 4292.120115376356, 4320.07118469529, 4055.756654600719, 4092.5498195198506, 4283.614474697277, 4302.505211900624, 4309.396684464177, 4247.235497610429, 4270.996315865769, 4277.828886844538, 4283.550227226143, 4292.570742925698, 4261.914761704764, 4287.8284868605215, 4295.162443323553, 4301.0, 4308.4399028126145, 3696.0020794385364, 3809.142942837867, 3834.6740527055235, 3847.172857835551, 3847.5960024197334, 5222.32109825724, 5222.582193424517, 5226.634135610509, 5230.913760881099, 5250.18622113573, 4882.584980276681, 4884.7069175849565, 4885.951140488585, 4886.267059941002, 4889.242167464049, 5441.891162176774, 5623.26897503326, 5647.830565083054, 5654.293213348332, 5661.547076233933, 4037.759043730728, 4059.553449120624, 4063.553009168989, 4076.8369265229653, 4100.138970816132, 5884.440268483224, 5912.14273930282, 5947.316058653267, 5954.374790646963, 5960.731767070492, 3974.503187101612, 4161.91676166475, 4166.7708276045105, 4183.6234738873645, 4197.958020419818, 4230.61924426803, 4235.919840440668, 4242.936355954663, 4248.044190057212, 4255.510616279105, 4842.878928026827, 4856.198727210041, 4869.853904382874, 4869.9513004870205, 4876.634252431082, 5569.136783798518, 5708.514776243983, 5715.714214289269, 5721.427857214246, 5787.218725472091, 1371.2389623758909, 1403.7964495148146, 1409.4503143773936, 1419.9432022718975, 1426.543506078045, 987.0327079462168, 1004.4029992312259, 1007.2495990487134, 1009.3893194617298, 1012.8227560176939, 5153.7165455900285, 5376.91934620981, 5434.212039254286, 5439.945600544023, 5451.345838499326, 5727.684977326204, 5734.799282025109, 5776.191333213354, 5791.044477661223, 5811.535077193815, 5152.948470515322, 5377.467421784772, 5398.433164517748, 5403.810866619728, 5411.83764487066, 2692.990128701737, 2721.333273348003, 2728.31792051987, 2732.194002769188, 2733.8906443742426, 5141.871453213699, 5229.712365819916, 5278.445763194886, 5287.259783630295, 5289.3652761668845, 5203.8178663746585, 5224.791008359699, 5248.606354523426, 5572.60991730575, 6000.189974353494, 5990.460858522754, 6007.339192688801, 6014.368491308524, 6038.365971572922, 6047.969760151259, 5823.8835223294445, 5846.386129456346, 5855.214159681338, 5902.144189092472, 5911.9012750474685, 5570.415106413769, 5807.738651760766, 5845.912311315419, 5850.297964244318, 5862.915360658292, 5970.611910225822, 5984.491318237824, 5986.88026239464, 5988.640681559121, 6010.158577799024, 3969.503812023497, 4204.579542045771, 4215.451991241119, 4220.957790422057, 4225.788710564521, 5819.312399404294, 5828.542864283929, 5839.182514448065, 5842.006858833924, 5880.882382352414, 5473.2063850742215, 5508.44915508462, 5684.289463817023, 5684.9431505684415, 5706.229658996149, 5620.8032718856275, 5635.4496667099465, 5638.182463542681, 5639.661620302795, 5652.689102099424, 5333.266688326387, 5581.581381396492, 5631.408702086386, 5676.51749601272, 5709.286339207599, 5728.8567785804025, 5751.763370875282, 5763.567732420001, 5782.826515204551, 5793.768249269982, 5601.7759289629585, 5607.130894711327, 5641.887162256814, 5691.743871525874, 5698.430156984268], "value": 4306.098075176048, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.4197000429652, 726.4878260826118, 731.7694926098279, 747.1669088965798, 750.504666919833, 15610.297536610851, 16056.678866422664, 16704.248308826103, 16735.916320418397, 16842.157892105377, 14353.0, 14593.562193134223, 14608.0, 14610.780838287434, 14635.92682036591, 655.6426747422666, 800.0559339978852, 802.3180296747762, 821.876718492228, 827.1728271728272, 820.9302209312216, 828.1470085811624, 830.1698301698302, 830.2071521696795, 831.0442990560842, 861.1646702698404, 864.1574464896738, 865.9783505412352, 869.7303835810887, 870.0081906626451, 691.1050190003932, 836.3601844588894, 862.2670729879615, 864.2394692670441, 864.8789169516273, 632.2539403503864, 632.9905051424232, 633.3191818794814, 633.9175907132043, 634.742929113705, 14690.045147065406, 14796.40814367424, 14820.184889831055, 14823.77764333536, 14827.555173344817, 13918.512852050231, 14436.0, 14492.637684057878, 14523.419063237458, 14709.632259193606, 12586.622401327975, 12587.622371328875, 12740.617781466479, 12898.87101128986, 13205.47178112884, 4380.277254253045, 4406.515283318832, 4483.887902802423, 4519.457665080178, 4622.838200662961, 73717.6314118426, 73748.26251737468, 74118.62940685262, 74664.25335746627, 78036.0, 10206.234532410099, 10281.897181028244, 10378.169746420268, 10462.319949203278, 10524.842127368096, 19089.0, 19100.0, 19102.80897191038, 19138.904305478383, 19180.520486987938, 8618.612162452704, 8711.956440217886, 8863.911360886437, 8903.053764293569, 9174.220191283815, 4895.853124406273, 5011.498850115032, 5046.369203849519, 5073.822416215415, 5105.540501354822, 3543.875964341236, 3663.5420572428447, 3677.3380791457794, 3682.6317368262958, 3685.299793039314, 606.3178923710825, 617.102116420607, 617.200725061047, 624.6064979063161, 627.1502114634695, 605.797057985571, 641.6374748267214, 645.8062581225613, 657.7380952380952, 674.6188403551978, 8249.628766705513, 8603.225709686158, 8796.780080498038, 8892.610758862687, 9207.677731279373, 496.39687779348264, 588.5468189494065, 593.3502814418205, 597.4413922981939, 616.7717944360616, 4162.188373267184, 4175.54069052404, 4216.494020717533, 4227.8097485613225, 4330.328799036154, 111698.0, 112248.0, 113656.43171784088, 115358.42320788342, 116543.41728291474, 99749.50125249327, 100289.49855250678, 100865.49567252117, 101139.49430252802, 101820.0, 58167.709161453924, 87881.0, 88428.0, 89064.0, 89273.55363223272, 7890.526568405914, 7964.283214510722, 8002.479838810459, 8115.634796434293, 8163.510189388656, 37489.12554372216, 48372.758136210505, 50588.74705626448, 52198.0, 52323.47676523186, 69680.30319696738, 70399.0, 77662.6116869412, 78654.606726966, 79664.0, 10510.527026283988, 10520.579176832842, 10777.892221078002, 10892.292001019909, 11191.832122518332, 11292.774144517229, 11418.771624567296, 11494.527482044441, 11649.650510484698, 12070.879291206975, 10895.564177432814, 11136.554537818396, 11332.6033588824, 11336.703982199677, 11367.829482557934, 11032.779344413228, 11070.335779853234, 11207.943960280147, 11383.601573944872, 11475.0, 10714.303570267908, 10890.78218435611, 10898.291611045257, 11133.665990020312, 11261.380624065756, 9310.48792316402, 9476.905230947603, 9762.316637835283, 9987.950060249943, 10029.29794914349, 9050.592723327334, 9288.95355523245, 9310.674126405544, 9336.673216437392, 9394.16872460775], "value": 7146.685896527219, "unit": "score"}], "name": "dromaeo_css", "value": 7489.712024352423, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 110.0, 110.0, 111.0, 110.0, 111.0, 111.0, 111.0, 111.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 117.0, 119.0, 167.0, 122.0, 117.0, 145.0, 121.0, 153.0, 124.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 160.0, 161.0, 162.0, 160.0, 161.0, 162.0, 162.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 122.0, 74.0, 80.0, 76.0, 76.0, 99.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 111.0, 84.0, 84.0, 84.0, 116.0, 83.0, 83.0, 126.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 145.0, 146.0, 146.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 52.0, 51.0, 53.0, 53.0, 53.0, 51.0, 53.0], "value": 52.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 60.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 80.0, 84.0, 74.0, 75.0, 77.0, 75.0, 74.0, 84.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 121.0, 120.0, 116.0, 127.0, 120.0, 144.0, 120.0, 159.0, 119.0], "value": 126.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 161.0, 158.0, 154.0, 154.0, 161.0, 157.0, 161.0, 154.0, 154.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 62.0, 62.0, 61.0, 64.0, 66.0, 62.0, 61.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1478.1, "alertThreshold": 2.0}]} 09:39:38 INFO - Return code: 0 09:39:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:38 INFO - # TBPL SUCCESS # 09:39:38 INFO - Running post-action listener: _resource_record_post_action 09:39:38 INFO - ##### 09:39:38 INFO - ##### Finished run-tests step (success) 09:39:38 INFO - ##### 09:39:38 INFO - Running post-run listener: _resource_record_post_run 09:39:38 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 0; Write bytes: 566722560; Read time: 0; Write time: 940300 09:39:38 INFO - TinderboxPrint: CPU usage
13.0% 09:39:38 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:39:38 INFO - TinderboxPrint: I/O write bytes / time
566,722,560 / 940,300 09:39:38 INFO - TinderboxPrint: CPU idle
8,286.0 (86.9%) 09:39:38 INFO - TinderboxPrint: CPU user
1,195.0 (12.5%) 09:39:38 INFO - TinderboxPrint: Swap in / out
0 / 0 09:39:38 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 272527360; Read time: 0; Write time: 466892 09:39:38 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 294195200; Read time: 0; Write time: 473408 09:39:38 INFO - Running post-run listener: _upload_blobber_files 09:39:38 INFO - Blob upload gear active. 09:39:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:38 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:39:38 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:39:38 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:39:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:42 INFO - (blobuploader) - INFO - Done attempting. 09:39:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:39:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:39:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:43 INFO - (blobuploader) - INFO - Done attempting. 09:39:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:39:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:39:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:44 INFO - (blobuploader) - INFO - Done attempting. 09:39:44 INFO - (blobuploader) - INFO - Iteration through files over. 09:39:44 INFO - Return code: 0 09:39:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1b233a2668c5b7e2c92dcde8d8dcf5c1d107c5f4c84ee55606473110bb8e331ccb9ef7e28ab56e010dae4811f39d2dc7dc243f66de501fe15d651e2477c19fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb1a31feca1476941aaea6b04317d0e615541fd84fd6a9a52f29d0356b7650e02e2856118b2856bc475a811d93156e03c61737b9e0a0c0154f2c58a9e1e6123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/caeec73f0c1f996bc146908702e87d2a7baf59cbad9f63c14d14811bf5953586800ff9b06fc5855ae06961fee09767c8a96b497c2c1fc5506d6671dffab7fea9"} 09:39:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:44 INFO - Contents: 09:39:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a1b233a2668c5b7e2c92dcde8d8dcf5c1d107c5f4c84ee55606473110bb8e331ccb9ef7e28ab56e010dae4811f39d2dc7dc243f66de501fe15d651e2477c19fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb1a31feca1476941aaea6b04317d0e615541fd84fd6a9a52f29d0356b7650e02e2856118b2856bc475a811d93156e03c61737b9e0a0c0154f2c58a9e1e6123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/caeec73f0c1f996bc146908702e87d2a7baf59cbad9f63c14d14811bf5953586800ff9b06fc5855ae06961fee09767c8a96b497c2c1fc5506d6671dffab7fea9"} 09:39:44 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:44 INFO - Copying logs to upload dir... 09:39:44 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.282545 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 32 secs) (at 2016-07-05 09:39:44.409512) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:39:44.412704) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777 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/sha512/a1b233a2668c5b7e2c92dcde8d8dcf5c1d107c5f4c84ee55606473110bb8e331ccb9ef7e28ab56e010dae4811f39d2dc7dc243f66de501fe15d651e2477c19fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb1a31feca1476941aaea6b04317d0e615541fd84fd6a9a52f29d0356b7650e02e2856118b2856bc475a811d93156e03c61737b9e0a0c0154f2c58a9e1e6123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/caeec73f0c1f996bc146908702e87d2a7baf59cbad9f63c14d14811bf5953586800ff9b06fc5855ae06961fee09767c8a96b497c2c1fc5506d6671dffab7fea9"} build_url:https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/TSsXmBL_TP-IfV9s7riA4w/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/sha512/a1b233a2668c5b7e2c92dcde8d8dcf5c1d107c5f4c84ee55606473110bb8e331ccb9ef7e28ab56e010dae4811f39d2dc7dc243f66de501fe15d651e2477c19fb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/edb1a31feca1476941aaea6b04317d0e615541fd84fd6a9a52f29d0356b7650e02e2856118b2856bc475a811d93156e03c61737b9e0a0c0154f2c58a9e1e6123", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/caeec73f0c1f996bc146908702e87d2a7baf59cbad9f63c14d14811bf5953586800ff9b06fc5855ae06961fee09767c8a96b497c2c1fc5506d6671dffab7fea9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 09:39:44.438868) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:39:44.439267) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1467735550.505232-1687375777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 09:39:44.520451) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:39:44.520784) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 09:39:44.521104) ========= ========= Total master_lag: 0.20 =========