builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-028 starttime: 1468811129.91 results: success (0) buildid: 20160717184351 builduid: 1337154ddddb446da9ddbe04fa50f76b revision: 4cefce05d01dd194c47090e51f9796a109674352 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 20:05:29.908288) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-17 20:05:29.908758) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-07-17 20:05:29.909034) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2016-07-17 20:05:31.090882) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 20:05:31.091313) ========= 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=836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-17 20:05:31-- 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% 67.1M=0s 2016-07-17 20:05:31 (67.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.129179 ========= master_lag: 0.45 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 20:05:31.674008) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 20:05:31.674418) ========= 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=836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016810 ========= master_lag: 0.40 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 20:05:32.093665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-17 20:05:32.094332) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4cefce05d01dd194c47090e51f9796a109674352 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 4cefce05d01dd194c47090e51f9796a109674352 --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=836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-17 20:05:32,641 truncating revision to first 12 chars 2016-07-17 20:05:32,641 Setting DEBUG logging. 2016-07-17 20:05:32,641 attempt 1/10 2016-07-17 20:05:32,641 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4cefce05d01d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-17 20:05:32,944 unpacking tar archive at: autoland-4cefce05d01d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.654192 ========= master_lag: 0.43 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-17 20:05:33.180492) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 20:05:33.180853) ========= script_repo_revision: 4cefce05d01dd194c47090e51f9796a109674352 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-17 20:05:33.181727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 20:05:33.181996) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-17 20:05:33.204625) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-17 20:05:33.204936) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:05:33 INFO - MultiFileLogger online at 20160717 20:05:33 in /builds/slave/test 20:05:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 20:05:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:05:33 INFO - {'append_to_log': False, 20:05:33 INFO - 'base_work_dir': '/builds/slave/test', 20:05:33 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 20:05:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:05:33 INFO - 'branch': 'Autoland-Non-PGO', 20:05:33 INFO - 'buildbot_json_path': 'buildprops.json', 20:05:33 INFO - 'config_files': ('talos/linux_config.py',), 20:05:33 INFO - 'default_actions': ('clobber', 20:05:33 INFO - 'read-buildbot-config', 20:05:33 INFO - 'download-and-extract', 20:05:33 INFO - 'populate-webroot', 20:05:33 INFO - 'create-virtualenv', 20:05:33 INFO - 'install', 20:05:33 INFO - 'run-tests'), 20:05:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:05:33 INFO - 'download_minidump_stackwalk': True, 20:05:33 INFO - 'download_symbols': 'ondemand', 20:05:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:05:33 INFO - 'tooltool.py': '/tools/tooltool.py', 20:05:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:05:33 INFO - '/tools/misc-python/virtualenv.py')}, 20:05:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:05:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:05:33 INFO - 'installer_path': 'installer.exe', 20:05:33 INFO - 'log_level': 'info', 20:05:33 INFO - 'log_name': 'talos', 20:05:33 INFO - 'log_to_console': True, 20:05:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:05:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:05:33 INFO - 'opt_config_files': (), 20:05:33 INFO - 'pip_index': False, 20:05:33 INFO - 'sps_profile': False, 20:05:33 INFO - 'sps_profile_interval': 0, 20:05:33 INFO - 'suite': 'dromaeojs-e10s', 20:05:33 INFO - 'system_bits': '32', 20:05:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:05:33 INFO - 'title': 'talos-linux64-ix-028', 20:05:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:05:33 INFO - 'use_talos_json': True, 20:05:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:05:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:05:33 INFO - 'work_dir': 'build'} 20:05:33 INFO - ##### 20:05:33 INFO - ##### Running clobber step. 20:05:33 INFO - ##### 20:05:33 INFO - Running pre-action listener: _resource_record_pre_action 20:05:33 INFO - Running main action method: clobber 20:05:33 INFO - rmtree: /builds/slave/test/build 20:05:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:05:33 INFO - Running post-action listener: _resource_record_post_action 20:05:33 INFO - ##### 20:05:33 INFO - ##### Finished clobber step (success) 20:05:33 INFO - ##### 20:05:33 INFO - ##### 20:05:33 INFO - ##### Running read-buildbot-config step. 20:05:33 INFO - ##### 20:05:33 INFO - Running pre-action listener: _resource_record_pre_action 20:05:33 INFO - Running main action method: read_buildbot_config 20:05:33 INFO - Using buildbot properties: 20:05:33 INFO - { 20:05:33 INFO - "project": "", 20:05:33 INFO - "product": "firefox", 20:05:33 INFO - "script_repo_revision": "production", 20:05:33 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 20:05:33 INFO - "repository": "", 20:05:33 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 20:05:33 INFO - "buildid": "20160717184351", 20:05:33 INFO - "pgo_build": "False", 20:05:33 INFO - "basedir": "/builds/slave/test", 20:05:33 INFO - "buildnumber": 124, 20:05:33 INFO - "slavename": "talos-linux64-ix-028", 20:05:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:05:33 INFO - "platform": "ubuntu64_hw", 20:05:33 INFO - "scheduler": "tests-autoland-linux64-talos", 20:05:33 INFO - "branch": "autoland", 20:05:33 INFO - "repo_path": "integration/autoland", 20:05:33 INFO - "revision": "4cefce05d01dd194c47090e51f9796a109674352", 20:05:33 INFO - "stage_platform": "linux64", 20:05:33 INFO - "builduid": "1337154ddddb446da9ddbe04fa50f76b", 20:05:33 INFO - "slavebuilddir": "test" 20:05:33 INFO - } 20:05:33 INFO - Found installer url https://queue.taskcluster.net/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 20:05:33 INFO - Running post-action listener: _resource_record_post_action 20:05:33 INFO - ##### 20:05:33 INFO - ##### Finished read-buildbot-config step (success) 20:05:33 INFO - ##### 20:05:33 INFO - ##### 20:05:33 INFO - ##### Running download-and-extract step. 20:05:33 INFO - ##### 20:05:33 INFO - Running pre-action listener: _resource_record_pre_action 20:05:33 INFO - Running main action method: download_and_extract 20:05:33 INFO - mkdir: /builds/slave/test/build/tests 20:05:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:33 INFO - https://queue.taskcluster.net/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 20:05:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:05:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:05:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/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 20:05:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/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 20:05:34 INFO - Downloaded 1361 bytes. 20:05:34 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 20:05:34 INFO - Using the following test package requirements: 20:05:34 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:34 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:05:34 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:05:34 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:34 INFO - u'jsshell-linux-x86_64.zip'], 20:05:34 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:05:34 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 20:05:34 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:05:34 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:05:34 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:05:34 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 20:05:34 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:05:34 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:34 INFO - https://queue.taskcluster.net/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/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 20:05:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/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 20:05:36 INFO - Downloaded 22763991 bytes. 20:05:36 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'] 20:05:36 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 20:05:37 INFO - Return code: 0 20:05:37 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 20:05:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:05:37 INFO - https://queue.taskcluster.net/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:05:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 20:05:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/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 20:05:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/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 20:05:47 INFO - Downloaded 22763991 bytes. 20:05:47 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'] 20:05:47 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 20:05:48 INFO - Return code: 0 20:05:48 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')]} 20:05:48 INFO - https://queue.taskcluster.net/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:05:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 20:05:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/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 20:05:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/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 20:05:49 INFO - Downloaded 14403317 bytes. 20:05:49 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'] 20:05:49 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 20:05:49 INFO - Return code: 0 20:05:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:05:49 INFO - https://queue.taskcluster.net/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:05:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:05:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:05:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/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 20:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AZmiQU7nSAuAg94gGzPN_g/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 20:05:51 INFO - Downloaded 57097811 bytes. 20:05:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:05:51 INFO - mkdir: /builds/slave/test/properties 20:05:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:05:51 INFO - Writing to file /builds/slave/test/properties/build_url 20:05:51 INFO - Contents: 20:05:51 INFO - build_url:https://queue.taskcluster.net/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 20:05:51 INFO - Running post-action listener: _resource_record_post_action 20:05:51 INFO - Running post-action listener: set_extra_try_arguments 20:05:51 INFO - ##### 20:05:51 INFO - ##### Finished download-and-extract step (success) 20:05:51 INFO - ##### 20:05:51 INFO - ##### 20:05:51 INFO - ##### Running populate-webroot step. 20:05:51 INFO - ##### 20:05:51 INFO - Running pre-action listener: _resource_record_pre_action 20:05:51 INFO - Running main action method: populate_webroot 20:05:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:05:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:05:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:05:51 INFO - '--tppagecycles', 20:05:51 INFO - '7'], 20:05:51 INFO - 'tests': ['tsvgm']}}, 20:05:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:05:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:05:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:05:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:05:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:05:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:05:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:51 INFO - 'talos_options': ['--disable-e10s'], 20:05:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:05:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:51 INFO - 'talos_options': ['--disable-e10s'], 20:05:51 INFO - 'tests': ['damp', 'tps']}, 20:05:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:51 INFO - 'tests': ['damp', 'tps']}, 20:05:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:05:51 INFO - 'tests': ['dromaeo_dom']}, 20:05:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:05:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:05:51 INFO - 'tests': ['basic_compositor_video']}, 20:05:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:05:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:05:51 INFO - 'tests': ['a11yr', 20:05:51 INFO - 'ts_paint', 20:05:51 INFO - 'tpaint', 20:05:51 INFO - 'sessionrestore', 20:05:51 INFO - 'sessionrestore_no_auto_restore', 20:05:51 INFO - 'tabpaint']}, 20:05:51 INFO - 'other-e10s': {'tests': ['a11yr', 20:05:51 INFO - 'ts_paint', 20:05:51 INFO - 'tpaint', 20:05:51 INFO - 'sessionrestore', 20:05:51 INFO - 'sessionrestore_no_auto_restore', 20:05:51 INFO - 'tabpaint']}, 20:05:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:05:51 INFO - 'ts_paint', 20:05:51 INFO - 'tpaint', 20:05:51 INFO - 'sessionrestore', 20:05:51 INFO - 'sessionrestore_no_auto_restore', 20:05:51 INFO - 'tabpaint']}, 20:05:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:05:51 INFO - 'ts_paint', 20:05:51 INFO - 'tpaint', 20:05:51 INFO - 'sessionrestore', 20:05:51 INFO - 'sessionrestore_no_auto_restore', 20:05:51 INFO - 'tabpaint']}, 20:05:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:05:51 INFO - 'tests': ['a11yr', 20:05:51 INFO - 'ts_paint', 20:05:51 INFO - 'tpaint', 20:05:51 INFO - 'sessionrestore', 20:05:51 INFO - 'sessionrestore_no_auto_restore', 20:05:51 INFO - 'tabpaint']}, 20:05:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:05:51 INFO - 'tests': ['a11yr', 20:05:51 INFO - 'ts_paint', 20:05:51 INFO - 'tpaint', 20:05:51 INFO - 'sessionrestore', 20:05:51 INFO - 'sessionrestore_no_auto_restore', 20:05:51 INFO - 'tabpaint']}, 20:05:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:05:51 INFO - 'tests': ['tsvgx', 20:05:51 INFO - 'tsvgr_opacity', 20:05:51 INFO - 'tart', 20:05:51 INFO - 'tscrollx', 20:05:51 INFO - 'cart']}, 20:05:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:05:51 INFO - 'tsvgr_opacity', 20:05:51 INFO - 'tart', 20:05:51 INFO - 'tscrollx', 20:05:51 INFO - 'cart']}, 20:05:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:51 INFO - 'talos_options': ['--disable-e10s'], 20:05:51 INFO - 'tests': ['tp5o']}, 20:05:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:51 INFO - 'tests': ['tp5o']}, 20:05:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:51 INFO - 'talos_options': ['--disable-e10s', 20:05:51 INFO - '--xperf_path', 20:05:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:51 INFO - 'tests': ['tp5n']}, 20:05:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:05:51 INFO - 'talos_options': ['--xperf_path', 20:05:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:05:51 INFO - 'tests': ['tp5n']}}, 20:05:51 INFO - 'talos.zip': {'path': '', 20:05:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:05:51 INFO - Running post-action listener: _resource_record_post_action 20:05:51 INFO - ##### 20:05:51 INFO - ##### Finished populate-webroot step (success) 20:05:51 INFO - ##### 20:05:51 INFO - ##### 20:05:51 INFO - ##### Running create-virtualenv step. 20:05:51 INFO - ##### 20:05:51 INFO - Running pre-action listener: _resource_record_pre_action 20:05:51 INFO - Running main action method: create_virtualenv 20:05:51 INFO - Creating virtualenv /builds/slave/test/build/venv 20:05:51 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 20:05:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:05:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:05:52 INFO - Using real prefix '/usr' 20:05:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:05:52 INFO - Installing distribute.............................................................................................................................................................................................done. 20:05:54 INFO - Installing pip.................done. 20:05:54 INFO - Return code: 0 20:05:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:54 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 0xd76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034570>, '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 0x1035470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035900>, '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': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', '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 20:05:54 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 20:05:54 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 20:05:54 INFO - Using env: {'DISPLAY': ':0', 20:05:54 INFO - 'HOME': '/home/cltbld', 20:05:54 INFO - 'LANG': 'en_US.UTF-8', 20:05:54 INFO - 'LANGUAGE': 'en_US:en', 20:05:54 INFO - 'LOGNAME': 'cltbld', 20:05:54 INFO - 'MAIL': '/var/mail/cltbld', 20:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:54 INFO - 'MOZ_NO_REMOTE': '1', 20:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:54 INFO - 'NO_EM_RESTART': '1', 20:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:54 INFO - 'PWD': '/builds/slave/test', 20:05:54 INFO - 'SHELL': '/bin/bash', 20:05:54 INFO - 'SHLVL': '1', 20:05:54 INFO - 'TERM': 'linux', 20:05:54 INFO - 'TMOUT': '86400', 20:05:54 INFO - 'USER': 'cltbld', 20:05:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', 20:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:54 INFO - '_': '/tools/buildbot/bin/python'} 20:05:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:54 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 20:05:54 INFO - Cleaning up... 20:05:54 INFO - Return code: 0 20:05:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:05:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:05:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:54 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 0xd76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034570>, '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 0x1035470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035900>, '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': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', '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 20:05:54 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 20:05:54 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 20:05:54 INFO - Using env: {'DISPLAY': ':0', 20:05:54 INFO - 'HOME': '/home/cltbld', 20:05:54 INFO - 'LANG': 'en_US.UTF-8', 20:05:54 INFO - 'LANGUAGE': 'en_US:en', 20:05:54 INFO - 'LOGNAME': 'cltbld', 20:05:54 INFO - 'MAIL': '/var/mail/cltbld', 20:05:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:54 INFO - 'MOZ_NO_REMOTE': '1', 20:05:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:54 INFO - 'NO_EM_RESTART': '1', 20:05:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:54 INFO - 'PWD': '/builds/slave/test', 20:05:54 INFO - 'SHELL': '/bin/bash', 20:05:54 INFO - 'SHLVL': '1', 20:05:54 INFO - 'TERM': 'linux', 20:05:54 INFO - 'TMOUT': '86400', 20:05:54 INFO - 'USER': 'cltbld', 20:05:54 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', 20:05:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:54 INFO - '_': '/tools/buildbot/bin/python'} 20:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:55 INFO - Downloading/unpacking psutil>=3.1.1 20:05:55 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 20:05:55 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 20:05:55 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 20:05:55 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 20:05:55 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 20:05:55 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 20:05:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:05:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:57 INFO - Installing collected packages: psutil 20:05:57 INFO - Running setup.py install for psutil 20:05:57 INFO - building 'psutil._psutil_linux' extension 20:05:57 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 20:05:57 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 20:05:57 INFO - building 'psutil._psutil_posix' extension 20:05:57 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 20:05:57 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 20:05:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:05:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:05:57 INFO - Successfully installed psutil 20:05:57 INFO - Cleaning up... 20:05:57 INFO - Return code: 0 20:05:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:05:57 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')]} 20:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:57 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')]} 20:05:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:57 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 0xd76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034570>, '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 0x1035470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035900>, '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': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', '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 20:05:57 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 20:05:57 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 20:05:57 INFO - Using env: {'DISPLAY': ':0', 20:05:57 INFO - 'HOME': '/home/cltbld', 20:05:57 INFO - 'LANG': 'en_US.UTF-8', 20:05:57 INFO - 'LANGUAGE': 'en_US:en', 20:05:57 INFO - 'LOGNAME': 'cltbld', 20:05:57 INFO - 'MAIL': '/var/mail/cltbld', 20:05:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:57 INFO - 'MOZ_NO_REMOTE': '1', 20:05:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:57 INFO - 'NO_EM_RESTART': '1', 20:05:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:57 INFO - 'PWD': '/builds/slave/test', 20:05:57 INFO - 'SHELL': '/bin/bash', 20:05:57 INFO - 'SHLVL': '1', 20:05:57 INFO - 'TERM': 'linux', 20:05:57 INFO - 'TMOUT': '86400', 20:05:57 INFO - 'USER': 'cltbld', 20:05:57 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', 20:05:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:57 INFO - '_': '/tools/buildbot/bin/python'} 20:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:05:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:05:57 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 20:05:57 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 20:05:57 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 20:05:57 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 20:05:57 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 20:05:57 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 20:05:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:05:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:05:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:05:59 INFO - Installing collected packages: mozsystemmonitor 20:05:59 INFO - Running setup.py install for mozsystemmonitor 20:05:59 INFO - Successfully installed mozsystemmonitor 20:05:59 INFO - Cleaning up... 20:05:59 INFO - Return code: 0 20:05:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:05:59 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 0xd76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034570>, '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 0x1035470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035900>, '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': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', '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 20:05:59 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 20:05:59 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 20:05:59 INFO - Using env: {'DISPLAY': ':0', 20:05:59 INFO - 'HOME': '/home/cltbld', 20:05:59 INFO - 'LANG': 'en_US.UTF-8', 20:05:59 INFO - 'LANGUAGE': 'en_US:en', 20:05:59 INFO - 'LOGNAME': 'cltbld', 20:05:59 INFO - 'MAIL': '/var/mail/cltbld', 20:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:05:59 INFO - 'MOZ_NO_REMOTE': '1', 20:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:05:59 INFO - 'NO_EM_RESTART': '1', 20:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:05:59 INFO - 'PWD': '/builds/slave/test', 20:05:59 INFO - 'SHELL': '/bin/bash', 20:05:59 INFO - 'SHLVL': '1', 20:05:59 INFO - 'TERM': 'linux', 20:05:59 INFO - 'TMOUT': '86400', 20:05:59 INFO - 'USER': 'cltbld', 20:05:59 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', 20:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:05:59 INFO - '_': '/tools/buildbot/bin/python'} 20:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:00 INFO - Downloading/unpacking jsonschema==2.5.1 20:06:00 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 20:06:00 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 20:06:00 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 20:06:00 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 20:06:00 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 20:06:00 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 20:06:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:06:02 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 20:06:02 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 20:06:02 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 20:06:02 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 20:06:02 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 20:06:02 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 20:06:02 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:02 INFO - warning: no files found matching '*.txt' 20:06:02 INFO - no previously-included directories found matching 'build' 20:06:02 INFO - no previously-included directories found matching 'dist' 20:06:02 INFO - no previously-included directories found matching '.git*' 20:06:02 INFO - Installing collected packages: jsonschema, functools32 20:06:02 INFO - Running setup.py install for functools32 20:06:02 INFO - warning: no files found matching '*.txt' 20:06:02 INFO - no previously-included directories found matching 'build' 20:06:02 INFO - no previously-included directories found matching 'dist' 20:06:02 INFO - no previously-included directories found matching '.git*' 20:06:02 INFO - Successfully installed jsonschema functools32 20:06:02 INFO - Cleaning up... 20:06:02 INFO - Return code: 0 20:06:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:02 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 0xd76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034570>, '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 0x1035470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035900>, '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': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', '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 20:06:02 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 20:06:02 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 20:06:02 INFO - Using env: {'DISPLAY': ':0', 20:06:02 INFO - 'HOME': '/home/cltbld', 20:06:02 INFO - 'LANG': 'en_US.UTF-8', 20:06:02 INFO - 'LANGUAGE': 'en_US:en', 20:06:02 INFO - 'LOGNAME': 'cltbld', 20:06:02 INFO - 'MAIL': '/var/mail/cltbld', 20:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:02 INFO - 'MOZ_NO_REMOTE': '1', 20:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:02 INFO - 'NO_EM_RESTART': '1', 20:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:02 INFO - 'PWD': '/builds/slave/test', 20:06:02 INFO - 'SHELL': '/bin/bash', 20:06:02 INFO - 'SHLVL': '1', 20:06:02 INFO - 'TERM': 'linux', 20:06:02 INFO - 'TMOUT': '86400', 20:06:02 INFO - 'USER': 'cltbld', 20:06:02 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', 20:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:02 INFO - '_': '/tools/buildbot/bin/python'} 20:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:02 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:02 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 20:06:02 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 20:06:02 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 20:06:02 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 20:06:02 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 20:06:02 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 20:06:04 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06:04 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 20:06:04 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 20:06:04 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 20:06:04 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 20:06:04 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 20:06:04 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 20:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06:05 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 20:06:05 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 20:06:05 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 20:06:05 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 20:06:05 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 20:06:05 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 20:06:05 INFO - Downloading docopt-0.6.1.tar.gz 20:06:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:05 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:05 INFO - Running setup.py install for blobuploader 20:06:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:05 INFO - Running setup.py install for requests 20:06:05 INFO - Running setup.py install for docopt 20:06:05 INFO - Successfully installed blobuploader requests docopt 20:06:05 INFO - Cleaning up... 20:06:05 INFO - Return code: 0 20:06:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:05 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 0xd76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034570>, '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 0x1035470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035900>, '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': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', '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 20:06:05 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 20:06:05 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 20:06:05 INFO - Using env: {'DISPLAY': ':0', 20:06:05 INFO - 'HOME': '/home/cltbld', 20:06:05 INFO - 'LANG': 'en_US.UTF-8', 20:06:05 INFO - 'LANGUAGE': 'en_US:en', 20:06:05 INFO - 'LOGNAME': 'cltbld', 20:06:05 INFO - 'MAIL': '/var/mail/cltbld', 20:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:05 INFO - 'MOZ_NO_REMOTE': '1', 20:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:05 INFO - 'NO_EM_RESTART': '1', 20:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:05 INFO - 'PWD': '/builds/slave/test', 20:06:05 INFO - 'SHELL': '/bin/bash', 20:06:05 INFO - 'SHLVL': '1', 20:06:05 INFO - 'TERM': 'linux', 20:06:05 INFO - 'TMOUT': '86400', 20:06:05 INFO - 'USER': 'cltbld', 20:06:05 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', 20:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:05 INFO - '_': '/tools/buildbot/bin/python'} 20:06:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:06 INFO - Running setup.py (path:/tmp/pip-6SUzyx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:06 INFO - Running setup.py (path:/tmp/pip-4S44br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:06 INFO - Running setup.py (path:/tmp/pip-p4_O6a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:06 INFO - Running setup.py (path:/tmp/pip-NLL7sR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:06 INFO - Running setup.py (path:/tmp/pip-WRuUL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:06 INFO - Running setup.py (path:/tmp/pip-hFCuzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:06 INFO - Running setup.py (path:/tmp/pip-3NqBpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:06 INFO - Running setup.py (path:/tmp/pip-wTAObe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:06 INFO - Running setup.py (path:/tmp/pip-A7ACvS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:06 INFO - Running setup.py (path:/tmp/pip-3n_Dkr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:06 INFO - Running setup.py (path:/tmp/pip-uIZYGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:06 INFO - Running setup.py (path:/tmp/pip-97mTrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:07 INFO - Running setup.py (path:/tmp/pip-dF4Tnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:07 INFO - Running setup.py (path:/tmp/pip-P3gqtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:07 INFO - Running setup.py (path:/tmp/pip-fxHtzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:07 INFO - Running setup.py (path:/tmp/pip-2JTIRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:07 INFO - Running setup.py (path:/tmp/pip-jt31qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:07 INFO - Running setup.py install for manifestparser 20:06:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:07 INFO - Running setup.py install for mozcrash 20:06:07 INFO - Running setup.py install for mozdebug 20:06:07 INFO - Running setup.py install for mozdevice 20:06:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:07 INFO - Running setup.py install for mozfile 20:06:07 INFO - Running setup.py install for mozhttpd 20:06:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:08 INFO - Running setup.py install for mozinfo 20:06:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:08 INFO - Running setup.py install for mozInstall 20:06:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:08 INFO - Running setup.py install for mozleak 20:06:08 INFO - Running setup.py install for mozlog 20:06:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:08 INFO - Running setup.py install for moznetwork 20:06:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:08 INFO - Running setup.py install for mozprocess 20:06:08 INFO - Running setup.py install for mozprofile 20:06:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:08 INFO - Running setup.py install for mozrunner 20:06:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:08 INFO - Running setup.py install for mozscreenshot 20:06:08 INFO - Running setup.py install for moztest 20:06:09 INFO - Running setup.py install for mozversion 20:06:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:09 INFO - Cleaning up... 20:06:09 INFO - Return code: 0 20:06:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:06:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 20:06:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:09 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 0xd76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034570>, '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 0x1035470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035900>, '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': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', '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 20:06:09 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 20:06:09 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 20:06:09 INFO - Using env: {'DISPLAY': ':0', 20:06:09 INFO - 'HOME': '/home/cltbld', 20:06:09 INFO - 'LANG': 'en_US.UTF-8', 20:06:09 INFO - 'LANGUAGE': 'en_US:en', 20:06:09 INFO - 'LOGNAME': 'cltbld', 20:06:09 INFO - 'MAIL': '/var/mail/cltbld', 20:06:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:09 INFO - 'MOZ_NO_REMOTE': '1', 20:06:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:09 INFO - 'NO_EM_RESTART': '1', 20:06:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:09 INFO - 'PWD': '/builds/slave/test', 20:06:09 INFO - 'SHELL': '/bin/bash', 20:06:09 INFO - 'SHLVL': '1', 20:06:09 INFO - 'TERM': 'linux', 20:06:09 INFO - 'TMOUT': '86400', 20:06:09 INFO - 'USER': 'cltbld', 20:06:09 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', 20:06:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:09 INFO - '_': '/tools/buildbot/bin/python'} 20:06:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:09 INFO - Running setup.py (path:/tmp/pip-cQosVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:09 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)) 20:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:09 INFO - Running setup.py (path:/tmp/pip-_PMIaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:09 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)) 20:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:09 INFO - Running setup.py (path:/tmp/pip-CFUc3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:09 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)) 20:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:09 INFO - Running setup.py (path:/tmp/pip-xVJnGm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:09 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)) 20:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:09 INFO - Running setup.py (path:/tmp/pip-KfCm_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:09 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)) 20:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:09 INFO - Running setup.py (path:/tmp/pip-YKK1fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:09 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)) 20:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:09 INFO - Running setup.py (path:/tmp/pip-hE5p22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:09 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)) 20:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:09 INFO - Running setup.py (path:/tmp/pip-Sd1CJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:09 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)) 20:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:09 INFO - Running setup.py (path:/tmp/pip-3p794r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:10 INFO - Running setup.py (path:/tmp/pip-fdLzZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:10 INFO - Running setup.py (path:/tmp/pip-w52YBJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:10 INFO - Running setup.py (path:/tmp/pip-GyJu9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:10 INFO - Running setup.py (path:/tmp/pip-BNzpEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:10 INFO - Running setup.py (path:/tmp/pip-Lq8g9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:10 INFO - Running setup.py (path:/tmp/pip-Hd6x7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:10 INFO - Running setup.py (path:/tmp/pip-qmjwHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:10 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)) 20:06:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:10 INFO - Running setup.py (path:/tmp/pip-qvTGgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:10 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)) 20:06:10 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)) 20:06:10 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)) 20:06:10 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)) 20:06:10 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)) 20:06:10 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)) 20:06:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:10 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 20:06:10 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 20:06:10 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 20:06:10 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 20:06:10 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 20:06:10 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 20:06:12 INFO - Downloading blessings-1.6.tar.gz 20:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:12 INFO - Installing collected packages: blessings 20:06:12 INFO - Running setup.py install for blessings 20:06:12 INFO - Successfully installed blessings 20:06:12 INFO - Cleaning up... 20:06:12 INFO - Return code: 0 20:06:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:13 INFO - Reading from file tmpfile_stdout 20:06:13 INFO - Current package versions: 20:06:13 INFO - argparse == 1.2.1 20:06:13 INFO - blessings == 1.6 20:06:13 INFO - blobuploader == 1.2.4 20:06:13 INFO - docopt == 0.6.1 20:06:13 INFO - functools32 == 3.2.3-2 20:06:13 INFO - jsonschema == 2.5.1 20:06:13 INFO - manifestparser == 1.1 20:06:13 INFO - mozInstall == 1.12 20:06:13 INFO - mozcrash == 0.17 20:06:13 INFO - mozdebug == 0.1 20:06:13 INFO - mozdevice == 0.48 20:06:13 INFO - mozfile == 1.2 20:06:13 INFO - mozhttpd == 0.7 20:06:13 INFO - mozinfo == 0.9 20:06:13 INFO - mozleak == 0.1 20:06:13 INFO - mozlog == 3.2 20:06:13 INFO - moznetwork == 0.27 20:06:13 INFO - mozprocess == 0.23 20:06:13 INFO - mozprofile == 0.28 20:06:13 INFO - mozrunner == 6.12 20:06:13 INFO - mozscreenshot == 0.1 20:06:13 INFO - mozsystemmonitor == 0.3 20:06:13 INFO - moztest == 0.7 20:06:13 INFO - mozversion == 1.4 20:06:13 INFO - psutil == 3.1.1 20:06:13 INFO - requests == 1.2.3 20:06:13 INFO - wsgiref == 0.1.2 20:06:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:13 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 0xd76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034570>, '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 0x1035470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035900>, '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': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', '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 20:06:13 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 20:06:13 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 20:06:13 INFO - Using env: {'DISPLAY': ':0', 20:06:13 INFO - 'HOME': '/home/cltbld', 20:06:13 INFO - 'LANG': 'en_US.UTF-8', 20:06:13 INFO - 'LANGUAGE': 'en_US:en', 20:06:13 INFO - 'LOGNAME': 'cltbld', 20:06:13 INFO - 'MAIL': '/var/mail/cltbld', 20:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:13 INFO - 'MOZ_NO_REMOTE': '1', 20:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:13 INFO - 'NO_EM_RESTART': '1', 20:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:13 INFO - 'PWD': '/builds/slave/test', 20:06:13 INFO - 'SHELL': '/bin/bash', 20:06:13 INFO - 'SHLVL': '1', 20:06:13 INFO - 'TERM': 'linux', 20:06:13 INFO - 'TMOUT': '86400', 20:06:13 INFO - 'USER': 'cltbld', 20:06:13 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', 20:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:13 INFO - '_': '/tools/buildbot/bin/python'} 20:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 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)) 20:06:13 INFO - Cleaning up... 20:06:13 INFO - Return code: 0 20:06:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:13 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 0xd76030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfa5400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1034570>, '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 0x1035470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035900>, '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': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', '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 20:06:13 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 20:06:13 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 20:06:13 INFO - Using env: {'DISPLAY': ':0', 20:06:13 INFO - 'HOME': '/home/cltbld', 20:06:13 INFO - 'LANG': 'en_US.UTF-8', 20:06:13 INFO - 'LANGUAGE': 'en_US:en', 20:06:13 INFO - 'LOGNAME': 'cltbld', 20:06:13 INFO - 'MAIL': '/var/mail/cltbld', 20:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:13 INFO - 'MOZ_NO_REMOTE': '1', 20:06:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:13 INFO - 'NO_EM_RESTART': '1', 20:06:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:13 INFO - 'PWD': '/builds/slave/test', 20:06:13 INFO - 'SHELL': '/bin/bash', 20:06:13 INFO - 'SHLVL': '1', 20:06:13 INFO - 'TERM': 'linux', 20:06:13 INFO - 'TMOUT': '86400', 20:06:13 INFO - 'USER': 'cltbld', 20:06:13 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', 20:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:13 INFO - '_': '/tools/buildbot/bin/python'} 20:06:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:06:13 INFO - Cleaning up... 20:06:13 INFO - Return code: 0 20:06:13 INFO - Running post-action listener: _resource_record_post_action 20:06:13 INFO - Running post-action listener: _start_resource_monitoring 20:06:13 INFO - Starting resource monitoring. 20:06:13 INFO - ##### 20:06:13 INFO - ##### Finished create-virtualenv step (success) 20:06:13 INFO - ##### 20:06:13 INFO - ##### 20:06:13 INFO - ##### Running install step. 20:06:13 INFO - ##### 20:06:13 INFO - Running pre-action listener: _resource_record_pre_action 20:06:13 INFO - Running main action method: install 20:06:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:13 INFO - Reading from file tmpfile_stdout 20:06:13 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:13 INFO - Reading from file tmpfile_stdout 20:06:13 INFO - Output received: 20:06:13 INFO - Usage: mozinstall [options] installer 20:06:13 INFO - Options: 20:06:13 INFO - -h, --help show this help message and exit 20:06:13 INFO - -d DEST, --destination=DEST 20:06:13 INFO - Directory to install application into. [default: 20:06:13 INFO - "/builds/slave/test"] 20:06:13 INFO - --app=APP Application being installed. [default: firefox] 20:06:13 INFO - mkdir: /builds/slave/test/build/application 20:06:13 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'] 20:06:13 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 20:06:30 INFO - Reading from file tmpfile_stdout 20:06:30 INFO - Output received: 20:06:30 INFO - /builds/slave/test/build/application/firefox/firefox 20:06:30 INFO - Running post-action listener: _resource_record_post_action 20:06:30 INFO - ##### 20:06:30 INFO - ##### Finished install step (success) 20:06:30 INFO - ##### 20:06:30 INFO - ##### 20:06:30 INFO - ##### Running run-tests step. 20:06:30 INFO - ##### 20:06:30 INFO - Running pre-action listener: _resource_record_pre_action 20:06:30 INFO - Running main action method: run_tests 20:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:06:30 INFO - Python 2.7.3 20:06:30 INFO - Return code: 0 20:06:30 INFO - grabbing minidump binary from tooltool 20:06:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:06:30 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 0x1034570>, '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 0x1035470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1035900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:06:30 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 20:06:30 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 20:06:30 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 20:06:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:06:30 INFO - Return code: 0 20:06:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:06:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:06:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:06:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:06:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 20:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 20:06:30 INFO - Using env: {'DISPLAY': ':0', 20:06:30 INFO - 'HOME': '/home/cltbld', 20:06:30 INFO - 'LANG': 'en_US.UTF-8', 20:06:30 INFO - 'LANGUAGE': 'en_US:en', 20:06:30 INFO - 'LOGNAME': 'cltbld', 20:06:30 INFO - 'MAIL': '/var/mail/cltbld', 20:06:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:06:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:06:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:30 INFO - 'MOZ_NO_REMOTE': '1', 20:06:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:06:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:30 INFO - 'NO_EM_RESTART': '1', 20:06:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:30 INFO - 'PWD': '/builds/slave/test', 20:06:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:06:30 INFO - 'SHELL': '/bin/bash', 20:06:30 INFO - 'SHLVL': '1', 20:06:30 INFO - 'TERM': 'linux', 20:06:30 INFO - 'TMOUT': '86400', 20:06:30 INFO - 'USER': 'cltbld', 20:06:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863', 20:06:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:30 INFO - '_': '/tools/buildbot/bin/python'} 20:06:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 20:06:30 INFO - mozversion application_buildid: 20160717184351 20:06:30 INFO - mozversion application_changeset: 4cefce05d01dd194c47090e51f9796a109674352 20:06:30 INFO - mozversion application_display_name: Nightly 20:06:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:06:30 INFO - mozversion application_name: Firefox 20:06:30 INFO - mozversion application_remotingname: firefox 20:06:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 20:06:30 INFO - mozversion application_vendor: Mozilla 20:06:30 INFO - mozversion application_version: 50.0a1 20:06:30 INFO - mozversion platform_buildid: 20160717184351 20:06:30 INFO - mozversion platform_changeset: 4cefce05d01dd194c47090e51f9796a109674352 20:06:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 20:06:30 INFO - mozversion platform_version: 50.0a1 20:06:30 INFO - using testdate: 1468811190 20:06:30 INFO - actual date: 1468811190 20:06:30 INFO - starting webserver on 'localhost:41260' 20:06:30 INFO - SUITE-START | Running 2 tests 20:06:30 INFO - TEST-START | dromaeo_css 20:06:30 INFO - operating with platform_type : linux_ 20:06:30 INFO - Initialising browser for dromaeo_css test... 20:06:30 INFO - TEST-INFO | started process 12335 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Tu02W/profile http://localhost:41260/getInfo.html) 20:06:33 INFO - PROCESS | 12335 | JavaScript error: , line 0: uncaught exception: undefined 20:06:35 INFO - PROCESS | 12335 | __metrics Screen width/height:1600/1200 20:06:35 INFO - PROCESS | 12335 | colorDepth:24 20:06:35 INFO - PROCESS | 12335 | Browser inner width/height: 1024/697 20:06:35 INFO - PROCESS | 12335 | __metrics 20:06:36 ERROR - PROCESS | 12335 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:06:37 INFO - TEST-INFO | 12335: exit 0 20:06:37 INFO - Browser initialized. 20:06:37 INFO - Running cycle 1/1 for dromaeo_css test... 20:06:37 INFO - TEST-INFO | started process 12456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1Tu02W/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:06:49 INFO - PROCESS | 12456 | RSS: Main: 169582592 20:06:49 INFO - PROCESS | 12456 | 20:07:38 INFO - PROCESS | 12456 | 1468811258873 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] 20:09:51 INFO - PROCESS | 12456 | Cycle 1(1): loaded http://localhost:41260/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41260/tests/dromaeo/cssquery-ext.html) 20:09:52 INFO - PROCESS | 12456 | RSS: Main: 170340352 20:09:52 INFO - PROCESS | 12456 | 20:12:54 INFO - PROCESS | 12456 | Cycle 1(1): loaded http://localhost:41260/tests/dromaeo/cssquery-ext.html (next: http://localhost:41260/tests/dromaeo/cssquery-jquery.html) 20:12:55 INFO - PROCESS | 12456 | RSS: Main: 170491904 20:12:55 INFO - PROCESS | 12456 | 20:15:57 INFO - PROCESS | 12456 | Cycle 1(1): loaded http://localhost:41260/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41260/tests/dromaeo/cssquery-mootools.html) 20:15:57 INFO - PROCESS | 12456 | RSS: Main: 173301760 20:15:57 INFO - PROCESS | 12456 | 20:18:59 INFO - PROCESS | 12456 | Cycle 1(1): loaded http://localhost:41260/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41260/tests/dromaeo/cssquery-prototype.html) 20:19:00 INFO - PROCESS | 12456 | RSS: Main: 168243200 20:19:00 INFO - PROCESS | 12456 | 20:22:03 INFO - PROCESS | 12456 | Cycle 1(1): loaded http://localhost:41260/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41260/tests/dromaeo/cssquery-yui.html) 20:22:03 INFO - PROCESS | 12456 | RSS: Main: 169984000 20:22:03 INFO - PROCESS | 12456 | 20:25:06 INFO - PROCESS | 12456 | Cycle 1(1): loaded http://localhost:41260/tests/dromaeo/cssquery-yui.html (next: http://localhost:41260/tests/dromaeo/cssquery-dojo.html) 20:25:06 INFO - PROCESS | 12456 | RSS: Main: 173715456 20:25:06 INFO - PROCESS | 12456 | 20:25:06 INFO - PROCESS | 12456 | __start_tp_report 20:25:06 INFO - PROCESS | 12456 | _x_x_mozilla_page_load 20:25:06 INFO - PROCESS | 12456 | _x_x_mozilla_page_load_details 20:25:06 INFO - PROCESS | 12456 | |i|pagename|runs| 20:25:06 INFO - PROCESS | 12456 | |0;dojo.html;2577.716451190369;2602.973970260298;2603.9218823435303;2607.882645280962;2633.881475333611;4701.435827700677;4782.689125206859;4838.322634831122;4852.272159176126;4861.197902346117;4662.487126416091;4753.8811529711775;4767.785449654765;4771.308160316752;4789.856304310876;4354.782260886951;4382.386465894777;4473.642108631302;4503.1218912312115;4504.234280172363;4188.685848561355;4451.399061126755;4453.198424283628;4534.1158474097565;4540.341650460681;4290.42079319291;4292.12011537634;4308.633766129883;4402.4056752338665;4419.071994881079;4382.802773875152;4383.780810959471;4429.7785110744335;4455.710378825366;4468.017036252052;4417.955820441819;4428.0922410906005;4432.20220360335;4442.800073996678;4472.888177795581;4640.164770341337;4649.767511624439;4671.976640116812;4690.202665546831;4690.812367505296;5016.974915125401;5035.546800787946;5039.344885164942;5046.369203849519;5083.771230294646;4847.975760121212;5035.622328325354;5080.314157588715;5114.820981265675;5122.92315615266;4810.903781924342;4817.108834865561;4835.516448355136;4837.346958160603;4884.633652476114;5266.4470230626;5278.709670968057;5285.339332583427;5303.893922121536;5343.171808369709;4807.326974223612;4962.255661650781;5017.8243761468175;5081.034603425337;5081.18701007837;4991.850244492671;5137.743112844343;5161.483851614808;5164.845054648366;5173.379194496684;4996.950030499721;5038.521340472649;5064.4935506449065;5077.898442031139;5079.060373830853;5005.62457815658;5055.949440505621;5061.367329083864;5065.240213967861;5082.669626474341;4448.5551444855255;4455.598996090367;4459.888502787391;4461.665375096881;4509.729416235036;3716.2939041582013;3848.249591329664;3875.96124038756;3910.413437984268;3913.0608653922855;4369.431973843443;4469.5530446955045;4470.262406702923;4479.059397526491;4515.029268707243;5173.663711858717;5175.378954525481;5177.663451875616;5195.142801437721;5235.65968212065;4303.870883873489;4439.533848945879;4467.5755803198645;4487.192305384997;4499.505054444008;4733.881652958635;4737.644676649265;4742.739149346819;4769.928451073237;4801.303810947393;4580.770961451981;4807.759612019455;4824.469308376076;4857;4878.536539028858;4997.3253610762085;5035.647504674784;5048.7728052237;5069.543741063175;5073.467285935071;4711.081339138835;4719.834805781781;4737.810487580458;4751.429828420612;4757.524247575215;4931.432885218246;4932.087563800708;4985.077760614298;4993.675411098267;5037.798488060436;5080.441151473261;5093.694378337312;5096.745162741922;5116.7441627917715;5174.353205849269;4984.2025275955675;5002.649814512949;5016.3227964225825;5018.4730603286125;5060.645754797129;4760.809567617256;4951.158303088411;4972.776225069808;5007.874803129951;5038.596912246938;4808.855734327975;4814.831480898292;4819.975900120477;4822.059698358787;4823.155947709207;4960.330355402119;4969.776360063734;4970.6023518117745;4988.12707776145;5031.949680503295;4615.892185875433;4758.738269395078;4786.329913811999;4864.9725959143;4883.511648835088 20:25:06 INFO - PROCESS | 12456 | |1;ext.html;510.36204744069937;555.588864240462;557.4258513730854;563.6054761666834;565.3696128816368;28508.28729281769;37970.81014594927;38838.41742373867;38884.61115388849;39035.804820975856;39378.015549611206;39919.80040099803;39958.400623990594;40026.7998660007;40088.39867401991;7664.578448185333;7782.727604533842;7837.333826624744;7845.156388248757;7860.764177074697;7671.041119860018;7719.266669666373;7729.072511298624;7750.263724946121;7772.65023073963;7797.181295963927;7842.5294482330955;7845.450818442711;7848.254415830515;7851;7658.961705191494;7720.575368354738;7735.535867847947;7758.612069396508;7774.727884524043;7553;7678.884816727754;7711.190325015848;7738.110117336522;7738.380929525681;37755.056123596856;38077.61922380796;38255;38288.80855595732;38357;2922.8246305221755;2941.558766185068;2975.6875528069672;3008.578798968146;3017.9849100754577;28351.858240708665;28764.568531472043;28992.42015159706;29175.708242917724;29673.554896676567;3501.972731358932;3507.9649203507893;3516.6659167379057;3539.3275277697153;3567.3935430976794;252335;252589;253066;253407;253540;50854.745726271874;51286;51354.48645513572;51397.22904156441;51516.74241628843;32734.18164545858;33732.49401258983;33844.661553384154;35675;35724.821375892956;14694;14746.852531474762;14762.48331308399;14771.40914363435;14810;10761.730956726144;10769.03078722903;10776.245662803685;10789.622363217406;10790;18152.72770908411;18232.726509102373;18290.54273643143;18303.45089647313;18311.450656480327;6627.1716035495565;6707.295733947865;6929.514933954676;6951.374376306056;6960.443164546824;746.7834328044914;855.5080828523623;888.3559419420868;976.4824642939253;1018.7300365403174;27252.45495090127;27957.580636290473;28179.71820281812;28365.858170709427;28391;892.1078921078921;899.9965038981488;922.6816748221987;930.9581068851918;962.9229661627053;13927.651808704863;14017.859821401655;14238.501652442115;14314;14531.418743250362;426244;428405;429190;430287;430555;47479.762601186776;47791.76104119457;47795.28307075397;47995.52004479911;48056.759716201195;1160.3791971295316;1190.7678002789373;1206.3003457994519;1208.1542919955891;1214;25584.488310234065;26472;26644.600330994665;26652.466950661266;27038.324041899108;40866.38700419555;41534;41616;41750.79124604358;41779.7911010443;349207;351624;352075;353927;356094;24016.51966960686;24088.75911240865;24484.632730509413;24521.264362069167;24542.754572454047;39426;39835;40068.59931400649;40989.18021639491;41193;34637;35699.286014280086;35938.820305898305;36050;36328.09179770527;34816;35153.64846351504;35634.64365356313;35642.10894727652;35751.46372804358;34315.82842085774;34638.653613463546;35136.12159696028;36203;36306.4554031695;31615;32791.836040819646;33353.332933341684;33365.666343336256;33513.32973340471;25032.62451063272;25145.24564263075;25642.48715025652;25829.22512324633;26026.609600855623 20:25:06 INFO - PROCESS | 12456 | |2;jquery.html;370.7367768884094;374.8425661222286;380.47304483290645;384.75183506638217;388.5201775806878;15556.92221538892;16056.357745690173;17205.053722045315;17265.309387624497;17271.74092388615;16698.914570552904;16908.746368804477;17724.911375443105;17735.46793596194;17779.37772177974;5069.923951140727;5184.948150518484;5203.479652034785;5242.528172464477;5256.474352564732;4942.505749425065;5148.073346797575;5163.7159956202395;5188.558972487343;5190.2474141249495;5260.605454590902;5293.470652934714;5316.9202461963105;5330.840074797743;5332.14685650296;5486.423925487826;5881.911771323434;6014.368491308415;6121;6151.323354431009;5219.947800521984;5283.498067683564;5334.51989320963;5380.3274590676165;5444.346678398618;11457.885421145766;11686.824697629458;20359.47303952195;20845.061972211286;21051.8947405262;1894.8199921007483;1938.8545859060628;1943.1061711612533;1976.495993521657;2472.7156377016695;8922.821543569156;9065.456072635663;9089.909100909039;9350.532473376372;9391.530423478798;1709.487153853839;1714.5113642611796;1718.871084668655;1748.3268941457504;1757.674830156425;64197.67901160464;67228.32771672319;68448;68730.31269687289;69527;9464.810703785886;9501.619935202652;9645.614175433044;9754;9890.109890109781;13195.47218111284;13254.536091236952;13289.534866279633;13379.933100334436;13446.394912228972;7344.522606030698;7423.109226892808;7564.659590318449;7602.1257555380735;7714.9228507715325;7363.7422690205585;7389.556626602313;7406.592637404887;7589.392848572101;7600.543967361976;3914.706397020235;4144.316187829035;4322.308430651081;4438.312061630452;4555.908881822345;1638.7705721199043;1694.8813583049068;1706.829317068308;1740.721484562464;1742.2072956804623;703.8733028055;806.1132753970585;813.3290035720554;830.8504469195602;876.8071024374755;17077.573060673334;17263.65472690539;17782.555436114202;17900.373486927896;18132.184051717704;819.6393586821779;825.8678611422264;835.703325319515;877.8288233794349;881.2641444393875;6760.661966901635;9718.70843874685;9909.45497997617;9985.051420115078;10055.949720251498;290427;294855;295726;380285;386495;80550;87333;87534.56232718796;88058.59707014624;88267;776.091972392291;788.077948799894;822.6544851162527;831.8544254755394;832.488019867789;14464.638384040483;14722.484713034992;15738.055716657038;16219.18904054816;16708.331666733193;28447.715522845334;31376;33134;34810.65189348074;39238.411423828096;52824.735876320374;53944;54021.45978540164;55394.44605553893;56044.43955560392;7690.6539205737;7771.494852834548;7821.178776228641;7892.881606776018;7937.690281103553;11608.709782255512;12155.635330940086;12302.077344199042;12348.567800126952;12352.691182720504;10703.143748500257;10806.135509159405;10809.13526917829;10829.729256768644;11095.16786241019;10240.18078553699;10289.228307876789;10535;10620.415877126832;10635.14918806509;10907.672769816918;10987.450627468754;10999.835002475129;11079.169062320198;11151.776964460503;6735.932640673531;6937.410320122846;7010.474214433836;8041.557714325768;8123.634436450256;10534.789304214026;10583.523741431809;10663.626773062906;10880.075193608633;10974.890251097388 20:25:06 INFO - PROCESS | 12456 | |3;mootools.html;1378.4003958278147;1417.6739349949512;1516.9848301516981;1680.361462644195;1701.064414571986;6828.4878634102515;7509.737159199429;7554.433417493682;8135.593220338981;8143.307818835398;7611.238876112386;7757.922420775791;7867.763967080997;7873.37013038957;7876;2140.8929553522303;2176.858504197222;2178.70587470691;2181.2583721534675;2196.6924630551734;2106.441792924876;2131.978680213201;2179.899150928779;2184.85798423102;2191.3316438486336;2156.7304086989125;2159.8920053997317;2164.8592841465256;2168.392850002002;2187.58435897179;2031.7054027166052;2042.0402410866795;2051.21028404064;2063.1437953249383;2071.782462841395;2059.4439501334705;2117.1954657230153;2124.3626911926362;2131.6056529542084;2132.5948069866677;7921.841563168762;8035.23665251806;8035.437519373646;8036.4776289541;8048.31589314909;4453.309736990772;4541.954580454186;4573.679842411033;4577.748223847687;4581.5647513486165;2872.942541149186;2917.9124626261246;2949.188973032412;2977.1961570376093;2978.5085460898927;842.3429724814654;877.8990416102166;889.6263569300844;893.3924931046951;904.5658084119659;11033.944830275877;11063.834042489369;11064.889351106467;11090.833637495443;11110.277831940897;4073.429719839225;4152.958470415258;4312.870613881589;4314.568543145723;4331.480222373335;9255.167034966886;9278.907210927939;9309.394889332172;9336.206422454032;9336.39313444624;4750.429948406213;4752.263399173134;4786.425628924551;4789.257665061851;4793.400824896888;3635.182084031072;4184.121334519724;4331.068820203672;4373.475182978;4374.475062992461;3595.8921232363073;3652.36083685354;3664.7434679572175;3780.1683629601443;3819.5416550014174;1149.2818236736132;1181.599804231988;1199.6101267088231;1210.9818352724717;1215.0219073645624;646.0051520658134;650.9218893732688;668.5921587831419;784.0591290451481;818.5497976113234;4863.148948933923;4993.6005119590345;5169.06956747789;5290.867728306823;5305.602079844027;417.4656439757116;425.3768229543671;425.6063141594075;431.37450696490214;433.65091101663467;3393.270446853889;3487.843047062888;3514.332276867387;3526.488659144461;3584.1039740064984;9299.860502092473;9771.4625695586;9936.105750482348;9953.950230248802;9955.751106222258;9698.660546880825;9754.268429867789;9767.072128147815;9787;9799.755006124904;7384.372328352043;7425.034745483053;7455.0681164854395;7459;7473.991011213417;5022.648414610942;5082.695038297714;5084.1102807009365;5091.87270318245;5196.142636465092;9072.138146876036;9115.817683646157;9118.99691033999;9121.179093881583;9142.63429462814;8575.571221438779;8902.510361929897;8965.237954773916;9121.133492318218;9202.769930751785;6059.303180134341;6681.198256209092;6942.479314051366;6964.199117101395;7109.1824440187975;7670.693172273047;7695.345895598937;7713.305802477804;7734.7679569613;7746.57393843344;6577.934220657924;6724.899126513008;6749.527533072638;6767.424768894699;6866.485013624098;6904.275051119761;6911.75808846688;6967.65161741921;7107.466939979626;7131.750388736369;6302.747890084529;6377.426031657174;6408.839779005376;6432.195975503062;6497.415232629086;4473.46318441789;4479.059397526556;4498.932516012197;4529.207388706897;4569.017661202857;4463.754493502888;4503.527129651339;4503.729776213438;4519.5480451954545;4573.5426457354 20:25:06 INFO - PROCESS | 12456 | |4;prototype.html;297.64877444615354;300.50416812259766;302.8778376116489;306.16569847166477;306.5554945329273;4944.431390390107;4996.425411077727;4997.925031124536;5022.321986531817;5026.648134630573;4925.7783399747;4930.531599498051;4936.876578085549;4939.728314942677;4953.993632578811;3657.8171091445456;3783.0731470789697;3866.420036994459;3881.7670939743566;3900.609939006091;3840.7311488195837;3875.3411919973532;3882.786446745428;3883.4757307763516;3903.2287076175808;3855.749376290546;3882.165334453092;3884.834549635098;3912.9804350978206;3914.5693973663015;3815.561210460805;3882.456456096149;3907.589703081164;3912.4522566840524;3920.176762879799;3420.939508752295;3429.1427143214196;3435.2270739083506;3440.6215316315183;3441.741869359783;4809.711417314972;4832.815960089765;4844.56398924095;4861.343718597979;4873.951260487421;4382;4447.933281000787;4451.666125040602;4456.153330867125;4466.508684044752;5136.332276803992;5211.478852114796;5214.322138122057;5235.55497782689;5254.870202906355;3783.697304215656;3786.678132358753;3789;3791.715621328384;3802.239552089593;5421.593380496439;5433.510984011418;5447.809326673548;5458.017556839767;5459.563234941195;3495.790252584853;3727.981360093182;3734.327820992193;3738.775673459601;3739.6073412291316;3740.551133863954;3771.5474143103;3776.7167462440425;3779.1874746929543;3787.4697542344093;4336.176126535948;4346.043870348518;4355.303151495746;4367.694261401735;4405.713628614129;5082.390113186368;5200.2979597754575;5217.895642087137;5256.474352564789;5261.947380526222;1272.8798657181621;1283.7304166125218;1290.993545032269;1291.5921645406552;1291.6383412644475;804.2480280937342;804.6741069866596;823.7734622978729;840.0549381945311;845.754731127966;4461.843835465808;4606.101810146989;4612.561806628365;4614.884627884263;4631.675782695246;5321.270587059221;5391.16436952273;5394.217838413408;5405.243265942771;5408.891822163535;4395.560443955643;4615.123126605934;4622.699524530894;4630.21286381316;4633.189191891405;2846;2847.1031625038045;2867.197184788263;2871.4831330360316;2871.4831330360735;5015.498450154955;5015.84952451427;5042.823501177514;5055.772490237948;5065;5112.182050871843;5477.247280870083;5478.150886612581;5512;5551.750171242304;5061.670991385548;5064.215046667772;5072.1123803335;5072.797088116507;5082.771275292695;5434.83695489136;5450.427705090909;5452.209429632601;5460.590455715757;5463.7979644478155;5203.713795741271;5303.840884773463;5312.548433383051;5312.681239125664;5326.6537675050995;5044.066847633199;5045.974770126126;5052.444231134646;5101.20931255656;5107.361579802525;3725.6833169180923;3733.3013478866505;3741.7006639469323;3744.7455102540953;3750.437434384864;5274.657147285414;5383.380911195262;5392.325959255093;5409.729513524387;5445.237666726741;5232.508735010504;5237.904838064805;5249.291345668438;5254.605904557097;5270.497908096174;5190.664201109591;5226.8954620908125;5236.162214045735;5241.213817927342;5284.863754292845;4978.726170060537;5183.637145399785;5191;5196.714180719945;5210.426853046086;5053.36832895888;5108.335916330853;5254.710990895537;5278.604104692086;5325.414204437587;5150.665206761549;5154.974225129;5155.819546315861;5178.508041736029;5192.636515443883 20:25:06 INFO - PROCESS | 12456 | |5;yui.html;584.0859055578018;618.5175563060811;625.7403177681261;654.247615242471;723.5803234124207;11251.099912007041;11640.708982275448;11702;11710.648680539576;11713.765724685512;12274.93862530686;12981.415836287366;12994;12994.285314307734;12998.54505092322;615.3415845045803;763.3168314358645;772.4592785050487;772.5403384985952;778.766370088971;748.2255865179541;766.8351304469538;773.5745340062971;773.8104164479711;775.8409526047146;804.694216197844;807.9151689072621;808.8382323535287;810.116972499975;813.5606772342958;798.0343784021342;802.1577343789028;802.9718959836407;804.2158895077312;806.3790881021639;590.0647473754104;592.1295695327861;593.8248216776018;594.349187639534;594.6907608043837;12457.06572007103;12525.874741252563;12534.74930501385;12546.81179782295;12602.873971260262;13118.803217951738;13305.800412993813;13419.329033548382;13432.19406835593;13512;10579.153667706641;10604.75809676128;10613.893861061368;10640.57437702491;10966.835497467544;3198.760092993035;3256.169676732418;3265.673432656739;3276.7542434317284;3282.7373810095137;58780;58930.70534647342;59061;60756.696216518634;61005.694971524856;9520.603219082854;9633.373830700983;10039.4478303694;10060.245481588763;10229.130523905551;17952.640947181244;18016.189271482814;18195.727064094048;18241.087945602932;18255;6393.200849893763;6492.837679057967;6512.6092434454085;6537.803865884031;6740.224874139439;3596.7841929484316;3617.855285788539;3638.6179451157245;3659.451082337671;3678.5585729712607;2862.6994165612728;2942.6321709786275;2943.632045994251;2953.867075981586;2971.1086673997715;511.69809812210974;512.1191550533077;512.9743512824344;518.1942080065535;529.5551736541324;526.5945222178901;530.1014779947951;537.7768226186167;547.5838362844268;552.8977139229255;7509.62451877404;7664.961675191588;7809.648565814552;7839.725609603636;7949.642266097924;485.5241862974305;492.95563399294235;500.2321436594882;507.1784106755579;517.8575891629756;3607.3867442534834;3639.2357604902736;3669.7884836699636;3735;3846.4038074098;77752.61123694346;93578.53210733902;96854.51572742232;97153;97823.53264701035;86908;88632.55683721669;88678;88909.11090889008;89129.55435222782;64360.678196608715;75192.62403687947;76379.61810191025;76713;76928;7212.603306818175;7212.855742885218;7340.192578816433;7389.076365454318;7549.2073332299315;44063.33904991492;45115;46934.29598555956;47097.2935405976;47409.28886066781;58965;60692.69653651703;60822.391776083445;61724.382756171864;62022.68988655028;9072.274218062406;9163.175314221751;9200.355975081948;9328.53357332117;9410.24718022543;10120.797584048425;10383.376997380181;10399;10498.055175034284;10541.420221887869;9429.764255893657;9559.61761529531;9660.468674222986;9940.45327506994;10036.598536058476;9761.267904907303;9785.266105042292;9811.166050885755;9854.605815767289;9880.555375007998;9192.080791920755;9274.165325120772;9285.4892980884;9767.609295628095;9874.061964113398;7794.415418843723;7954.164812694584;7994.1606131355375;8272.17278272168;8409.621567029377;7795.259450352208;7942.880856787268;8027.631848604559;8077.434579579373;8131.79670508242 20:25:06 INFO - PROCESS | 12456 | __end_tp_report 20:25:06 INFO - PROCESS | 12456 | __start_cc_report 20:25:06 INFO - PROCESS | 12456 | _x_x_mozilla_cycle_collect,406 20:25:06 INFO - PROCESS | 12456 | __end_cc_report 20:25:06 INFO - PROCESS | 12456 | __startTimestamp1468812306673__endTimestamp 20:25:06 INFO - PROCESS | 12456 | 20:25:06 INFO - PROCESS | 12456 | ------- Summary: start ------- 20:25:06 INFO - PROCESS | 12456 | Number of tests: 6 20:25:06 INFO - PROCESS | 12456 | 20:25:06 INFO - PROCESS | 12456 | [#0] dojo.html Cycles:165 Average:4718.94 Median:4817.11 stddev:487.97 (10.1%) stddev-sans-first:459.65 20:25:06 INFO - PROCESS | 12456 | Values: 2577.7 2603.0 2603.9 2607.9 2633.9 4701.4 4782.7 4838.3 4852.3 4861.2 4662.5 4753.9 4767.8 4771.3 4789.9 4354.8 4382.4 4473.6 4503.1 4504.2 4188.7 4451.4 4453.2 4534.1 4540.3 4290.4 4292.1 4308.6 4402.4 4419.1 4382.8 4383.8 4429.8 4455.7 4468.0 4418.0 4428.1 4432.2 4442.8 4472.9 4640.2 4649.8 4672.0 4690.2 4690.8 5017.0 5035.5 5039.3 5046.4 5083.8 4848.0 5035.6 5080.3 5114.8 5122.9 4810.9 4817.1 4835.5 4837.3 4884.6 5266.4 5278.7 5285.3 5303.9 5343.2 4807.3 4962.3 5017.8 5081.0 5081.2 4991.9 5137.7 5161.5 5164.8 5173.4 4997.0 5038.5 5064.5 5077.9 5079.1 5005.6 5055.9 5061.4 5065.2 5082.7 4448.6 4455.6 4459.9 4461.7 4509.7 3716.3 3848.2 3876.0 3910.4 3913.1 4369.4 4469.6 4470.3 4479.1 4515.0 5173.7 5175.4 5177.7 5195.1 5235.7 4303.9 4439.5 4467.6 4487.2 4499.5 4733.9 4737.6 4742.7 4769.9 4801.3 4580.8 4807.8 4824.5 4857.0 4878.5 4997.3 5035.6 5048.8 5069.5 5073.5 4711.1 4719.8 4737.8 4751.4 4757.5 4931.4 4932.1 4985.1 4993.7 5037.8 5080.4 5093.7 5096.7 5116.7 5174.4 4984.2 5002.6 5016.3 5018.5 5060.6 4760.8 4951.2 4972.8 5007.9 5038.6 4808.9 4814.8 4820.0 4822.1 4823.2 4960.3 4969.8 4970.6 4988.1 5031.9 4615.9 4758.7 4786.3 4865.0 4883.5 20:25:06 INFO - PROCESS | 12456 | 20:25:06 INFO - PROCESS | 12456 | [#1] ext.html Cycles:180 Average:48634.90 Median:35738.14 stddev:93158.10 (260.7%) stddev-sans-first:93349.36 20:25:06 INFO - PROCESS | 12456 | Values: 510.4 555.6 557.4 563.6 565.4 28508.3 37970.8 38838.4 38884.6 39035.8 39378.0 39919.8 39958.4 40026.8 40088.4 7664.6 7782.7 7837.3 7845.2 7860.8 7671.0 7719.3 7729.1 7750.3 7772.7 7797.2 7842.5 7845.5 7848.3 7851.0 7659.0 7720.6 7735.5 7758.6 7774.7 7553.0 7678.9 7711.2 7738.1 7738.4 37755.1 38077.6 38255.0 38288.8 38357.0 2922.8 2941.6 2975.7 3008.6 3018.0 28351.9 28764.6 28992.4 29175.7 29673.6 3502.0 3508.0 3516.7 3539.3 3567.4 252335.0 252589.0 253066.0 253407.0 253540.0 50854.7 51286.0 51354.5 51397.2 51516.7 32734.2 33732.5 33844.7 35675.0 35724.8 14694.0 14746.9 14762.5 14771.4 14810.0 10761.7 10769.0 10776.2 10789.6 10790.0 18152.7 18232.7 18290.5 18303.5 18311.5 6627.2 6707.3 6929.5 6951.4 6960.4 746.8 855.5 888.4 976.5 1018.7 27252.5 27957.6 28179.7 28365.9 28391.0 892.1 900.0 922.7 931.0 962.9 13927.7 14017.9 14238.5 14314.0 14531.4 426244.0 428405.0 429190.0 430287.0 430555.0 47479.8 47791.8 47795.3 47995.5 48056.8 1160.4 1190.8 1206.3 1208.2 1214.0 25584.5 26472.0 26644.6 26652.5 27038.3 40866.4 41534.0 41616.0 41750.8 41779.8 349207.0 351624.0 352075.0 353927.0 356094.0 24016.5 24088.8 24484.6 24521.3 24542.8 39426.0 39835.0 40068.6 40989.2 41193.0 34637.0 35699.3 35938.8 36050.0 36328.1 34816.0 35153.6 35634.6 35642.1 35751.5 34315.8 34638.7 35136.1 36203.0 36306.5 31615.0 32791.8 33353.3 33365.7 33513.3 25032.6 25145.2 25642.5 25829.2 26026.6 20:25:06 INFO - PROCESS | 12456 | 20:25:06 INFO - PROCESS | 12456 | [#2] jquery.html Cycles:180 Average:22833.76 Median:4749.21 stddev:55636.95 (1171.5%) stddev-sans-first:55767.47 20:25:06 INFO - PROCESS | 12456 | Values: 370.7 374.8 380.5 384.8 388.5 15556.9 16056.4 17205.1 17265.3 17271.7 16698.9 16908.7 17724.9 17735.5 17779.4 5069.9 5184.9 5203.5 5242.5 5256.5 4942.5 5148.1 5163.7 5188.6 5190.2 5260.6 5293.5 5316.9 5330.8 5332.1 5486.4 5881.9 6014.4 6121.0 6151.3 5219.9 5283.5 5334.5 5380.3 5444.3 11457.9 11686.8 20359.5 20845.1 21051.9 1894.8 1938.9 1943.1 1976.5 2472.7 8922.8 9065.5 9089.9 9350.5 9391.5 1709.5 1714.5 1718.9 1748.3 1757.7 64197.7 67228.3 68448.0 68730.3 69527.0 9464.8 9501.6 9645.6 9754.0 9890.1 13195.5 13254.5 13289.5 13379.9 13446.4 7344.5 7423.1 7564.7 7602.1 7714.9 7363.7 7389.6 7406.6 7589.4 7600.5 3914.7 4144.3 4322.3 4438.3 4555.9 1638.8 1694.9 1706.8 1740.7 1742.2 703.9 806.1 813.3 830.9 876.8 17077.6 17263.7 17782.6 17900.4 18132.2 819.6 825.9 835.7 877.8 881.3 6760.7 9718.7 9909.5 9985.1 10055.9 290427.0 294855.0 295726.0 380285.0 386495.0 80550.0 87333.0 87534.6 88058.6 88267.0 776.1 788.1 822.7 831.9 832.5 14464.6 14722.5 15738.1 16219.2 16708.3 28447.7 31376.0 33134.0 34810.7 39238.4 52824.7 53944.0 54021.5 55394.4 56044.4 7690.7 7771.5 7821.2 7892.9 7937.7 11608.7 12155.6 12302.1 12348.6 12352.7 10703.1 10806.1 10809.1 10829.7 11095.2 10240.2 10289.2 10535.0 10620.4 10635.1 10907.7 10987.5 10999.8 11079.2 11151.8 6735.9 6937.4 7010.5 8041.6 8123.6 10534.8 10583.5 10663.6 10880.1 10974.9 20:25:06 INFO - PROCESS | 12456 | 20:25:06 INFO - PROCESS | 12456 | [#3] mootools.html Cycles:180 Average:5167.35 Median:4928.37 stddev:2973.13 (60.3%) stddev-sans-first:2967.83 20:25:06 INFO - PROCESS | 12456 | Values: 1378.4 1417.7 1517.0 1680.4 1701.1 6828.5 7509.7 7554.4 8135.6 8143.3 7611.2 7757.9 7867.8 7873.4 7876.0 2140.9 2176.9 2178.7 2181.3 2196.7 2106.4 2132.0 2179.9 2184.9 2191.3 2156.7 2159.9 2164.9 2168.4 2187.6 2031.7 2042.0 2051.2 2063.1 2071.8 2059.4 2117.2 2124.4 2131.6 2132.6 7921.8 8035.2 8035.4 8036.5 8048.3 4453.3 4542.0 4573.7 4577.7 4581.6 2872.9 2917.9 2949.2 2977.2 2978.5 842.3 877.9 889.6 893.4 904.6 11033.9 11063.8 11064.9 11090.8 11110.3 4073.4 4153.0 4312.9 4314.6 4331.5 9255.2 9278.9 9309.4 9336.2 9336.4 4750.4 4752.3 4786.4 4789.3 4793.4 3635.2 4184.1 4331.1 4373.5 4374.5 3595.9 3652.4 3664.7 3780.2 3819.5 1149.3 1181.6 1199.6 1211.0 1215.0 646.0 650.9 668.6 784.1 818.5 4863.1 4993.6 5169.1 5290.9 5305.6 417.5 425.4 425.6 431.4 433.7 3393.3 3487.8 3514.3 3526.5 3584.1 9299.9 9771.5 9936.1 9954.0 9955.8 9698.7 9754.3 9767.1 9787.0 9799.8 7384.4 7425.0 7455.1 7459.0 7474.0 5022.6 5082.7 5084.1 5091.9 5196.1 9072.1 9115.8 9119.0 9121.2 9142.6 8575.6 8902.5 8965.2 9121.1 9202.8 6059.3 6681.2 6942.5 6964.2 7109.2 7670.7 7695.3 7713.3 7734.8 7746.6 6577.9 6724.9 6749.5 6767.4 6866.5 6904.3 6911.8 6967.7 7107.5 7131.8 6302.7 6377.4 6408.8 6432.2 6497.4 4473.5 4479.1 4498.9 4529.2 4569.0 4463.8 4503.5 4503.7 4519.5 4573.5 20:25:06 INFO - PROCESS | 12456 | 20:25:06 INFO - PROCESS | 12456 | [#4] prototype.html Cycles:180 Average:4330.46 Median:4966.36 stddev:1273.54 (25.6%) stddev-sans-first:1240.62 20:25:06 INFO - PROCESS | 12456 | Values: 297.6 300.5 302.9 306.2 306.6 4944.4 4996.4 4997.9 5022.3 5026.6 4925.8 4930.5 4936.9 4939.7 4954.0 3657.8 3783.1 3866.4 3881.8 3900.6 3840.7 3875.3 3882.8 3883.5 3903.2 3855.7 3882.2 3884.8 3913.0 3914.6 3815.6 3882.5 3907.6 3912.5 3920.2 3420.9 3429.1 3435.2 3440.6 3441.7 4809.7 4832.8 4844.6 4861.3 4874.0 4382.0 4447.9 4451.7 4456.2 4466.5 5136.3 5211.5 5214.3 5235.6 5254.9 3783.7 3786.7 3789.0 3791.7 3802.2 5421.6 5433.5 5447.8 5458.0 5459.6 3495.8 3728.0 3734.3 3738.8 3739.6 3740.6 3771.5 3776.7 3779.2 3787.5 4336.2 4346.0 4355.3 4367.7 4405.7 5082.4 5200.3 5217.9 5256.5 5261.9 1272.9 1283.7 1291.0 1291.6 1291.6 804.2 804.7 823.8 840.1 845.8 4461.8 4606.1 4612.6 4614.9 4631.7 5321.3 5391.2 5394.2 5405.2 5408.9 4395.6 4615.1 4622.7 4630.2 4633.2 2846.0 2847.1 2867.2 2871.5 2871.5 5015.5 5015.8 5042.8 5055.8 5065.0 5112.2 5477.2 5478.2 5512.0 5551.8 5061.7 5064.2 5072.1 5072.8 5082.8 5434.8 5450.4 5452.2 5460.6 5463.8 5203.7 5303.8 5312.5 5312.7 5326.7 5044.1 5046.0 5052.4 5101.2 5107.4 3725.7 3733.3 3741.7 3744.7 3750.4 5274.7 5383.4 5392.3 5409.7 5445.2 5232.5 5237.9 5249.3 5254.6 5270.5 5190.7 5226.9 5236.2 5241.2 5284.9 4978.7 5183.6 5191.0 5196.7 5210.4 5053.4 5108.3 5254.7 5278.6 5325.4 5150.7 5155.0 5155.8 5178.5 5192.6 20:25:06 INFO - PROCESS | 12456 | 20:25:06 INFO - PROCESS | 12456 | [#5] yui.html Cycles:180 Average:17125.67 Median:60789.54 stddev:25222.92 (41.5%) stddev-sans-first:25263.09 20:25:06 INFO - PROCESS | 12456 | Values: 584.1 618.5 625.7 654.2 723.6 11251.1 11640.7 11702.0 11710.6 11713.8 12274.9 12981.4 12994.0 12994.3 12998.5 615.3 763.3 772.5 772.5 778.8 748.2 766.8 773.6 773.8 775.8 804.7 807.9 808.8 810.1 813.6 798.0 802.2 803.0 804.2 806.4 590.1 592.1 593.8 594.3 594.7 12457.1 12525.9 12534.7 12546.8 12602.9 13118.8 13305.8 13419.3 13432.2 13512.0 10579.2 10604.8 10613.9 10640.6 10966.8 3198.8 3256.2 3265.7 3276.8 3282.7 58780.0 58930.7 59061.0 60756.7 61005.7 9520.6 9633.4 10039.4 10060.2 10229.1 17952.6 18016.2 18195.7 18241.1 18255.0 6393.2 6492.8 6512.6 6537.8 6740.2 3596.8 3617.9 3638.6 3659.5 3678.6 2862.7 2942.6 2943.6 2953.9 2971.1 511.7 512.1 513.0 518.2 529.6 526.6 530.1 537.8 547.6 552.9 7509.6 7665.0 7809.6 7839.7 7949.6 485.5 493.0 500.2 507.2 517.9 3607.4 3639.2 3669.8 3735.0 3846.4 77752.6 93578.5 96854.5 97153.0 97823.5 86908.0 88632.6 88678.0 88909.1 89129.6 64360.7 75192.6 76379.6 76713.0 76928.0 7212.6 7212.9 7340.2 7389.1 7549.2 44063.3 45115.0 46934.3 47097.3 47409.3 58965.0 60692.7 60822.4 61724.4 62022.7 9072.3 9163.2 9200.4 9328.5 9410.2 10120.8 10383.4 10399.0 10498.1 10541.4 9429.8 9559.6 9660.5 9940.5 10036.6 9761.3 9785.3 9811.2 9854.6 9880.6 9192.1 9274.2 9285.5 9767.6 9874.1 7794.4 7954.2 7994.2 8272.2 8409.6 7795.3 7942.9 8027.6 8077.4 8131.8 20:25:06 INFO - PROCESS | 12456 | -------- Summary: end -------- 20:25:06 INFO - PROCESS | 12456 | 20:25:07 INFO - TEST-INFO | 12456: exit 0 20:25:07 INFO - TEST-OK | dromaeo_css | took 1117062ms 20:25:07 INFO - TEST-START | kraken 20:25:07 INFO - operating with platform_type : linux_ 20:25:07 INFO - Initialising browser for kraken test... 20:25:07 INFO - TEST-INFO | started process 12707 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvvHDuh/profile http://localhost:41260/getInfo.html) 20:25:11 INFO - PROCESS | 12707 | JavaScript error: , line 0: uncaught exception: undefined 20:25:12 INFO - PROCESS | 12707 | __metrics Screen width/height:1600/1200 20:25:12 INFO - PROCESS | 12707 | colorDepth:24 20:25:12 INFO - PROCESS | 12707 | Browser inner width/height: 1024/697 20:25:12 INFO - PROCESS | 12707 | __metrics 20:25:13 ERROR - PROCESS | 12707 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:25:14 INFO - TEST-INFO | 12707: exit 0 20:25:14 INFO - Browser initialized. 20:25:14 INFO - Running cycle 1/1 for kraken test... 20:25:14 INFO - TEST-INFO | started process 12828 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvvHDuh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:25:26 INFO - PROCESS | 12828 | RSS: Main: 169635840 20:25:26 INFO - PROCESS | 12828 | 20:25:28 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41260/tests/kraken/driver.html?testName=audio-beat-detection) 20:25:29 INFO - PROCESS | 12828 | RSS: Main: 174907392 20:25:29 INFO - PROCESS | 12828 | 20:25:32 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41260/tests/kraken/driver.html?testName=audio-dft) 20:25:33 INFO - PROCESS | 12828 | RSS: Main: 174862336 20:25:33 INFO - PROCESS | 12828 | 20:25:36 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41260/tests/kraken/driver.html?testName=audio-fft) 20:25:36 INFO - PROCESS | 12828 | RSS: Main: 168394752 20:25:36 INFO - PROCESS | 12828 | 20:25:38 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41260/tests/kraken/driver.html?testName=audio-oscillator) 20:25:39 INFO - PROCESS | 12828 | RSS: Main: 169947136 20:25:39 INFO - PROCESS | 12828 | 20:25:41 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41260/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:25:42 INFO - PROCESS | 12828 | RSS: Main: 169742336 20:25:42 INFO - PROCESS | 12828 | 20:25:45 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41260/tests/kraken/driver.html?testName=imaging-darkroom) 20:25:46 INFO - PROCESS | 12828 | RSS: Main: 169607168 20:25:46 INFO - PROCESS | 12828 | 20:25:49 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41260/tests/kraken/driver.html?testName=imaging-desaturate) 20:25:50 INFO - PROCESS | 12828 | RSS: Main: 167280640 20:25:50 INFO - PROCESS | 12828 | 20:25:53 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41260/tests/kraken/driver.html?testName=json-parse-financial) 20:25:54 INFO - PROCESS | 12828 | RSS: Main: 169177088 20:25:54 INFO - PROCESS | 12828 | 20:25:55 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41260/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:25:56 INFO - PROCESS | 12828 | RSS: Main: 169717760 20:25:56 INFO - PROCESS | 12828 | 20:25:58 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41260/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:25:58 INFO - PROCESS | 12828 | RSS: Main: 169779200 20:25:58 INFO - PROCESS | 12828 | 20:26:01 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41260/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:01 INFO - PROCESS | 12828 | RSS: Main: 170328064 20:26:01 INFO - PROCESS | 12828 | 20:26:04 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:05 INFO - PROCESS | 12828 | RSS: Main: 170532864 20:26:05 INFO - PROCESS | 12828 | 20:26:08 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:08 INFO - PROCESS | 12828 | RSS: Main: 170196992 20:26:08 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | Cycle 1(1): loaded http://localhost:41260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41260/tests/kraken/driver.html?testName=ai-astar) 20:26:10 INFO - PROCESS | 12828 | RSS: Main: 170803200 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | __start_tp_report 20:26:10 INFO - PROCESS | 12828 | _x_x_mozilla_page_load 20:26:10 INFO - PROCESS | 12828 | _x_x_mozilla_page_load_details 20:26:10 INFO - PROCESS | 12828 | |i|pagename|runs| 20:26:10 INFO - PROCESS | 12828 | |0;ai-astar;104;115;109;114;114;115;117;115;114;115 20:26:10 INFO - PROCESS | 12828 | |1;audio-beat-detection;160;130;147;191;123;156;150;130;181;125 20:26:10 INFO - PROCESS | 12828 | |2;audio-dft;162;163;171;169;167;162;162;164;162;161 20:26:10 INFO - PROCESS | 12828 | |3;audio-fft;76;76;75;152;78;78;80;76;158;77 20:26:10 INFO - PROCESS | 12828 | |4;audio-oscillator;85;86;155;86;85;85;134;85;85;139 20:26:10 INFO - PROCESS | 12828 | |5;imaging-gaussian-blur;118;118;118;117;118;117;117;117;118;118 20:26:10 INFO - PROCESS | 12828 | |6;imaging-darkroom;149;148;148;147;149;149;149;147;148;149 20:26:10 INFO - PROCESS | 12828 | |7;imaging-desaturate;96;95;96;96;95;97;97;96;95;95 20:26:10 INFO - PROCESS | 12828 | |8;json-parse-financial;64;64;66;65;68;64;72;64;64;64 20:26:10 INFO - PROCESS | 12828 | |9;json-stringify-tinderbox;65;65;65;65;65;65;65;65;65;66 20:26:10 INFO - PROCESS | 12828 | |10;stanford-crypto-aes;85;85;79;79;79;80;78;78;80;80 20:26:10 INFO - PROCESS | 12828 | |11;stanford-crypto-ccm;129;131;138;130;142;138;146;135;189;144 20:26:10 INFO - PROCESS | 12828 | |12;stanford-crypto-pbkdf2;166;170;162;170;165;167;172;164;165;169 20:26:10 INFO - PROCESS | 12828 | |13;stanford-crypto-sha256-iterative;68;70;68;67;68;70;67;68;66;79 20:26:10 INFO - PROCESS | 12828 | __end_tp_report 20:26:10 INFO - PROCESS | 12828 | __start_cc_report 20:26:10 INFO - PROCESS | 12828 | _x_x_mozilla_cycle_collect,996 20:26:10 INFO - PROCESS | 12828 | __end_cc_report 20:26:10 INFO - PROCESS | 12828 | __startTimestamp1468812370727__endTimestamp 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | ------- Summary: start ------- 20:26:10 INFO - PROCESS | 12828 | Number of tests: 14 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#0] ai-astar Cycles:10 Average:113.20 Median:115.00 stddev:3.82 (3.3%) stddev-sans-first:2.17 20:26:10 INFO - PROCESS | 12828 | Values: 104.0 115.0 109.0 114.0 114.0 115.0 117.0 115.0 114.0 115.0 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#1] audio-beat-detection Cycles:10 Average:149.30 Median:153.00 stddev:23.42 (15.3%) stddev-sans-first:24.52 20:26:10 INFO - PROCESS | 12828 | Values: 160.0 130.0 147.0 191.0 123.0 156.0 150.0 130.0 181.0 125.0 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#2] audio-dft Cycles:10 Average:164.30 Median:163.50 stddev:3.47 (2.1%) stddev-sans-first:3.57 20:26:10 INFO - PROCESS | 12828 | Values: 162.0 163.0 171.0 169.0 167.0 162.0 162.0 164.0 162.0 161.0 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#3] audio-fft Cycles:10 Average:92.60 Median:76.50 stddev:32.95 (43.1%) stddev-sans-first:34.40 20:26:10 INFO - PROCESS | 12828 | Values: 76.0 76.0 75.0 152.0 78.0 78.0 80.0 76.0 158.0 77.0 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#4] audio-oscillator Cycles:10 Average:102.50 Median:85.00 stddev:28.20 (33.2%) stddev-sans-first:29.19 20:26:10 INFO - PROCESS | 12828 | Values: 85.0 86.0 155.0 86.0 85.0 85.0 134.0 85.0 85.0 139.0 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 20:26:10 INFO - PROCESS | 12828 | Values: 118.0 118.0 118.0 117.0 118.0 117.0 117.0 117.0 118.0 118.0 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:149.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 20:26:10 INFO - PROCESS | 12828 | Values: 149.0 148.0 148.0 147.0 149.0 149.0 149.0 147.0 148.0 149.0 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 20:26:10 INFO - PROCESS | 12828 | Values: 96.0 95.0 96.0 96.0 95.0 97.0 97.0 96.0 95.0 95.0 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:64.50 stddev:2.64 (4.1%) stddev-sans-first:2.74 20:26:10 INFO - PROCESS | 12828 | Values: 64.0 64.0 66.0 65.0 68.0 64.0 72.0 64.0 64.0 64.0 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 20:26:10 INFO - PROCESS | 12828 | Values: 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 65.0 66.0 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#10] stanford-crypto-aes Cycles:10 Average:80.30 Median:80.00 stddev:2.58 (3.2%) stddev-sans-first:2.11 20:26:10 INFO - PROCESS | 12828 | Values: 85.0 85.0 79.0 79.0 79.0 80.0 78.0 78.0 80.0 80.0 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:140.00 stddev:17.46 (12.5%) stddev-sans-first:17.85 20:26:10 INFO - PROCESS | 12828 | Values: 129.0 131.0 138.0 130.0 142.0 138.0 146.0 135.0 189.0 144.0 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:168.00 stddev:3.16 (1.9%) stddev-sans-first:3.33 20:26:10 INFO - PROCESS | 12828 | Values: 166.0 170.0 162.0 170.0 165.0 167.0 172.0 164.0 165.0 169.0 20:26:10 INFO - PROCESS | 12828 | 20:26:10 INFO - PROCESS | 12828 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:68.00 stddev:3.70 (5.4%) stddev-sans-first:3.90 20:26:10 INFO - PROCESS | 12828 | Values: 68.0 70.0 68.0 67.0 68.0 70.0 67.0 68.0 66.0 79.0 20:26:10 INFO - PROCESS | 12828 | -------- Summary: end -------- 20:26:10 INFO - PROCESS | 12828 | 20:26:11 INFO - TEST-INFO | 12828: exit 0 20:26:11 INFO - TEST-OK | kraken | took 64377ms 20:26:11 INFO - SUITE-END | took 1181s 20:26:11 INFO - Completed test suite (00:19:41) 20:26:11 INFO - javascript benchmark 20:26:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6326.720647181714, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2577.716451190369, 2602.973970260298, 2603.9218823435303, 2607.882645280962, 2633.881475333611, 4701.435827700677, 4782.689125206859, 4838.322634831122, 4852.272159176126, 4861.197902346117, 4662.487126416091, 4753.8811529711775, 4767.785449654765, 4771.308160316752, 4789.856304310876, 4354.782260886951, 4382.386465894777, 4473.642108631302, 4503.1218912312115, 4504.234280172363, 4188.685848561355, 4451.399061126755, 4453.198424283628, 4534.1158474097565, 4540.341650460681, 4290.42079319291, 4292.12011537634, 4308.633766129883, 4402.4056752338665, 4419.071994881079, 4382.802773875152, 4383.780810959471, 4429.7785110744335, 4455.710378825366, 4468.017036252052, 4417.955820441819, 4428.0922410906005, 4432.20220360335, 4442.800073996678, 4472.888177795581, 4640.164770341337, 4649.767511624439, 4671.976640116812, 4690.202665546831, 4690.812367505296, 5016.974915125401, 5035.546800787946, 5039.344885164942, 5046.369203849519, 5083.771230294646, 4847.975760121212, 5035.622328325354, 5080.314157588715, 5114.820981265675, 5122.92315615266, 4810.903781924342, 4817.108834865561, 4835.516448355136, 4837.346958160603, 4884.633652476114, 5266.4470230626, 5278.709670968057, 5285.339332583427, 5303.893922121536, 5343.171808369709, 4807.326974223612, 4962.255661650781, 5017.8243761468175, 5081.034603425337, 5081.18701007837, 4991.850244492671, 5137.743112844343, 5161.483851614808, 5164.845054648366, 5173.379194496684, 4996.950030499721, 5038.521340472649, 5064.4935506449065, 5077.898442031139, 5079.060373830853, 5005.62457815658, 5055.949440505621, 5061.367329083864, 5065.240213967861, 5082.669626474341, 4448.5551444855255, 4455.598996090367, 4459.888502787391, 4461.665375096881, 4509.729416235036, 3716.2939041582013, 3848.249591329664, 3875.96124038756, 3910.413437984268, 3913.0608653922855, 4369.431973843443, 4469.5530446955045, 4470.262406702923, 4479.059397526491, 4515.029268707243, 5173.663711858717, 5175.378954525481, 5177.663451875616, 5195.142801437721, 5235.65968212065, 4303.870883873489, 4439.533848945879, 4467.5755803198645, 4487.192305384997, 4499.505054444008, 4733.881652958635, 4737.644676649265, 4742.739149346819, 4769.928451073237, 4801.303810947393, 4580.770961451981, 4807.759612019455, 4824.469308376076, 4857.0, 4878.536539028858, 4997.3253610762085, 5035.647504674784, 5048.7728052237, 5069.543741063175, 5073.467285935071, 4711.081339138835, 4719.834805781781, 4737.810487580458, 4751.429828420612, 4757.524247575215, 4931.432885218246, 4932.087563800708, 4985.077760614298, 4993.675411098267, 5037.798488060436, 5080.441151473261, 5093.694378337312, 5096.745162741922, 5116.7441627917715, 5174.353205849269, 4984.2025275955675, 5002.649814512949, 5016.3227964225825, 5018.4730603286125, 5060.645754797129, 4760.809567617256, 4951.158303088411, 4972.776225069808, 5007.874803129951, 5038.596912246938, 4808.855734327975, 4814.831480898292, 4819.975900120477, 4822.059698358787, 4823.155947709207, 4960.330355402119, 4969.776360063734, 4970.6023518117745, 4988.12707776145, 5031.949680503295, 4615.892185875433, 4758.738269395078, 4786.329913811999, 4864.9725959143, 4883.511648835088], "value": 4687.638604114318, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [510.36204744069937, 555.588864240462, 557.4258513730854, 563.6054761666834, 565.3696128816368, 28508.28729281769, 37970.81014594927, 38838.41742373867, 38884.61115388849, 39035.804820975856, 39378.015549611206, 39919.80040099803, 39958.400623990594, 40026.7998660007, 40088.39867401991, 7664.578448185333, 7782.727604533842, 7837.333826624744, 7845.156388248757, 7860.764177074697, 7671.041119860018, 7719.266669666373, 7729.072511298624, 7750.263724946121, 7772.65023073963, 7797.181295963927, 7842.5294482330955, 7845.450818442711, 7848.254415830515, 7851.0, 7658.961705191494, 7720.575368354738, 7735.535867847947, 7758.612069396508, 7774.727884524043, 7553.0, 7678.884816727754, 7711.190325015848, 7738.110117336522, 7738.380929525681, 37755.056123596856, 38077.61922380796, 38255.0, 38288.80855595732, 38357.0, 2922.8246305221755, 2941.558766185068, 2975.6875528069672, 3008.578798968146, 3017.9849100754577, 28351.858240708665, 28764.568531472043, 28992.42015159706, 29175.708242917724, 29673.554896676567, 3501.972731358932, 3507.9649203507893, 3516.6659167379057, 3539.3275277697153, 3567.3935430976794, 252335.0, 252589.0, 253066.0, 253407.0, 253540.0, 50854.745726271874, 51286.0, 51354.48645513572, 51397.22904156441, 51516.74241628843, 32734.18164545858, 33732.49401258983, 33844.661553384154, 35675.0, 35724.821375892956, 14694.0, 14746.852531474762, 14762.48331308399, 14771.40914363435, 14810.0, 10761.730956726144, 10769.03078722903, 10776.245662803685, 10789.622363217406, 10790.0, 18152.72770908411, 18232.726509102373, 18290.54273643143, 18303.45089647313, 18311.450656480327, 6627.1716035495565, 6707.295733947865, 6929.514933954676, 6951.374376306056, 6960.443164546824, 746.7834328044914, 855.5080828523623, 888.3559419420868, 976.4824642939253, 1018.7300365403174, 27252.45495090127, 27957.580636290473, 28179.71820281812, 28365.858170709427, 28391.0, 892.1078921078921, 899.9965038981488, 922.6816748221987, 930.9581068851918, 962.9229661627053, 13927.651808704863, 14017.859821401655, 14238.501652442115, 14314.0, 14531.418743250362, 426244.0, 428405.0, 429190.0, 430287.0, 430555.0, 47479.762601186776, 47791.76104119457, 47795.28307075397, 47995.52004479911, 48056.759716201195, 1160.3791971295316, 1190.7678002789373, 1206.3003457994519, 1208.1542919955891, 1214.0, 25584.488310234065, 26472.0, 26644.600330994665, 26652.466950661266, 27038.324041899108, 40866.38700419555, 41534.0, 41616.0, 41750.79124604358, 41779.7911010443, 349207.0, 351624.0, 352075.0, 353927.0, 356094.0, 24016.51966960686, 24088.75911240865, 24484.632730509413, 24521.264362069167, 24542.754572454047, 39426.0, 39835.0, 40068.59931400649, 40989.18021639491, 41193.0, 34637.0, 35699.286014280086, 35938.820305898305, 36050.0, 36328.09179770527, 34816.0, 35153.64846351504, 35634.64365356313, 35642.10894727652, 35751.46372804358, 34315.82842085774, 34638.653613463546, 35136.12159696028, 36203.0, 36306.4554031695, 31615.0, 32791.836040819646, 33353.332933341684, 33365.666343336256, 33513.32973340471, 25032.62451063272, 25145.24564263075, 25642.48715025652, 25829.22512324633, 26026.609600855623], "value": 17144.383742129423, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.7367768884094, 374.8425661222286, 380.47304483290645, 384.75183506638217, 388.5201775806878, 15556.92221538892, 16056.357745690173, 17205.053722045315, 17265.309387624497, 17271.74092388615, 16698.914570552904, 16908.746368804477, 17724.911375443105, 17735.46793596194, 17779.37772177974, 5069.923951140727, 5184.948150518484, 5203.479652034785, 5242.528172464477, 5256.474352564732, 4942.505749425065, 5148.073346797575, 5163.7159956202395, 5188.558972487343, 5190.2474141249495, 5260.605454590902, 5293.470652934714, 5316.9202461963105, 5330.840074797743, 5332.14685650296, 5486.423925487826, 5881.911771323434, 6014.368491308415, 6121.0, 6151.323354431009, 5219.947800521984, 5283.498067683564, 5334.51989320963, 5380.3274590676165, 5444.346678398618, 11457.885421145766, 11686.824697629458, 20359.47303952195, 20845.061972211286, 21051.8947405262, 1894.8199921007483, 1938.8545859060628, 1943.1061711612533, 1976.495993521657, 2472.7156377016695, 8922.821543569156, 9065.456072635663, 9089.909100909039, 9350.532473376372, 9391.530423478798, 1709.487153853839, 1714.5113642611796, 1718.871084668655, 1748.3268941457504, 1757.674830156425, 64197.67901160464, 67228.32771672319, 68448.0, 68730.31269687289, 69527.0, 9464.810703785886, 9501.619935202652, 9645.614175433044, 9754.0, 9890.109890109781, 13195.47218111284, 13254.536091236952, 13289.534866279633, 13379.933100334436, 13446.394912228972, 7344.522606030698, 7423.109226892808, 7564.659590318449, 7602.1257555380735, 7714.9228507715325, 7363.7422690205585, 7389.556626602313, 7406.592637404887, 7589.392848572101, 7600.543967361976, 3914.706397020235, 4144.316187829035, 4322.308430651081, 4438.312061630452, 4555.908881822345, 1638.7705721199043, 1694.8813583049068, 1706.829317068308, 1740.721484562464, 1742.2072956804623, 703.8733028055, 806.1132753970585, 813.3290035720554, 830.8504469195602, 876.8071024374755, 17077.573060673334, 17263.65472690539, 17782.555436114202, 17900.373486927896, 18132.184051717704, 819.6393586821779, 825.8678611422264, 835.703325319515, 877.8288233794349, 881.2641444393875, 6760.661966901635, 9718.70843874685, 9909.45497997617, 9985.051420115078, 10055.949720251498, 290427.0, 294855.0, 295726.0, 380285.0, 386495.0, 80550.0, 87333.0, 87534.56232718796, 88058.59707014624, 88267.0, 776.091972392291, 788.077948799894, 822.6544851162527, 831.8544254755394, 832.488019867789, 14464.638384040483, 14722.484713034992, 15738.055716657038, 16219.18904054816, 16708.331666733193, 28447.715522845334, 31376.0, 33134.0, 34810.65189348074, 39238.411423828096, 52824.735876320374, 53944.0, 54021.45978540164, 55394.44605553893, 56044.43955560392, 7690.6539205737, 7771.494852834548, 7821.178776228641, 7892.881606776018, 7937.690281103553, 11608.709782255512, 12155.635330940086, 12302.077344199042, 12348.567800126952, 12352.691182720504, 10703.143748500257, 10806.135509159405, 10809.13526917829, 10829.729256768644, 11095.16786241019, 10240.18078553699, 10289.228307876789, 10535.0, 10620.415877126832, 10635.14918806509, 10907.672769816918, 10987.450627468754, 10999.835002475129, 11079.169062320198, 11151.776964460503, 6735.932640673531, 6937.410320122846, 7010.474214433836, 8041.557714325768, 8123.634436450256, 10534.789304214026, 10583.523741431809, 10663.626773062906, 10880.075193608633, 10974.890251097388], "value": 8162.9284782387385, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1378.4003958278147, 1417.6739349949512, 1516.9848301516981, 1680.361462644195, 1701.064414571986, 6828.4878634102515, 7509.737159199429, 7554.433417493682, 8135.593220338981, 8143.307818835398, 7611.238876112386, 7757.922420775791, 7867.763967080997, 7873.37013038957, 7876.0, 2140.8929553522303, 2176.858504197222, 2178.70587470691, 2181.2583721534675, 2196.6924630551734, 2106.441792924876, 2131.978680213201, 2179.899150928779, 2184.85798423102, 2191.3316438486336, 2156.7304086989125, 2159.8920053997317, 2164.8592841465256, 2168.392850002002, 2187.58435897179, 2031.7054027166052, 2042.0402410866795, 2051.21028404064, 2063.1437953249383, 2071.782462841395, 2059.4439501334705, 2117.1954657230153, 2124.3626911926362, 2131.6056529542084, 2132.5948069866677, 7921.841563168762, 8035.23665251806, 8035.437519373646, 8036.4776289541, 8048.31589314909, 4453.309736990772, 4541.954580454186, 4573.679842411033, 4577.748223847687, 4581.5647513486165, 2872.942541149186, 2917.9124626261246, 2949.188973032412, 2977.1961570376093, 2978.5085460898927, 842.3429724814654, 877.8990416102166, 889.6263569300844, 893.3924931046951, 904.5658084119659, 11033.944830275877, 11063.834042489369, 11064.889351106467, 11090.833637495443, 11110.277831940897, 4073.429719839225, 4152.958470415258, 4312.870613881589, 4314.568543145723, 4331.480222373335, 9255.167034966886, 9278.907210927939, 9309.394889332172, 9336.206422454032, 9336.39313444624, 4750.429948406213, 4752.263399173134, 4786.425628924551, 4789.257665061851, 4793.400824896888, 3635.182084031072, 4184.121334519724, 4331.068820203672, 4373.475182978, 4374.475062992461, 3595.8921232363073, 3652.36083685354, 3664.7434679572175, 3780.1683629601443, 3819.5416550014174, 1149.2818236736132, 1181.599804231988, 1199.6101267088231, 1210.9818352724717, 1215.0219073645624, 646.0051520658134, 650.9218893732688, 668.5921587831419, 784.0591290451481, 818.5497976113234, 4863.148948933923, 4993.6005119590345, 5169.06956747789, 5290.867728306823, 5305.602079844027, 417.4656439757116, 425.3768229543671, 425.6063141594075, 431.37450696490214, 433.65091101663467, 3393.270446853889, 3487.843047062888, 3514.332276867387, 3526.488659144461, 3584.1039740064984, 9299.860502092473, 9771.4625695586, 9936.105750482348, 9953.950230248802, 9955.751106222258, 9698.660546880825, 9754.268429867789, 9767.072128147815, 9787.0, 9799.755006124904, 7384.372328352043, 7425.034745483053, 7455.0681164854395, 7459.0, 7473.991011213417, 5022.648414610942, 5082.695038297714, 5084.1102807009365, 5091.87270318245, 5196.142636465092, 9072.138146876036, 9115.817683646157, 9118.99691033999, 9121.179093881583, 9142.63429462814, 8575.571221438779, 8902.510361929897, 8965.237954773916, 9121.133492318218, 9202.769930751785, 6059.303180134341, 6681.198256209092, 6942.479314051366, 6964.199117101395, 7109.1824440187975, 7670.693172273047, 7695.345895598937, 7713.305802477804, 7734.7679569613, 7746.57393843344, 6577.934220657924, 6724.899126513008, 6749.527533072638, 6767.424768894699, 6866.485013624098, 6904.275051119761, 6911.75808846688, 6967.65161741921, 7107.466939979626, 7131.750388736369, 6302.747890084529, 6377.426031657174, 6408.839779005376, 6432.195975503062, 6497.415232629086, 4473.46318441789, 4479.059397526556, 4498.932516012197, 4529.207388706897, 4569.017661202857, 4463.754493502888, 4503.527129651339, 4503.729776213438, 4519.5480451954545, 4573.5426457354], "value": 4053.3755887410002, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.64877444615354, 300.50416812259766, 302.8778376116489, 306.16569847166477, 306.5554945329273, 4944.431390390107, 4996.425411077727, 4997.925031124536, 5022.321986531817, 5026.648134630573, 4925.7783399747, 4930.531599498051, 4936.876578085549, 4939.728314942677, 4953.993632578811, 3657.8171091445456, 3783.0731470789697, 3866.420036994459, 3881.7670939743566, 3900.609939006091, 3840.7311488195837, 3875.3411919973532, 3882.786446745428, 3883.4757307763516, 3903.2287076175808, 3855.749376290546, 3882.165334453092, 3884.834549635098, 3912.9804350978206, 3914.5693973663015, 3815.561210460805, 3882.456456096149, 3907.589703081164, 3912.4522566840524, 3920.176762879799, 3420.939508752295, 3429.1427143214196, 3435.2270739083506, 3440.6215316315183, 3441.741869359783, 4809.711417314972, 4832.815960089765, 4844.56398924095, 4861.343718597979, 4873.951260487421, 4382.0, 4447.933281000787, 4451.666125040602, 4456.153330867125, 4466.508684044752, 5136.332276803992, 5211.478852114796, 5214.322138122057, 5235.55497782689, 5254.870202906355, 3783.697304215656, 3786.678132358753, 3789.0, 3791.715621328384, 3802.239552089593, 5421.593380496439, 5433.510984011418, 5447.809326673548, 5458.017556839767, 5459.563234941195, 3495.790252584853, 3727.981360093182, 3734.327820992193, 3738.775673459601, 3739.6073412291316, 3740.551133863954, 3771.5474143103, 3776.7167462440425, 3779.1874746929543, 3787.4697542344093, 4336.176126535948, 4346.043870348518, 4355.303151495746, 4367.694261401735, 4405.713628614129, 5082.390113186368, 5200.2979597754575, 5217.895642087137, 5256.474352564789, 5261.947380526222, 1272.8798657181621, 1283.7304166125218, 1290.993545032269, 1291.5921645406552, 1291.6383412644475, 804.2480280937342, 804.6741069866596, 823.7734622978729, 840.0549381945311, 845.754731127966, 4461.843835465808, 4606.101810146989, 4612.561806628365, 4614.884627884263, 4631.675782695246, 5321.270587059221, 5391.16436952273, 5394.217838413408, 5405.243265942771, 5408.891822163535, 4395.560443955643, 4615.123126605934, 4622.699524530894, 4630.21286381316, 4633.189191891405, 2846.0, 2847.1031625038045, 2867.197184788263, 2871.4831330360316, 2871.4831330360735, 5015.498450154955, 5015.84952451427, 5042.823501177514, 5055.772490237948, 5065.0, 5112.182050871843, 5477.247280870083, 5478.150886612581, 5512.0, 5551.750171242304, 5061.670991385548, 5064.215046667772, 5072.1123803335, 5072.797088116507, 5082.771275292695, 5434.83695489136, 5450.427705090909, 5452.209429632601, 5460.590455715757, 5463.7979644478155, 5203.713795741271, 5303.840884773463, 5312.548433383051, 5312.681239125664, 5326.6537675050995, 5044.066847633199, 5045.974770126126, 5052.444231134646, 5101.20931255656, 5107.361579802525, 3725.6833169180923, 3733.3013478866505, 3741.7006639469323, 3744.7455102540953, 3750.437434384864, 5274.657147285414, 5383.380911195262, 5392.325959255093, 5409.729513524387, 5445.237666726741, 5232.508735010504, 5237.904838064805, 5249.291345668438, 5254.605904557097, 5270.497908096174, 5190.664201109591, 5226.8954620908125, 5236.162214045735, 5241.213817927342, 5284.863754292845, 4978.726170060537, 5183.637145399785, 5191.0, 5196.714180719945, 5210.426853046086, 5053.36832895888, 5108.335916330853, 5254.710990895537, 5278.604104692086, 5325.414204437587, 5150.665206761549, 5154.974225129, 5155.819546315861, 5178.508041736029, 5192.636515443883], "value": 3917.964726199876, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [584.0859055578018, 618.5175563060811, 625.7403177681261, 654.247615242471, 723.5803234124207, 11251.099912007041, 11640.708982275448, 11702.0, 11710.648680539576, 11713.765724685512, 12274.93862530686, 12981.415836287366, 12994.0, 12994.285314307734, 12998.54505092322, 615.3415845045803, 763.3168314358645, 772.4592785050487, 772.5403384985952, 778.766370088971, 748.2255865179541, 766.8351304469538, 773.5745340062971, 773.8104164479711, 775.8409526047146, 804.694216197844, 807.9151689072621, 808.8382323535287, 810.116972499975, 813.5606772342958, 798.0343784021342, 802.1577343789028, 802.9718959836407, 804.2158895077312, 806.3790881021639, 590.0647473754104, 592.1295695327861, 593.8248216776018, 594.349187639534, 594.6907608043837, 12457.06572007103, 12525.874741252563, 12534.74930501385, 12546.81179782295, 12602.873971260262, 13118.803217951738, 13305.800412993813, 13419.329033548382, 13432.19406835593, 13512.0, 10579.153667706641, 10604.75809676128, 10613.893861061368, 10640.57437702491, 10966.835497467544, 3198.760092993035, 3256.169676732418, 3265.673432656739, 3276.7542434317284, 3282.7373810095137, 58780.0, 58930.70534647342, 59061.0, 60756.696216518634, 61005.694971524856, 9520.603219082854, 9633.373830700983, 10039.4478303694, 10060.245481588763, 10229.130523905551, 17952.640947181244, 18016.189271482814, 18195.727064094048, 18241.087945602932, 18255.0, 6393.200849893763, 6492.837679057967, 6512.6092434454085, 6537.803865884031, 6740.224874139439, 3596.7841929484316, 3617.855285788539, 3638.6179451157245, 3659.451082337671, 3678.5585729712607, 2862.6994165612728, 2942.6321709786275, 2943.632045994251, 2953.867075981586, 2971.1086673997715, 511.69809812210974, 512.1191550533077, 512.9743512824344, 518.1942080065535, 529.5551736541324, 526.5945222178901, 530.1014779947951, 537.7768226186167, 547.5838362844268, 552.8977139229255, 7509.62451877404, 7664.961675191588, 7809.648565814552, 7839.725609603636, 7949.642266097924, 485.5241862974305, 492.95563399294235, 500.2321436594882, 507.1784106755579, 517.8575891629756, 3607.3867442534834, 3639.2357604902736, 3669.7884836699636, 3735.0, 3846.4038074098, 77752.61123694346, 93578.53210733902, 96854.51572742232, 97153.0, 97823.53264701035, 86908.0, 88632.55683721669, 88678.0, 88909.11090889008, 89129.55435222782, 64360.678196608715, 75192.62403687947, 76379.61810191025, 76713.0, 76928.0, 7212.603306818175, 7212.855742885218, 7340.192578816433, 7389.076365454318, 7549.2073332299315, 44063.33904991492, 45115.0, 46934.29598555956, 47097.2935405976, 47409.28886066781, 58965.0, 60692.69653651703, 60822.391776083445, 61724.382756171864, 62022.68988655028, 9072.274218062406, 9163.175314221751, 9200.355975081948, 9328.53357332117, 9410.24718022543, 10120.797584048425, 10383.376997380181, 10399.0, 10498.055175034284, 10541.420221887869, 9429.764255893657, 9559.61761529531, 9660.468674222986, 9940.45327506994, 10036.598536058476, 9761.267904907303, 9785.266105042292, 9811.166050885755, 9854.605815767289, 9880.555375007998, 9192.080791920755, 9274.165325120772, 9285.4892980884, 9767.609295628095, 9874.061964113398, 7794.415418843723, 7954.164812694584, 7994.1606131355375, 8272.17278272168, 8409.621567029377, 7795.259450352208, 7942.880856787268, 8027.631848604559, 8077.434579579373, 8131.79670508242], "value": 6154.952987440087, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 109.0, 114.0, 114.0, 115.0, 117.0, 115.0, 114.0, 115.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 130.0, 147.0, 191.0, 123.0, 156.0, 150.0, 130.0, 181.0, 125.0], "value": 149.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 171.0, 169.0, 167.0, 162.0, 162.0, 164.0, 162.0, 161.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 152.0, 78.0, 78.0, 80.0, 76.0, 158.0, 77.0], "value": 92.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 155.0, 86.0, 85.0, 85.0, 134.0, 85.0, 85.0, 139.0], "value": 102.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 148.0, 147.0, 149.0, 149.0, 149.0, 147.0, 148.0, 149.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 97.0, 97.0, 96.0, 95.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 66.0, 65.0, 68.0, 64.0, 72.0, 64.0, 64.0, 64.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 79.0, 79.0, 79.0, 80.0, 78.0, 78.0, 80.0, 80.0], "value": 80.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 138.0, 130.0, 142.0, 138.0, 146.0, 135.0, 189.0, 144.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 162.0, 170.0, 165.0, 167.0, 172.0, 164.0, 165.0, 169.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 67.0, 68.0, 70.0, 67.0, 68.0, 66.0, 79.0], "value": 69.1, "unit": "score"}]}]} 20:26:11 INFO - Return code: 0 20:26:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:26:12 ERROR - # TBPL SUCCESS # 20:26:12 INFO - Running post-action listener: _resource_record_post_action 20:26:12 INFO - ##### 20:26:12 INFO - ##### Finished run-tests step (success) 20:26:12 INFO - ##### 20:26:12 INFO - Running post-run listener: _resource_record_post_run 20:26:12 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 196608; Write bytes: 548503552; Read time: 68; Write time: 401244 20:26:12 INFO - TinderboxPrint: CPU usage
13.3% 20:26:12 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 68 20:26:12 INFO - TinderboxPrint: I/O write bytes / time
548,503,552 / 401,244 20:26:12 INFO - TinderboxPrint: CPU idle
8,287.6 (86.7%) 20:26:12 INFO - TinderboxPrint: CPU user
1,218.5 (12.7%) 20:26:12 INFO - TinderboxPrint: Swap in / out
0 / 0 20:26:12 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246595584; Read time: 0; Write time: 193796 20:26:12 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 192512; Write bytes: 301293568; Read time: 56; Write time: 207448 20:26:12 INFO - Running post-run listener: _upload_blobber_files 20:26:12 INFO - Blob upload gear active. 20:26:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:12 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 20:26:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:26:13 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:26:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:26:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:13 INFO - (blobuploader) - INFO - Done attempting. 20:26:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:17 INFO - (blobuploader) - INFO - Done attempting. 20:26:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:26:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:26:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:17 INFO - (blobuploader) - INFO - Done attempting. 20:26:17 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:17 INFO - Return code: 0 20:26:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3c65533d2fd5544f119f6fd49b9f9b8702fd1b26919d61fb53758341dbc9cf4a9a61995699caba7639f47cb637a704b3ea10b2550cbe31f8350651ddccc88134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8b64da95599f1f9310c33158187bad376df84c72cacb13f61d37c108b968c650d5b9bd1ba7124e15bd1e1aa3766500f000a89d845b7ab4915c4947c9fb19c6b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3d777d6822c2b9190c751acb24993fc1e924b81c483bd61d56ebb3a611179ccd9839928e3d64a6c720a4655986665c6f94dd5f78ef6138c15718b5db4fe52573"} 20:26:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:17 INFO - Contents: 20:26:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3c65533d2fd5544f119f6fd49b9f9b8702fd1b26919d61fb53758341dbc9cf4a9a61995699caba7639f47cb637a704b3ea10b2550cbe31f8350651ddccc88134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8b64da95599f1f9310c33158187bad376df84c72cacb13f61d37c108b968c650d5b9bd1ba7124e15bd1e1aa3766500f000a89d845b7ab4915c4947c9fb19c6b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3d777d6822c2b9190c751acb24993fc1e924b81c483bd61d56ebb3a611179ccd9839928e3d64a6c720a4655986665c6f94dd5f78ef6138c15718b5db4fe52573"} 20:26:17 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:17 INFO - Copying logs to upload dir... 20:26:17 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.585582 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-07-17 20:26:17.801585) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 20:26:17.804827) ========= 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=836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3c65533d2fd5544f119f6fd49b9f9b8702fd1b26919d61fb53758341dbc9cf4a9a61995699caba7639f47cb637a704b3ea10b2550cbe31f8350651ddccc88134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8b64da95599f1f9310c33158187bad376df84c72cacb13f61d37c108b968c650d5b9bd1ba7124e15bd1e1aa3766500f000a89d845b7ab4915c4947c9fb19c6b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3d777d6822c2b9190c751acb24993fc1e924b81c483bd61d56ebb3a611179ccd9839928e3d64a6c720a4655986665c6f94dd5f78ef6138c15718b5db4fe52573"} build_url:https://queue.taskcluster.net/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/AZmiQU7nSAuAg94gGzPN_g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3c65533d2fd5544f119f6fd49b9f9b8702fd1b26919d61fb53758341dbc9cf4a9a61995699caba7639f47cb637a704b3ea10b2550cbe31f8350651ddccc88134", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/8b64da95599f1f9310c33158187bad376df84c72cacb13f61d37c108b968c650d5b9bd1ba7124e15bd1e1aa3766500f000a89d845b7ab4915c4947c9fb19c6b0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/3d777d6822c2b9190c751acb24993fc1e924b81c483bd61d56ebb3a611179ccd9839928e3d64a6c720a4655986665c6f94dd5f78ef6138c15718b5db4fe52573"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-17 20:26:17.830093) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 20:26:17.830442) ========= 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=836cfdc75598d54cb747368e000001a9-1468811127.600962-1761816863 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-17 20:26:17.912739) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 20:26:17.913105) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-17 20:26:17.913504) ========= ========= Total master_lag: 1.39 =========