builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-040 starttime: 1468340340.62 results: success (0) buildid: 20160712074537 builduid: a3118e63853e427a851b7065ff5e63de revision: 7ebc6c9a418eeafa7fbb22fce71707e99615db33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:00.623702) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:00.624380) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:00.624710) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:00.640739) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:00.641124) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 09:19:01-- 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% 224M=0s 2016-07-12 09:19:01 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096590 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:00.752691) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:00.753060) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018269 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:00.803055) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:00.803481) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7ebc6c9a418eeafa7fbb22fce71707e99615db33 --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 7ebc6c9a418eeafa7fbb22fce71707e99615db33 --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=9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 09:19:01,270 truncating revision to first 12 chars 2016-07-12 09:19:01,270 Setting DEBUG logging. 2016-07-12 09:19:01,270 attempt 1/10 2016-07-12 09:19:01,270 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7ebc6c9a418e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 09:19:01,581 unpacking tar archive at: fx-team-7ebc6c9a418e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.639565 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:01.457028) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:01.457364) ========= script_repo_revision: 7ebc6c9a418eeafa7fbb22fce71707e99615db33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:01.457860) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:01.458133) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 09:19:01.468447) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-12 09:19:01.468885) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:19:02 INFO - MultiFileLogger online at 20160712 09:19:02 in /builds/slave/test 09:19:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:19:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:19:02 INFO - {'append_to_log': False, 09:19:02 INFO - 'base_work_dir': '/builds/slave/test', 09:19:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:19:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:19:02 INFO - 'branch': 'Fx-Team-Non-PGO', 09:19:02 INFO - 'buildbot_json_path': 'buildprops.json', 09:19:02 INFO - 'config_files': ('talos/linux_config.py',), 09:19:02 INFO - 'default_actions': ('clobber', 09:19:02 INFO - 'read-buildbot-config', 09:19:02 INFO - 'download-and-extract', 09:19:02 INFO - 'populate-webroot', 09:19:02 INFO - 'create-virtualenv', 09:19:02 INFO - 'install', 09:19:02 INFO - 'run-tests'), 09:19:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:19:02 INFO - 'download_minidump_stackwalk': True, 09:19:02 INFO - 'download_symbols': 'ondemand', 09:19:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:19:02 INFO - 'tooltool.py': '/tools/tooltool.py', 09:19:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:19:02 INFO - '/tools/misc-python/virtualenv.py')}, 09:19:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:19:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:19:02 INFO - 'installer_path': 'installer.exe', 09:19:02 INFO - 'log_level': 'info', 09:19:02 INFO - 'log_name': 'talos', 09:19:02 INFO - 'log_to_console': True, 09:19:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:19:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:19:02 INFO - 'opt_config_files': (), 09:19:02 INFO - 'pip_index': False, 09:19:02 INFO - 'sps_profile': False, 09:19:02 INFO - 'sps_profile_interval': 0, 09:19:02 INFO - 'suite': 'dromaeojs', 09:19:02 INFO - 'system_bits': '32', 09:19:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:19:02 INFO - 'title': 'talos-linux64-ix-040', 09:19:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:19:02 INFO - 'use_talos_json': True, 09:19:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:19:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:19:02 INFO - 'work_dir': 'build'} 09:19:02 INFO - ##### 09:19:02 INFO - ##### Running clobber step. 09:19:02 INFO - ##### 09:19:02 INFO - Running pre-action listener: _resource_record_pre_action 09:19:02 INFO - Running main action method: clobber 09:19:02 INFO - rmtree: /builds/slave/test/build 09:19:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:19:02 INFO - Running post-action listener: _resource_record_post_action 09:19:02 INFO - ##### 09:19:02 INFO - ##### Finished clobber step (success) 09:19:02 INFO - ##### 09:19:02 INFO - ##### 09:19:02 INFO - ##### Running read-buildbot-config step. 09:19:02 INFO - ##### 09:19:02 INFO - Running pre-action listener: _resource_record_pre_action 09:19:02 INFO - Running main action method: read_buildbot_config 09:19:02 INFO - Using buildbot properties: 09:19:02 INFO - { 09:19:02 INFO - "project": "", 09:19:02 INFO - "product": "firefox", 09:19:02 INFO - "script_repo_revision": "production", 09:19:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:19:02 INFO - "repository": "", 09:19:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:19:02 INFO - "buildid": "20160712074537", 09:19:02 INFO - "pgo_build": "False", 09:19:02 INFO - "basedir": "/builds/slave/test", 09:19:02 INFO - "buildnumber": 1977, 09:19:02 INFO - "slavename": "talos-linux64-ix-040", 09:19:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:19:02 INFO - "platform": "ubuntu64_hw", 09:19:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:19:02 INFO - "branch": "fx-team", 09:19:02 INFO - "repo_path": "integration/fx-team", 09:19:02 INFO - "revision": "7ebc6c9a418eeafa7fbb22fce71707e99615db33", 09:19:02 INFO - "stage_platform": "linux64", 09:19:02 INFO - "builduid": "a3118e63853e427a851b7065ff5e63de", 09:19:02 INFO - "slavebuilddir": "test" 09:19:02 INFO - } 09:19:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:19:02 INFO - Running post-action listener: _resource_record_post_action 09:19:02 INFO - ##### 09:19:02 INFO - ##### Finished read-buildbot-config step (success) 09:19:02 INFO - ##### 09:19:02 INFO - ##### 09:19:02 INFO - ##### Running download-and-extract step. 09:19:02 INFO - ##### 09:19:02 INFO - Running pre-action listener: _resource_record_pre_action 09:19:02 INFO - Running main action method: download_and_extract 09:19:02 INFO - mkdir: /builds/slave/test/build/tests 09:19:02 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:02 INFO - https://queue.taskcluster.net/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:19:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:19:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:19:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/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:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/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:03 INFO - Downloaded 1361 bytes. 09:19:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:19:03 INFO - Using the following test package requirements: 09:19:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:19:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:19:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:19:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:03 INFO - u'jsshell-linux-x86_64.zip'], 09:19:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:19:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:19:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:19:03 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:19:03 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:19:03 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:19:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:19:03 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:19:03 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:03 INFO - https://queue.taskcluster.net/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:19:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:19:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:19:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/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:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/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:05 INFO - Downloaded 22750521 bytes. 09:19:05 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:05 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:06 INFO - Return code: 0 09:19:06 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:06 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:06 INFO - https://queue.taskcluster.net/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:19:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:19:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:19:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/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:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/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:07 INFO - Downloaded 22750521 bytes. 09:19:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:19:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:19:08 INFO - Return code: 0 09:19:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:19:08 INFO - https://queue.taskcluster.net/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:19:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:19:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:19:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/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:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/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:11 INFO - Downloaded 14403317 bytes. 09:19:11 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:11 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:11 INFO - Return code: 0 09:19:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:11 INFO - https://queue.taskcluster.net/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:19:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:19:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:19:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/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:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NesttIeaQf-iOFnPAKe-7A/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:13 INFO - Downloaded 56665747 bytes. 09:19:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:19:13 INFO - mkdir: /builds/slave/test/properties 09:19:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:19:13 INFO - Writing to file /builds/slave/test/properties/build_url 09:19:13 INFO - Contents: 09:19:13 INFO - build_url:https://queue.taskcluster.net/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:19:14 INFO - Running post-action listener: _resource_record_post_action 09:19:14 INFO - Running post-action listener: set_extra_try_arguments 09:19:14 INFO - ##### 09:19:14 INFO - ##### Finished download-and-extract step (success) 09:19:14 INFO - ##### 09:19:14 INFO - ##### 09:19:14 INFO - ##### Running populate-webroot step. 09:19:14 INFO - ##### 09:19:14 INFO - Running pre-action listener: _resource_record_pre_action 09:19:14 INFO - Running main action method: populate_webroot 09:19:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:19:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:19:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:19:14 INFO - '--tppagecycles', 09:19:14 INFO - '7'], 09:19:14 INFO - 'tests': ['tsvgm']}}, 09:19:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:19:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:19:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:19:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:19:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:19:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['damp', 'tps']}, 09:19:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'tests': ['damp', 'tps']}, 09:19:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['dromaeo_dom']}, 09:19:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:19:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['basic_compositor_video']}, 09:19:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:19:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other-e10s': {'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['a11yr', 09:19:14 INFO - 'ts_paint', 09:19:14 INFO - 'tpaint', 09:19:14 INFO - 'sessionrestore', 09:19:14 INFO - 'sessionrestore_no_auto_restore', 09:19:14 INFO - 'tabpaint']}, 09:19:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['tsvgx', 09:19:14 INFO - 'tsvgr_opacity', 09:19:14 INFO - 'tart', 09:19:14 INFO - 'tscrollx', 09:19:14 INFO - 'cart']}, 09:19:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:19:14 INFO - 'tsvgr_opacity', 09:19:14 INFO - 'tart', 09:19:14 INFO - 'tscrollx', 09:19:14 INFO - 'cart']}, 09:19:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'talos_options': ['--disable-e10s'], 09:19:14 INFO - 'tests': ['tp5o']}, 09:19:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'tests': ['tp5o']}, 09:19:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'talos_options': ['--disable-e10s', 09:19:14 INFO - '--xperf_path', 09:19:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:14 INFO - 'tests': ['tp5n']}, 09:19:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:19:14 INFO - 'talos_options': ['--xperf_path', 09:19:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:19:14 INFO - 'tests': ['tp5n']}}, 09:19:14 INFO - 'talos.zip': {'path': '', 09:19:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:19:14 INFO - Running post-action listener: _resource_record_post_action 09:19:14 INFO - ##### 09:19:14 INFO - ##### Finished populate-webroot step (success) 09:19:14 INFO - ##### 09:19:14 INFO - ##### 09:19:14 INFO - ##### Running create-virtualenv step. 09:19:14 INFO - ##### 09:19:14 INFO - Running pre-action listener: _resource_record_pre_action 09:19:14 INFO - Running main action method: create_virtualenv 09:19:14 INFO - Creating virtualenv /builds/slave/test/build/venv 09:19:14 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:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:19:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:19:14 INFO - Using real prefix '/usr' 09:19:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:19:15 INFO - Installing distribute.............................................................................................................................................................................................done. 09:19:17 INFO - Installing pip.................done. 09:19:17 INFO - Return code: 0 09:19:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:19:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:17 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 0x18ee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad3b0>, '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 0x1bae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 09:19:17 INFO - 'HOME': '/home/cltbld', 09:19:17 INFO - 'LANG': 'en_US.UTF-8', 09:19:17 INFO - 'LANGUAGE': 'en_US:en', 09:19:17 INFO - 'LOGNAME': 'cltbld', 09:19:17 INFO - 'MAIL': '/var/mail/cltbld', 09:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:17 INFO - 'MOZ_NO_REMOTE': '1', 09:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:17 INFO - 'NO_EM_RESTART': '1', 09:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:17 INFO - 'PWD': '/builds/slave/test', 09:19:17 INFO - 'SHELL': '/bin/bash', 09:19:17 INFO - 'SHLVL': '1', 09:19:17 INFO - 'TERM': 'linux', 09:19:17 INFO - 'TMOUT': '86400', 09:19:17 INFO - 'USER': 'cltbld', 09:19:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', 09:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:17 INFO - '_': '/tools/buildbot/bin/python'} 09:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:17 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:17 INFO - Cleaning up... 09:19:17 INFO - Return code: 0 09:19:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:19:17 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:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:17 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:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:17 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 0x18ee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad3b0>, '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 0x1bae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 09:19:17 INFO - 'HOME': '/home/cltbld', 09:19:17 INFO - 'LANG': 'en_US.UTF-8', 09:19:17 INFO - 'LANGUAGE': 'en_US:en', 09:19:17 INFO - 'LOGNAME': 'cltbld', 09:19:17 INFO - 'MAIL': '/var/mail/cltbld', 09:19:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:17 INFO - 'MOZ_NO_REMOTE': '1', 09:19:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:17 INFO - 'NO_EM_RESTART': '1', 09:19:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:17 INFO - 'PWD': '/builds/slave/test', 09:19:17 INFO - 'SHELL': '/bin/bash', 09:19:17 INFO - 'SHLVL': '1', 09:19:17 INFO - 'TERM': 'linux', 09:19:17 INFO - 'TMOUT': '86400', 09:19:17 INFO - 'USER': 'cltbld', 09:19:17 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', 09:19:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:17 INFO - '_': '/tools/buildbot/bin/python'} 09:19:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:17 INFO - Downloading/unpacking psutil>=3.1.1 09:19:17 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:17 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:17 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:17 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:17 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:17 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:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:19:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:19 INFO - Installing collected packages: psutil 09:19:19 INFO - Running setup.py install for psutil 09:19:19 INFO - building 'psutil._psutil_linux' extension 09:19:19 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:19 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:19 INFO - building 'psutil._psutil_posix' extension 09:19:19 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:20 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:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:19:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:19:20 INFO - Successfully installed psutil 09:19:20 INFO - Cleaning up... 09:19:20 INFO - Return code: 0 09:19:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:20 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 0x18ee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad3b0>, '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 0x1bae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', '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:20 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:20 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:20 INFO - Using env: {'DISPLAY': ':0', 09:19:20 INFO - 'HOME': '/home/cltbld', 09:19:20 INFO - 'LANG': 'en_US.UTF-8', 09:19:20 INFO - 'LANGUAGE': 'en_US:en', 09:19:20 INFO - 'LOGNAME': 'cltbld', 09:19:20 INFO - 'MAIL': '/var/mail/cltbld', 09:19:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:20 INFO - 'MOZ_NO_REMOTE': '1', 09:19:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:20 INFO - 'NO_EM_RESTART': '1', 09:19:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:20 INFO - 'PWD': '/builds/slave/test', 09:19:20 INFO - 'SHELL': '/bin/bash', 09:19:20 INFO - 'SHLVL': '1', 09:19:20 INFO - 'TERM': 'linux', 09:19:20 INFO - 'TMOUT': '86400', 09:19:20 INFO - 'USER': 'cltbld', 09:19:20 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', 09:19:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:20 INFO - '_': '/tools/buildbot/bin/python'} 09:19:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:19:20 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:20 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:20 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:20 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:20 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:20 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:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:19:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:19:22 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:22 INFO - Installing collected packages: mozsystemmonitor 09:19:22 INFO - Running setup.py install for mozsystemmonitor 09:19:22 INFO - Successfully installed mozsystemmonitor 09:19:22 INFO - Cleaning up... 09:19:22 INFO - Return code: 0 09:19:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:22 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 0x18ee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad3b0>, '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 0x1bae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', '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:22 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:22 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:22 INFO - Using env: {'DISPLAY': ':0', 09:19:22 INFO - 'HOME': '/home/cltbld', 09:19:22 INFO - 'LANG': 'en_US.UTF-8', 09:19:22 INFO - 'LANGUAGE': 'en_US:en', 09:19:22 INFO - 'LOGNAME': 'cltbld', 09:19:22 INFO - 'MAIL': '/var/mail/cltbld', 09:19:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:22 INFO - 'MOZ_NO_REMOTE': '1', 09:19:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:22 INFO - 'NO_EM_RESTART': '1', 09:19:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:22 INFO - 'PWD': '/builds/slave/test', 09:19:22 INFO - 'SHELL': '/bin/bash', 09:19:22 INFO - 'SHLVL': '1', 09:19:22 INFO - 'TERM': 'linux', 09:19:22 INFO - 'TMOUT': '86400', 09:19:22 INFO - 'USER': 'cltbld', 09:19:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', 09:19:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:22 INFO - '_': '/tools/buildbot/bin/python'} 09:19:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:22 INFO - Downloading/unpacking jsonschema==2.5.1 09:19:22 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:22 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:22 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:22 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:22 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:22 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:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:19:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:19:24 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:24 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:24 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:24 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:24 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:24 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:24 INFO - Downloading functools32-3.2.3-2.tar.gz 09:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:19:25 INFO - warning: no files found matching '*.txt' 09:19:25 INFO - no previously-included directories found matching 'build' 09:19:25 INFO - no previously-included directories found matching 'dist' 09:19:25 INFO - no previously-included directories found matching '.git*' 09:19:25 INFO - Installing collected packages: jsonschema, functools32 09:19:25 INFO - Running setup.py install for functools32 09:19:25 INFO - warning: no files found matching '*.txt' 09:19:25 INFO - no previously-included directories found matching 'build' 09:19:25 INFO - no previously-included directories found matching 'dist' 09:19:25 INFO - no previously-included directories found matching '.git*' 09:19:25 INFO - Successfully installed jsonschema functools32 09:19:25 INFO - Cleaning up... 09:19:25 INFO - Return code: 0 09:19:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18ee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad3b0>, '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 0x1bae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', '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:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:19:25 INFO - Using env: {'DISPLAY': ':0', 09:19:25 INFO - 'HOME': '/home/cltbld', 09:19:25 INFO - 'LANG': 'en_US.UTF-8', 09:19:25 INFO - 'LANGUAGE': 'en_US:en', 09:19:25 INFO - 'LOGNAME': 'cltbld', 09:19:25 INFO - 'MAIL': '/var/mail/cltbld', 09:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:25 INFO - 'MOZ_NO_REMOTE': '1', 09:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:25 INFO - 'NO_EM_RESTART': '1', 09:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:25 INFO - 'PWD': '/builds/slave/test', 09:19:25 INFO - 'SHELL': '/bin/bash', 09:19:25 INFO - 'SHLVL': '1', 09:19:25 INFO - 'TERM': 'linux', 09:19:25 INFO - 'TMOUT': '86400', 09:19:25 INFO - 'USER': 'cltbld', 09:19:25 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', 09:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:25 INFO - '_': '/tools/buildbot/bin/python'} 09:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:25 INFO - Downloading/unpacking blobuploader==1.2.4 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 - Downloading blobuploader-1.2.4.tar.gz 09:19:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:19:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 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:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:19:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 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:28 INFO - Downloading docopt-0.6.1.tar.gz 09:19:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:19:28 INFO - Installing collected packages: blobuploader, requests, docopt 09:19:28 INFO - Running setup.py install for blobuploader 09:19:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:19:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:19:28 INFO - Running setup.py install for requests 09:19:28 INFO - Running setup.py install for docopt 09:19:28 INFO - Successfully installed blobuploader requests docopt 09:19:28 INFO - Cleaning up... 09:19:28 INFO - Return code: 0 09:19:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:28 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 0x18ee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad3b0>, '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 0x1bae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', '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:28 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:28 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:28 INFO - Using env: {'DISPLAY': ':0', 09:19:28 INFO - 'HOME': '/home/cltbld', 09:19:28 INFO - 'LANG': 'en_US.UTF-8', 09:19:28 INFO - 'LANGUAGE': 'en_US:en', 09:19:28 INFO - 'LOGNAME': 'cltbld', 09:19:28 INFO - 'MAIL': '/var/mail/cltbld', 09:19:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:28 INFO - 'MOZ_NO_REMOTE': '1', 09:19:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:28 INFO - 'NO_EM_RESTART': '1', 09:19:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:28 INFO - 'PWD': '/builds/slave/test', 09:19:28 INFO - 'SHELL': '/bin/bash', 09:19:28 INFO - 'SHLVL': '1', 09:19:28 INFO - 'TERM': 'linux', 09:19:28 INFO - 'TMOUT': '86400', 09:19:28 INFO - 'USER': 'cltbld', 09:19:28 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', 09:19:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:28 INFO - '_': '/tools/buildbot/bin/python'} 09:19:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:28 INFO - Running setup.py (path:/tmp/pip-KZHKmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:29 INFO - Running setup.py (path:/tmp/pip-NKWFTs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:29 INFO - Running setup.py (path:/tmp/pip-0yKbZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:29 INFO - Running setup.py (path:/tmp/pip-yZg5Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:29 INFO - Running setup.py (path:/tmp/pip-97kk4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:29 INFO - Running setup.py (path:/tmp/pip-PxCqck-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:29 INFO - Running setup.py (path:/tmp/pip-fWZePq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:29 INFO - Running setup.py (path:/tmp/pip-xdWc_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:29 INFO - Running setup.py (path:/tmp/pip-hwqm3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:29 INFO - Running setup.py (path:/tmp/pip-Se7_Dt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:29 INFO - Running setup.py (path:/tmp/pip-q6EDrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:29 INFO - Running setup.py (path:/tmp/pip-uqALJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:29 INFO - Running setup.py (path:/tmp/pip-c9MrUu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:29 INFO - Running setup.py (path:/tmp/pip-l91AKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:29 INFO - Running setup.py (path:/tmp/pip-Q5wRaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:30 INFO - Running setup.py (path:/tmp/pip-5euRKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:30 INFO - Running setup.py (path:/tmp/pip-UuLlkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:19:30 INFO - Running setup.py install for manifestparser 09:19:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:19:30 INFO - Running setup.py install for mozcrash 09:19:30 INFO - Running setup.py install for mozdebug 09:19:30 INFO - Running setup.py install for mozdevice 09:19:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:19:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:19:30 INFO - Running setup.py install for mozfile 09:19:30 INFO - Running setup.py install for mozhttpd 09:19:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:19:30 INFO - Running setup.py install for mozinfo 09:19:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:19:30 INFO - Running setup.py install for mozInstall 09:19:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:19:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:19:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:19:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:19:30 INFO - Running setup.py install for mozleak 09:19:31 INFO - Running setup.py install for mozlog 09:19:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:19:31 INFO - Running setup.py install for moznetwork 09:19:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:19:31 INFO - Running setup.py install for mozprocess 09:19:31 INFO - Running setup.py install for mozprofile 09:19:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:19:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:19:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:19:31 INFO - Running setup.py install for mozrunner 09:19:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:19:31 INFO - Running setup.py install for mozscreenshot 09:19:31 INFO - Running setup.py install for moztest 09:19:31 INFO - Running setup.py install for mozversion 09:19:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:19:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:19:31 INFO - Cleaning up... 09:19:31 INFO - Return code: 0 09:19:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:31 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:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:31 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:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:31 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 0x18ee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad3b0>, '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 0x1bae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', '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:31 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:31 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:31 INFO - Using env: {'DISPLAY': ':0', 09:19:31 INFO - 'HOME': '/home/cltbld', 09:19:31 INFO - 'LANG': 'en_US.UTF-8', 09:19:31 INFO - 'LANGUAGE': 'en_US:en', 09:19:31 INFO - 'LOGNAME': 'cltbld', 09:19:31 INFO - 'MAIL': '/var/mail/cltbld', 09:19:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:31 INFO - 'MOZ_NO_REMOTE': '1', 09:19:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:31 INFO - 'NO_EM_RESTART': '1', 09:19:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:31 INFO - 'PWD': '/builds/slave/test', 09:19:31 INFO - 'SHELL': '/bin/bash', 09:19:31 INFO - 'SHLVL': '1', 09:19:31 INFO - 'TERM': 'linux', 09:19:31 INFO - 'TMOUT': '86400', 09:19:31 INFO - 'USER': 'cltbld', 09:19:31 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', 09:19:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:31 INFO - '_': '/tools/buildbot/bin/python'} 09:19:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:19:32 INFO - Running setup.py (path:/tmp/pip-tSgTlr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:19:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:19:32 INFO - Running setup.py (path:/tmp/pip-z0Mls3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:19:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:19:32 INFO - Running setup.py (path:/tmp/pip-Go2IYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:19:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:19:32 INFO - Running setup.py (path:/tmp/pip-GpiXaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:19:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:19:32 INFO - Running setup.py (path:/tmp/pip-QJkePS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:19:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:19:32 INFO - Running setup.py (path:/tmp/pip-aanzCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:19:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:19:32 INFO - Running setup.py (path:/tmp/pip-HetQkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:19:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:19:32 INFO - Running setup.py (path:/tmp/pip-oMm_9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:19:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:19:32 INFO - Running setup.py (path:/tmp/pip-qG0HpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:19:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:19:32 INFO - Running setup.py (path:/tmp/pip-Hn6Kwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:19:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:19:32 INFO - Running setup.py (path:/tmp/pip-MM4dqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:19:32 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:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:19:32 INFO - Running setup.py (path:/tmp/pip-9UWzNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:19:33 INFO - Running setup.py (path:/tmp/pip-XCOf0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:19:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:19:33 INFO - Running setup.py (path:/tmp/pip-iIs_Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:19:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:19:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:33 INFO - Running setup.py (path:/tmp/pip-J1bd0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:19:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:19:33 INFO - Running setup.py (path:/tmp/pip-Jx5EqE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:19:33 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:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:19:33 INFO - Running setup.py (path:/tmp/pip-chhVuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:19:33 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:33 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:33 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:33 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:33 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:33 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:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:19:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:19:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:19:35 INFO - Downloading blessings-1.6.tar.gz 09:19:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:19:35 INFO - Installing collected packages: blessings 09:19:35 INFO - Running setup.py install for blessings 09:19:35 INFO - Successfully installed blessings 09:19:35 INFO - Cleaning up... 09:19:35 INFO - Return code: 0 09:19:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:19:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:35 INFO - Reading from file tmpfile_stdout 09:19:35 INFO - Current package versions: 09:19:35 INFO - argparse == 1.2.1 09:19:35 INFO - blessings == 1.6 09:19:35 INFO - blobuploader == 1.2.4 09:19:35 INFO - docopt == 0.6.1 09:19:35 INFO - functools32 == 3.2.3-2 09:19:35 INFO - jsonschema == 2.5.1 09:19:35 INFO - manifestparser == 1.1 09:19:35 INFO - mozInstall == 1.12 09:19:35 INFO - mozcrash == 0.17 09:19:35 INFO - mozdebug == 0.1 09:19:35 INFO - mozdevice == 0.48 09:19:35 INFO - mozfile == 1.2 09:19:35 INFO - mozhttpd == 0.7 09:19:35 INFO - mozinfo == 0.9 09:19:35 INFO - mozleak == 0.1 09:19:35 INFO - mozlog == 3.2 09:19:35 INFO - moznetwork == 0.27 09:19:35 INFO - mozprocess == 0.23 09:19:35 INFO - mozprofile == 0.28 09:19:35 INFO - mozrunner == 6.12 09:19:35 INFO - mozscreenshot == 0.1 09:19:35 INFO - mozsystemmonitor == 0.3 09:19:35 INFO - moztest == 0.7 09:19:35 INFO - mozversion == 1.4 09:19:35 INFO - psutil == 3.1.1 09:19:35 INFO - requests == 1.2.3 09:19:35 INFO - wsgiref == 0.1.2 09:19:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:19:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:19:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:35 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:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:19:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:19:35 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 0x18ee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad3b0>, '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 0x1bae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 09:19:35 INFO - 'HOME': '/home/cltbld', 09:19:35 INFO - 'LANG': 'en_US.UTF-8', 09:19:35 INFO - 'LANGUAGE': 'en_US:en', 09:19:35 INFO - 'LOGNAME': 'cltbld', 09:19:35 INFO - 'MAIL': '/var/mail/cltbld', 09:19:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:35 INFO - 'MOZ_NO_REMOTE': '1', 09:19:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:35 INFO - 'NO_EM_RESTART': '1', 09:19:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:35 INFO - 'PWD': '/builds/slave/test', 09:19:35 INFO - 'SHELL': '/bin/bash', 09:19:35 INFO - 'SHLVL': '1', 09:19:35 INFO - 'TERM': 'linux', 09:19:35 INFO - 'TMOUT': '86400', 09:19:35 INFO - 'USER': 'cltbld', 09:19:35 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', 09:19:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:35 INFO - '_': '/tools/buildbot/bin/python'} 09:19:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:19:36 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:36 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:36 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:36 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:36 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:36 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:36 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:36 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:36 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:36 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:36 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:36 INFO - Cleaning up... 09:19:36 INFO - Return code: 0 09:19:36 INFO - Installing jsonschema 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', '--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 0x18ee030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a518a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1baf180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad3b0>, '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 0x1bae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bae740>, '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': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', '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', '--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:36 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: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': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', 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 - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:19:36 INFO - Cleaning up... 09:19:36 INFO - Return code: 0 09:19:36 INFO - Running post-action listener: _resource_record_post_action 09:19:36 INFO - Running post-action listener: _start_resource_monitoring 09:19:36 INFO - Starting resource monitoring. 09:19:36 INFO - ##### 09:19:36 INFO - ##### Finished create-virtualenv step (success) 09:19:36 INFO - ##### 09:19:36 INFO - ##### 09:19:36 INFO - ##### Running install step. 09:19:36 INFO - ##### 09:19:36 INFO - Running pre-action listener: _resource_record_pre_action 09:19:36 INFO - Running main action method: install 09:19:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:19:36 INFO - Reading from file tmpfile_stdout 09:19:36 INFO - Detecting whether we're running mozinstall >=1.0... 09:19:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:19:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:19:36 INFO - Reading from file tmpfile_stdout 09:19:36 INFO - Output received: 09:19:36 INFO - Usage: mozinstall [options] installer 09:19:36 INFO - Options: 09:19:36 INFO - -h, --help show this help message and exit 09:19:36 INFO - -d DEST, --destination=DEST 09:19:36 INFO - Directory to install application into. [default: 09:19:36 INFO - "/builds/slave/test"] 09:19:36 INFO - --app=APP Application being installed. [default: firefox] 09:19:36 INFO - mkdir: /builds/slave/test/build/application 09:19:36 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:36 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:19:52 INFO - Reading from file tmpfile_stdout 09:19:52 INFO - Output received: 09:19:52 INFO - /builds/slave/test/build/application/firefox/firefox 09:19:52 INFO - Running post-action listener: _resource_record_post_action 09:19:52 INFO - ##### 09:19:52 INFO - ##### Finished install step (success) 09:19:52 INFO - ##### 09:19:52 INFO - ##### 09:19:52 INFO - ##### Running run-tests step. 09:19:52 INFO - ##### 09:19:52 INFO - Running pre-action listener: _resource_record_pre_action 09:19:52 INFO - Running main action method: run_tests 09:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:19:52 INFO - Python 2.7.3 09:19:52 INFO - Return code: 0 09:19:52 INFO - grabbing minidump binary from tooltool 09:19:52 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:52 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 0x1bad3b0>, '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 0x1bae2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bae740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:19:52 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:19:52 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:19:52 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:19:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:19:52 INFO - Return code: 0 09:19:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:19:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:19:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:19:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:19:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:19:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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:19:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --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:19:52 INFO - Using env: {'DISPLAY': ':0', 09:19:52 INFO - 'HOME': '/home/cltbld', 09:19:52 INFO - 'LANG': 'en_US.UTF-8', 09:19:52 INFO - 'LANGUAGE': 'en_US:en', 09:19:52 INFO - 'LOGNAME': 'cltbld', 09:19:52 INFO - 'MAIL': '/var/mail/cltbld', 09:19:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:19:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:19:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:19:52 INFO - 'MOZ_NO_REMOTE': '1', 09:19:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:19:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:19:52 INFO - 'NO_EM_RESTART': '1', 09:19:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:19:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:19:52 INFO - 'PWD': '/builds/slave/test', 09:19:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:19:52 INFO - 'SHELL': '/bin/bash', 09:19:52 INFO - 'SHLVL': '1', 09:19:52 INFO - 'TERM': 'linux', 09:19:52 INFO - 'TMOUT': '86400', 09:19:52 INFO - 'USER': 'cltbld', 09:19:52 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705', 09:19:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:19:52 INFO - '_': '/tools/buildbot/bin/python'} 09:19:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--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:19:53 INFO - mozversion application_buildid: 20160712074537 09:19:53 INFO - mozversion application_changeset: 7ebc6c9a418eeafa7fbb22fce71707e99615db33 09:19:53 INFO - mozversion application_display_name: Nightly 09:19:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:19:53 INFO - mozversion application_name: Firefox 09:19:53 INFO - mozversion application_remotingname: firefox 09:19:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:19:53 INFO - mozversion application_vendor: Mozilla 09:19:53 INFO - mozversion application_version: 50.0a1 09:19:53 INFO - mozversion platform_buildid: 20160712074537 09:19:53 INFO - mozversion platform_changeset: 7ebc6c9a418eeafa7fbb22fce71707e99615db33 09:19:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:19:53 INFO - mozversion platform_version: 50.0a1 09:19:53 INFO - using testdate: 1468340393 09:19:53 INFO - actual date: 1468340393 09:19:53 INFO - starting webserver on 'localhost:48964' 09:19:53 INFO - SUITE-START | Running 2 tests 09:19:53 INFO - TEST-START | dromaeo_css 09:19:53 INFO - operating with platform_type : linux_ 09:19:53 INFO - Initialising browser for dromaeo_css test... 09:19:53 INFO - TEST-INFO | started process 469 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6oidfV/profile http://localhost:48964/getInfo.html) 09:19:57 INFO - PROCESS | 469 | __metrics Screen width/height:1600/1200 09:19:57 INFO - PROCESS | 469 | colorDepth:24 09:19:57 INFO - PROCESS | 469 | Browser inner width/height: 1024/697 09:19:57 INFO - PROCESS | 469 | __metrics 09:19:58 INFO - PROCESS | 469 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:19:58 INFO - PROCESS | 469 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:19:59 INFO - TEST-INFO | 469: exit 0 09:19:59 INFO - Browser initialized. 09:19:59 INFO - Running cycle 1/1 for dromaeo_css test... 09:19:59 INFO - TEST-INFO | started process 550 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6oidfV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:20:11 INFO - PROCESS | 550 | RSS: Main: 158601216 09:20:11 INFO - PROCESS | 550 | 09:21:02 INFO - PROCESS | 550 | 1468340462271 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:14 INFO - PROCESS | 550 | Cycle 1(1): loaded http://localhost:48964/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48964/tests/dromaeo/cssquery-ext.html) 09:23:16 INFO - PROCESS | 550 | RSS: Main: 272236544 09:23:16 INFO - PROCESS | 550 | 09:26:19 INFO - PROCESS | 550 | Cycle 1(1): loaded http://localhost:48964/tests/dromaeo/cssquery-ext.html (next: http://localhost:48964/tests/dromaeo/cssquery-jquery.html) 09:26:19 INFO - PROCESS | 550 | RSS: Main: 244416512 09:26:19 INFO - PROCESS | 550 | 09:29:21 INFO - PROCESS | 550 | Cycle 1(1): loaded http://localhost:48964/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48964/tests/dromaeo/cssquery-mootools.html) 09:29:22 INFO - PROCESS | 550 | RSS: Main: 241356800 09:29:22 INFO - PROCESS | 550 | 09:32:24 INFO - PROCESS | 550 | Cycle 1(1): loaded http://localhost:48964/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48964/tests/dromaeo/cssquery-prototype.html) 09:32:25 INFO - PROCESS | 550 | RSS: Main: 239919104 09:32:25 INFO - PROCESS | 550 | 09:35:28 INFO - PROCESS | 550 | Cycle 1(1): loaded http://localhost:48964/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48964/tests/dromaeo/cssquery-yui.html) 09:35:29 INFO - PROCESS | 550 | RSS: Main: 218943488 09:35:29 INFO - PROCESS | 550 | 09:38:31 INFO - PROCESS | 550 | Cycle 1(1): loaded http://localhost:48964/tests/dromaeo/cssquery-yui.html (next: http://localhost:48964/tests/dromaeo/cssquery-dojo.html) 09:38:32 INFO - PROCESS | 550 | RSS: Main: 326832128 09:38:32 INFO - PROCESS | 550 | 09:38:32 INFO - PROCESS | 550 | __start_tp_report 09:38:32 INFO - PROCESS | 550 | _x_x_mozilla_page_load 09:38:32 INFO - PROCESS | 550 | _x_x_mozilla_page_load_details 09:38:32 INFO - PROCESS | 550 | |i|pagename|runs| 09:38:32 INFO - PROCESS | 550 | |0;dojo.html;2609.373750299928;2644.0877897125483;2673.9598906016413;2687.2207059952616;2689.448663024079;4645.396098507189;4692.671512994092;4702.576768090871;4755.9286610700865;4800.423949126105;4724.480307166209;4728;4748.216544270192;4767.070421267854;4782.736949467778;4293.420388247593;4301.032267739749;4345.152695224432;4384.824607015731;4397.252467080588;4344.847930322439;4366;4402.955970440303;4427.335899615067;4436.334549817537;4268.381084742726;4282.957170428287;4304.440422745023;4393.033532622818;4421;4283.635890949273;4332.740035597874;4332.870013899588;4336.978315108436;4364.432623758923;4351.0645211279725;4353.346997950302;4356.346548017823;4356.847510337155;4396;4606.654500912445;4646.721196728207;4721.504242054569;4788.9521104788855;4799.11216424959;5019.67372120811;5040.445550989388;5068.847934561933;5088.7964481420695;5091.847244582631;5090.77091530882;5112.028714544224;5112.233165025239;5115.718635475047;5119.795208191668;4613.76931153441;4672;4714.599259062984;4748.905021899543;4758.952410475851;5200.063988482034;5212.40057393397;5214.765335559909;5264.684118952799;5267.683938963674;4994.700317980933;4997.950020499821;5041.571466425322;5045.924311135336;5048.545630893237;4936.802527898915;5002.824901128443;5052.494750524992;5056.974715126401;5126.846194614168;5001.274815151783;5007.949920500749;5017.37282839645;5018.422881368616;5063.291139240509;4988.875278118004;4995.600351971833;4997.500249975046;5001.049800537886;5046.167382381939;4175.64507016907;4213.367994800743;4237.660987121085;4256.29771087767;4270.252705776476;3724.0689827543115;3731.3097077040293;3734.981325093357;3775.30156920965;3797.3354662933875;4381.619789766213;4385.934210986838;4386.780660966939;4427.8228870844805;4435.889102772457;4936.160852655057;4987.775550100182;5036.622253331015;5041.092603331363;5126.820561280338;4363.956360436418;4368.5194628590825;4369.2572262714775;4375.978120109443;4399.406080179135;4510.729356238636;4524.5927866492175;4524.615407690383;4527.139843429738;4568.885777855514;4615.192341340252;4713.552212539803;4753.762311884461;4754.168020596451;4774.474807771073;5057.393112826484;5070.112730272262;5083.18669012971;5085.0338435697095;5135.691858488353;4567.840125595588;4780.569748722632;4789.856304310876;4793.400824896888;4844.0554091951735;4964.875878102932;4991.750412479434;4996.325496057985;4999.175136102648;5029.7736601852275;5017.774200160929;5020.924686129638;5047.293378927026;5057.8229761958155;5101.566366858859;4727.3854398927915;4868.391451068616;4924.8276310328965;4943.703377797344;4986.700797952134;4945.826896058621;4974.925376119433;4986.252062190701;4996.900061998667;5044.848654540369;4896.902061958812;4903.338049363433;4948.307236986897;4950.801967921243;4961.975190124026;4871.391076115486;4907.950920490749;4933.851984440473;4998;5019.0463811875625;4882.877928051827;4899.31409602663;4909.828156014522;4913.901721965469;4964.801407943642 09:38:32 INFO - PROCESS | 550 | |1;ext.html;569.53013763645;575.8733078722682;576.7837061102086;579.9275090613673;589.2163422647878;27243.591346129822;27717.168484945432;30138.69861301392;30144;30166.3966720666;30682.232944176405;41099;41481;42371.57628423715;43104;7712.035995500562;7845.725399611015;8006.51960882346;8008.479448835807;8012.158723334053;7521.7743467696055;7840.13758486566;7914.050313962304;7915.445918785687;7917.56453395063;10252.89747102527;10472.424016679079;10517.158627309835;10840.891591084068;10862.402567858764;10333.276670633059;10417.374957502574;10421.218408619385;10433.956604339543;10434.634787782392;10303.845442318372;10373.325733827352;10374.79250414995;10385.480725963671;10387;39411.40882886759;39666.20667586661;39739.8013009936;39750.40374394386;39751.00622484461;2024.7873973232893;2171.8588291760984;2349.6738229153184;2981.9403611927855;3122.469180239365;30063.549046764096;30684.936985397384;31013.689863101306;31051.378972420425;31086.68913310883;3451.5685539307588;3575.159837438226;3611.1694310308776;3658.396364599838;3704.3517384457614;267247;267485;268382;268686;269099;45875.541244587796;51412;53233;53645.36723644039;53792.19311710328;57791.422085778606;58721.119183212286;58767.706161469774;58850.70574647185;58911.116333255035;15211.467598633995;15561;15580.220988950507;15588.298526566332;15590.688186236212;11280.379579123062;11467.713307167387;11472.426378681033;11473.254238474472;11628.592999244986;16760.497185084223;16802.915985419993;16874.662506749795;17032;17099.401520946707;6051.425114614105;6181.350958149419;6205.348438413902;6222.471089957314;6263.592866463665;778.7430148051129;816.5917041479261;848.1942154952819;922.3635691372931;929.8977112517617;26417.86791066071;28169.43661126766;28292.71707282942;28591;28646.713532864822;759.4949358676529;969.4183489906;970.4953424219366;990.8266053440619;1022.9335093218917;14548.563543093724;14663.266836658124;14893.106413615002;15001.774973375408;15055.774163387558;267249;269418;271510;271980;272393;49346.50653493491;49416;49499;49541;49668.25497617538;1172.4255114993762;1196.5094311332311;1201.9819702704467;1221.248931906871;1221.2733423612935;26515.33711657224;27394.726052739217;27637.861810690818;27940.30149246285;28227;41721.1655766889;42073.78963105165;42102.36846447244;42123.57876421197;42201;341474;341621;342370;342917;343650;21899.343019709435;22020.229291974705;22793.430164246027;25236.495270094863;25637.3590660235;42175.7891210542;42378.15243695171;43093.569064310206;43194.35208471813;43372;35698.46452303165;35817.64182358143;35948.28103437969;36267.45598815967;36482.452763209105;35337.82331088328;35998.28003439864;36336.81831590931;36360.818195908854;36699.63300366962;33514;33533.161670957445;33683.49474757832;34267;34738.131546711535;31259.687403126587;32680.83659581687;32687.34625307433;32734;32796.83601581977;25049;25340.239792806246;25511.87244063768;25650.61524077103;25796.742032579434 09:38:32 INFO - PROCESS | 550 | |2;jquery.html;355.46502513716854;365.9012066741981;369.8649992752646;373.402555910543;391.82759585782253;16439.671206575862;17035.488935331945;17703.645927081467;17726.734098988527;17750.201240944156;16225.188740562984;17067.317307307723;17084.060376679277;17109.31562737489;17174;5001.149804533229;5205.869853253661;5248.107821670306;5249.973750131263;5253.133233016548;3739.6821270192067;3922.431247469115;5157.819476318329;5753.741081651315;6074.51403887688;6083.209182806229;6106.603070800406;6107.541934354919;6118.663473508956;6119.326874043873;5819.941800582003;6006.759729610832;6007.8197654070445;6012.6993650317745;6013.75944962201;3382.120648631349;4901.8774530636665;5180.1452760294505;5185.922211166836;5282.630215884889;20909.790902090936;20945.895270523702;21178.894105529373;21216.78783212179;21334.893325533274;1896.9620607587772;1986.265081919699;2131.936041918745;2529.6458495810602;2537.6701028866314;12904.612861614072;13264.071514993955;13305.201687898758;13603.047786654937;13880;1698.8216237295153;1733.8092809790912;1738.1569938579778;1750.509857239962;1763.0303333166707;68509;70413.64793176053;70445.2955470449;70730.64634676845;72568.27431725668;9553.23574114083;9616.615335386507;9848.704538863702;9913.45475998827;9955.950220248853;13409.128406653535;13490.730185396236;13520.59438216855;13527.053106282467;13528.526501572398;7337;7354.374878135419;7416.480846340704;7421.369183619345;7471.738489152854;6860.554063985925;6935.375816176568;6957.686904089328;7034.2262351141335;7058.576485410892;6165.198524191826;6281.434670879551;6391.488680905516;6404.391582799627;6469.417752402306;1627.6744651069596;1742.364037126465;1750.1074452029302;1772.955676108082;1786.0712429536568;877.8332116897769;879.1779685993489;923.7782932096383;961.4519723757531;997.3153027741756;17376;17566.38517651876;17921;18131.456056318333;18463.353782617545;840.7940054686641;849.0575461238021;851.7700220940435;855.9828803423896;863.6502216602286;9477.620895164255;9622;9778.75553111178;9814.803703926023;9877.703668889944;299948;303780;304641;386470;386984;52361;53061.734691326295;53755;78228;86597.44504454287;915.4869882173476;919.6137622198693;948.6821914658528;950.0641867760389;962.4610218277787;16142.596435089217;16198.757018644965;16277.67444651124;16292;16400.343986240416;30142.84928575343;38921.80539097286;39981.40027899526;40109.39835902405;40237.39643905285;55916;56745.43254567401;57208.71395642995;57227.42772572221;57388.42611573998;7473.514221575798;7511.9624401877645;7640.235976402538;7724.92275077242;7867.567283799446;8703.086175951434;11578.478968446272;11643.59247426336;11999.880001199876;12029.759404811679;9567.330286879851;10340.482975851328;10347.741306467398;10473.476326183509;10477.31897426665;9287.72136835896;9392.248620110511;9622.37454565451;10340.37957722539;10358.5338659762;9797.755056123653;9864.5560949756;10062.849057264293;10117.949410252902;10211.795764084825;7790.259925307087;7816.06207255133;7884.44808863397;7975.84048319042;8042.517448953082;7615.7334493292465;8383.371247156365;10040.196784257096;10184.439855808001;10404.78592187902 09:38:32 INFO - PROCESS | 550 | |3;mootools.html;1230.0651504856307;1290.3225806451612;1353.6886516101297;1386.7018591002939;1690.8562772164366;6151;7183.353498185163;7437.590932498724;7452.6273686315735;7631;7415.110186777581;7519.849603007937;7531.811704707385;7544.0569928758905;7547.924520754791;2201.823854091677;2222.9333120006427;2226.2430773536994;2227.5656247031834;2228.097620463715;2142.1431427429075;2198.835087368446;2205.0408072488517;2206.9779302206935;2212.236778311488;2149.258505815491;2185.3334732906455;2188.7154669892893;2189.35414052854;2204.801567858892;2096.5282811367474;2101.737282839645;2102.4848912016655;2105.410485064177;2105.947351316214;2091.2366986050133;2121.1303365620174;2123.3948324727535;2129.1057755742627;2129.968050479244;7365.705371785122;7475.102987641518;7500.624968751541;7536.133344665379;7597.430192735567;4472.284434490466;4559.202139625552;4574.176648203322;4586.151561961048;4595.218812801798;2846.644169478815;2891.8843246270126;2944.05790147153;2950.2329394357407;2954.9556756648667;881.9735407937773;888.3648191543077;900.3787386703219;901.8962819275802;902.4089221559823;9705.805883882284;9723.611055557698;9739.366941148803;9753.658621948269;9754;3831.9616803831605;3943.6056394360908;4079.204555111784;4081.2041651878194;4083.9387409188885;7878.172791856887;7971.800704982422;7972.083210430875;7973.441859069925;7981.3614910807;4444.422225110715;4453.910921781546;4461.620762235247;4464.263396539534;4464.575865292792;3511.6839484446523;3881.9805900970314;4098.610631989956;4152.937705934413;4160.313548264563;3525.964740352615;3608.4226523756074;3685.4656074868994;3704.49989251453;3704.870329538453;1178.452019810792;1192.1833544022372;1200.33981310279;1200.5977997370978;1204.0848954794244;754.5698951597647;775.6276987046136;859.076492770262;867.314821291173;872.7032808845023;5178.145605974972;5199.012187684328;5252.947470525322;5285.497877701612;5484.945150548443;827.5159031966367;869.3349587565517;885.7369569529881;891.5497673674882;954.427343593852;3685.244524872395;3839.232153569297;3847.249786291646;3956.5647778744315;3956.8219430125714;8963.507007114671;9067.81864362709;9160.496172710431;9161.633534658538;9206.493642849708;8559.144085591392;9127.406718563272;9135.223506001932;9136.862947055799;9160.816783664422;6705.899411508832;7020.403265722471;7060.399866011344;7069.328413800681;7086.397656199178;5109.9744501277255;5153.0466863630345;5385.084535628874;5472.91790623149;5546.195801608664;8268.9663792026;8428.241458268785;8659.913400866162;8663.436876603;8672.523011234443;8489.278411335106;8556.229939305493;8795.12048795141;8813;8820.823583528421;5718.771249150153;6291.245050593775;6419.903701444388;6547.214334279917;6547.345265473415;7317.743878964211;7326.157491888501;7359;7394;7396.186419493959;6460.095586617783;6516;6548.901766473602;6660.6336651484635;6667.499937504804;6318.842028949313;6371.23545174582;6377.96811015942;6424.967875160594;6476.579022363531;5800.59395842287;5814.186013957965;5845.853853653693;5845.970770146122;5850.94149058504;4297.183535128315;4479.686421950432;4487.865364039084;4520.141173177086;4567.520410356865;4564.88587785308;4609.723416595015;4664.020555683344;4751.7861696224445;4773.689710168828 09:38:32 INFO - PROCESS | 550 | |4;prototype.html;292.38161288874034;297.290961057877;298.56856841863504;307.78608866837556;308.4986896293523;4832.719329377714;4894;4915.336429582006;4918.188498897677;4920.852374428769;4741.644376671747;4794.801299675081;4810.302506136608;4816.772762249293;4854.538818812216;3634.7637403568683;3739.308227977819;3756.6476068615275;3832.923341533168;3860.4944071812015;3803.7717736935733;3813.1039205786756;3849.8825645894785;3851.9022078707576;3855.1133239354967;3618.3125206210734;3772.434134879776;3772.4529943158227;3789.3747531657245;3795.35478968576;3700.611435799243;3797.5442946846556;3813.809309534512;3814.19901820618;3831.67430768385;3365.697087262158;3378.189234583707;3384.3062172254627;3407.4377727674905;3415.26571787067;4719.10337035962;4722.409698787652;4730.172219861545;4737.407824021997;4740.146773580754;4276.23027854986;4359.016647425446;4371.868843934687;4388.42950416447;4399.318105693591;4996.475370086125;5013.298138260647;5042.697438153723;5078.949210507922;5080.542751152414;3671.284099600552;3697.9815100924325;3712.1833196696684;3712.5706602958057;3723.8510459581853;5013.498650134994;5228.320318358665;5258.13240815265;5275.630705850592;5284.841454756325;3756.8309426075343;3783.5459744830796;3788.886333410002;3790.298794722985;3795.4306853971575;3832.2718683450057;3840.8847734568008;3845.2309538092495;3846.249981253629;3851.094992676719;4332.025294308755;4346.500152482442;4352.869413917588;4355.237833379146;4366.345048242789;4818.204996175662;4987.226979818134;4990.72551009698;4997.950020499821;5001.8499445016705;1246.0280980834782;1268.7081971146688;1268.7525932443084;1270.275942712645;1276.5914907229596;813.5118928642885;829.7676650537859;869.3610196505564;902.3142411766974;907.0430695616056;4410.16206920684;4415.62467190286;4420.093880754438;4471.19518486669;4480.081583275421;5110.1568241239775;5110.948890511122;5120.846374608767;5125.487451254845;5144.742762861842;4241.512226094039;4416.205083085076;4430.269005614037;4436.179306828247;4476.41806565151;2726.6455360803366;2741.8629068546493;2743.696744046562;2750.422411293651;2755.2147637923094;4834.114695268848;4849.199882019428;4852.296417019513;4858.975705121523;4862.78117484714;5100;5173.870653233699;5252.2384254282915;5256.947430525723;5297.443768404262;4775.976120119377;4808.206645903387;4835.3714017178245;4849.660523763303;4875.902481950412;5156.767945442539;5160.277561141368;5162.457941916195;5165.483451654804;5171.448565430431;4861.222204447272;5061.822836200715;5076.923846142237;5148.0141517920265;5164.8192313268855;4919.204490361064;4938.160557679277;4939.678920870132;4943.209086546135;4945.925811112908;3673.118451571657;3703.166787472797;3704.1850792825535;3711.7772933622987;3718.925621487609;5196.454372291007;5295.973520132375;5312.150055991023;5316.920246196233;5320.255164277081;5071.797128114982;5106.948930510647;5109.540141387293;5116.360454943132;5126.820561280338;5141.203113517411;5144.125498665161;5146.459621739664;5170.224466330081;5187.533122019036;4929;5004.749762511787;5059.620528460307;5085.694858308513;5096.694198348111;4897.142999974919;4970.6023518117745;5133.614978876524;5136.871578210575;5137.87155321105;5001.299818025552;5009.824656137018;5021.447640759587;5022.890386037946;5050.89370037417 09:38:32 INFO - PROCESS | 550 | |5;yui.html;642.3704769326059;688.5490004047344;715.3561794385056;718.3104219948849;746.0972223609431;12659.367031648415;13223.93388033061;13235.470581176742;13260.469581216752;13276.800847987275;12524.56164034259;12585.056120790954;12602.936985315084;12951.352432378391;13183.143095698797;630.268888089816;782.256855986812;789.6170357376668;795.5664163031133;795.6021989005498;760.7261385901071;784.0865391818525;796.195842199377;797.3182928596054;797.6251161953901;843.464400105934;845.4589062999654;845.8435189489965;845.9280961118312;846.031294168177;653.4315145823117;665.0356982375527;823.2549542663899;837.3343192162215;839.3998291221775;496.7168713833117;497.02830965462795;584.2346526050887;595.1964847455943;609.8048624440181;12981.805272920914;13038.608841734764;13055.608331750063;13060.281684507348;13139.211647301192;12165.574204902874;12603.684907877285;12703.555375561811;12866.163699359606;13123.671908202372;11579;11595.826062609067;11648.184627076109;11762.588309409215;11807.468663910146;4096.1193343431305;4128.380742888561;4156.43888075109;4195.077083041726;4264.808083636212;59224;59227.40772592262;59713;62345;62706;10132.392056476636;10279.537420816081;10330.173586113093;10522.31604945676;10683.358998460117;19175.904120479307;19196;19203.615927681647;19207.711884321747;19216;6729.49528785343;6841.726330946706;6863.931360686429;6892.483063770237;6902.068220790129;3603.765755225902;3676.485292059114;3691.7046636269033;3702.0559757261726;3748.156664750409;2637.2483842104907;2699.91900242993;2731.1942976821883;2735.849528275924;2738.411241583069;501.19307914258013;535.3629181274271;561.1750726432219;563.5097465205298;563.5181919458804;511.7032121369597;572.83101485062;573.5554944917723;574.4513989140361;624.4723208888482;8133.652689849929;8627.094155113748;8733.737987860375;8997.235235005099;9022.684206052889;488.863118326869;562.8508445262008;606.2703985758051;615.4092071611303;642.1972534332085;3904.668103211202;4046.1503084352025;4132.669386449077;4155.501339839238;4190.643795277375;92413.07586924179;105393;105975;109007.45496272467;109632;66936.330636693;90829.54585227031;93779;93927.53036234775;94362;62594.37405625977;71822.28177718261;73268.63365683137;74368.62815685887;74555;7219.8556028880175;7490.775276741707;7569.545827250383;7601.961990190013;7737.961310193413;31231.375372492876;32708.836455817567;35086.47370289396;41130.38304425376;44755;60457;63478;64479.67760161169;64724.35275647183;65664;11597.88402115968;11619.419029048344;11766;11820.822687659864;12087.576934807239;12816.166949148275;12867.163634363736;13434;13738.862611374157;13794.93102534481;11666.358350290815;11718.88281117178;12325.52566944208;12331.568395106127;12376;11962.521499140285;12142.453589588313;12195.085368597569;12233.510659573518;12361.07291953125;11876.76246475083;11896.881031189578;11998;12258.325792081521;12338.753224935272;10044.196464282693;10272.73133505813;10468.476576171313;10627.25609207379;10733.195010374096;9750.512474376395;10379.481025948522;10384.584616615251;10393.324433911772;10447 09:38:32 INFO - PROCESS | 550 | __end_tp_report 09:38:32 INFO - PROCESS | 550 | __start_cc_report 09:38:32 INFO - PROCESS | 550 | _x_x_mozilla_cycle_collect,1154 09:38:32 INFO - PROCESS | 550 | __end_cc_report 09:38:32 INFO - PROCESS | 550 | __startTimestamp1468341512229__endTimestamp 09:38:32 INFO - PROCESS | 550 | 09:38:32 INFO - PROCESS | 550 | ------- Summary: start ------- 09:38:32 INFO - PROCESS | 550 | Number of tests: 6 09:38:32 INFO - PROCESS | 550 | 09:38:32 INFO - PROCESS | 550 | [#0] dojo.html Cycles:165 Average:4678.92 Median:4793.40 stddev:490.76 (10.2%) stddev-sans-first:464.63 09:38:32 INFO - PROCESS | 550 | Values: 2609.4 2644.1 2674.0 2687.2 2689.4 4645.4 4692.7 4702.6 4755.9 4800.4 4724.5 4728.0 4748.2 4767.1 4782.7 4293.4 4301.0 4345.2 4384.8 4397.3 4344.8 4366.0 4403.0 4427.3 4436.3 4268.4 4283.0 4304.4 4393.0 4421.0 4283.6 4332.7 4332.9 4337.0 4364.4 4351.1 4353.3 4356.3 4356.8 4396.0 4606.7 4646.7 4721.5 4789.0 4799.1 5019.7 5040.4 5068.8 5088.8 5091.8 5090.8 5112.0 5112.2 5115.7 5119.8 4613.8 4672.0 4714.6 4748.9 4759.0 5200.1 5212.4 5214.8 5264.7 5267.7 4994.7 4998.0 5041.6 5045.9 5048.5 4936.8 5002.8 5052.5 5057.0 5126.8 5001.3 5007.9 5017.4 5018.4 5063.3 4988.9 4995.6 4997.5 5001.0 5046.2 4175.6 4213.4 4237.7 4256.3 4270.3 3724.1 3731.3 3735.0 3775.3 3797.3 4381.6 4385.9 4386.8 4427.8 4435.9 4936.2 4987.8 5036.6 5041.1 5126.8 4364.0 4368.5 4369.3 4376.0 4399.4 4510.7 4524.6 4524.6 4527.1 4568.9 4615.2 4713.6 4753.8 4754.2 4774.5 5057.4 5070.1 5083.2 5085.0 5135.7 4567.8 4780.6 4789.9 4793.4 4844.1 4964.9 4991.8 4996.3 4999.2 5029.8 5017.8 5020.9 5047.3 5057.8 5101.6 4727.4 4868.4 4924.8 4943.7 4986.7 4945.8 4974.9 4986.3 4996.9 5044.8 4896.9 4903.3 4948.3 4950.8 4962.0 4871.4 4908.0 4933.9 4998.0 5019.0 4882.9 4899.3 4909.8 4913.9 4964.8 09:38:32 INFO - PROCESS | 550 | 09:38:32 INFO - PROCESS | 550 | [#1] ext.html Cycles:180 Average:45271.92 Median:32765.42 stddev:77430.58 (236.3%) stddev-sans-first:77575.05 09:38:32 INFO - PROCESS | 550 | Values: 569.5 575.9 576.8 579.9 589.2 27243.6 27717.2 30138.7 30144.0 30166.4 30682.2 41099.0 41481.0 42371.6 43104.0 7712.0 7845.7 8006.5 8008.5 8012.2 7521.8 7840.1 7914.1 7915.4 7917.6 10252.9 10472.4 10517.2 10840.9 10862.4 10333.3 10417.4 10421.2 10434.0 10434.6 10303.8 10373.3 10374.8 10385.5 10387.0 39411.4 39666.2 39739.8 39750.4 39751.0 2024.8 2171.9 2349.7 2981.9 3122.5 30063.5 30684.9 31013.7 31051.4 31086.7 3451.6 3575.2 3611.2 3658.4 3704.4 267247.0 267485.0 268382.0 268686.0 269099.0 45875.5 51412.0 53233.0 53645.4 53792.2 57791.4 58721.1 58767.7 58850.7 58911.1 15211.5 15561.0 15580.2 15588.3 15590.7 11280.4 11467.7 11472.4 11473.3 11628.6 16760.5 16802.9 16874.7 17032.0 17099.4 6051.4 6181.4 6205.3 6222.5 6263.6 778.7 816.6 848.2 922.4 929.9 26417.9 28169.4 28292.7 28591.0 28646.7 759.5 969.4 970.5 990.8 1022.9 14548.6 14663.3 14893.1 15001.8 15055.8 267249.0 269418.0 271510.0 271980.0 272393.0 49346.5 49416.0 49499.0 49541.0 49668.3 1172.4 1196.5 1202.0 1221.2 1221.3 26515.3 27394.7 27637.9 27940.3 28227.0 41721.2 42073.8 42102.4 42123.6 42201.0 341474.0 341621.0 342370.0 342917.0 343650.0 21899.3 22020.2 22793.4 25236.5 25637.4 42175.8 42378.2 43093.6 43194.4 43372.0 35698.5 35817.6 35948.3 36267.5 36482.5 35337.8 35998.3 36336.8 36360.8 36699.6 33514.0 33533.2 33683.5 34267.0 34738.1 31259.7 32680.8 32687.3 32734.0 32796.8 25049.0 25340.2 25511.9 25650.6 25796.7 09:38:32 INFO - PROCESS | 550 | 09:38:32 INFO - PROCESS | 550 | [#2] jquery.html Cycles:180 Average:22916.13 Median:28804.55 stddev:56211.74 (195.1%) stddev-sans-first:56343.91 09:38:32 INFO - PROCESS | 550 | Values: 355.5 365.9 369.9 373.4 391.8 16439.7 17035.5 17703.6 17726.7 17750.2 16225.2 17067.3 17084.1 17109.3 17174.0 5001.1 5205.9 5248.1 5250.0 5253.1 3739.7 3922.4 5157.8 5753.7 6074.5 6083.2 6106.6 6107.5 6118.7 6119.3 5819.9 6006.8 6007.8 6012.7 6013.8 3382.1 4901.9 5180.1 5185.9 5282.6 20909.8 20945.9 21178.9 21216.8 21334.9 1897.0 1986.3 2131.9 2529.6 2537.7 12904.6 13264.1 13305.2 13603.0 13880.0 1698.8 1733.8 1738.2 1750.5 1763.0 68509.0 70413.6 70445.3 70730.6 72568.3 9553.2 9616.6 9848.7 9913.5 9956.0 13409.1 13490.7 13520.6 13527.1 13528.5 7337.0 7354.4 7416.5 7421.4 7471.7 6860.6 6935.4 6957.7 7034.2 7058.6 6165.2 6281.4 6391.5 6404.4 6469.4 1627.7 1742.4 1750.1 1773.0 1786.1 877.8 879.2 923.8 961.5 997.3 17376.0 17566.4 17921.0 18131.5 18463.4 840.8 849.1 851.8 856.0 863.7 9477.6 9622.0 9778.8 9814.8 9877.7 299948.0 303780.0 304641.0 386470.0 386984.0 52361.0 53061.7 53755.0 78228.0 86597.4 915.5 919.6 948.7 950.1 962.5 16142.6 16198.8 16277.7 16292.0 16400.3 30142.8 38921.8 39981.4 40109.4 40237.4 55916.0 56745.4 57208.7 57227.4 57388.4 7473.5 7512.0 7640.2 7724.9 7867.6 8703.1 11578.5 11643.6 11999.9 12029.8 9567.3 10340.5 10347.7 10473.5 10477.3 9287.7 9392.2 9622.4 10340.4 10358.5 9797.8 9864.6 10062.8 10117.9 10211.8 7790.3 7816.1 7884.4 7975.8 8042.5 7615.7 8383.4 10040.2 10184.4 10404.8 09:38:32 INFO - PROCESS | 550 | 09:38:32 INFO - PROCESS | 550 | [#3] mootools.html Cycles:180 Average:4940.41 Median:5759.68 stddev:2664.31 (46.3%) stddev-sans-first:2657.19 09:38:32 INFO - PROCESS | 550 | Values: 1230.1 1290.3 1353.7 1386.7 1690.9 6151.0 7183.4 7437.6 7452.6 7631.0 7415.1 7519.8 7531.8 7544.1 7547.9 2201.8 2222.9 2226.2 2227.6 2228.1 2142.1 2198.8 2205.0 2207.0 2212.2 2149.3 2185.3 2188.7 2189.4 2204.8 2096.5 2101.7 2102.5 2105.4 2105.9 2091.2 2121.1 2123.4 2129.1 2130.0 7365.7 7475.1 7500.6 7536.1 7597.4 4472.3 4559.2 4574.2 4586.2 4595.2 2846.6 2891.9 2944.1 2950.2 2955.0 882.0 888.4 900.4 901.9 902.4 9705.8 9723.6 9739.4 9753.7 9754.0 3832.0 3943.6 4079.2 4081.2 4083.9 7878.2 7971.8 7972.1 7973.4 7981.4 4444.4 4453.9 4461.6 4464.3 4464.6 3511.7 3882.0 4098.6 4152.9 4160.3 3526.0 3608.4 3685.5 3704.5 3704.9 1178.5 1192.2 1200.3 1200.6 1204.1 754.6 775.6 859.1 867.3 872.7 5178.1 5199.0 5252.9 5285.5 5484.9 827.5 869.3 885.7 891.5 954.4 3685.2 3839.2 3847.2 3956.6 3956.8 8963.5 9067.8 9160.5 9161.6 9206.5 8559.1 9127.4 9135.2 9136.9 9160.8 6705.9 7020.4 7060.4 7069.3 7086.4 5110.0 5153.0 5385.1 5472.9 5546.2 8269.0 8428.2 8659.9 8663.4 8672.5 8489.3 8556.2 8795.1 8813.0 8820.8 5718.8 6291.2 6419.9 6547.2 6547.3 7317.7 7326.2 7359.0 7394.0 7396.2 6460.1 6516.0 6548.9 6660.6 6667.5 6318.8 6371.2 6378.0 6425.0 6476.6 5800.6 5814.2 5845.9 5846.0 5850.9 4297.2 4479.7 4487.9 4520.1 4567.5 4564.9 4609.7 4664.0 4751.8 4773.7 09:38:32 INFO - PROCESS | 550 | 09:38:32 INFO - PROCESS | 550 | [#4] prototype.html Cycles:180 Average:4216.02 Median:4817.49 stddev:1214.49 (25.2%) stddev-sans-first:1181.65 09:38:32 INFO - PROCESS | 550 | Values: 292.4 297.3 298.6 307.8 308.5 4832.7 4894.0 4915.3 4918.2 4920.9 4741.6 4794.8 4810.3 4816.8 4854.5 3634.8 3739.3 3756.6 3832.9 3860.5 3803.8 3813.1 3849.9 3851.9 3855.1 3618.3 3772.4 3772.5 3789.4 3795.4 3700.6 3797.5 3813.8 3814.2 3831.7 3365.7 3378.2 3384.3 3407.4 3415.3 4719.1 4722.4 4730.2 4737.4 4740.1 4276.2 4359.0 4371.9 4388.4 4399.3 4996.5 5013.3 5042.7 5078.9 5080.5 3671.3 3698.0 3712.2 3712.6 3723.9 5013.5 5228.3 5258.1 5275.6 5284.8 3756.8 3783.5 3788.9 3790.3 3795.4 3832.3 3840.9 3845.2 3846.2 3851.1 4332.0 4346.5 4352.9 4355.2 4366.3 4818.2 4987.2 4990.7 4998.0 5001.8 1246.0 1268.7 1268.8 1270.3 1276.6 813.5 829.8 869.4 902.3 907.0 4410.2 4415.6 4420.1 4471.2 4480.1 5110.2 5110.9 5120.8 5125.5 5144.7 4241.5 4416.2 4430.3 4436.2 4476.4 2726.6 2741.9 2743.7 2750.4 2755.2 4834.1 4849.2 4852.3 4859.0 4862.8 5100.0 5173.9 5252.2 5256.9 5297.4 4776.0 4808.2 4835.4 4849.7 4875.9 5156.8 5160.3 5162.5 5165.5 5171.4 4861.2 5061.8 5076.9 5148.0 5164.8 4919.2 4938.2 4939.7 4943.2 4945.9 3673.1 3703.2 3704.2 3711.8 3718.9 5196.5 5296.0 5312.2 5316.9 5320.3 5071.8 5106.9 5109.5 5116.4 5126.8 5141.2 5144.1 5146.5 5170.2 5187.5 4929.0 5004.7 5059.6 5085.7 5096.7 4897.1 4970.6 5133.6 5136.9 5137.9 5001.3 5009.8 5021.4 5022.9 5050.9 09:38:32 INFO - PROCESS | 550 | 09:38:32 INFO - PROCESS | 550 | [#5] yui.html Cycles:180 Average:17890.37 Median:4130.53 stddev:25904.76 (627.2%) stddev-sans-first:25945.06 09:38:32 INFO - PROCESS | 550 | Values: 642.4 688.5 715.4 718.3 746.1 12659.4 13223.9 13235.5 13260.5 13276.8 12524.6 12585.1 12602.9 12951.4 13183.1 630.3 782.3 789.6 795.6 795.6 760.7 784.1 796.2 797.3 797.6 843.5 845.5 845.8 845.9 846.0 653.4 665.0 823.3 837.3 839.4 496.7 497.0 584.2 595.2 609.8 12981.8 13038.6 13055.6 13060.3 13139.2 12165.6 12603.7 12703.6 12866.2 13123.7 11579.0 11595.8 11648.2 11762.6 11807.5 4096.1 4128.4 4156.4 4195.1 4264.8 59224.0 59227.4 59713.0 62345.0 62706.0 10132.4 10279.5 10330.2 10522.3 10683.4 19175.9 19196.0 19203.6 19207.7 19216.0 6729.5 6841.7 6863.9 6892.5 6902.1 3603.8 3676.5 3691.7 3702.1 3748.2 2637.2 2699.9 2731.2 2735.8 2738.4 501.2 535.4 561.2 563.5 563.5 511.7 572.8 573.6 574.5 624.5 8133.7 8627.1 8733.7 8997.2 9022.7 488.9 562.9 606.3 615.4 642.2 3904.7 4046.2 4132.7 4155.5 4190.6 92413.1 105393.0 105975.0 109007.5 109632.0 66936.3 90829.5 93779.0 93927.5 94362.0 62594.4 71822.3 73268.6 74368.6 74555.0 7219.9 7490.8 7569.5 7602.0 7738.0 31231.4 32708.8 35086.5 41130.4 44755.0 60457.0 63478.0 64479.7 64724.4 65664.0 11597.9 11619.4 11766.0 11820.8 12087.6 12816.2 12867.2 13434.0 13738.9 13794.9 11666.4 11718.9 12325.5 12331.6 12376.0 11962.5 12142.5 12195.1 12233.5 12361.1 11876.8 11896.9 11998.0 12258.3 12338.8 10044.2 10272.7 10468.5 10627.3 10733.2 9750.5 10379.5 10384.6 10393.3 10447.0 09:38:32 INFO - PROCESS | 550 | -------- Summary: end -------- 09:38:32 INFO - PROCESS | 550 | 09:38:32 INFO - TEST-INFO | 550: exit 0 09:38:32 INFO - TEST-OK | dromaeo_css | took 1119830ms 09:38:32 INFO - TEST-START | kraken 09:38:32 INFO - operating with platform_type : linux_ 09:38:32 INFO - Initialising browser for kraken test... 09:38:32 INFO - TEST-INFO | started process 741 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvY7A6E/profile http://localhost:48964/getInfo.html) 09:38:37 INFO - PROCESS | 741 | __metrics Screen width/height:1600/1200 09:38:37 INFO - PROCESS | 741 | colorDepth:24 09:38:37 INFO - PROCESS | 741 | Browser inner width/height: 1024/697 09:38:37 INFO - PROCESS | 741 | __metrics 09:38:38 INFO - PROCESS | 741 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:38:38 INFO - PROCESS | 741 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:38:38 INFO - TEST-INFO | 741: exit 0 09:38:38 INFO - Browser initialized. 09:38:38 INFO - Running cycle 1/1 for kraken test... 09:38:38 INFO - TEST-INFO | started process 832 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvY7A6E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:38:50 INFO - PROCESS | 832 | RSS: Main: 159080448 09:38:50 INFO - PROCESS | 832 | 09:38:53 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48964/tests/kraken/driver.html?testName=audio-beat-detection) 09:38:54 INFO - PROCESS | 832 | RSS: Main: 217149440 09:38:54 INFO - PROCESS | 832 | 09:38:57 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48964/tests/kraken/driver.html?testName=audio-dft) 09:38:57 INFO - PROCESS | 832 | RSS: Main: 204152832 09:38:57 INFO - PROCESS | 832 | 09:39:01 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48964/tests/kraken/driver.html?testName=audio-fft) 09:39:01 INFO - PROCESS | 832 | RSS: Main: 271048704 09:39:01 INFO - PROCESS | 832 | 09:39:03 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48964/tests/kraken/driver.html?testName=audio-oscillator) 09:39:04 INFO - PROCESS | 832 | RSS: Main: 181727232 09:39:04 INFO - PROCESS | 832 | 09:39:06 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48964/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:39:07 INFO - PROCESS | 832 | RSS: Main: 185442304 09:39:07 INFO - PROCESS | 832 | 09:39:10 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48964/tests/kraken/driver.html?testName=imaging-darkroom) 09:39:11 INFO - PROCESS | 832 | RSS: Main: 222253056 09:39:11 INFO - PROCESS | 832 | 09:39:14 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48964/tests/kraken/driver.html?testName=imaging-desaturate) 09:39:15 INFO - PROCESS | 832 | RSS: Main: 217743360 09:39:15 INFO - PROCESS | 832 | 09:39:18 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48964/tests/kraken/driver.html?testName=json-parse-financial) 09:39:18 INFO - PROCESS | 832 | RSS: Main: 220762112 09:39:18 INFO - PROCESS | 832 | 09:39:20 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48964/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:39:20 INFO - PROCESS | 832 | RSS: Main: 206786560 09:39:20 INFO - PROCESS | 832 | 09:39:22 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48964/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:39:23 INFO - PROCESS | 832 | RSS: Main: 212185088 09:39:23 INFO - PROCESS | 832 | 09:39:25 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48964/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:39:26 INFO - PROCESS | 832 | RSS: Main: 209596416 09:39:26 INFO - PROCESS | 832 | 09:39:29 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:39:29 INFO - PROCESS | 832 | RSS: Main: 224124928 09:39:29 INFO - PROCESS | 832 | 09:39:32 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:39:33 INFO - PROCESS | 832 | RSS: Main: 225169408 09:39:33 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | Cycle 1(1): loaded http://localhost:48964/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48964/tests/kraken/driver.html?testName=ai-astar) 09:39:35 INFO - PROCESS | 832 | RSS: Main: 268464128 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | __start_tp_report 09:39:35 INFO - PROCESS | 832 | _x_x_mozilla_page_load 09:39:35 INFO - PROCESS | 832 | _x_x_mozilla_page_load_details 09:39:35 INFO - PROCESS | 832 | |i|pagename|runs| 09:39:35 INFO - PROCESS | 832 | |0;ai-astar;104;115;113;114;114;113;114;112;115;113 09:39:35 INFO - PROCESS | 832 | |1;audio-beat-detection;146;123;125;173;125;124;152;128;168;130 09:39:35 INFO - PROCESS | 832 | |2;audio-dft;162;161;162;162;160;173;163;160;162;160 09:39:35 INFO - PROCESS | 832 | |3;audio-fft;76;75;77;115;75;77;75;74;105;75 09:39:35 INFO - PROCESS | 832 | |4;audio-oscillator;85;87;121;86;85;87;119;85;85;125 09:39:35 INFO - PROCESS | 832 | |5;imaging-gaussian-blur;117;116;117;116;117;117;117;117;117;117 09:39:35 INFO - PROCESS | 832 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 09:39:35 INFO - PROCESS | 832 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;94;94 09:39:35 INFO - PROCESS | 832 | |8;json-parse-financial;63;62;63;63;64;63;64;63;64;63 09:39:35 INFO - PROCESS | 832 | |9;json-stringify-tinderbox;66;65;67;65;66;66;66;69;65;66 09:39:35 INFO - PROCESS | 832 | |10;stanford-crypto-aes;79;79;80;78;79;78;79;80;80;84 09:39:35 INFO - PROCESS | 832 | |11;stanford-crypto-ccm;139;141;140;131;129;131;130;128;211;133 09:39:35 INFO - PROCESS | 832 | |12;stanford-crypto-pbkdf2;177;169;165;167;168;171;174;169;170;163 09:39:35 INFO - PROCESS | 832 | |13;stanford-crypto-sha256-iterative;68;67;70;68;66;72;67;66;67;66 09:39:35 INFO - PROCESS | 832 | __end_tp_report 09:39:35 INFO - PROCESS | 832 | __start_cc_report 09:39:35 INFO - PROCESS | 832 | _x_x_mozilla_cycle_collect,1912 09:39:35 INFO - PROCESS | 832 | __end_cc_report 09:39:35 INFO - PROCESS | 832 | __startTimestamp1468341575278__endTimestamp 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | ------- Summary: start ------- 09:39:35 INFO - PROCESS | 832 | Number of tests: 14 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#0] ai-astar Cycles:10 Average:112.70 Median:114.00 stddev:3.20 (2.8%) stddev-sans-first:1.00 09:39:35 INFO - PROCESS | 832 | Values: 104.0 115.0 113.0 114.0 114.0 113.0 114.0 112.0 115.0 113.0 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#1] audio-beat-detection Cycles:10 Average:139.40 Median:138.00 stddev:19.11 (13.9%) stddev-sans-first:20.12 09:39:35 INFO - PROCESS | 832 | Values: 146.0 123.0 125.0 173.0 125.0 124.0 152.0 128.0 168.0 130.0 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:3.84 (2.4%) stddev-sans-first:4.07 09:39:35 INFO - PROCESS | 832 | Values: 162.0 161.0 162.0 162.0 160.0 173.0 163.0 160.0 162.0 160.0 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#3] audio-fft Cycles:10 Average:82.40 Median:75.00 stddev:14.77 (19.7%) stddev-sans-first:15.48 09:39:35 INFO - PROCESS | 832 | Values: 76.0 75.0 77.0 115.0 75.0 77.0 75.0 74.0 105.0 75.0 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:85.00 stddev:17.44 (20.5%) stddev-sans-first:18.00 09:39:35 INFO - PROCESS | 832 | Values: 85.0 87.0 121.0 86.0 85.0 87.0 119.0 85.0 85.0 125.0 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:39:35 INFO - PROCESS | 832 | Values: 117.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:39:35 INFO - PROCESS | 832 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 09:39:35 INFO - PROCESS | 832 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 94.0 94.0 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 09:39:35 INFO - PROCESS | 832 | Values: 63.0 62.0 63.0 63.0 64.0 63.0 64.0 63.0 64.0 63.0 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 09:39:35 INFO - PROCESS | 832 | Values: 66.0 65.0 67.0 65.0 66.0 66.0 66.0 69.0 65.0 66.0 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.50 stddev:1.71 (2.2%) stddev-sans-first:1.80 09:39:35 INFO - PROCESS | 832 | Values: 79.0 79.0 80.0 78.0 79.0 78.0 79.0 80.0 80.0 84.0 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#11] stanford-crypto-ccm Cycles:10 Average:141.30 Median:136.00 stddev:24.95 (18.3%) stddev-sans-first:26.45 09:39:35 INFO - PROCESS | 832 | Values: 139.0 141.0 140.0 131.0 129.0 131.0 130.0 128.0 211.0 133.0 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.30 Median:169.50 stddev:4.08 (2.4%) stddev-sans-first:3.24 09:39:35 INFO - PROCESS | 832 | Values: 177.0 169.0 165.0 167.0 168.0 171.0 174.0 169.0 170.0 163.0 09:39:35 INFO - PROCESS | 832 | 09:39:35 INFO - PROCESS | 832 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.50 stddev:1.95 (2.9%) stddev-sans-first:2.06 09:39:35 INFO - PROCESS | 832 | Values: 68.0 67.0 70.0 68.0 66.0 72.0 67.0 66.0 67.0 66.0 09:39:35 INFO - PROCESS | 832 | -------- Summary: end -------- 09:39:35 INFO - PROCESS | 832 | 09:39:36 INFO - TEST-INFO | 832: exit 0 09:39:36 INFO - TEST-OK | kraken | took 63381ms 09:39:36 INFO - SUITE-END | took 1183s 09:39:36 INFO - Completed test suite (00:19:43) 09:39:36 INFO - javascript benchmark 09:39:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.373750299928, 2644.0877897125483, 2673.9598906016413, 2687.2207059952616, 2689.448663024079, 4645.396098507189, 4692.671512994092, 4702.576768090871, 4755.9286610700865, 4800.423949126105, 4724.480307166209, 4728.0, 4748.216544270192, 4767.070421267854, 4782.736949467778, 4293.420388247593, 4301.032267739749, 4345.152695224432, 4384.824607015731, 4397.252467080588, 4344.847930322439, 4366.0, 4402.955970440303, 4427.335899615067, 4436.334549817537, 4268.381084742726, 4282.957170428287, 4304.440422745023, 4393.033532622818, 4421.0, 4283.635890949273, 4332.740035597874, 4332.870013899588, 4336.978315108436, 4364.432623758923, 4351.0645211279725, 4353.346997950302, 4356.346548017823, 4356.847510337155, 4396.0, 4606.654500912445, 4646.721196728207, 4721.504242054569, 4788.9521104788855, 4799.11216424959, 5019.67372120811, 5040.445550989388, 5068.847934561933, 5088.7964481420695, 5091.847244582631, 5090.77091530882, 5112.028714544224, 5112.233165025239, 5115.718635475047, 5119.795208191668, 4613.76931153441, 4672.0, 4714.599259062984, 4748.905021899543, 4758.952410475851, 5200.063988482034, 5212.40057393397, 5214.765335559909, 5264.684118952799, 5267.683938963674, 4994.700317980933, 4997.950020499821, 5041.571466425322, 5045.924311135336, 5048.545630893237, 4936.802527898915, 5002.824901128443, 5052.494750524992, 5056.974715126401, 5126.846194614168, 5001.274815151783, 5007.949920500749, 5017.37282839645, 5018.422881368616, 5063.291139240509, 4988.875278118004, 4995.600351971833, 4997.500249975046, 5001.049800537886, 5046.167382381939, 4175.64507016907, 4213.367994800743, 4237.660987121085, 4256.29771087767, 4270.252705776476, 3724.0689827543115, 3731.3097077040293, 3734.981325093357, 3775.30156920965, 3797.3354662933875, 4381.619789766213, 4385.934210986838, 4386.780660966939, 4427.8228870844805, 4435.889102772457, 4936.160852655057, 4987.775550100182, 5036.622253331015, 5041.092603331363, 5126.820561280338, 4363.956360436418, 4368.5194628590825, 4369.2572262714775, 4375.978120109443, 4399.406080179135, 4510.729356238636, 4524.5927866492175, 4524.615407690383, 4527.139843429738, 4568.885777855514, 4615.192341340252, 4713.552212539803, 4753.762311884461, 4754.168020596451, 4774.474807771073, 5057.393112826484, 5070.112730272262, 5083.18669012971, 5085.0338435697095, 5135.691858488353, 4567.840125595588, 4780.569748722632, 4789.856304310876, 4793.400824896888, 4844.0554091951735, 4964.875878102932, 4991.750412479434, 4996.325496057985, 4999.175136102648, 5029.7736601852275, 5017.774200160929, 5020.924686129638, 5047.293378927026, 5057.8229761958155, 5101.566366858859, 4727.3854398927915, 4868.391451068616, 4924.8276310328965, 4943.703377797344, 4986.700797952134, 4945.826896058621, 4974.925376119433, 4986.252062190701, 4996.900061998667, 5044.848654540369, 4896.902061958812, 4903.338049363433, 4948.307236986897, 4950.801967921243, 4961.975190124026, 4871.391076115486, 4907.950920490749, 4933.851984440473, 4998.0, 5019.0463811875625, 4882.877928051827, 4899.31409602663, 4909.828156014522, 4913.901721965469, 4964.801407943642], "value": 4647.706015270961, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.53013763645, 575.8733078722682, 576.7837061102086, 579.9275090613673, 589.2163422647878, 27243.591346129822, 27717.168484945432, 30138.69861301392, 30144.0, 30166.3966720666, 30682.232944176405, 41099.0, 41481.0, 42371.57628423715, 43104.0, 7712.035995500562, 7845.725399611015, 8006.51960882346, 8008.479448835807, 8012.158723334053, 7521.7743467696055, 7840.13758486566, 7914.050313962304, 7915.445918785687, 7917.56453395063, 10252.89747102527, 10472.424016679079, 10517.158627309835, 10840.891591084068, 10862.402567858764, 10333.276670633059, 10417.374957502574, 10421.218408619385, 10433.956604339543, 10434.634787782392, 10303.845442318372, 10373.325733827352, 10374.79250414995, 10385.480725963671, 10387.0, 39411.40882886759, 39666.20667586661, 39739.8013009936, 39750.40374394386, 39751.00622484461, 2024.7873973232893, 2171.8588291760984, 2349.6738229153184, 2981.9403611927855, 3122.469180239365, 30063.549046764096, 30684.936985397384, 31013.689863101306, 31051.378972420425, 31086.68913310883, 3451.5685539307588, 3575.159837438226, 3611.1694310308776, 3658.396364599838, 3704.3517384457614, 267247.0, 267485.0, 268382.0, 268686.0, 269099.0, 45875.541244587796, 51412.0, 53233.0, 53645.36723644039, 53792.19311710328, 57791.422085778606, 58721.119183212286, 58767.706161469774, 58850.70574647185, 58911.116333255035, 15211.467598633995, 15561.0, 15580.220988950507, 15588.298526566332, 15590.688186236212, 11280.379579123062, 11467.713307167387, 11472.426378681033, 11473.254238474472, 11628.592999244986, 16760.497185084223, 16802.915985419993, 16874.662506749795, 17032.0, 17099.401520946707, 6051.425114614105, 6181.350958149419, 6205.348438413902, 6222.471089957314, 6263.592866463665, 778.7430148051129, 816.5917041479261, 848.1942154952819, 922.3635691372931, 929.8977112517617, 26417.86791066071, 28169.43661126766, 28292.71707282942, 28591.0, 28646.713532864822, 759.4949358676529, 969.4183489906, 970.4953424219366, 990.8266053440619, 1022.9335093218917, 14548.563543093724, 14663.266836658124, 14893.106413615002, 15001.774973375408, 15055.774163387558, 267249.0, 269418.0, 271510.0, 271980.0, 272393.0, 49346.50653493491, 49416.0, 49499.0, 49541.0, 49668.25497617538, 1172.4255114993762, 1196.5094311332311, 1201.9819702704467, 1221.248931906871, 1221.2733423612935, 26515.33711657224, 27394.726052739217, 27637.861810690818, 27940.30149246285, 28227.0, 41721.1655766889, 42073.78963105165, 42102.36846447244, 42123.57876421197, 42201.0, 341474.0, 341621.0, 342370.0, 342917.0, 343650.0, 21899.343019709435, 22020.229291974705, 22793.430164246027, 25236.495270094863, 25637.3590660235, 42175.7891210542, 42378.15243695171, 43093.569064310206, 43194.35208471813, 43372.0, 35698.46452303165, 35817.64182358143, 35948.28103437969, 36267.45598815967, 36482.452763209105, 35337.82331088328, 35998.28003439864, 36336.81831590931, 36360.818195908854, 36699.63300366962, 33514.0, 33533.161670957445, 33683.49474757832, 34267.0, 34738.131546711535, 31259.687403126587, 32680.83659581687, 32687.34625307433, 32734.0, 32796.83601581977, 25049.0, 25340.239792806246, 25511.87244063768, 25650.61524077103, 25796.742032579434], "value": 17556.34931959526, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.46502513716854, 365.9012066741981, 369.8649992752646, 373.402555910543, 391.82759585782253, 16439.671206575862, 17035.488935331945, 17703.645927081467, 17726.734098988527, 17750.201240944156, 16225.188740562984, 17067.317307307723, 17084.060376679277, 17109.31562737489, 17174.0, 5001.149804533229, 5205.869853253661, 5248.107821670306, 5249.973750131263, 5253.133233016548, 3739.6821270192067, 3922.431247469115, 5157.819476318329, 5753.741081651315, 6074.51403887688, 6083.209182806229, 6106.603070800406, 6107.541934354919, 6118.663473508956, 6119.326874043873, 5819.941800582003, 6006.759729610832, 6007.8197654070445, 6012.6993650317745, 6013.75944962201, 3382.120648631349, 4901.8774530636665, 5180.1452760294505, 5185.922211166836, 5282.630215884889, 20909.790902090936, 20945.895270523702, 21178.894105529373, 21216.78783212179, 21334.893325533274, 1896.9620607587772, 1986.265081919699, 2131.936041918745, 2529.6458495810602, 2537.6701028866314, 12904.612861614072, 13264.071514993955, 13305.201687898758, 13603.047786654937, 13880.0, 1698.8216237295153, 1733.8092809790912, 1738.1569938579778, 1750.509857239962, 1763.0303333166707, 68509.0, 70413.64793176053, 70445.2955470449, 70730.64634676845, 72568.27431725668, 9553.23574114083, 9616.615335386507, 9848.704538863702, 9913.45475998827, 9955.950220248853, 13409.128406653535, 13490.730185396236, 13520.59438216855, 13527.053106282467, 13528.526501572398, 7337.0, 7354.374878135419, 7416.480846340704, 7421.369183619345, 7471.738489152854, 6860.554063985925, 6935.375816176568, 6957.686904089328, 7034.2262351141335, 7058.576485410892, 6165.198524191826, 6281.434670879551, 6391.488680905516, 6404.391582799627, 6469.417752402306, 1627.6744651069596, 1742.364037126465, 1750.1074452029302, 1772.955676108082, 1786.0712429536568, 877.8332116897769, 879.1779685993489, 923.7782932096383, 961.4519723757531, 997.3153027741756, 17376.0, 17566.38517651876, 17921.0, 18131.456056318333, 18463.353782617545, 840.7940054686641, 849.0575461238021, 851.7700220940435, 855.9828803423896, 863.6502216602286, 9477.620895164255, 9622.0, 9778.75553111178, 9814.803703926023, 9877.703668889944, 299948.0, 303780.0, 304641.0, 386470.0, 386984.0, 52361.0, 53061.734691326295, 53755.0, 78228.0, 86597.44504454287, 915.4869882173476, 919.6137622198693, 948.6821914658528, 950.0641867760389, 962.4610218277787, 16142.596435089217, 16198.757018644965, 16277.67444651124, 16292.0, 16400.343986240416, 30142.84928575343, 38921.80539097286, 39981.40027899526, 40109.39835902405, 40237.39643905285, 55916.0, 56745.43254567401, 57208.71395642995, 57227.42772572221, 57388.42611573998, 7473.514221575798, 7511.9624401877645, 7640.235976402538, 7724.92275077242, 7867.567283799446, 8703.086175951434, 11578.478968446272, 11643.59247426336, 11999.880001199876, 12029.759404811679, 9567.330286879851, 10340.482975851328, 10347.741306467398, 10473.476326183509, 10477.31897426665, 9287.72136835896, 9392.248620110511, 9622.37454565451, 10340.37957722539, 10358.5338659762, 9797.755056123653, 9864.5560949756, 10062.849057264293, 10117.949410252902, 10211.795764084825, 7790.259925307087, 7816.06207255133, 7884.44808863397, 7975.84048319042, 8042.517448953082, 7615.7334493292465, 8383.371247156365, 10040.196784257096, 10184.439855808001, 10404.78592187902], "value": 8384.694778081934, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1230.0651504856307, 1290.3225806451612, 1353.6886516101297, 1386.7018591002939, 1690.8562772164366, 6151.0, 7183.353498185163, 7437.590932498724, 7452.6273686315735, 7631.0, 7415.110186777581, 7519.849603007937, 7531.811704707385, 7544.0569928758905, 7547.924520754791, 2201.823854091677, 2222.9333120006427, 2226.2430773536994, 2227.5656247031834, 2228.097620463715, 2142.1431427429075, 2198.835087368446, 2205.0408072488517, 2206.9779302206935, 2212.236778311488, 2149.258505815491, 2185.3334732906455, 2188.7154669892893, 2189.35414052854, 2204.801567858892, 2096.5282811367474, 2101.737282839645, 2102.4848912016655, 2105.410485064177, 2105.947351316214, 2091.2366986050133, 2121.1303365620174, 2123.3948324727535, 2129.1057755742627, 2129.968050479244, 7365.705371785122, 7475.102987641518, 7500.624968751541, 7536.133344665379, 7597.430192735567, 4472.284434490466, 4559.202139625552, 4574.176648203322, 4586.151561961048, 4595.218812801798, 2846.644169478815, 2891.8843246270126, 2944.05790147153, 2950.2329394357407, 2954.9556756648667, 881.9735407937773, 888.3648191543077, 900.3787386703219, 901.8962819275802, 902.4089221559823, 9705.805883882284, 9723.611055557698, 9739.366941148803, 9753.658621948269, 9754.0, 3831.9616803831605, 3943.6056394360908, 4079.204555111784, 4081.2041651878194, 4083.9387409188885, 7878.172791856887, 7971.800704982422, 7972.083210430875, 7973.441859069925, 7981.3614910807, 4444.422225110715, 4453.910921781546, 4461.620762235247, 4464.263396539534, 4464.575865292792, 3511.6839484446523, 3881.9805900970314, 4098.610631989956, 4152.937705934413, 4160.313548264563, 3525.964740352615, 3608.4226523756074, 3685.4656074868994, 3704.49989251453, 3704.870329538453, 1178.452019810792, 1192.1833544022372, 1200.33981310279, 1200.5977997370978, 1204.0848954794244, 754.5698951597647, 775.6276987046136, 859.076492770262, 867.314821291173, 872.7032808845023, 5178.145605974972, 5199.012187684328, 5252.947470525322, 5285.497877701612, 5484.945150548443, 827.5159031966367, 869.3349587565517, 885.7369569529881, 891.5497673674882, 954.427343593852, 3685.244524872395, 3839.232153569297, 3847.249786291646, 3956.5647778744315, 3956.8219430125714, 8963.507007114671, 9067.81864362709, 9160.496172710431, 9161.633534658538, 9206.493642849708, 8559.144085591392, 9127.406718563272, 9135.223506001932, 9136.862947055799, 9160.816783664422, 6705.899411508832, 7020.403265722471, 7060.399866011344, 7069.328413800681, 7086.397656199178, 5109.9744501277255, 5153.0466863630345, 5385.084535628874, 5472.91790623149, 5546.195801608664, 8268.9663792026, 8428.241458268785, 8659.913400866162, 8663.436876603, 8672.523011234443, 8489.278411335106, 8556.229939305493, 8795.12048795141, 8813.0, 8820.823583528421, 5718.771249150153, 6291.245050593775, 6419.903701444388, 6547.214334279917, 6547.345265473415, 7317.743878964211, 7326.157491888501, 7359.0, 7394.0, 7396.186419493959, 6460.095586617783, 6516.0, 6548.901766473602, 6660.6336651484635, 6667.499937504804, 6318.842028949313, 6371.23545174582, 6377.96811015942, 6424.967875160594, 6476.579022363531, 5800.59395842287, 5814.186013957965, 5845.853853653693, 5845.970770146122, 5850.94149058504, 4297.183535128315, 4479.686421950432, 4487.865364039084, 4520.141173177086, 4567.520410356865, 4564.88587785308, 4609.723416595015, 4664.020555683344, 4751.7861696224445, 4773.689710168828], "value": 4028.4853443610687, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.38161288874034, 297.290961057877, 298.56856841863504, 307.78608866837556, 308.4986896293523, 4832.719329377714, 4894.0, 4915.336429582006, 4918.188498897677, 4920.852374428769, 4741.644376671747, 4794.801299675081, 4810.302506136608, 4816.772762249293, 4854.538818812216, 3634.7637403568683, 3739.308227977819, 3756.6476068615275, 3832.923341533168, 3860.4944071812015, 3803.7717736935733, 3813.1039205786756, 3849.8825645894785, 3851.9022078707576, 3855.1133239354967, 3618.3125206210734, 3772.434134879776, 3772.4529943158227, 3789.3747531657245, 3795.35478968576, 3700.611435799243, 3797.5442946846556, 3813.809309534512, 3814.19901820618, 3831.67430768385, 3365.697087262158, 3378.189234583707, 3384.3062172254627, 3407.4377727674905, 3415.26571787067, 4719.10337035962, 4722.409698787652, 4730.172219861545, 4737.407824021997, 4740.146773580754, 4276.23027854986, 4359.016647425446, 4371.868843934687, 4388.42950416447, 4399.318105693591, 4996.475370086125, 5013.298138260647, 5042.697438153723, 5078.949210507922, 5080.542751152414, 3671.284099600552, 3697.9815100924325, 3712.1833196696684, 3712.5706602958057, 3723.8510459581853, 5013.498650134994, 5228.320318358665, 5258.13240815265, 5275.630705850592, 5284.841454756325, 3756.8309426075343, 3783.5459744830796, 3788.886333410002, 3790.298794722985, 3795.4306853971575, 3832.2718683450057, 3840.8847734568008, 3845.2309538092495, 3846.249981253629, 3851.094992676719, 4332.025294308755, 4346.500152482442, 4352.869413917588, 4355.237833379146, 4366.345048242789, 4818.204996175662, 4987.226979818134, 4990.72551009698, 4997.950020499821, 5001.8499445016705, 1246.0280980834782, 1268.7081971146688, 1268.7525932443084, 1270.275942712645, 1276.5914907229596, 813.5118928642885, 829.7676650537859, 869.3610196505564, 902.3142411766974, 907.0430695616056, 4410.16206920684, 4415.62467190286, 4420.093880754438, 4471.19518486669, 4480.081583275421, 5110.1568241239775, 5110.948890511122, 5120.846374608767, 5125.487451254845, 5144.742762861842, 4241.512226094039, 4416.205083085076, 4430.269005614037, 4436.179306828247, 4476.41806565151, 2726.6455360803366, 2741.8629068546493, 2743.696744046562, 2750.422411293651, 2755.2147637923094, 4834.114695268848, 4849.199882019428, 4852.296417019513, 4858.975705121523, 4862.78117484714, 5100.0, 5173.870653233699, 5252.2384254282915, 5256.947430525723, 5297.443768404262, 4775.976120119377, 4808.206645903387, 4835.3714017178245, 4849.660523763303, 4875.902481950412, 5156.767945442539, 5160.277561141368, 5162.457941916195, 5165.483451654804, 5171.448565430431, 4861.222204447272, 5061.822836200715, 5076.923846142237, 5148.0141517920265, 5164.8192313268855, 4919.204490361064, 4938.160557679277, 4939.678920870132, 4943.209086546135, 4945.925811112908, 3673.118451571657, 3703.166787472797, 3704.1850792825535, 3711.7772933622987, 3718.925621487609, 5196.454372291007, 5295.973520132375, 5312.150055991023, 5316.920246196233, 5320.255164277081, 5071.797128114982, 5106.948930510647, 5109.540141387293, 5116.360454943132, 5126.820561280338, 5141.203113517411, 5144.125498665161, 5146.459621739664, 5170.224466330081, 5187.533122019036, 4929.0, 5004.749762511787, 5059.620528460307, 5085.694858308513, 5096.694198348111, 4897.142999974919, 4970.6023518117745, 5133.614978876524, 5136.871578210575, 5137.87155321105, 5001.299818025552, 5009.824656137018, 5021.447640759587, 5022.890386037946, 5050.89370037417], "value": 3828.0868041076824, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.3704769326059, 688.5490004047344, 715.3561794385056, 718.3104219948849, 746.0972223609431, 12659.367031648415, 13223.93388033061, 13235.470581176742, 13260.469581216752, 13276.800847987275, 12524.56164034259, 12585.056120790954, 12602.936985315084, 12951.352432378391, 13183.143095698797, 630.268888089816, 782.256855986812, 789.6170357376668, 795.5664163031133, 795.6021989005498, 760.7261385901071, 784.0865391818525, 796.195842199377, 797.3182928596054, 797.6251161953901, 843.464400105934, 845.4589062999654, 845.8435189489965, 845.9280961118312, 846.031294168177, 653.4315145823117, 665.0356982375527, 823.2549542663899, 837.3343192162215, 839.3998291221775, 496.7168713833117, 497.02830965462795, 584.2346526050887, 595.1964847455943, 609.8048624440181, 12981.805272920914, 13038.608841734764, 13055.608331750063, 13060.281684507348, 13139.211647301192, 12165.574204902874, 12603.684907877285, 12703.555375561811, 12866.163699359606, 13123.671908202372, 11579.0, 11595.826062609067, 11648.184627076109, 11762.588309409215, 11807.468663910146, 4096.1193343431305, 4128.380742888561, 4156.43888075109, 4195.077083041726, 4264.808083636212, 59224.0, 59227.40772592262, 59713.0, 62345.0, 62706.0, 10132.392056476636, 10279.537420816081, 10330.173586113093, 10522.31604945676, 10683.358998460117, 19175.904120479307, 19196.0, 19203.615927681647, 19207.711884321747, 19216.0, 6729.49528785343, 6841.726330946706, 6863.931360686429, 6892.483063770237, 6902.068220790129, 3603.765755225902, 3676.485292059114, 3691.7046636269033, 3702.0559757261726, 3748.156664750409, 2637.2483842104907, 2699.91900242993, 2731.1942976821883, 2735.849528275924, 2738.411241583069, 501.19307914258013, 535.3629181274271, 561.1750726432219, 563.5097465205298, 563.5181919458804, 511.7032121369597, 572.83101485062, 573.5554944917723, 574.4513989140361, 624.4723208888482, 8133.652689849929, 8627.094155113748, 8733.737987860375, 8997.235235005099, 9022.684206052889, 488.863118326869, 562.8508445262008, 606.2703985758051, 615.4092071611303, 642.1972534332085, 3904.668103211202, 4046.1503084352025, 4132.669386449077, 4155.501339839238, 4190.643795277375, 92413.07586924179, 105393.0, 105975.0, 109007.45496272467, 109632.0, 66936.330636693, 90829.54585227031, 93779.0, 93927.53036234775, 94362.0, 62594.37405625977, 71822.28177718261, 73268.63365683137, 74368.62815685887, 74555.0, 7219.8556028880175, 7490.775276741707, 7569.545827250383, 7601.961990190013, 7737.961310193413, 31231.375372492876, 32708.836455817567, 35086.47370289396, 41130.38304425376, 44755.0, 60457.0, 63478.0, 64479.67760161169, 64724.35275647183, 65664.0, 11597.88402115968, 11619.419029048344, 11766.0, 11820.822687659864, 12087.576934807239, 12816.166949148275, 12867.163634363736, 13434.0, 13738.862611374157, 13794.93102534481, 11666.358350290815, 11718.88281117178, 12325.52566944208, 12331.568395106127, 12376.0, 11962.521499140285, 12142.453589588313, 12195.085368597569, 12233.510659573518, 12361.07291953125, 11876.76246475083, 11896.881031189578, 11998.0, 12258.325792081521, 12338.753224935272, 10044.196464282693, 10272.73133505813, 10468.476576171313, 10627.25609207379, 10733.195010374096, 9750.512474376395, 10379.481025948522, 10384.584616615251, 10393.324433911772, 10447.0], "value": 6633.259386853098, "unit": "score"}], "name": "dromaeo_css", "value": 6419.63359992434, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 113.0, 114.0, 114.0, 113.0, 114.0, 112.0, 115.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 123.0, 125.0, 173.0, 125.0, 124.0, 152.0, 128.0, 168.0, 130.0], "value": 139.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 162.0, 160.0, 173.0, 163.0, 160.0, 162.0, 160.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 115.0, 75.0, 77.0, 75.0, 74.0, 105.0, 75.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 121.0, 86.0, 85.0, 87.0, 119.0, 85.0, 85.0, 125.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 63.0, 64.0, 63.0, 64.0, 63.0, 64.0, 63.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 65.0, 66.0, 66.0, 66.0, 69.0, 65.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 78.0, 79.0, 78.0, 79.0, 80.0, 80.0, 84.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 140.0, 131.0, 129.0, 131.0, 130.0, 128.0, 211.0, 133.0], "value": 141.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 169.0, 165.0, 167.0, 168.0, 171.0, 174.0, 169.0, 170.0, 163.0], "value": 169.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 70.0, 68.0, 66.0, 72.0, 67.0, 66.0, 67.0, 66.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1538.1999999999998, "alertThreshold": 2.0}]} 09:39:36 INFO - Return code: 0 09:39:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:39:36 INFO - # TBPL SUCCESS # 09:39:36 INFO - Running post-action listener: _resource_record_post_action 09:39:36 INFO - ##### 09:39:36 INFO - ##### Finished run-tests step (success) 09:39:36 INFO - ##### 09:39:36 INFO - Running post-run listener: _resource_record_post_run 09:39:36 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 0; Write bytes: 541249536; Read time: 0; Write time: 413292 09:39:36 INFO - TinderboxPrint: CPU usage
13.0% 09:39:36 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:39:36 INFO - TinderboxPrint: I/O write bytes / time
541,249,536 / 413,292 09:39:36 INFO - TinderboxPrint: CPU idle
8,336.1 (87.0%) 09:39:36 INFO - TinderboxPrint: CPU user
1,200.2 (12.5%) 09:39:36 INFO - TinderboxPrint: Swap in / out
0 / 0 09:39:36 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 254189568; Read time: 0; Write time: 226768 09:39:36 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 287059968; Read time: 0; Write time: 186524 09:39:37 INFO - Running post-run listener: _upload_blobber_files 09:39:37 INFO - Blob upload gear active. 09:39:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:39:37 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:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:39:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:39:37 INFO - (blobuploader) - INFO - Open directory for files ... 09:39:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:39:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:39:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:39:41 INFO - (blobuploader) - INFO - Done attempting. 09:39:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:39:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:39:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:39:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: 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 - Iteration through files over. 09:39:43 INFO - Return code: 0 09:39:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:39:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:39:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ac217848e360c97c51c8d59e5953022fb88cfbf181b321c20df282511d8bd999805840e679f1aa5e0924c687587a66fd196cda255f2443b56844f16c46cc3590", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/645237a5ac681488636fb5380ca02688ae7c2d4b36c04fef00a1e8cf2be159a5f21175cfbabd1f14f5e9279c95f8a5cdd4d663347dd19cc2cef8189cd5a5ae23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c40fb36902128e30e7f6cf12c9c9e2d5ad2541be5b66ef3b761234a1f9a8b917339e743e5d3015483812d50af15582ec6ff6309d919e948fdfae83b8113a1b2d"} 09:39:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:39:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:39:43 INFO - Contents: 09:39:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ac217848e360c97c51c8d59e5953022fb88cfbf181b321c20df282511d8bd999805840e679f1aa5e0924c687587a66fd196cda255f2443b56844f16c46cc3590", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/645237a5ac681488636fb5380ca02688ae7c2d4b36c04fef00a1e8cf2be159a5f21175cfbabd1f14f5e9279c95f8a5cdd4d663347dd19cc2cef8189cd5a5ae23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c40fb36902128e30e7f6cf12c9c9e2d5ad2541be5b66ef3b761234a1f9a8b917339e743e5d3015483812d50af15582ec6ff6309d919e948fdfae83b8113a1b2d"} 09:39:43 INFO - Running post-run listener: copy_logs_to_upload_dir 09:39:43 INFO - Copying logs to upload dir... 09:39:43 INFO - mkdir: /builds/slave/test/build/upload/logs 09:39:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.542116 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-12 09:39:43.034873) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 09:39:43.039294) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ac217848e360c97c51c8d59e5953022fb88cfbf181b321c20df282511d8bd999805840e679f1aa5e0924c687587a66fd196cda255f2443b56844f16c46cc3590", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/645237a5ac681488636fb5380ca02688ae7c2d4b36c04fef00a1e8cf2be159a5f21175cfbabd1f14f5e9279c95f8a5cdd4d663347dd19cc2cef8189cd5a5ae23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c40fb36902128e30e7f6cf12c9c9e2d5ad2541be5b66ef3b761234a1f9a8b917339e743e5d3015483812d50af15582ec6ff6309d919e948fdfae83b8113a1b2d"} build_url:https://queue.taskcluster.net/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011187 build_url: 'https://queue.taskcluster.net/v1/task/NesttIeaQf-iOFnPAKe-7A/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ac217848e360c97c51c8d59e5953022fb88cfbf181b321c20df282511d8bd999805840e679f1aa5e0924c687587a66fd196cda255f2443b56844f16c46cc3590", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/645237a5ac681488636fb5380ca02688ae7c2d4b36c04fef00a1e8cf2be159a5f21175cfbabd1f14f5e9279c95f8a5cdd4d663347dd19cc2cef8189cd5a5ae23", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c40fb36902128e30e7f6cf12c9c9e2d5ad2541be5b66ef3b761234a1f9a8b917339e743e5d3015483812d50af15582ec6ff6309d919e948fdfae83b8113a1b2d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 09:39:43.068058) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:39:43.068659) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1468340173.761212-1142488705 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 09:39:43.153227) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 09:39:43.153560) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 09:39:43.153913) ========= ========= Total master_lag: 0.18 =========