builder: autoland_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-010 starttime: 1468469729.23 results: success (0) buildid: 20160713183004 builduid: 52a99e9bfae04bb6bda144896a2376b7 revision: 52e28dee863fa0640842373c9372a4766a664d35 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:29.228624) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:29.229032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:29.229324) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:29.245589) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:29.245928) ========= 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=eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 21:15:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2016-07-13 21:15:29 (46.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.069556 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:29.329609) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:29.329930) ========= 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=eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017151 ========= master_lag: 0.24 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:29.589262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:29.589618) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 52e28dee863fa0640842373c9372a4766a664d35 --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 52e28dee863fa0640842373c9372a4766a664d35 --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=eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 21:15:30,127 truncating revision to first 12 chars 2016-07-13 21:15:30,127 Setting DEBUG logging. 2016-07-13 21:15:30,127 attempt 1/10 2016-07-13 21:15:30,127 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/52e28dee863f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 21:15:30,655 unpacking tar archive at: autoland-52e28dee863f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.861590 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:30.536775) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:30.537486) ========= script_repo_revision: 52e28dee863fa0640842373c9372a4766a664d35 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:30.538361) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:30.539016) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 21:15:30.550695) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-13 21:15:30.550966) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:15:31 INFO - MultiFileLogger online at 20160713 21:15:31 in /builds/slave/test 21:15:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 21:15:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:15:31 INFO - {'append_to_log': False, 21:15:31 INFO - 'base_work_dir': '/builds/slave/test', 21:15:31 INFO - 'blob_upload_branch': 'Autoland', 21:15:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:15:31 INFO - 'branch': 'Autoland', 21:15:31 INFO - 'buildbot_json_path': 'buildprops.json', 21:15:31 INFO - 'config_files': ('talos/linux_config.py',), 21:15:31 INFO - 'default_actions': ('clobber', 21:15:31 INFO - 'read-buildbot-config', 21:15:31 INFO - 'download-and-extract', 21:15:31 INFO - 'populate-webroot', 21:15:31 INFO - 'create-virtualenv', 21:15:31 INFO - 'install', 21:15:31 INFO - 'run-tests'), 21:15:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:15:31 INFO - 'download_minidump_stackwalk': True, 21:15:31 INFO - 'download_symbols': 'ondemand', 21:15:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:15:31 INFO - 'tooltool.py': '/tools/tooltool.py', 21:15:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:15:31 INFO - '/tools/misc-python/virtualenv.py')}, 21:15:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:15:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:15:31 INFO - 'installer_path': 'installer.exe', 21:15:31 INFO - 'log_level': 'info', 21:15:31 INFO - 'log_name': 'talos', 21:15:31 INFO - 'log_to_console': True, 21:15:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:15:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:15:31 INFO - 'opt_config_files': (), 21:15:31 INFO - 'pip_index': False, 21:15:31 INFO - 'sps_profile': False, 21:15:31 INFO - 'sps_profile_interval': 0, 21:15:31 INFO - 'suite': 'dromaeojs', 21:15:31 INFO - 'system_bits': '32', 21:15:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:15:31 INFO - 'title': 'talos-linux64-ix-010', 21:15:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:15:31 INFO - 'use_talos_json': True, 21:15:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:15:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:15:31 INFO - 'work_dir': 'build'} 21:15:31 INFO - ##### 21:15:31 INFO - ##### Running clobber step. 21:15:31 INFO - ##### 21:15:31 INFO - Running pre-action listener: _resource_record_pre_action 21:15:31 INFO - Running main action method: clobber 21:15:31 INFO - rmtree: /builds/slave/test/build 21:15:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:15:32 INFO - Running post-action listener: _resource_record_post_action 21:15:32 INFO - ##### 21:15:32 INFO - ##### Finished clobber step (success) 21:15:32 INFO - ##### 21:15:32 INFO - ##### 21:15:32 INFO - ##### Running read-buildbot-config step. 21:15:32 INFO - ##### 21:15:32 INFO - Running pre-action listener: _resource_record_pre_action 21:15:32 INFO - Running main action method: read_buildbot_config 21:15:32 INFO - Using buildbot properties: 21:15:32 INFO - { 21:15:32 INFO - "project": "", 21:15:32 INFO - "product": "firefox", 21:15:32 INFO - "script_repo_revision": "production", 21:15:32 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 21:15:32 INFO - "repository": "", 21:15:32 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs", 21:15:32 INFO - "buildid": "20160713183004", 21:15:32 INFO - "pgo_build": "True", 21:15:32 INFO - "basedir": "/builds/slave/test", 21:15:32 INFO - "buildnumber": 42, 21:15:32 INFO - "slavename": "talos-linux64-ix-010", 21:15:32 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 21:15:32 INFO - "platform": "ubuntu64_hw", 21:15:32 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 21:15:32 INFO - "branch": "autoland", 21:15:32 INFO - "repo_path": "integration/autoland", 21:15:32 INFO - "revision": "52e28dee863fa0640842373c9372a4766a664d35", 21:15:32 INFO - "stage_platform": "linux64-pgo", 21:15:32 INFO - "builduid": "52a99e9bfae04bb6bda144896a2376b7", 21:15:32 INFO - "slavebuilddir": "test" 21:15:32 INFO - } 21:15:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 21:15:32 INFO - Running post-action listener: _resource_record_post_action 21:15:32 INFO - ##### 21:15:32 INFO - ##### Finished read-buildbot-config step (success) 21:15:32 INFO - ##### 21:15:32 INFO - ##### 21:15:32 INFO - ##### Running download-and-extract step. 21:15:32 INFO - ##### 21:15:32 INFO - Running pre-action listener: _resource_record_pre_action 21:15:32 INFO - Running main action method: download_and_extract 21:15:32 INFO - mkdir: /builds/slave/test/build/tests 21:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:15:32 INFO - https://queue.taskcluster.net/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 21:15:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:15:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:15:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/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 21:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/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 21:15:32 INFO - Downloaded 1361 bytes. 21:15:32 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 21:15:32 INFO - Using the following test package requirements: 21:15:32 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:15:32 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:15:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:15:32 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:15:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:15:32 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:15:32 INFO - u'jsshell-linux-x86_64.zip'], 21:15:32 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:15:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:15:32 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 21:15:32 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:15:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:15:32 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:15:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:15:32 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:15:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:15:32 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 21:15:32 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:15:32 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:15:32 INFO - https://queue.taskcluster.net/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:15:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:15:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:15:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/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 21:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/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 21:15:33 INFO - Downloaded 24325563 bytes. 21:15:33 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'] 21:15:33 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 21:15:35 INFO - Return code: 0 21:15:35 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 21:15:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:15:35 INFO - https://queue.taskcluster.net/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 21:15:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:15:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 21:15:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/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 21:15:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/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 21:15:36 INFO - Downloaded 24325563 bytes. 21:15: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'] 21:15: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 21:15:37 INFO - Return code: 0 21:15: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')]} 21:15:37 INFO - https://queue.taskcluster.net/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 21:15:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:15:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 21:15:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/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 21:15:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/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 21:15:38 INFO - Downloaded 14403317 bytes. 21:15:38 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'] 21:15:38 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 21:15:39 INFO - Return code: 0 21:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:15:39 INFO - https://queue.taskcluster.net/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 21:15:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:15:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:15:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/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 21:15:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SS6iuP42TN2AyXIBKVJhuQ/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 21:15:40 INFO - Downloaded 60805450 bytes. 21:15:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:15:40 INFO - mkdir: /builds/slave/test/properties 21:15:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:15:40 INFO - Writing to file /builds/slave/test/properties/build_url 21:15:40 INFO - Contents: 21:15:40 INFO - build_url:https://queue.taskcluster.net/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 21:15:41 INFO - Running post-action listener: _resource_record_post_action 21:15:41 INFO - Running post-action listener: set_extra_try_arguments 21:15:41 INFO - ##### 21:15:41 INFO - ##### Finished download-and-extract step (success) 21:15:41 INFO - ##### 21:15:41 INFO - ##### 21:15:41 INFO - ##### Running populate-webroot step. 21:15:41 INFO - ##### 21:15:41 INFO - Running pre-action listener: _resource_record_pre_action 21:15:41 INFO - Running main action method: populate_webroot 21:15:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:15:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:15:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:15:41 INFO - '--tppagecycles', 21:15:41 INFO - '7'], 21:15:41 INFO - 'tests': ['tsvgm']}}, 21:15:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:15:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:15:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:15:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:15:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:15:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:15:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:41 INFO - 'talos_options': ['--disable-e10s'], 21:15:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:15:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:15:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:41 INFO - 'talos_options': ['--disable-e10s'], 21:15:41 INFO - 'tests': ['damp', 'tps']}, 21:15:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:41 INFO - 'tests': ['damp', 'tps']}, 21:15:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:15:41 INFO - 'tests': ['dromaeo_dom']}, 21:15:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:15:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:15:41 INFO - 'tests': ['basic_compositor_video']}, 21:15:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:15:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:15:41 INFO - 'tests': ['a11yr', 21:15:41 INFO - 'ts_paint', 21:15:41 INFO - 'tpaint', 21:15:41 INFO - 'sessionrestore', 21:15:41 INFO - 'sessionrestore_no_auto_restore', 21:15:41 INFO - 'tabpaint']}, 21:15:41 INFO - 'other-e10s': {'tests': ['a11yr', 21:15:41 INFO - 'ts_paint', 21:15:41 INFO - 'tpaint', 21:15:41 INFO - 'sessionrestore', 21:15:41 INFO - 'sessionrestore_no_auto_restore', 21:15:41 INFO - 'tabpaint']}, 21:15:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:15:41 INFO - 'ts_paint', 21:15:41 INFO - 'tpaint', 21:15:41 INFO - 'sessionrestore', 21:15:41 INFO - 'sessionrestore_no_auto_restore', 21:15:41 INFO - 'tabpaint']}, 21:15:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:15:41 INFO - 'ts_paint', 21:15:41 INFO - 'tpaint', 21:15:41 INFO - 'sessionrestore', 21:15:41 INFO - 'sessionrestore_no_auto_restore', 21:15:41 INFO - 'tabpaint']}, 21:15:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:15:41 INFO - 'tests': ['a11yr', 21:15:41 INFO - 'ts_paint', 21:15:41 INFO - 'tpaint', 21:15:41 INFO - 'sessionrestore', 21:15:41 INFO - 'sessionrestore_no_auto_restore', 21:15:41 INFO - 'tabpaint']}, 21:15:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:15:41 INFO - 'tests': ['a11yr', 21:15:41 INFO - 'ts_paint', 21:15:41 INFO - 'tpaint', 21:15:41 INFO - 'sessionrestore', 21:15:41 INFO - 'sessionrestore_no_auto_restore', 21:15:41 INFO - 'tabpaint']}, 21:15:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:15:41 INFO - 'tests': ['tsvgx', 21:15:41 INFO - 'tsvgr_opacity', 21:15:41 INFO - 'tart', 21:15:41 INFO - 'tscrollx', 21:15:41 INFO - 'cart']}, 21:15:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:15:41 INFO - 'tsvgr_opacity', 21:15:41 INFO - 'tart', 21:15:41 INFO - 'tscrollx', 21:15:41 INFO - 'cart']}, 21:15:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:41 INFO - 'talos_options': ['--disable-e10s'], 21:15:41 INFO - 'tests': ['tp5o']}, 21:15:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:41 INFO - 'tests': ['tp5o']}, 21:15:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:41 INFO - 'talos_options': ['--disable-e10s', 21:15:41 INFO - '--xperf_path', 21:15:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:15:41 INFO - 'tests': ['tp5n']}, 21:15:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:15:41 INFO - 'talos_options': ['--xperf_path', 21:15:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:15:41 INFO - 'tests': ['tp5n']}}, 21:15:41 INFO - 'talos.zip': {'path': '', 21:15:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:15:41 INFO - Running post-action listener: _resource_record_post_action 21:15:41 INFO - ##### 21:15:41 INFO - ##### Finished populate-webroot step (success) 21:15:41 INFO - ##### 21:15:41 INFO - ##### 21:15:41 INFO - ##### Running create-virtualenv step. 21:15:41 INFO - ##### 21:15:41 INFO - Running pre-action listener: _resource_record_pre_action 21:15:41 INFO - Running main action method: create_virtualenv 21:15:41 INFO - Creating virtualenv /builds/slave/test/build/venv 21:15:41 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 21:15:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:15:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:15:41 INFO - Using real prefix '/usr' 21:15:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:15:41 INFO - Installing distribute.............................................................................................................................................................................................done. 21:15:43 INFO - Installing pip.................done. 21:15:43 INFO - Return code: 0 21:15:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2925030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be43b0>, '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 0x2be52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5740>, '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': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', '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 21:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:15:43 INFO - Using env: {'DISPLAY': ':0', 21:15:43 INFO - 'HOME': '/home/cltbld', 21:15:43 INFO - 'LANG': 'en_US.UTF-8', 21:15:43 INFO - 'LANGUAGE': 'en_US:en', 21:15:43 INFO - 'LOGNAME': 'cltbld', 21:15:43 INFO - 'MAIL': '/var/mail/cltbld', 21:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:43 INFO - 'MOZ_NO_REMOTE': '1', 21:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:15:43 INFO - 'NO_EM_RESTART': '1', 21:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:43 INFO - 'PWD': '/builds/slave/test', 21:15:43 INFO - 'SHELL': '/bin/bash', 21:15:43 INFO - 'SHLVL': '1', 21:15:43 INFO - 'TERM': 'linux', 21:15:43 INFO - 'TMOUT': '86400', 21:15:43 INFO - 'USER': 'cltbld', 21:15:43 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', 21:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:43 INFO - '_': '/tools/buildbot/bin/python'} 21:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:44 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 21:15:44 INFO - Cleaning up... 21:15:44 INFO - Return code: 0 21:15:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:15:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 21:15:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x2925030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be43b0>, '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 0x2be52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5740>, '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': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', '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 21:15:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:15:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:15:44 INFO - Using env: {'DISPLAY': ':0', 21:15:44 INFO - 'HOME': '/home/cltbld', 21:15:44 INFO - 'LANG': 'en_US.UTF-8', 21:15:44 INFO - 'LANGUAGE': 'en_US:en', 21:15:44 INFO - 'LOGNAME': 'cltbld', 21:15:44 INFO - 'MAIL': '/var/mail/cltbld', 21:15:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:44 INFO - 'MOZ_NO_REMOTE': '1', 21:15:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:15:44 INFO - 'NO_EM_RESTART': '1', 21:15:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:15:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:44 INFO - 'PWD': '/builds/slave/test', 21:15:44 INFO - 'SHELL': '/bin/bash', 21:15:44 INFO - 'SHLVL': '1', 21:15:44 INFO - 'TERM': 'linux', 21:15:44 INFO - 'TMOUT': '86400', 21:15:44 INFO - 'USER': 'cltbld', 21:15:44 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', 21:15:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:44 INFO - '_': '/tools/buildbot/bin/python'} 21:15:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:44 INFO - Downloading/unpacking psutil>=3.1.1 21:15:44 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 21:15:44 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 21:15:44 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 21:15:44 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 21:15:44 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 21:15:44 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 21:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:15:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:15:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:15:46 INFO - Installing collected packages: psutil 21:15:46 INFO - Running setup.py install for psutil 21:15:46 INFO - building 'psutil._psutil_linux' extension 21:15:46 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 21:15:46 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 21:15:46 INFO - building 'psutil._psutil_posix' extension 21:15:46 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 21:15:46 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 21:15:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:15:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:15:46 INFO - Successfully installed psutil 21:15:46 INFO - Cleaning up... 21:15:46 INFO - Return code: 0 21:15:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:46 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 0x2925030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be43b0>, '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 0x2be52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5740>, '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': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', '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 21:15:46 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 21:15:46 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 21:15:46 INFO - Using env: {'DISPLAY': ':0', 21:15:46 INFO - 'HOME': '/home/cltbld', 21:15:46 INFO - 'LANG': 'en_US.UTF-8', 21:15:46 INFO - 'LANGUAGE': 'en_US:en', 21:15:46 INFO - 'LOGNAME': 'cltbld', 21:15:46 INFO - 'MAIL': '/var/mail/cltbld', 21:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:46 INFO - 'MOZ_NO_REMOTE': '1', 21:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:15:46 INFO - 'NO_EM_RESTART': '1', 21:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:46 INFO - 'PWD': '/builds/slave/test', 21:15:46 INFO - 'SHELL': '/bin/bash', 21:15:46 INFO - 'SHLVL': '1', 21:15:46 INFO - 'TERM': 'linux', 21:15:46 INFO - 'TMOUT': '86400', 21:15:46 INFO - 'USER': 'cltbld', 21:15:46 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', 21:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:46 INFO - '_': '/tools/buildbot/bin/python'} 21:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:15:47 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 21:15:47 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 21:15:47 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 21:15:47 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 21:15:47 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 21:15:47 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 21:15:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:15:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:15:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:15:49 INFO - Installing collected packages: mozsystemmonitor 21:15:49 INFO - Running setup.py install for mozsystemmonitor 21:15:49 INFO - Successfully installed mozsystemmonitor 21:15:49 INFO - Cleaning up... 21:15:49 INFO - Return code: 0 21:15:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:15: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')]} 21:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15: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')]} 21:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:49 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 0x2925030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be43b0>, '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 0x2be52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5740>, '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': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', '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 21:15:49 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 21:15:49 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 21:15:49 INFO - Using env: {'DISPLAY': ':0', 21:15:49 INFO - 'HOME': '/home/cltbld', 21:15:49 INFO - 'LANG': 'en_US.UTF-8', 21:15:49 INFO - 'LANGUAGE': 'en_US:en', 21:15:49 INFO - 'LOGNAME': 'cltbld', 21:15:49 INFO - 'MAIL': '/var/mail/cltbld', 21:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:49 INFO - 'MOZ_NO_REMOTE': '1', 21:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:15:49 INFO - 'NO_EM_RESTART': '1', 21:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:49 INFO - 'PWD': '/builds/slave/test', 21:15:49 INFO - 'SHELL': '/bin/bash', 21:15:49 INFO - 'SHLVL': '1', 21:15:49 INFO - 'TERM': 'linux', 21:15:49 INFO - 'TMOUT': '86400', 21:15:49 INFO - 'USER': 'cltbld', 21:15:49 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', 21:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:49 INFO - '_': '/tools/buildbot/bin/python'} 21:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:49 INFO - Downloading/unpacking jsonschema==2.5.1 21:15:49 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 21:15:49 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 21:15:49 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 21:15:49 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 21:15:49 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 21:15:49 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 21:15:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:15:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:15:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:15:51 INFO - Downloading functools32-3.2.3-2.tar.gz 21:15:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:15:51 INFO - warning: no files found matching '*.txt' 21:15:51 INFO - no previously-included directories found matching 'build' 21:15:51 INFO - no previously-included directories found matching 'dist' 21:15:51 INFO - no previously-included directories found matching '.git*' 21:15:51 INFO - Installing collected packages: jsonschema, functools32 21:15:51 INFO - Running setup.py install for functools32 21:15:51 INFO - warning: no files found matching '*.txt' 21:15:51 INFO - no previously-included directories found matching 'build' 21:15:51 INFO - no previously-included directories found matching 'dist' 21:15:51 INFO - no previously-included directories found matching '.git*' 21:15:51 INFO - Successfully installed jsonschema functools32 21:15:51 INFO - Cleaning up... 21:15:51 INFO - Return code: 0 21:15:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:15:51 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')]} 21:15:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:51 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')]} 21:15:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:51 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 0x2925030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be43b0>, '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 0x2be52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5740>, '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': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', '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 21:15:51 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 21:15:51 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 21:15:51 INFO - Using env: {'DISPLAY': ':0', 21:15:51 INFO - 'HOME': '/home/cltbld', 21:15:51 INFO - 'LANG': 'en_US.UTF-8', 21:15:51 INFO - 'LANGUAGE': 'en_US:en', 21:15:51 INFO - 'LOGNAME': 'cltbld', 21:15:51 INFO - 'MAIL': '/var/mail/cltbld', 21:15:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:51 INFO - 'MOZ_NO_REMOTE': '1', 21:15:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:15:51 INFO - 'NO_EM_RESTART': '1', 21:15:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:15:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:51 INFO - 'PWD': '/builds/slave/test', 21:15:51 INFO - 'SHELL': '/bin/bash', 21:15:51 INFO - 'SHLVL': '1', 21:15:51 INFO - 'TERM': 'linux', 21:15:51 INFO - 'TMOUT': '86400', 21:15:51 INFO - 'USER': 'cltbld', 21:15:51 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', 21:15:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:51 INFO - '_': '/tools/buildbot/bin/python'} 21:15:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:52 INFO - Downloading/unpacking blobuploader==1.2.4 21:15:52 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 21:15:52 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 21:15:52 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 21:15:52 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 21:15:52 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 21:15:52 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 21:15:53 INFO - Downloading blobuploader-1.2.4.tar.gz 21:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:15:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:15:53 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 21:15:53 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 21:15:53 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 21:15:53 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 21:15:53 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 21:15:53 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 21:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:15:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:15:54 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 21:15:54 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 21:15:54 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 21:15:54 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 21:15:54 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 21:15:54 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 21:15:54 INFO - Downloading docopt-0.6.1.tar.gz 21:15:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:15:54 INFO - Installing collected packages: blobuploader, requests, docopt 21:15:54 INFO - Running setup.py install for blobuploader 21:15:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:15:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:15:54 INFO - Running setup.py install for requests 21:15:55 INFO - Running setup.py install for docopt 21:15:55 INFO - Successfully installed blobuploader requests docopt 21:15:55 INFO - Cleaning up... 21:15:55 INFO - Return code: 0 21:15:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:15:55 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')]} 21:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:55 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')]} 21:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:55 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 0x2925030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be43b0>, '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 0x2be52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5740>, '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': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', '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 21:15:55 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 21:15:55 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 21:15:55 INFO - Using env: {'DISPLAY': ':0', 21:15:55 INFO - 'HOME': '/home/cltbld', 21:15:55 INFO - 'LANG': 'en_US.UTF-8', 21:15:55 INFO - 'LANGUAGE': 'en_US:en', 21:15:55 INFO - 'LOGNAME': 'cltbld', 21:15:55 INFO - 'MAIL': '/var/mail/cltbld', 21:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:55 INFO - 'MOZ_NO_REMOTE': '1', 21:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:15:55 INFO - 'NO_EM_RESTART': '1', 21:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:55 INFO - 'PWD': '/builds/slave/test', 21:15:55 INFO - 'SHELL': '/bin/bash', 21:15:55 INFO - 'SHLVL': '1', 21:15:55 INFO - 'TERM': 'linux', 21:15:55 INFO - 'TMOUT': '86400', 21:15:55 INFO - 'USER': 'cltbld', 21:15:55 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', 21:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:55 INFO - '_': '/tools/buildbot/bin/python'} 21:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:15:55 INFO - Running setup.py (path:/tmp/pip-33UXcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:15:55 INFO - Running setup.py (path:/tmp/pip-pJoga4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:15:55 INFO - Running setup.py (path:/tmp/pip-lhU7Ln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:15:55 INFO - Running setup.py (path:/tmp/pip-dKXrc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:15:55 INFO - Running setup.py (path:/tmp/pip-LAVpHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:15:55 INFO - Running setup.py (path:/tmp/pip-b8PA8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:15:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:15:55 INFO - Running setup.py (path:/tmp/pip-EDNbu8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:15:56 INFO - Running setup.py (path:/tmp/pip-CV3UE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:15:56 INFO - Running setup.py (path:/tmp/pip-0MoZNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:15:56 INFO - Running setup.py (path:/tmp/pip-S7u3nI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:15:56 INFO - Running setup.py (path:/tmp/pip-CBw74g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:15:56 INFO - Running setup.py (path:/tmp/pip-xluiWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:15:56 INFO - Running setup.py (path:/tmp/pip-_Nf5zF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:15:56 INFO - Running setup.py (path:/tmp/pip-EwfulV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:56 INFO - Running setup.py (path:/tmp/pip-IDtcWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:15:56 INFO - Running setup.py (path:/tmp/pip-r8pyFR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:15:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:15:56 INFO - Running setup.py (path:/tmp/pip-q4GPSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:15:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:15:56 INFO - Running setup.py install for manifestparser 21:15:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:15:56 INFO - Running setup.py install for mozcrash 21:15:56 INFO - Running setup.py install for mozdebug 21:15:57 INFO - Running setup.py install for mozdevice 21:15:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:15:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:15:57 INFO - Running setup.py install for mozfile 21:15:57 INFO - Running setup.py install for mozhttpd 21:15:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:15:57 INFO - Running setup.py install for mozinfo 21:15:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:15:57 INFO - Running setup.py install for mozInstall 21:15:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:15:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:15:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:15:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:15:57 INFO - Running setup.py install for mozleak 21:15:57 INFO - Running setup.py install for mozlog 21:15:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:15:57 INFO - Running setup.py install for moznetwork 21:15:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:15:57 INFO - Running setup.py install for mozprocess 21:15:57 INFO - Running setup.py install for mozprofile 21:15:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:15:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:15:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:15:58 INFO - Running setup.py install for mozrunner 21:15:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:15:58 INFO - Running setup.py install for mozscreenshot 21:15:58 INFO - Running setup.py install for moztest 21:15:58 INFO - Running setup.py install for mozversion 21:15:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:15:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:15:58 INFO - Cleaning up... 21:15:58 INFO - Return code: 0 21:15:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:15:58 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')]} 21:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:58 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')]} 21:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:15:58 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 0x2925030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be43b0>, '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 0x2be52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5740>, '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': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', '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 21:15:58 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 21:15:58 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 21:15:58 INFO - Using env: {'DISPLAY': ':0', 21:15:58 INFO - 'HOME': '/home/cltbld', 21:15:58 INFO - 'LANG': 'en_US.UTF-8', 21:15:58 INFO - 'LANGUAGE': 'en_US:en', 21:15:58 INFO - 'LOGNAME': 'cltbld', 21:15:58 INFO - 'MAIL': '/var/mail/cltbld', 21:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:15:58 INFO - 'MOZ_NO_REMOTE': '1', 21:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:15:58 INFO - 'NO_EM_RESTART': '1', 21:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:15:58 INFO - 'PWD': '/builds/slave/test', 21:15:58 INFO - 'SHELL': '/bin/bash', 21:15:58 INFO - 'SHLVL': '1', 21:15:58 INFO - 'TERM': 'linux', 21:15:58 INFO - 'TMOUT': '86400', 21:15:58 INFO - 'USER': 'cltbld', 21:15:58 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', 21:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:15:58 INFO - '_': '/tools/buildbot/bin/python'} 21:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:15:58 INFO - Running setup.py (path:/tmp/pip-7FN8zH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:15:58 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)) 21:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:15:58 INFO - Running setup.py (path:/tmp/pip-Jg0Zis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:15:58 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)) 21:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:15:58 INFO - Running setup.py (path:/tmp/pip-DDu0Jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:15:58 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)) 21:15:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:15:59 INFO - Running setup.py (path:/tmp/pip-c3_VmM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:15:59 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)) 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:15:59 INFO - Running setup.py (path:/tmp/pip-lMV_2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:15:59 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)) 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:15:59 INFO - Running setup.py (path:/tmp/pip-YqpObe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:15:59 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)) 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:15:59 INFO - Running setup.py (path:/tmp/pip-fonm4b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:15:59 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)) 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:15:59 INFO - Running setup.py (path:/tmp/pip-njrQAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:15:59 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)) 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:15:59 INFO - Running setup.py (path:/tmp/pip-03lpk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:15:59 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)) 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:15:59 INFO - Running setup.py (path:/tmp/pip-cntKea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:15:59 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)) 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:15:59 INFO - Running setup.py (path:/tmp/pip-ODdh_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:15:59 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)) 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:15:59 INFO - Running setup.py (path:/tmp/pip-qNAYNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:15:59 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)) 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:15:59 INFO - Running setup.py (path:/tmp/pip-ZKU9vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:15:59 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)) 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:15:59 INFO - Running setup.py (path:/tmp/pip-O6h0F3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:15:59 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)) 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:59 INFO - Running setup.py (path:/tmp/pip-OxkldG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:15:59 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)) 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:15:59 INFO - Running setup.py (path:/tmp/pip-rkUgLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:15:59 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)) 21:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:15:59 INFO - Running setup.py (path:/tmp/pip-1NhmvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:16:00 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)) 21:16:00 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)) 21:16:00 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)) 21:16:00 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)) 21:16:00 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)) 21:16:00 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)) 21:16:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:16: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 21:16: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 21:16: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 21:16: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 21:16: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 21:16: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 21:16:01 INFO - Downloading blessings-1.6.tar.gz 21:16:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:16:02 INFO - Installing collected packages: blessings 21:16:02 INFO - Running setup.py install for blessings 21:16:02 INFO - Successfully installed blessings 21:16:02 INFO - Cleaning up... 21:16:02 INFO - Return code: 0 21:16:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:16:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:16:02 INFO - Reading from file tmpfile_stdout 21:16:02 INFO - Current package versions: 21:16:02 INFO - argparse == 1.2.1 21:16:02 INFO - blessings == 1.6 21:16:02 INFO - blobuploader == 1.2.4 21:16:02 INFO - docopt == 0.6.1 21:16:02 INFO - functools32 == 3.2.3-2 21:16:02 INFO - jsonschema == 2.5.1 21:16:02 INFO - manifestparser == 1.1 21:16:02 INFO - mozInstall == 1.12 21:16:02 INFO - mozcrash == 0.17 21:16:02 INFO - mozdebug == 0.1 21:16:02 INFO - mozdevice == 0.48 21:16:02 INFO - mozfile == 1.2 21:16:02 INFO - mozhttpd == 0.7 21:16:02 INFO - mozinfo == 0.9 21:16:02 INFO - mozleak == 0.1 21:16:02 INFO - mozlog == 3.2 21:16:02 INFO - moznetwork == 0.27 21:16:02 INFO - mozprocess == 0.23 21:16:02 INFO - mozprofile == 0.28 21:16:02 INFO - mozrunner == 6.12 21:16:02 INFO - mozscreenshot == 0.1 21:16:02 INFO - mozsystemmonitor == 0.3 21:16:02 INFO - moztest == 0.7 21:16:02 INFO - mozversion == 1.4 21:16:02 INFO - psutil == 3.1.1 21:16:02 INFO - requests == 1.2.3 21:16:02 INFO - wsgiref == 0.1.2 21:16:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:16: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')]} 21:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16: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')]} 21:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16:02 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 0x2925030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be43b0>, '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 0x2be52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5740>, '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': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', '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 21:16:02 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 21:16:02 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 21:16:02 INFO - Using env: {'DISPLAY': ':0', 21:16:02 INFO - 'HOME': '/home/cltbld', 21:16:02 INFO - 'LANG': 'en_US.UTF-8', 21:16:02 INFO - 'LANGUAGE': 'en_US:en', 21:16:02 INFO - 'LOGNAME': 'cltbld', 21:16:02 INFO - 'MAIL': '/var/mail/cltbld', 21:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:02 INFO - 'MOZ_NO_REMOTE': '1', 21:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:16:02 INFO - 'NO_EM_RESTART': '1', 21:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:02 INFO - 'PWD': '/builds/slave/test', 21:16:02 INFO - 'SHELL': '/bin/bash', 21:16:02 INFO - 'SHLVL': '1', 21:16:02 INFO - 'TERM': 'linux', 21:16:02 INFO - 'TMOUT': '86400', 21:16:02 INFO - 'USER': 'cltbld', 21:16:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', 21:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:02 INFO - '_': '/tools/buildbot/bin/python'} 21:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:02 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)) 21:16:02 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)) 21:16:02 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)) 21:16:02 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)) 21:16:02 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)) 21:16:02 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)) 21:16:02 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)) 21:16:02 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)) 21:16:02 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)) 21:16:02 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)) 21:16:02 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)) 21:16:02 INFO - Cleaning up... 21:16:02 INFO - Return code: 0 21:16:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:16: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')]} 21:16:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:16:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16: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')]} 21:16:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:16:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:16: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2925030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2be6180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2be43b0>, '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 0x2be52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5740>, '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': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', '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 21:16: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', 'jsonschema'] in /builds/slave/test/build 21:16: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 jsonschema 21:16:02 INFO - Using env: {'DISPLAY': ':0', 21:16:02 INFO - 'HOME': '/home/cltbld', 21:16:02 INFO - 'LANG': 'en_US.UTF-8', 21:16:02 INFO - 'LANGUAGE': 'en_US:en', 21:16:02 INFO - 'LOGNAME': 'cltbld', 21:16:02 INFO - 'MAIL': '/var/mail/cltbld', 21:16:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:02 INFO - 'MOZ_NO_REMOTE': '1', 21:16:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:16:02 INFO - 'NO_EM_RESTART': '1', 21:16:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:16:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:02 INFO - 'PWD': '/builds/slave/test', 21:16:02 INFO - 'SHELL': '/bin/bash', 21:16:02 INFO - 'SHLVL': '1', 21:16:02 INFO - 'TERM': 'linux', 21:16:02 INFO - 'TMOUT': '86400', 21:16:02 INFO - 'USER': 'cltbld', 21:16:02 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', 21:16:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:02 INFO - '_': '/tools/buildbot/bin/python'} 21:16:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:16:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:16:02 INFO - Cleaning up... 21:16:02 INFO - Return code: 0 21:16:02 INFO - Running post-action listener: _resource_record_post_action 21:16:02 INFO - Running post-action listener: _start_resource_monitoring 21:16:02 INFO - Starting resource monitoring. 21:16:02 INFO - ##### 21:16:02 INFO - ##### Finished create-virtualenv step (success) 21:16:02 INFO - ##### 21:16:02 INFO - ##### 21:16:02 INFO - ##### Running install step. 21:16:02 INFO - ##### 21:16:02 INFO - Running pre-action listener: _resource_record_pre_action 21:16:02 INFO - Running main action method: install 21:16:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:16:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:16:03 INFO - Reading from file tmpfile_stdout 21:16:03 INFO - Detecting whether we're running mozinstall >=1.0... 21:16:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:16:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:16:03 INFO - Reading from file tmpfile_stdout 21:16:03 INFO - Output received: 21:16:03 INFO - Usage: mozinstall [options] installer 21:16:03 INFO - Options: 21:16:03 INFO - -h, --help show this help message and exit 21:16:03 INFO - -d DEST, --destination=DEST 21:16:03 INFO - Directory to install application into. [default: 21:16:03 INFO - "/builds/slave/test"] 21:16:03 INFO - --app=APP Application being installed. [default: firefox] 21:16:03 INFO - mkdir: /builds/slave/test/build/application 21:16:03 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'] 21:16:03 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 21:16:21 INFO - Reading from file tmpfile_stdout 21:16:21 INFO - Output received: 21:16:21 INFO - /builds/slave/test/build/application/firefox/firefox 21:16:21 INFO - Running post-action listener: _resource_record_post_action 21:16:21 INFO - ##### 21:16:21 INFO - ##### Finished install step (success) 21:16:21 INFO - ##### 21:16:21 INFO - ##### 21:16:21 INFO - ##### Running run-tests step. 21:16:21 INFO - ##### 21:16:21 INFO - Running pre-action listener: _resource_record_pre_action 21:16:21 INFO - Running main action method: run_tests 21:16:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:16:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:16:21 INFO - Python 2.7.3 21:16:21 INFO - Return code: 0 21:16:21 INFO - grabbing minidump binary from tooltool 21:16:21 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')]} 21:16:21 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 0x2be43b0>, '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 0x2be52b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2be5740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:16:21 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 21:16:21 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 21:16:21 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 21:16:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:16:21 INFO - Return code: 0 21:16:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:16:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:16:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:16:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:16:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:16:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:16:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:16:21 INFO - Using env: {'DISPLAY': ':0', 21:16:21 INFO - 'HOME': '/home/cltbld', 21:16:21 INFO - 'LANG': 'en_US.UTF-8', 21:16:21 INFO - 'LANGUAGE': 'en_US:en', 21:16:21 INFO - 'LOGNAME': 'cltbld', 21:16:21 INFO - 'MAIL': '/var/mail/cltbld', 21:16:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:16:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:16:21 INFO - 'MOZ_NO_REMOTE': '1', 21:16:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:16:21 INFO - 'NO_EM_RESTART': '1', 21:16:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:16:21 INFO - 'PWD': '/builds/slave/test', 21:16:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:16:21 INFO - 'SHELL': '/bin/bash', 21:16:21 INFO - 'SHLVL': '1', 21:16:21 INFO - 'TERM': 'linux', 21:16:21 INFO - 'TMOUT': '86400', 21:16:21 INFO - 'USER': 'cltbld', 21:16:21 INFO - 'XDG_SESSION_COOKIE': 'eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392', 21:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:16:21 INFO - '_': '/tools/buildbot/bin/python'} 21:16:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:16:21 INFO - mozversion application_buildid: 20160713183004 21:16:21 INFO - mozversion application_changeset: 52e28dee863fa0640842373c9372a4766a664d35 21:16:21 INFO - mozversion application_display_name: Nightly 21:16:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:16:21 INFO - mozversion application_name: Firefox 21:16:21 INFO - mozversion application_remotingname: firefox 21:16:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 21:16:21 INFO - mozversion application_vendor: Mozilla 21:16:21 INFO - mozversion application_version: 50.0a1 21:16:21 INFO - mozversion platform_buildid: 20160713183004 21:16:21 INFO - mozversion platform_changeset: 52e28dee863fa0640842373c9372a4766a664d35 21:16:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 21:16:21 INFO - mozversion platform_version: 50.0a1 21:16:21 INFO - using testdate: 1468469781 21:16:21 INFO - actual date: 1468469781 21:16:21 INFO - starting webserver on 'localhost:42533' 21:16:21 INFO - SUITE-START | Running 2 tests 21:16:21 INFO - TEST-START | dromaeo_css 21:16:21 INFO - operating with platform_type : linux_ 21:16:21 INFO - Initialising browser for dromaeo_css test... 21:16:21 INFO - TEST-INFO | started process 17589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3di4Cf/profile http://localhost:42533/getInfo.html) 21:16:26 INFO - PROCESS | 17589 | __metrics Screen width/height:1600/1200 21:16:26 INFO - PROCESS | 17589 | colorDepth:24 21:16:26 INFO - PROCESS | 17589 | Browser inner width/height: 1024/697 21:16:26 INFO - PROCESS | 17589 | __metrics 21:16:27 INFO - PROCESS | 17589 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:16:27 INFO - PROCESS | 17589 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:16:27 INFO - PROCESS | 17589 | console.error: PushService: 21:16:27 INFO - PROCESS | 17589 | stateChangeProcessEnqueue: Error transitioning state 21:16:27 INFO - PROCESS | 17589 | UnknownError 21:16:28 INFO - TEST-INFO | 17589: exit 0 21:16:28 INFO - Browser initialized. 21:16:28 INFO - Running cycle 1/1 for dromaeo_css test... 21:16:28 INFO - TEST-INFO | started process 17671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3di4Cf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:16:40 INFO - PROCESS | 17671 | RSS: Main: 157708288 21:16:40 INFO - PROCESS | 17671 | 21:17:31 INFO - PROCESS | 17671 | 1468469851512 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] 21:19:40 INFO - PROCESS | 17671 | Cycle 1(1): loaded http://localhost:42533/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42533/tests/dromaeo/cssquery-ext.html) 21:19:40 INFO - PROCESS | 17671 | RSS: Main: 246239232 21:19:40 INFO - PROCESS | 17671 | 21:22:43 INFO - PROCESS | 17671 | Cycle 1(1): loaded http://localhost:42533/tests/dromaeo/cssquery-ext.html (next: http://localhost:42533/tests/dromaeo/cssquery-jquery.html) 21:22:44 INFO - PROCESS | 17671 | RSS: Main: 238813184 21:22:44 INFO - PROCESS | 17671 | 21:25:45 INFO - PROCESS | 17671 | Cycle 1(1): loaded http://localhost:42533/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42533/tests/dromaeo/cssquery-mootools.html) 21:25:46 INFO - PROCESS | 17671 | RSS: Main: 239902720 21:25:46 INFO - PROCESS | 17671 | 21:28:48 INFO - PROCESS | 17671 | Cycle 1(1): loaded http://localhost:42533/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42533/tests/dromaeo/cssquery-prototype.html) 21:28:49 INFO - PROCESS | 17671 | RSS: Main: 234201088 21:28:49 INFO - PROCESS | 17671 | 21:31:51 INFO - PROCESS | 17671 | Cycle 1(1): loaded http://localhost:42533/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42533/tests/dromaeo/cssquery-yui.html) 21:31:52 INFO - PROCESS | 17671 | RSS: Main: 227774464 21:31:52 INFO - PROCESS | 17671 | 21:34:55 INFO - PROCESS | 17671 | Cycle 1(1): loaded http://localhost:42533/tests/dromaeo/cssquery-yui.html (next: http://localhost:42533/tests/dromaeo/cssquery-dojo.html) 21:34:55 INFO - PROCESS | 17671 | RSS: Main: 277446656 21:34:55 INFO - PROCESS | 17671 | 21:34:55 INFO - PROCESS | 17671 | __start_tp_report 21:34:55 INFO - PROCESS | 17671 | _x_x_mozilla_page_load 21:34:55 INFO - PROCESS | 17671 | _x_x_mozilla_page_load_details 21:34:55 INFO - PROCESS | 17671 | |i|pagename|runs| 21:34:55 INFO - PROCESS | 17671 | |0;dojo.html;3000.0999700089974;3019.1697283247117;3040.680728523505;3045.330027393974;3049.9542506862385;5211.192265198891;5244.68531888087;5258.6318957672975;5304.257403963444;5353.922789539228;5216.139337009398;5324.094903866342;5329.280547126137;5394.703291318976;5416.295881535405;4823.517648235174;4876.97561512192;4887.535684110004;4894.53501917319;4927.975360123212;4976.875578110558;4979.60163186946;4988.376452943382;4993.450720420751;5013.222950442687;4734.384530011093;4761.452432970218;4775.188218002948;4907.730074845882;4918.04098200851;4821.855344339676;4821.927671084936;4825.879353016167;4827;4827.734474603895;4788.928166077511;4805.183118869801;4808.206645903421;4810.855674329776;4813.964997525513;5169.53474187325;5184.844454666366;5228.346456692913;5232.2674825524455;5255.054090263751;5606.55147588192;5627.071533197018;5629.915551266734;5684.403137670526;5695.231143795618;5661.943380566183;5678.9432105678825;5699.401562835884;5729.140628905656;5731.799387021434;5144.794208231704;5213.4004589472315;5284;5293.920591191135;5372.382176049726;5781.161731548902;5801.3328467225965;5802.245708057925;5807.680577568274;5812.0119579671555;5345.518903298722;5584.6090773646265;5600.60795744294;5602.635828671123;5606.103023516218;5530.142827861688;5548.722563871871;5555.027870122713;5579.721013949367;5651.971740141355;5560.944390556043;5568.359638641527;5568.721563921868;5581.6371935824045;5610.747516361774;5491.7254137292975;5519.751611177427;5565.666060036411;5566.443355664401;5586.888262234733;4331.978340108342;4336.869893903188;4337.609615134653;4375.890602734893;4378.671599630041;3863.8840834775;3872.8644497442456;3881.029742564359;3892.21854469193;3910.7262491625884;5230.686158830483;5247.737613119329;5251.133562962144;5390.110631745718;5436.728163591804;5550.306211723535;5594.552435805207;5602.803901863415;5611.551075913917;5657.2928383952;5291.735413229323;5306.893862122736;5312.495312945264;5313.256144139824;5356.276902618175;4781.330613714083;4796.136695394793;4801.375821143229;4857.247126695368;4858.878528036827;5765.798197063083;5769.365369809401;5773.509251713567;5776.046952252831;5811.186433899257;5535.225068490334;5586.692731899784;5591.30108736408;5596.888062238814;5609.186667933045;5651.547876169814;5708.400617935223;5712.285964254468;5746.908087463368;5772.393898640582;5494.835154945358;5495.2856128703015;5499.560035197254;5501.312335958005;5502.0921547945745;5566.554675626021;5605.5795815313195;5607.102863541813;5615.8876822464135;5619;5246.580273578028;5397.757100930546;5419.891602167856;5458.263134476795;5483.259759932358;5434.10337294342;5438.700871452108;5440.075187218262;5441.211024401518;5443.673379597237;5213.139831927841;5397.514223719884;5400.783968641211;5401.3248343957;5455.618106732491;5499.697516636624;5547.861303467284;5577.525910297508;5584.553235741212;5620.437956204347;5495.477929596682;5501.339839219319;5501.862453438696;5502.0921547944145;5502.2296878436255 21:34:55 INFO - PROCESS | 17671 | |1;ext.html;590.4390828712721;614.8708771158057;637.7480895046459;645.3320812958588;653.2716021635878;36842.63157368425;37488.43767343492;37492.06269843255;44323;45327.32009019867;46341.07317853649;46606.53393466073;46642.067158656806;46704.299435508496;46760;8913.598888050054;9087.636494540244;9093.818123637524;9094.363394562382;9098.363114581949;8917.73246802597;9008.909910900873;9027.277817774595;9033;9038.683646072388;9042.186203241707;9084.818303633923;9090.13643703847;9090.2273306769;9102.681406150787;9009.504477253748;9050.502222377767;9054.094590540959;9058.818823623524;9059.637614495412;8908.643654253821;8976.506292153928;8979.281657467387;8981.101889811032;8981.550922453916;43998.12003759939;44281.77859110716;44306;44397.11205775899;44469.332960005624;3312.817795021273;3346.297277571713;3353.9832300838584;3635.2366003139373;3717.832697528591;33546.3290734184;33564.328713425595;33899.15252118692;34509;35534;4454.242778727624;4469.620082293009;4481.865544033684;4498.595126438636;4739.194336962724;247601;248897;249851;249987;250204;61238;61238.69380653068;61492.69253653793;61496.38503614906;61509.69245153835;35568;36301.273974520365;36587;37790.811045944596;65107;17923.1934562945;18033.639327213383;18085.7287140693;18110.63778724418;18130;13587.456501740018;13849.51526696581;13850.722985540435;13855;13856.93071534636;20159.294424695065;20346.796532034787;20476;20507.69238461424;20508.794912050987;7436.847288670265;7455.478116531899;7524.247575242542;7569.772906812695;7781.494202876908;933.5752232734089;978.6476868327396;1055.4300677634146;1078.3691540448926;1113.716002419378;32641.836790816367;32778.18054548655;32848.17879552983;32953.693241473346;33097.66902330994;1006.8137394582026;1034.3018462537757;1100.9944950275196;1113.3987646670707;1117.9944100279447;17210.39763608268;17707.73438398425;17754.289828406978;17794;17806.433569227564;570108;571390;572072;573594;573803;61866.38133618606;62368.68815655893;62756.686216569535;62870.37129628737;62895.37104628895;1224.2226186371718;1341.805438211454;1359.7688392973218;1372.0464277327362;1396.3367400484892;30157.849210753804;34349;34521.136971575914;34524.65475345315;35090.649093508735;51781.7410912943;52608.47391526036;52639.473605263454;52658.736706316224;52724;396292;402534;402536;402807;404267;25002.37494062663;27758.861205693844;27993.720062799926;28099;28393.858030709715;48335.758321208166;48680.756596216794;49223.753881231794;49367;50091.74954125352;42675.7866210667;43222;43507.347389789815;44532.55467445284;44753.328700070175;43167.35248971205;43375;43515.56484435115;43559.56440435682;44181;41735;42798.35802463028;43138;43278.78360608303;43397.56602433935;36138.27723445569;38145.42781858219;38601.6139838598;39457.80271098741;39585;28454.71953762127;28468.85765571159;28937.7106228935;28939.41124191304;28951.565726514542 21:34:55 INFO - PROCESS | 17671 | |2;jquery.html;396.2174704957707;399.67626222759566;400.94587230723846;401.8794361691492;418.57305548340696;14024.71950560988;19332.22671093156;19980.800191998074;21011.57976840464;21021.159153633856;19146;19951.700724489143;19996.600067998632;20039.799602003975;20341.084651190697;5233.136532472137;5320.6275560710765;5328.20076988451;5340.62615616907;5370.5435038021815;3884.941725874114;5332.57339412848;5352.5182733553975;5358.91961620576;5359.196120581924;5629.915551266734;5886.911696324537;5887.205227294325;5887.61730487517;5903.144044113601;5684.118961560965;5863.79476718315;5891.469767720904;5915.645061296336;5946.048632218867;5664.490195882349;5697.658140511582;5710;5735.913961290584;5736.541076713853;12973.870261297456;14012.509562165274;22913.770862291498;23610;24036.27891163268;2294.4378627236433;2332.3236261484317;2357.5167090746354;2390.725066617344;2428.878556072207;9760.4631745254;9864.605415783431;10032.749181270527;10319.277650564463;10604.840927386096;1880.1445342369188;1968.7440632717799;1973.4474347182668;1977.831884289837;2036.5519585691125;83661.58169209176;90450.54774726085;91261.08738912593;91299;93857;11012.229143959847;11127.833082503768;11155.72110697239;11392.316461012366;11406.201565890475;15206.011609245365;15267.236638168048;15294.847051529565;15339.463118790789;15345.616359590877;8316.37627177964;8571.142885711379;8601.698940537051;8632.482051076955;8668.566571671392;8337.416380853281;8338.458000229966;8369.748907532783;8452.661893524313;8532.97604287477;4714.151452738472;4734;4886.267059941038;4923.261510773413;4984.975075124601;1803.2967142814314;1955.511122219445;1976.7726711428081;1999.7400337955974;2076.480879780055;927.8329900617819;942.8585712143233;1055.1242468750918;1057.7461409261875;1062.3785085724783;19841.404757857286;20420.38738837837;20688.275910343065;20755.792442075384;20795.480112997295;968.5738275158908;990.2573070197352;1001.399160503692;1018.5314755212685;1086.706589220906;10800.729981750519;11310.717232069099;11364.94317528407;11374.20380573352;11388.886111138783;154821;155261.2236938808;157342;218169;485406;56831.43168568344;57860.4213957855;67070.3292967064;85477.57261213654;92595.53702231446;1001.7245257554231;1011.8633984412157;1030.2324768047852;1045.257866914484;1049.1187402581868;18570.721439178153;18779.624407512045;19113.90443047776;19122.808771912103;19140.234390624777;45232.77383613061;45976.31035534536;46716.299255510516;47402.288965664855;47534;60715.05352152096;66622.66688666526;67286.66356668381;68439;68467;7634;7774.611269436618;7834.529928204326;8137.186281371815;8698.391112622308;12348.179147359027;12658.936705316415;12707.174033687781;12868.292243926673;13005.869941300465;10646.627368042391;10958.12335013213;11180.273282236629;11296.152788541056;11322.660320190407;10912.290701104403;10949.616763413242;11199.944000279946;11311.208215425171;11585.304881707125;10205.84691229647;10451.059404653313;10536.631217907643;10747.570097196025;11776;7681.807954801175;7711.460197786101;7719.961400193188;7767.766966990999;7880.566568838769;10046.346987445793;10984.505697243483;11071.391073491035;11159.832602511131;11318.26431281964 21:34:55 INFO - PROCESS | 17671 | |3;mootools.html;1509.1548732709684;1535.8617724404805;1658.3200887636065;1784.072282413146;1803.3958623861015;8600.268977136942;9070.319726020542;9089.59096840642;9091;9095.909040909597;7765.262300081497;8013.198680131998;8467.153284671529;8732.170443807843;8997.280217582595;2332.6384410416413;2358.41039740065;2359.138914296278;2359.209664762298;2365.3731761083327;2309.7574754650773;2341.309313752439;2378.0725517048363;2395.580773364663;2397.25685037638;2016.0423798695576;2232.966505502419;2327.406511339606;2328.2316835444262;2345.9648105278434;2350.670906073151;2366.3492539551676;2374.6912901322717;2387.892544835478;2388.1999530157245;2291.4042348989215;2295.070496448941;2298.10373954158;2300.344401845466;2304.0898844956314;9086.50024248666;9097.63609455621;9145.176934075898;9157.633694652273;9158.95420522893;5145.794168233266;5290.735463226823;5304.283921670563;5309.761060752276;5309.787608495694;3220.1949512621845;3262.934741305184;3301.042697617688;3307.2889328794186;3311.2549676322874;966.7152503048874;976.5361453309621;983.9852402213972;1001.2540657210425;1020.6478764826123;12660.873391266061;12677.619671409873;12680.365981700877;12687.873121268762;12697.111202215941;4546.431696037996;4642.396488456547;4705.85882423521;4710.26990816424;4742.928856067162;10706.089982351432;10739.83890241647;10748.838767418494;10754.139668826632;10759.08547773448;5358.732063396815;5369.946300537023;5372.409035006146;5374.220737993047;5377.247185394048;4697.976510117427;4901.681390709592;4934.5312195341385;4942.678725882806;4948.183549714328;3942.3692209246956;3969.0672691917375;4035.5964403559997;4086.6117718816663;4122.649574786117;1139.6524060161564;1196.7965445874222;1226.9754604907853;1252.6868282929267;1274.796032634774;866.696656170348;1000.049952545085;1021.3463383434607;1022.956584284041;1043.8778313313219;6186.628802271878;6290.087937249074;6404.871902562016;6501.707423165969;6678.298778628174;941.4351389166445;943.8631398447187;960;983.955721992512;1006.1849901579598;4095.508538975342;4217.641500472433;4351.825926962886;4371.540988196257;4373.103513779667;10936.398498082683;11286.717832054264;11359.148063895076;11380.374079425712;11392.145589080686;9947.253955953187;10668.253222274521;11298.887011129947;11306.208565400342;11316.773664526663;8163.346932245406;8421.031581368099;8503.23470887623;8506.872396914052;8512.191341822518;6348.746050158126;6398.4561312287115;6514.250861151028;6573.506986976092;6591.538592298493;10268.435236062089;10407.739806504898;10587.20595955322;10617.89382106169;10631.308964917256;10652.414117223627;10662.46687665598;10735.94632026835;10819.621313253998;10851.511681974172;7446.478746487694;7536.208698086622;7592.278733520307;7599.772006839804;7600.695972161052;8743.256823169848;8928;8934.195922367018;8945.821083578423;8955.641774329215;7595.506292090997;7770.92229077702;7836.138024817379;7941.444098913021;8207.056188538156;7557.811054723676;7608;7845.646945887334;7880.408969327438;8083.03003639567;7203.675834587351;7207.315305046012;7255.673494692857;7260.4554658399775;7260.782176534713;4892.828750993698;4940.728259945738;5054.29239906406;5070.4929507049;5117.74411279442;5448.972755136199;5468.835934921959;5484.095124304445;5676.148577713376;5727.31272247333 21:34:55 INFO - PROCESS | 17671 | |4;prototype.html;325.8843110695703;327.92129888826673;333.49975037443835;342.5153407927782;345.03218472185523;5379.220013098104;5386.899109347358;5388.43421440749;5409.188621706746;5437.972810135944;5284;5298.417174110845;5354.866128346794;5375.81184658537;5405.864853378667;4007.83968641254;4064.7967601619803;4163.97918010411;4181.351890456984;4199.391088292211;4125.855595054174;4153.587780154747;4161.563035881234;4179.143275628504;4199.370094485821;3986.900327491807;4119.299719047769;4133.937990930139;4137.586241375869;4142.813573389205;4099.233017713047;4165.666986564301;4169.437125987984;4189.162167566499;4192.287311157111;3640.6541378568995;3681.7054635629083;3688.704903607705;3690.372636651749;3705.1478160023344;5188.974055129738;5204.219367094928;5234.738263086869;5252.474752524755;5268.578513718893;4590.517995610447;4842.02215637384;4862.222044472867;4883.169861123618;4894.41267047953;5616.297962754656;5633.80281690143;5647.548196144298;5647.717614119278;5651.9152212716845;4140.523839758436;4149.605787450218;4154.5222299435645;4158.9376159357635;4162.4796900387455;5485.917711234335;5743.650242193081;5746.425357464262;5748.281464816898;5770.855728606818;4028.4158796974275;4058.431819545266;4063.309237429644;4065.918681626351;4072.6334629883454;4140.875773726793;4165.062860856283;4172.645325147336;4174.519930208005;4179.226843034048;4667.416572928384;4691.601213896789;4695.5539223773685;4702.6473014524045;4716.716996980193;5542.8337149885565;5562.554995600342;5568.49883510486;5575.637583557056;5578.721063946787;1441.1857300625113;1448.855404230646;1455.9053661511969;1455.995363199389;1457.4024649893704;964.3924327673661;975.4439969217619;994.1947022911465;999.3054826895383;999.3803841618243;5369.865753356197;5376.462353764592;5379.704116273564;5389.218563308376;5389.730513474311;5675;5685.943140568541;5698.515626171739;5734.132933533233;5737.598368114275;5202.1272341956865;5363;5463.262459567987;5464.508194262536;5485.698286594195;3037.2255074955747;3040.9391812164076;3046.3602643444683;3052.832094234838;3058.189579761365;5684.914726279109;5892.705364731746;5900.940990590039;5941.821745347646;5950.821475355746;5809.390014048464;5812.622179558315;5818.2436283282905;5818.359980402152;5841.130838131757;5868.970655146697;5926.436988486087;5928.916963179123;5951.970240148771;5953.7023148843255;5439.265699130567;5711.572581652864;5714.514266287246;5745.1382292656435;5790.10253410722;5618.775248989995;5666.15007748841;5698.373178950395;5699.8860022800145;5711.228984087095;5747.827565173052;5951.791687290924;5952.8809423812145;5966.76132954677;5976.372480889618;4125.401816736617;4140.109876376593;4140.302475984832;4141.958580414157;4163.97918010408;5525.336959564878;5661.2923384576925;5784.132380142844;5790.681512516852;5807.94192058074;5599.748011339581;5618.578606604603;5625.437456254342;5632.14139334027;5635.492805647511;5577.721113944368;5579.60942734021;5585.301837270341;5592.273004509388;5592.832215033555;5322.920156197582;5580.972095139498;5584.748686309044;5596.4123767003875;5605.915911261416;5606.551475882001;5668.631538949955;5693.658380497183;5709.800156994485;5720.6853623049465;5454.481824226692;5530.783227689902;5592.664440133442;5595.692236926845;5611.3266408031295 21:34:55 INFO - PROCESS | 17671 | |5;yui.html;767.7159451003126;782.6517199846071;805.8750893611491;815.5595978171788;835.0438747633963;15003.849961500382;16411.425600103983;17200.48398548044;17234.741478877826;18025;16627.66744665106;16674.49976500704;16759.413420530283;16802.411915582958;16810.32758689651;668.7659319238277;788.9329407000397;810.5622963599649;813.8046868751487;813.8209593889335;782.6047845837873;821.5276216175693;821.5481485183155;825.7110011495988;826.1078035721437;856.7344123321759;860.6428332242112;860.9009963854143;860.9741707748747;861.7845538615346;697.0972590495321;716.0333549707905;855.4610595324937;855.683397143058;855.8288342331558;601.3925934805834;615.6552330694825;616.005151680038;619.1764952613014;619.2599843187348;15329.616759580987;15382.923085384613;15404.46084387041;15410.460633877872;15446.150461724601;12900.870991290061;13224.206547607175;13266.66833329165;13410.396532155979;13703.177809331472;11819.822702659467;12289.385530723428;12473.501059957682;12740;12810.359482025862;3945.1517923646265;3953.078249152897;4003.899902502432;4024.416459613369;4050.736702114353;75747;76191.619041905;76307;76414.23585764127;76868.61565692247;10569.433052469396;10922.672319830417;11027.17296202788;11232.157588180919;11262.7184320391;20047.599048018958;20682.482937926674;20712.689309660367;21382.465438364165;21391.14435422597;8665.956670216734;9011.774705632411;9195.448273103635;9212.585433655502;9214.677486287948;4906.681065730788;4918.754062296871;4940.20956646942;4981.69886403304;4984.975075124601;3632.4369722693023;3739.6073412291316;3754.662080412776;3755.9812200938823;3756.286305601927;654.7282877605835;663.227340148731;663.2670898657011;663.8572706868047;666.2870728320651;620.92548894133;675.5642610516189;706.8232941764559;712.1189517131653;740.6037769793135;9391.585954601327;9403.200727938201;9582.952085239529;9641.758956026155;9734.561944712505;582.3652219081138;608.613530408194;633.9619622822645;712.8430557205597;719.9388052015637;4747.596454301423;4964.131277026506;4997.9750101249265;4999.225120106389;5188;105392.47303763585;107331;109532;110318.44840775745;110440.4477977605;57399.713001435564;91810.54094729484;91887.54056229809;93133.0686693138;93164;70140;84317.57841210754;85015;86007.56996215104;86533;9569.282303827102;9606.567704453177;9657.613695452103;9750.80498390014;9853.359531630422;50785.23822142597;51418.48581514286;51774.482255178475;52151;52524.474755251955;68121.65939170272;68778.65610672114;76783.61608191923;77480.61259693665;79125;12479.56321528742;12939.288339141438;13185;13339.799903001656;13557.796633050315;13541.796873046715;14994.850051499345;15276.465323713617;15358.923205383902;15504.844951550791;13718.588442346745;13728.65678358049;13793;14002.599740026324;14464.20446875432;12989.805152922903;13107.672308192372;13279.477894066571;13588.45646174142;13745.725085498434;13841.30793460343;13943.860561394256;14198.574042778733;14382.35279412408;14472.855271447572;11446.198766086627;11759.470823812779;12067.939660301643;12170.939145304217;12267.325297108744;11728.296302221894;11738.41307934617;11847.940760296144;11923;12193.756124877274 21:34:55 INFO - PROCESS | 17671 | __end_tp_report 21:34:55 INFO - PROCESS | 17671 | __start_cc_report 21:34:55 INFO - PROCESS | 17671 | _x_x_mozilla_cycle_collect,751 21:34:55 INFO - PROCESS | 17671 | __end_cc_report 21:34:55 INFO - PROCESS | 17671 | __startTimestamp1468470895864__endTimestamp 21:34:55 INFO - PROCESS | 17671 | 21:34:55 INFO - PROCESS | 17671 | ------- Summary: start ------- 21:34:55 INFO - PROCESS | 17671 | Number of tests: 6 21:34:55 INFO - PROCESS | 17671 | 21:34:55 INFO - PROCESS | 17671 | [#0] dojo.html Cycles:165 Average:5229.83 Median:5434.10 stddev:574.64 (10.6%) stddev-sans-first:549.13 21:34:55 INFO - PROCESS | 17671 | Values: 3000.1 3019.2 3040.7 3045.3 3050.0 5211.2 5244.7 5258.6 5304.3 5353.9 5216.1 5324.1 5329.3 5394.7 5416.3 4823.5 4877.0 4887.5 4894.5 4928.0 4976.9 4979.6 4988.4 4993.5 5013.2 4734.4 4761.5 4775.2 4907.7 4918.0 4821.9 4821.9 4825.9 4827.0 4827.7 4788.9 4805.2 4808.2 4810.9 4814.0 5169.5 5184.8 5228.3 5232.3 5255.1 5606.6 5627.1 5629.9 5684.4 5695.2 5661.9 5678.9 5699.4 5729.1 5731.8 5144.8 5213.4 5284.0 5293.9 5372.4 5781.2 5801.3 5802.2 5807.7 5812.0 5345.5 5584.6 5600.6 5602.6 5606.1 5530.1 5548.7 5555.0 5579.7 5652.0 5560.9 5568.4 5568.7 5581.6 5610.7 5491.7 5519.8 5565.7 5566.4 5586.9 4332.0 4336.9 4337.6 4375.9 4378.7 3863.9 3872.9 3881.0 3892.2 3910.7 5230.7 5247.7 5251.1 5390.1 5436.7 5550.3 5594.6 5602.8 5611.6 5657.3 5291.7 5306.9 5312.5 5313.3 5356.3 4781.3 4796.1 4801.4 4857.2 4858.9 5765.8 5769.4 5773.5 5776.0 5811.2 5535.2 5586.7 5591.3 5596.9 5609.2 5651.5 5708.4 5712.3 5746.9 5772.4 5494.8 5495.3 5499.6 5501.3 5502.1 5566.6 5605.6 5607.1 5615.9 5619.0 5246.6 5397.8 5419.9 5458.3 5483.3 5434.1 5438.7 5440.1 5441.2 5443.7 5213.1 5397.5 5400.8 5401.3 5455.6 5499.7 5547.9 5577.5 5584.6 5620.4 5495.5 5501.3 5501.9 5502.1 5502.2 21:34:55 INFO - PROCESS | 17671 | 21:34:55 INFO - PROCESS | 17671 | [#1] ext.html Cycles:180 Average:57846.59 Median:43250.39 stddev:113949.44 (263.5%) stddev-sans-first:114188.01 21:34:55 INFO - PROCESS | 17671 | Values: 590.4 614.9 637.7 645.3 653.3 36842.6 37488.4 37492.1 44323.0 45327.3 46341.1 46606.5 46642.1 46704.3 46760.0 8913.6 9087.6 9093.8 9094.4 9098.4 8917.7 9008.9 9027.3 9033.0 9038.7 9042.2 9084.8 9090.1 9090.2 9102.7 9009.5 9050.5 9054.1 9058.8 9059.6 8908.6 8976.5 8979.3 8981.1 8981.6 43998.1 44281.8 44306.0 44397.1 44469.3 3312.8 3346.3 3354.0 3635.2 3717.8 33546.3 33564.3 33899.2 34509.0 35534.0 4454.2 4469.6 4481.9 4498.6 4739.2 247601.0 248897.0 249851.0 249987.0 250204.0 61238.0 61238.7 61492.7 61496.4 61509.7 35568.0 36301.3 36587.0 37790.8 65107.0 17923.2 18033.6 18085.7 18110.6 18130.0 13587.5 13849.5 13850.7 13855.0 13856.9 20159.3 20346.8 20476.0 20507.7 20508.8 7436.8 7455.5 7524.2 7569.8 7781.5 933.6 978.6 1055.4 1078.4 1113.7 32641.8 32778.2 32848.2 32953.7 33097.7 1006.8 1034.3 1101.0 1113.4 1118.0 17210.4 17707.7 17754.3 17794.0 17806.4 570108.0 571390.0 572072.0 573594.0 573803.0 61866.4 62368.7 62756.7 62870.4 62895.4 1224.2 1341.8 1359.8 1372.0 1396.3 30157.8 34349.0 34521.1 34524.7 35090.6 51781.7 52608.5 52639.5 52658.7 52724.0 396292.0 402534.0 402536.0 402807.0 404267.0 25002.4 27758.9 27993.7 28099.0 28393.9 48335.8 48680.8 49223.8 49367.0 50091.7 42675.8 43222.0 43507.3 44532.6 44753.3 43167.4 43375.0 43515.6 43559.6 44181.0 41735.0 42798.4 43138.0 43278.8 43397.6 36138.3 38145.4 38601.6 39457.8 39585.0 28454.7 28468.9 28937.7 28939.4 28951.6 21:34:55 INFO - PROCESS | 17671 | 21:34:55 INFO - PROCESS | 17671 | [#2] jquery.html Cycles:180 Average:21852.99 Median:12604.10 stddev:46606.30 (369.8%) stddev-sans-first:46709.20 21:34:55 INFO - PROCESS | 17671 | Values: 396.2 399.7 400.9 401.9 418.6 14024.7 19332.2 19980.8 21011.6 21021.2 19146.0 19951.7 19996.6 20039.8 20341.1 5233.1 5320.6 5328.2 5340.6 5370.5 3884.9 5332.6 5352.5 5358.9 5359.2 5629.9 5886.9 5887.2 5887.6 5903.1 5684.1 5863.8 5891.5 5915.6 5946.0 5664.5 5697.7 5710.0 5735.9 5736.5 12973.9 14012.5 22913.8 23610.0 24036.3 2294.4 2332.3 2357.5 2390.7 2428.9 9760.5 9864.6 10032.7 10319.3 10604.8 1880.1 1968.7 1973.4 1977.8 2036.6 83661.6 90450.5 91261.1 91299.0 93857.0 11012.2 11127.8 11155.7 11392.3 11406.2 15206.0 15267.2 15294.8 15339.5 15345.6 8316.4 8571.1 8601.7 8632.5 8668.6 8337.4 8338.5 8369.7 8452.7 8533.0 4714.2 4734.0 4886.3 4923.3 4985.0 1803.3 1955.5 1976.8 1999.7 2076.5 927.8 942.9 1055.1 1057.7 1062.4 19841.4 20420.4 20688.3 20755.8 20795.5 968.6 990.3 1001.4 1018.5 1086.7 10800.7 11310.7 11364.9 11374.2 11388.9 154821.0 155261.2 157342.0 218169.0 485406.0 56831.4 57860.4 67070.3 85477.6 92595.5 1001.7 1011.9 1030.2 1045.3 1049.1 18570.7 18779.6 19113.9 19122.8 19140.2 45232.8 45976.3 46716.3 47402.3 47534.0 60715.1 66622.7 67286.7 68439.0 68467.0 7634.0 7774.6 7834.5 8137.2 8698.4 12348.2 12658.9 12707.2 12868.3 13005.9 10646.6 10958.1 11180.3 11296.2 11322.7 10912.3 10949.6 11199.9 11311.2 11585.3 10205.8 10451.1 10536.6 10747.6 11776.0 7681.8 7711.5 7720.0 7767.8 7880.6 10046.3 10984.5 11071.4 11159.8 11318.3 21:34:55 INFO - PROCESS | 17671 | 21:34:55 INFO - PROCESS | 17671 | [#3] mootools.html Cycles:180 Average:5940.88 Median:4726.60 stddev:3409.96 (72.1%) stddev-sans-first:3403.27 21:34:55 INFO - PROCESS | 17671 | Values: 1509.2 1535.9 1658.3 1784.1 1803.4 8600.3 9070.3 9089.6 9091.0 9095.9 7765.3 8013.2 8467.2 8732.2 8997.3 2332.6 2358.4 2359.1 2359.2 2365.4 2309.8 2341.3 2378.1 2395.6 2397.3 2016.0 2233.0 2327.4 2328.2 2346.0 2350.7 2366.3 2374.7 2387.9 2388.2 2291.4 2295.1 2298.1 2300.3 2304.1 9086.5 9097.6 9145.2 9157.6 9159.0 5145.8 5290.7 5304.3 5309.8 5309.8 3220.2 3262.9 3301.0 3307.3 3311.3 966.7 976.5 984.0 1001.3 1020.6 12660.9 12677.6 12680.4 12687.9 12697.1 4546.4 4642.4 4705.9 4710.3 4742.9 10706.1 10739.8 10748.8 10754.1 10759.1 5358.7 5369.9 5372.4 5374.2 5377.2 4698.0 4901.7 4934.5 4942.7 4948.2 3942.4 3969.1 4035.6 4086.6 4122.6 1139.7 1196.8 1227.0 1252.7 1274.8 866.7 1000.0 1021.3 1023.0 1043.9 6186.6 6290.1 6404.9 6501.7 6678.3 941.4 943.9 960.0 984.0 1006.2 4095.5 4217.6 4351.8 4371.5 4373.1 10936.4 11286.7 11359.1 11380.4 11392.1 9947.3 10668.3 11298.9 11306.2 11316.8 8163.3 8421.0 8503.2 8506.9 8512.2 6348.7 6398.5 6514.3 6573.5 6591.5 10268.4 10407.7 10587.2 10617.9 10631.3 10652.4 10662.5 10735.9 10819.6 10851.5 7446.5 7536.2 7592.3 7599.8 7600.7 8743.3 8928.0 8934.2 8945.8 8955.6 7595.5 7770.9 7836.1 7941.4 8207.1 7557.8 7608.0 7845.6 7880.4 8083.0 7203.7 7207.3 7255.7 7260.5 7260.8 4892.8 4940.7 5054.3 5070.5 5117.7 5449.0 5468.8 5484.1 5676.1 5727.3 21:34:55 INFO - PROCESS | 17671 | 21:34:55 INFO - PROCESS | 17671 | [#4] prototype.html Cycles:180 Average:4723.38 Median:5407.53 stddev:1380.42 (25.5%) stddev-sans-first:1344.26 21:34:55 INFO - PROCESS | 17671 | Values: 325.9 327.9 333.5 342.5 345.0 5379.2 5386.9 5388.4 5409.2 5438.0 5284.0 5298.4 5354.9 5375.8 5405.9 4007.8 4064.8 4164.0 4181.4 4199.4 4125.9 4153.6 4161.6 4179.1 4199.4 3986.9 4119.3 4133.9 4137.6 4142.8 4099.2 4165.7 4169.4 4189.2 4192.3 3640.7 3681.7 3688.7 3690.4 3705.1 5189.0 5204.2 5234.7 5252.5 5268.6 4590.5 4842.0 4862.2 4883.2 4894.4 5616.3 5633.8 5647.5 5647.7 5651.9 4140.5 4149.6 4154.5 4158.9 4162.5 5485.9 5743.7 5746.4 5748.3 5770.9 4028.4 4058.4 4063.3 4065.9 4072.6 4140.9 4165.1 4172.6 4174.5 4179.2 4667.4 4691.6 4695.6 4702.6 4716.7 5542.8 5562.6 5568.5 5575.6 5578.7 1441.2 1448.9 1455.9 1456.0 1457.4 964.4 975.4 994.2 999.3 999.4 5369.9 5376.5 5379.7 5389.2 5389.7 5675.0 5685.9 5698.5 5734.1 5737.6 5202.1 5363.0 5463.3 5464.5 5485.7 3037.2 3040.9 3046.4 3052.8 3058.2 5684.9 5892.7 5900.9 5941.8 5950.8 5809.4 5812.6 5818.2 5818.4 5841.1 5869.0 5926.4 5928.9 5952.0 5953.7 5439.3 5711.6 5714.5 5745.1 5790.1 5618.8 5666.2 5698.4 5699.9 5711.2 5747.8 5951.8 5952.9 5966.8 5976.4 4125.4 4140.1 4140.3 4142.0 4164.0 5525.3 5661.3 5784.1 5790.7 5807.9 5599.7 5618.6 5625.4 5632.1 5635.5 5577.7 5579.6 5585.3 5592.3 5592.8 5322.9 5581.0 5584.7 5596.4 5605.9 5606.6 5668.6 5693.7 5709.8 5720.7 5454.5 5530.8 5592.7 5595.7 5611.3 21:34:55 INFO - PROCESS | 17671 | 21:34:55 INFO - PROCESS | 17671 | [#5] yui.html Cycles:180 Average:20305.34 Median:4983.34 stddev:28256.63 (567.0%) stddev-sans-first:28297.82 21:34:55 INFO - PROCESS | 17671 | Values: 767.7 782.7 805.9 815.6 835.0 15003.8 16411.4 17200.5 17234.7 18025.0 16627.7 16674.5 16759.4 16802.4 16810.3 668.8 788.9 810.6 813.8 813.8 782.6 821.5 821.5 825.7 826.1 856.7 860.6 860.9 861.0 861.8 697.1 716.0 855.5 855.7 855.8 601.4 615.7 616.0 619.2 619.3 15329.6 15382.9 15404.5 15410.5 15446.2 12900.9 13224.2 13266.7 13410.4 13703.2 11819.8 12289.4 12473.5 12740.0 12810.4 3945.2 3953.1 4003.9 4024.4 4050.7 75747.0 76191.6 76307.0 76414.2 76868.6 10569.4 10922.7 11027.2 11232.2 11262.7 20047.6 20682.5 20712.7 21382.5 21391.1 8666.0 9011.8 9195.4 9212.6 9214.7 4906.7 4918.8 4940.2 4981.7 4985.0 3632.4 3739.6 3754.7 3756.0 3756.3 654.7 663.2 663.3 663.9 666.3 620.9 675.6 706.8 712.1 740.6 9391.6 9403.2 9583.0 9641.8 9734.6 582.4 608.6 634.0 712.8 719.9 4747.6 4964.1 4998.0 4999.2 5188.0 105392.5 107331.0 109532.0 110318.4 110440.4 57399.7 91810.5 91887.5 93133.1 93164.0 70140.0 84317.6 85015.0 86007.6 86533.0 9569.3 9606.6 9657.6 9750.8 9853.4 50785.2 51418.5 51774.5 52151.0 52524.5 68121.7 68778.7 76783.6 77480.6 79125.0 12479.6 12939.3 13185.0 13339.8 13557.8 13541.8 14994.9 15276.5 15358.9 15504.8 13718.6 13728.7 13793.0 14002.6 14464.2 12989.8 13107.7 13279.5 13588.5 13745.7 13841.3 13943.9 14198.6 14382.4 14472.9 11446.2 11759.5 12067.9 12170.9 12267.3 11728.3 11738.4 11847.9 11923.0 12193.8 21:34:55 INFO - PROCESS | 17671 | -------- Summary: end -------- 21:34:55 INFO - PROCESS | 17671 | 21:34:56 INFO - TEST-INFO | 17671: exit 0 21:34:56 INFO - TEST-OK | dromaeo_css | took 1114654ms 21:34:56 INFO - TEST-START | kraken 21:34:56 INFO - operating with platform_type : linux_ 21:34:56 INFO - Initialising browser for kraken test... 21:34:56 INFO - TEST-INFO | started process 17868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRlnYXb/profile http://localhost:42533/getInfo.html) 21:35:01 INFO - PROCESS | 17868 | __metrics Screen width/height:1600/1200 21:35:01 INFO - PROCESS | 17868 | colorDepth:24 21:35:01 INFO - PROCESS | 17868 | Browser inner width/height: 1024/697 21:35:01 INFO - PROCESS | 17868 | __metrics 21:35:02 INFO - PROCESS | 17868 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:35:02 INFO - PROCESS | 17868 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:35:03 INFO - TEST-INFO | 17868: exit 0 21:35:03 INFO - Browser initialized. 21:35:03 INFO - Running cycle 1/1 for kraken test... 21:35:03 INFO - TEST-INFO | started process 17955 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRlnYXb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:35:14 INFO - PROCESS | 17955 | RSS: Main: 157945856 21:35:14 INFO - PROCESS | 17955 | 21:35:17 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42533/tests/kraken/driver.html?testName=audio-beat-detection) 21:35:18 INFO - PROCESS | 17955 | RSS: Main: 216248320 21:35:18 INFO - PROCESS | 17955 | 21:35:20 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42533/tests/kraken/driver.html?testName=audio-dft) 21:35:21 INFO - PROCESS | 17955 | RSS: Main: 203485184 21:35:21 INFO - PROCESS | 17955 | 21:35:24 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42533/tests/kraken/driver.html?testName=audio-fft) 21:35:25 INFO - PROCESS | 17955 | RSS: Main: 269938688 21:35:25 INFO - PROCESS | 17955 | 21:35:27 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42533/tests/kraken/driver.html?testName=audio-oscillator) 21:35:27 INFO - PROCESS | 17955 | RSS: Main: 180961280 21:35:27 INFO - PROCESS | 17955 | 21:35:29 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42533/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:35:30 INFO - PROCESS | 17955 | RSS: Main: 184774656 21:35:30 INFO - PROCESS | 17955 | 21:35:33 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42533/tests/kraken/driver.html?testName=imaging-darkroom) 21:35:34 INFO - PROCESS | 17955 | RSS: Main: 218750976 21:35:34 INFO - PROCESS | 17955 | 21:35:37 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42533/tests/kraken/driver.html?testName=imaging-desaturate) 21:35:38 INFO - PROCESS | 17955 | RSS: Main: 221741056 21:35:38 INFO - PROCESS | 17955 | 21:35:41 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42533/tests/kraken/driver.html?testName=json-parse-financial) 21:35:41 INFO - PROCESS | 17955 | RSS: Main: 221466624 21:35:41 INFO - PROCESS | 17955 | 21:35:43 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42533/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:35:43 INFO - PROCESS | 17955 | RSS: Main: 209510400 21:35:43 INFO - PROCESS | 17955 | 21:35:45 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42533/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:35:46 INFO - PROCESS | 17955 | RSS: Main: 212672512 21:35:46 INFO - PROCESS | 17955 | 21:35:47 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42533/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:35:48 INFO - PROCESS | 17955 | RSS: Main: 210546688 21:35:48 INFO - PROCESS | 17955 | 21:35:51 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:35:51 INFO - PROCESS | 17955 | RSS: Main: 224354304 21:35:51 INFO - PROCESS | 17955 | 21:35:54 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:35:55 INFO - PROCESS | 17955 | RSS: Main: 224280576 21:35:55 INFO - PROCESS | 17955 | 21:35:56 INFO - PROCESS | 17955 | Cycle 1(1): loaded http://localhost:42533/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42533/tests/kraken/driver.html?testName=ai-astar) 21:35:57 INFO - PROCESS | 17955 | RSS: Main: 267272192 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | __start_tp_report 21:35:57 INFO - PROCESS | 17955 | _x_x_mozilla_page_load 21:35:57 INFO - PROCESS | 17955 | _x_x_mozilla_page_load_details 21:35:57 INFO - PROCESS | 17955 | |i|pagename|runs| 21:35:57 INFO - PROCESS | 17955 | |0;ai-astar;103;110;110;109;112;111;110;110;111;111 21:35:57 INFO - PROCESS | 17955 | |1;audio-beat-detection;147;118;120;167;119;119;144;117;148;117 21:35:57 INFO - PROCESS | 17955 | |2;audio-dft;161;161;160;161;160;161;161;160;161;160 21:35:57 INFO - PROCESS | 17955 | |3;audio-fft;75;75;75;115;74;75;75;74;100;76 21:35:57 INFO - PROCESS | 17955 | |4;audio-oscillator;84;84;111;84;84;83;120;85;84;134 21:35:57 INFO - PROCESS | 17955 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;117;116 21:35:57 INFO - PROCESS | 17955 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;145 21:35:57 INFO - PROCESS | 17955 | |7;imaging-desaturate;94;98;95;94;95;94;95;95;94;95 21:35:57 INFO - PROCESS | 17955 | |8;json-parse-financial;52;52;51;52;52;52;53;52;51;51 21:35:57 INFO - PROCESS | 17955 | |9;json-stringify-tinderbox;61;61;62;61;62;62;62;62;61;62 21:35:57 INFO - PROCESS | 17955 | |10;stanford-crypto-aes;76;76;75;75;75;74;80;78;74;76 21:35:57 INFO - PROCESS | 17955 | |11;stanford-crypto-ccm;130;117;130;131;126;118;118;118;166;129 21:35:57 INFO - PROCESS | 17955 | |12;stanford-crypto-pbkdf2;157;160;158;161;156;166;163;159;156;157 21:35:57 INFO - PROCESS | 17955 | |13;stanford-crypto-sha256-iterative;63;68;62;62;62;63;63;66;61;61 21:35:57 INFO - PROCESS | 17955 | __end_tp_report 21:35:57 INFO - PROCESS | 17955 | __start_cc_report 21:35:57 INFO - PROCESS | 17955 | _x_x_mozilla_cycle_collect,1640 21:35:57 INFO - PROCESS | 17955 | __end_cc_report 21:35:57 INFO - PROCESS | 17955 | __startTimestamp1468470957000__endTimestamp 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | ------- Summary: start ------- 21:35:57 INFO - PROCESS | 17955 | Number of tests: 14 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#0] ai-astar Cycles:10 Average:109.70 Median:110.50 stddev:2.50 (2.3%) stddev-sans-first:0.88 21:35:57 INFO - PROCESS | 17955 | Values: 103.0 110.0 110.0 109.0 112.0 111.0 110.0 110.0 111.0 111.0 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:132.00 stddev:18.19 (13.8%) stddev-sans-first:18.41 21:35:57 INFO - PROCESS | 17955 | Values: 147.0 118.0 120.0 167.0 119.0 119.0 144.0 117.0 148.0 117.0 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#2] audio-dft Cycles:10 Average:160.60 Median:161.00 stddev:0.52 (0.3%) stddev-sans-first:0.53 21:35:57 INFO - PROCESS | 17955 | Values: 161.0 161.0 160.0 161.0 160.0 161.0 161.0 160.0 161.0 160.0 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:14.21 (19.0%) stddev-sans-first:14.89 21:35:57 INFO - PROCESS | 17955 | Values: 75.0 75.0 75.0 115.0 74.0 75.0 75.0 74.0 100.0 76.0 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:84.00 stddev:19.00 (22.6%) stddev-sans-first:19.71 21:35:57 INFO - PROCESS | 17955 | Values: 84.0 84.0 111.0 84.0 84.0 83.0 120.0 85.0 84.0 134.0 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 21:35:57 INFO - PROCESS | 17955 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 116.0 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 21:35:57 INFO - PROCESS | 17955 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:1.20 (1.3%) stddev-sans-first:1.22 21:35:57 INFO - PROCESS | 17955 | Values: 94.0 98.0 95.0 94.0 95.0 94.0 95.0 95.0 94.0 95.0 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#8] json-parse-financial Cycles:10 Average:51.80 Median:52.00 stddev:0.63 (1.2%) stddev-sans-first:0.67 21:35:57 INFO - PROCESS | 17955 | Values: 52.0 52.0 51.0 52.0 52.0 52.0 53.0 52.0 51.0 51.0 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 21:35:57 INFO - PROCESS | 17955 | Values: 61.0 61.0 62.0 61.0 62.0 62.0 62.0 62.0 61.0 62.0 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:76.00 stddev:1.85 (2.4%) stddev-sans-first:1.96 21:35:57 INFO - PROCESS | 17955 | Values: 76.0 76.0 75.0 75.0 75.0 74.0 80.0 78.0 74.0 76.0 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:129.50 stddev:14.48 (11.2%) stddev-sans-first:15.34 21:35:57 INFO - PROCESS | 17955 | Values: 130.0 117.0 130.0 131.0 126.0 118.0 118.0 118.0 166.0 129.0 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:159.50 stddev:3.27 (2.0%) stddev-sans-first:3.36 21:35:57 INFO - PROCESS | 17955 | Values: 157.0 160.0 158.0 161.0 156.0 166.0 163.0 159.0 156.0 157.0 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - PROCESS | 17955 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:2.23 (3.5%) stddev-sans-first:2.37 21:35:57 INFO - PROCESS | 17955 | Values: 63.0 68.0 62.0 62.0 62.0 63.0 63.0 66.0 61.0 61.0 21:35:57 INFO - PROCESS | 17955 | -------- Summary: end -------- 21:35:57 INFO - PROCESS | 17955 | 21:35:57 INFO - TEST-INFO | 17955: exit 0 21:35:58 INFO - TEST-OK | kraken | took 61411ms 21:35:58 INFO - SUITE-END | took 1176s 21:35:58 INFO - Completed test suite (00:19:36) 21:35:58 INFO - javascript benchmark 21:35:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3000.0999700089974, 3019.1697283247117, 3040.680728523505, 3045.330027393974, 3049.9542506862385, 5211.192265198891, 5244.68531888087, 5258.6318957672975, 5304.257403963444, 5353.922789539228, 5216.139337009398, 5324.094903866342, 5329.280547126137, 5394.703291318976, 5416.295881535405, 4823.517648235174, 4876.97561512192, 4887.535684110004, 4894.53501917319, 4927.975360123212, 4976.875578110558, 4979.60163186946, 4988.376452943382, 4993.450720420751, 5013.222950442687, 4734.384530011093, 4761.452432970218, 4775.188218002948, 4907.730074845882, 4918.04098200851, 4821.855344339676, 4821.927671084936, 4825.879353016167, 4827.0, 4827.734474603895, 4788.928166077511, 4805.183118869801, 4808.206645903421, 4810.855674329776, 4813.964997525513, 5169.53474187325, 5184.844454666366, 5228.346456692913, 5232.2674825524455, 5255.054090263751, 5606.55147588192, 5627.071533197018, 5629.915551266734, 5684.403137670526, 5695.231143795618, 5661.943380566183, 5678.9432105678825, 5699.401562835884, 5729.140628905656, 5731.799387021434, 5144.794208231704, 5213.4004589472315, 5284.0, 5293.920591191135, 5372.382176049726, 5781.161731548902, 5801.3328467225965, 5802.245708057925, 5807.680577568274, 5812.0119579671555, 5345.518903298722, 5584.6090773646265, 5600.60795744294, 5602.635828671123, 5606.103023516218, 5530.142827861688, 5548.722563871871, 5555.027870122713, 5579.721013949367, 5651.971740141355, 5560.944390556043, 5568.359638641527, 5568.721563921868, 5581.6371935824045, 5610.747516361774, 5491.7254137292975, 5519.751611177427, 5565.666060036411, 5566.443355664401, 5586.888262234733, 4331.978340108342, 4336.869893903188, 4337.609615134653, 4375.890602734893, 4378.671599630041, 3863.8840834775, 3872.8644497442456, 3881.029742564359, 3892.21854469193, 3910.7262491625884, 5230.686158830483, 5247.737613119329, 5251.133562962144, 5390.110631745718, 5436.728163591804, 5550.306211723535, 5594.552435805207, 5602.803901863415, 5611.551075913917, 5657.2928383952, 5291.735413229323, 5306.893862122736, 5312.495312945264, 5313.256144139824, 5356.276902618175, 4781.330613714083, 4796.136695394793, 4801.375821143229, 4857.247126695368, 4858.878528036827, 5765.798197063083, 5769.365369809401, 5773.509251713567, 5776.046952252831, 5811.186433899257, 5535.225068490334, 5586.692731899784, 5591.30108736408, 5596.888062238814, 5609.186667933045, 5651.547876169814, 5708.400617935223, 5712.285964254468, 5746.908087463368, 5772.393898640582, 5494.835154945358, 5495.2856128703015, 5499.560035197254, 5501.312335958005, 5502.0921547945745, 5566.554675626021, 5605.5795815313195, 5607.102863541813, 5615.8876822464135, 5619.0, 5246.580273578028, 5397.757100930546, 5419.891602167856, 5458.263134476795, 5483.259759932358, 5434.10337294342, 5438.700871452108, 5440.075187218262, 5441.211024401518, 5443.673379597237, 5213.139831927841, 5397.514223719884, 5400.783968641211, 5401.3248343957, 5455.618106732491, 5499.697516636624, 5547.861303467284, 5577.525910297508, 5584.553235741212, 5620.437956204347, 5495.477929596682, 5501.339839219319, 5501.862453438696, 5502.0921547944145, 5502.2296878436255], "value": 5191.802999565399, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [590.4390828712721, 614.8708771158057, 637.7480895046459, 645.3320812958588, 653.2716021635878, 36842.63157368425, 37488.43767343492, 37492.06269843255, 44323.0, 45327.32009019867, 46341.07317853649, 46606.53393466073, 46642.067158656806, 46704.299435508496, 46760.0, 8913.598888050054, 9087.636494540244, 9093.818123637524, 9094.363394562382, 9098.363114581949, 8917.73246802597, 9008.909910900873, 9027.277817774595, 9033.0, 9038.683646072388, 9042.186203241707, 9084.818303633923, 9090.13643703847, 9090.2273306769, 9102.681406150787, 9009.504477253748, 9050.502222377767, 9054.094590540959, 9058.818823623524, 9059.637614495412, 8908.643654253821, 8976.506292153928, 8979.281657467387, 8981.101889811032, 8981.550922453916, 43998.12003759939, 44281.77859110716, 44306.0, 44397.11205775899, 44469.332960005624, 3312.817795021273, 3346.297277571713, 3353.9832300838584, 3635.2366003139373, 3717.832697528591, 33546.3290734184, 33564.328713425595, 33899.15252118692, 34509.0, 35534.0, 4454.242778727624, 4469.620082293009, 4481.865544033684, 4498.595126438636, 4739.194336962724, 247601.0, 248897.0, 249851.0, 249987.0, 250204.0, 61238.0, 61238.69380653068, 61492.69253653793, 61496.38503614906, 61509.69245153835, 35568.0, 36301.273974520365, 36587.0, 37790.811045944596, 65107.0, 17923.1934562945, 18033.639327213383, 18085.7287140693, 18110.63778724418, 18130.0, 13587.456501740018, 13849.51526696581, 13850.722985540435, 13855.0, 13856.93071534636, 20159.294424695065, 20346.796532034787, 20476.0, 20507.69238461424, 20508.794912050987, 7436.847288670265, 7455.478116531899, 7524.247575242542, 7569.772906812695, 7781.494202876908, 933.5752232734089, 978.6476868327396, 1055.4300677634146, 1078.3691540448926, 1113.716002419378, 32641.836790816367, 32778.18054548655, 32848.17879552983, 32953.693241473346, 33097.66902330994, 1006.8137394582026, 1034.3018462537757, 1100.9944950275196, 1113.3987646670707, 1117.9944100279447, 17210.39763608268, 17707.73438398425, 17754.289828406978, 17794.0, 17806.433569227564, 570108.0, 571390.0, 572072.0, 573594.0, 573803.0, 61866.38133618606, 62368.68815655893, 62756.686216569535, 62870.37129628737, 62895.37104628895, 1224.2226186371718, 1341.805438211454, 1359.7688392973218, 1372.0464277327362, 1396.3367400484892, 30157.849210753804, 34349.0, 34521.136971575914, 34524.65475345315, 35090.649093508735, 51781.7410912943, 52608.47391526036, 52639.473605263454, 52658.736706316224, 52724.0, 396292.0, 402534.0, 402536.0, 402807.0, 404267.0, 25002.37494062663, 27758.861205693844, 27993.720062799926, 28099.0, 28393.858030709715, 48335.758321208166, 48680.756596216794, 49223.753881231794, 49367.0, 50091.74954125352, 42675.7866210667, 43222.0, 43507.347389789815, 44532.55467445284, 44753.328700070175, 43167.35248971205, 43375.0, 43515.56484435115, 43559.56440435682, 44181.0, 41735.0, 42798.35802463028, 43138.0, 43278.78360608303, 43397.56602433935, 36138.27723445569, 38145.42781858219, 38601.6139838598, 39457.80271098741, 39585.0, 28454.71953762127, 28468.85765571159, 28937.7106228935, 28939.41124191304, 28951.565726514542], "value": 20275.16595637289, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.2174704957707, 399.67626222759566, 400.94587230723846, 401.8794361691492, 418.57305548340696, 14024.71950560988, 19332.22671093156, 19980.800191998074, 21011.57976840464, 21021.159153633856, 19146.0, 19951.700724489143, 19996.600067998632, 20039.799602003975, 20341.084651190697, 5233.136532472137, 5320.6275560710765, 5328.20076988451, 5340.62615616907, 5370.5435038021815, 3884.941725874114, 5332.57339412848, 5352.5182733553975, 5358.91961620576, 5359.196120581924, 5629.915551266734, 5886.911696324537, 5887.205227294325, 5887.61730487517, 5903.144044113601, 5684.118961560965, 5863.79476718315, 5891.469767720904, 5915.645061296336, 5946.048632218867, 5664.490195882349, 5697.658140511582, 5710.0, 5735.913961290584, 5736.541076713853, 12973.870261297456, 14012.509562165274, 22913.770862291498, 23610.0, 24036.27891163268, 2294.4378627236433, 2332.3236261484317, 2357.5167090746354, 2390.725066617344, 2428.878556072207, 9760.4631745254, 9864.605415783431, 10032.749181270527, 10319.277650564463, 10604.840927386096, 1880.1445342369188, 1968.7440632717799, 1973.4474347182668, 1977.831884289837, 2036.5519585691125, 83661.58169209176, 90450.54774726085, 91261.08738912593, 91299.0, 93857.0, 11012.229143959847, 11127.833082503768, 11155.72110697239, 11392.316461012366, 11406.201565890475, 15206.011609245365, 15267.236638168048, 15294.847051529565, 15339.463118790789, 15345.616359590877, 8316.37627177964, 8571.142885711379, 8601.698940537051, 8632.482051076955, 8668.566571671392, 8337.416380853281, 8338.458000229966, 8369.748907532783, 8452.661893524313, 8532.97604287477, 4714.151452738472, 4734.0, 4886.267059941038, 4923.261510773413, 4984.975075124601, 1803.2967142814314, 1955.511122219445, 1976.7726711428081, 1999.7400337955974, 2076.480879780055, 927.8329900617819, 942.8585712143233, 1055.1242468750918, 1057.7461409261875, 1062.3785085724783, 19841.404757857286, 20420.38738837837, 20688.275910343065, 20755.792442075384, 20795.480112997295, 968.5738275158908, 990.2573070197352, 1001.399160503692, 1018.5314755212685, 1086.706589220906, 10800.729981750519, 11310.717232069099, 11364.94317528407, 11374.20380573352, 11388.886111138783, 154821.0, 155261.2236938808, 157342.0, 218169.0, 485406.0, 56831.43168568344, 57860.4213957855, 67070.3292967064, 85477.57261213654, 92595.53702231446, 1001.7245257554231, 1011.8633984412157, 1030.2324768047852, 1045.257866914484, 1049.1187402581868, 18570.721439178153, 18779.624407512045, 19113.90443047776, 19122.808771912103, 19140.234390624777, 45232.77383613061, 45976.31035534536, 46716.299255510516, 47402.288965664855, 47534.0, 60715.05352152096, 66622.66688666526, 67286.66356668381, 68439.0, 68467.0, 7634.0, 7774.611269436618, 7834.529928204326, 8137.186281371815, 8698.391112622308, 12348.179147359027, 12658.936705316415, 12707.174033687781, 12868.292243926673, 13005.869941300465, 10646.627368042391, 10958.12335013213, 11180.273282236629, 11296.152788541056, 11322.660320190407, 10912.290701104403, 10949.616763413242, 11199.944000279946, 11311.208215425171, 11585.304881707125, 10205.84691229647, 10451.059404653313, 10536.631217907643, 10747.570097196025, 11776.0, 7681.807954801175, 7711.460197786101, 7719.961400193188, 7767.766966990999, 7880.566568838769, 10046.346987445793, 10984.505697243483, 11071.391073491035, 11159.832602511131, 11318.26431281964], "value": 8988.82612374775, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1509.1548732709684, 1535.8617724404805, 1658.3200887636065, 1784.072282413146, 1803.3958623861015, 8600.268977136942, 9070.319726020542, 9089.59096840642, 9091.0, 9095.909040909597, 7765.262300081497, 8013.198680131998, 8467.153284671529, 8732.170443807843, 8997.280217582595, 2332.6384410416413, 2358.41039740065, 2359.138914296278, 2359.209664762298, 2365.3731761083327, 2309.7574754650773, 2341.309313752439, 2378.0725517048363, 2395.580773364663, 2397.25685037638, 2016.0423798695576, 2232.966505502419, 2327.406511339606, 2328.2316835444262, 2345.9648105278434, 2350.670906073151, 2366.3492539551676, 2374.6912901322717, 2387.892544835478, 2388.1999530157245, 2291.4042348989215, 2295.070496448941, 2298.10373954158, 2300.344401845466, 2304.0898844956314, 9086.50024248666, 9097.63609455621, 9145.176934075898, 9157.633694652273, 9158.95420522893, 5145.794168233266, 5290.735463226823, 5304.283921670563, 5309.761060752276, 5309.787608495694, 3220.1949512621845, 3262.934741305184, 3301.042697617688, 3307.2889328794186, 3311.2549676322874, 966.7152503048874, 976.5361453309621, 983.9852402213972, 1001.2540657210425, 1020.6478764826123, 12660.873391266061, 12677.619671409873, 12680.365981700877, 12687.873121268762, 12697.111202215941, 4546.431696037996, 4642.396488456547, 4705.85882423521, 4710.26990816424, 4742.928856067162, 10706.089982351432, 10739.83890241647, 10748.838767418494, 10754.139668826632, 10759.08547773448, 5358.732063396815, 5369.946300537023, 5372.409035006146, 5374.220737993047, 5377.247185394048, 4697.976510117427, 4901.681390709592, 4934.5312195341385, 4942.678725882806, 4948.183549714328, 3942.3692209246956, 3969.0672691917375, 4035.5964403559997, 4086.6117718816663, 4122.649574786117, 1139.6524060161564, 1196.7965445874222, 1226.9754604907853, 1252.6868282929267, 1274.796032634774, 866.696656170348, 1000.049952545085, 1021.3463383434607, 1022.956584284041, 1043.8778313313219, 6186.628802271878, 6290.087937249074, 6404.871902562016, 6501.707423165969, 6678.298778628174, 941.4351389166445, 943.8631398447187, 960.0, 983.955721992512, 1006.1849901579598, 4095.508538975342, 4217.641500472433, 4351.825926962886, 4371.540988196257, 4373.103513779667, 10936.398498082683, 11286.717832054264, 11359.148063895076, 11380.374079425712, 11392.145589080686, 9947.253955953187, 10668.253222274521, 11298.887011129947, 11306.208565400342, 11316.773664526663, 8163.346932245406, 8421.031581368099, 8503.23470887623, 8506.872396914052, 8512.191341822518, 6348.746050158126, 6398.4561312287115, 6514.250861151028, 6573.506986976092, 6591.538592298493, 10268.435236062089, 10407.739806504898, 10587.20595955322, 10617.89382106169, 10631.308964917256, 10652.414117223627, 10662.46687665598, 10735.94632026835, 10819.621313253998, 10851.511681974172, 7446.478746487694, 7536.208698086622, 7592.278733520307, 7599.772006839804, 7600.695972161052, 8743.256823169848, 8928.0, 8934.195922367018, 8945.821083578423, 8955.641774329215, 7595.506292090997, 7770.92229077702, 7836.138024817379, 7941.444098913021, 8207.056188538156, 7557.811054723676, 7608.0, 7845.646945887334, 7880.408969327438, 8083.03003639567, 7203.675834587351, 7207.315305046012, 7255.673494692857, 7260.4554658399775, 7260.782176534713, 4892.828750993698, 4940.728259945738, 5054.29239906406, 5070.4929507049, 5117.74411279442, 5448.972755136199, 5468.835934921959, 5484.095124304445, 5676.148577713376, 5727.31272247333], "value": 4719.696249173882, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [325.8843110695703, 327.92129888826673, 333.49975037443835, 342.5153407927782, 345.03218472185523, 5379.220013098104, 5386.899109347358, 5388.43421440749, 5409.188621706746, 5437.972810135944, 5284.0, 5298.417174110845, 5354.866128346794, 5375.81184658537, 5405.864853378667, 4007.83968641254, 4064.7967601619803, 4163.97918010411, 4181.351890456984, 4199.391088292211, 4125.855595054174, 4153.587780154747, 4161.563035881234, 4179.143275628504, 4199.370094485821, 3986.900327491807, 4119.299719047769, 4133.937990930139, 4137.586241375869, 4142.813573389205, 4099.233017713047, 4165.666986564301, 4169.437125987984, 4189.162167566499, 4192.287311157111, 3640.6541378568995, 3681.7054635629083, 3688.704903607705, 3690.372636651749, 3705.1478160023344, 5188.974055129738, 5204.219367094928, 5234.738263086869, 5252.474752524755, 5268.578513718893, 4590.517995610447, 4842.02215637384, 4862.222044472867, 4883.169861123618, 4894.41267047953, 5616.297962754656, 5633.80281690143, 5647.548196144298, 5647.717614119278, 5651.9152212716845, 4140.523839758436, 4149.605787450218, 4154.5222299435645, 4158.9376159357635, 4162.4796900387455, 5485.917711234335, 5743.650242193081, 5746.425357464262, 5748.281464816898, 5770.855728606818, 4028.4158796974275, 4058.431819545266, 4063.309237429644, 4065.918681626351, 4072.6334629883454, 4140.875773726793, 4165.062860856283, 4172.645325147336, 4174.519930208005, 4179.226843034048, 4667.416572928384, 4691.601213896789, 4695.5539223773685, 4702.6473014524045, 4716.716996980193, 5542.8337149885565, 5562.554995600342, 5568.49883510486, 5575.637583557056, 5578.721063946787, 1441.1857300625113, 1448.855404230646, 1455.9053661511969, 1455.995363199389, 1457.4024649893704, 964.3924327673661, 975.4439969217619, 994.1947022911465, 999.3054826895383, 999.3803841618243, 5369.865753356197, 5376.462353764592, 5379.704116273564, 5389.218563308376, 5389.730513474311, 5675.0, 5685.943140568541, 5698.515626171739, 5734.132933533233, 5737.598368114275, 5202.1272341956865, 5363.0, 5463.262459567987, 5464.508194262536, 5485.698286594195, 3037.2255074955747, 3040.9391812164076, 3046.3602643444683, 3052.832094234838, 3058.189579761365, 5684.914726279109, 5892.705364731746, 5900.940990590039, 5941.821745347646, 5950.821475355746, 5809.390014048464, 5812.622179558315, 5818.2436283282905, 5818.359980402152, 5841.130838131757, 5868.970655146697, 5926.436988486087, 5928.916963179123, 5951.970240148771, 5953.7023148843255, 5439.265699130567, 5711.572581652864, 5714.514266287246, 5745.1382292656435, 5790.10253410722, 5618.775248989995, 5666.15007748841, 5698.373178950395, 5699.8860022800145, 5711.228984087095, 5747.827565173052, 5951.791687290924, 5952.8809423812145, 5966.76132954677, 5976.372480889618, 4125.401816736617, 4140.109876376593, 4140.302475984832, 4141.958580414157, 4163.97918010408, 5525.336959564878, 5661.2923384576925, 5784.132380142844, 5790.681512516852, 5807.94192058074, 5599.748011339581, 5618.578606604603, 5625.437456254342, 5632.14139334027, 5635.492805647511, 5577.721113944368, 5579.60942734021, 5585.301837270341, 5592.273004509388, 5592.832215033555, 5322.920156197582, 5580.972095139498, 5584.748686309044, 5596.4123767003875, 5605.915911261416, 5606.551475882001, 5668.631538949955, 5693.658380497183, 5709.800156994485, 5720.6853623049465, 5454.481824226692, 5530.783227689902, 5592.664440133442, 5595.692236926845, 5611.3266408031295], "value": 4285.492271488113, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [767.7159451003126, 782.6517199846071, 805.8750893611491, 815.5595978171788, 835.0438747633963, 15003.849961500382, 16411.425600103983, 17200.48398548044, 17234.741478877826, 18025.0, 16627.66744665106, 16674.49976500704, 16759.413420530283, 16802.411915582958, 16810.32758689651, 668.7659319238277, 788.9329407000397, 810.5622963599649, 813.8046868751487, 813.8209593889335, 782.6047845837873, 821.5276216175693, 821.5481485183155, 825.7110011495988, 826.1078035721437, 856.7344123321759, 860.6428332242112, 860.9009963854143, 860.9741707748747, 861.7845538615346, 697.0972590495321, 716.0333549707905, 855.4610595324937, 855.683397143058, 855.8288342331558, 601.3925934805834, 615.6552330694825, 616.005151680038, 619.1764952613014, 619.2599843187348, 15329.616759580987, 15382.923085384613, 15404.46084387041, 15410.460633877872, 15446.150461724601, 12900.870991290061, 13224.206547607175, 13266.66833329165, 13410.396532155979, 13703.177809331472, 11819.822702659467, 12289.385530723428, 12473.501059957682, 12740.0, 12810.359482025862, 3945.1517923646265, 3953.078249152897, 4003.899902502432, 4024.416459613369, 4050.736702114353, 75747.0, 76191.619041905, 76307.0, 76414.23585764127, 76868.61565692247, 10569.433052469396, 10922.672319830417, 11027.17296202788, 11232.157588180919, 11262.7184320391, 20047.599048018958, 20682.482937926674, 20712.689309660367, 21382.465438364165, 21391.14435422597, 8665.956670216734, 9011.774705632411, 9195.448273103635, 9212.585433655502, 9214.677486287948, 4906.681065730788, 4918.754062296871, 4940.20956646942, 4981.69886403304, 4984.975075124601, 3632.4369722693023, 3739.6073412291316, 3754.662080412776, 3755.9812200938823, 3756.286305601927, 654.7282877605835, 663.227340148731, 663.2670898657011, 663.8572706868047, 666.2870728320651, 620.92548894133, 675.5642610516189, 706.8232941764559, 712.1189517131653, 740.6037769793135, 9391.585954601327, 9403.200727938201, 9582.952085239529, 9641.758956026155, 9734.561944712505, 582.3652219081138, 608.613530408194, 633.9619622822645, 712.8430557205597, 719.9388052015637, 4747.596454301423, 4964.131277026506, 4997.9750101249265, 4999.225120106389, 5188.0, 105392.47303763585, 107331.0, 109532.0, 110318.44840775745, 110440.4477977605, 57399.713001435564, 91810.54094729484, 91887.54056229809, 93133.0686693138, 93164.0, 70140.0, 84317.57841210754, 85015.0, 86007.56996215104, 86533.0, 9569.282303827102, 9606.567704453177, 9657.613695452103, 9750.80498390014, 9853.359531630422, 50785.23822142597, 51418.48581514286, 51774.482255178475, 52151.0, 52524.474755251955, 68121.65939170272, 68778.65610672114, 76783.61608191923, 77480.61259693665, 79125.0, 12479.56321528742, 12939.288339141438, 13185.0, 13339.799903001656, 13557.796633050315, 13541.796873046715, 14994.850051499345, 15276.465323713617, 15358.923205383902, 15504.844951550791, 13718.588442346745, 13728.65678358049, 13793.0, 14002.599740026324, 14464.20446875432, 12989.805152922903, 13107.672308192372, 13279.477894066571, 13588.45646174142, 13745.725085498434, 13841.30793460343, 13943.860561394256, 14198.574042778733, 14382.35279412408, 14472.855271447572, 11446.198766086627, 11759.470823812779, 12067.939660301643, 12170.939145304217, 12267.325297108744, 11728.296302221894, 11738.41307934617, 11847.940760296144, 11923.0, 12193.756124877274], "value": 7608.085411347689, "unit": "score"}], "name": "dromaeo_css", "value": 7253.31800218324, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 110.0, 109.0, 112.0, 111.0, 110.0, 110.0, 111.0, 111.0], "value": 109.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 118.0, 120.0, 167.0, 119.0, 119.0, 144.0, 117.0, 148.0, 117.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 161.0, 160.0, 161.0, 161.0, 160.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 115.0, 74.0, 75.0, 75.0, 74.0, 100.0, 76.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 111.0, 84.0, 84.0, 83.0, 120.0, 85.0, 84.0, 134.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 98.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 52.0, 52.0, 52.0, 53.0, 52.0, 51.0, 51.0], "value": 51.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 62.0, 61.0, 62.0, 62.0, 62.0, 62.0, 61.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 75.0, 75.0, 74.0, 80.0, 78.0, 74.0, 76.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 117.0, 130.0, 131.0, 126.0, 118.0, 118.0, 118.0, 166.0, 129.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 160.0, 158.0, 161.0, 156.0, 166.0, 163.0, 159.0, 156.0, 157.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 68.0, 62.0, 62.0, 62.0, 63.0, 63.0, 66.0, 61.0, 61.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1476.3999999999996, "alertThreshold": 2.0}]} 21:35:58 INFO - Return code: 0 21:35:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:35:58 INFO - # TBPL SUCCESS # 21:35:58 INFO - Running post-action listener: _resource_record_post_action 21:35:58 INFO - ##### 21:35:58 INFO - ##### Finished run-tests step (success) 21:35:58 INFO - ##### 21:35:58 INFO - Running post-run listener: _resource_record_post_run 21:35:58 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 4096; Write bytes: 570888192; Read time: 12; Write time: 948876 21:35:58 INFO - TinderboxPrint: CPU usage
13.0% 21:35:58 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 21:35:58 INFO - TinderboxPrint: I/O write bytes / time
570,888,192 / 948,876 21:35:58 INFO - TinderboxPrint: CPU idle
8,294.0 (87.0%) 21:35:58 INFO - TinderboxPrint: CPU user
1,194.8 (12.5%) 21:35:58 INFO - TinderboxPrint: Swap in / out
0 / 0 21:35:58 INFO - install - Wall time: 19s; CPU: 15.0%; Read bytes: 0; Write bytes: 276664320; Read time: 0; Write time: 498396 21:35:58 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 0; Write bytes: 294223872; Read time: 0; Write time: 450480 21:35:58 INFO - Running post-run listener: _upload_blobber_files 21:35:58 INFO - Blob upload gear active. 21:35:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:35:58 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 21:35:58 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:35:58 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:35:59 INFO - (blobuploader) - INFO - Open directory for files ... 21:35:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:35:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:35:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:36:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:00 INFO - (blobuploader) - INFO - Done attempting. 21:36:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:36:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:36:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:36:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:06 INFO - (blobuploader) - INFO - Done attempting. 21:36:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:36:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:36:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:36:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:36:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:36:06 INFO - (blobuploader) - INFO - Done attempting. 21:36:06 INFO - (blobuploader) - INFO - Iteration through files over. 21:36:07 INFO - Return code: 0 21:36:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:36:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:36:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/512503d6da88ddd360bd119eb9632836db42d6f3653e922dbcf39d9ee5b91382ba8069cf2d3855537ceedb9ab0bb7128e98d7b4a088ed05c815f1fd155c8c83f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/266431439d3241e1bd4b27fc3aa90a06df94ce3ce2cf9f956177bc3bf0bda16f7309160b28bac3d5f5f1a26dc7c76c3cb4d2be4e001e76c719cbde4260f988ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6a0e7ee91084fcb1b731f507453140fbd31580c89d01fd394c7ffc2136825c070d5314ce746928abe7a00f0f938942bab26c8557dff260ac8f0ac04b52973c2a"} 21:36:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:36:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:36:07 INFO - Contents: 21:36:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/512503d6da88ddd360bd119eb9632836db42d6f3653e922dbcf39d9ee5b91382ba8069cf2d3855537ceedb9ab0bb7128e98d7b4a088ed05c815f1fd155c8c83f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/266431439d3241e1bd4b27fc3aa90a06df94ce3ce2cf9f956177bc3bf0bda16f7309160b28bac3d5f5f1a26dc7c76c3cb4d2be4e001e76c719cbde4260f988ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6a0e7ee91084fcb1b731f507453140fbd31580c89d01fd394c7ffc2136825c070d5314ce746928abe7a00f0f938942bab26c8557dff260ac8f0ac04b52973c2a"} 21:36:07 INFO - Running post-run listener: copy_logs_to_upload_dir 21:36:07 INFO - Copying logs to upload dir... 21:36:07 INFO - mkdir: /builds/slave/test/build/upload/logs 21:36:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.988701 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-13 21:36:06.561783) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 21:36:06.565720) ========= 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=eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/512503d6da88ddd360bd119eb9632836db42d6f3653e922dbcf39d9ee5b91382ba8069cf2d3855537ceedb9ab0bb7128e98d7b4a088ed05c815f1fd155c8c83f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/266431439d3241e1bd4b27fc3aa90a06df94ce3ce2cf9f956177bc3bf0bda16f7309160b28bac3d5f5f1a26dc7c76c3cb4d2be4e001e76c719cbde4260f988ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6a0e7ee91084fcb1b731f507453140fbd31580c89d01fd394c7ffc2136825c070d5314ce746928abe7a00f0f938942bab26c8557dff260ac8f0ac04b52973c2a"} build_url:https://queue.taskcluster.net/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/SS6iuP42TN2AyXIBKVJhuQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/512503d6da88ddd360bd119eb9632836db42d6f3653e922dbcf39d9ee5b91382ba8069cf2d3855537ceedb9ab0bb7128e98d7b4a088ed05c815f1fd155c8c83f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/266431439d3241e1bd4b27fc3aa90a06df94ce3ce2cf9f956177bc3bf0bda16f7309160b28bac3d5f5f1a26dc7c76c3cb4d2be4e001e76c719cbde4260f988ca", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/6a0e7ee91084fcb1b731f507453140fbd31580c89d01fd394c7ffc2136825c070d5314ce746928abe7a00f0f938942bab26c8557dff260ac8f0ac04b52973c2a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 21:36:06.595053) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 21:36:06.595834) ========= 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=eca2ab57546de7b41f256b19000001ef-1468469639.58381-1691256392 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004488 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 21:36:06.679918) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 21:36:06.680602) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 21:36:06.681190) ========= ========= Total master_lag: 0.46 =========