builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-009 starttime: 1467811832.89 results: success (0) buildid: 20160706055522 builduid: 027fab235eaa4c55b41bab052c3715b2 revision: 5dc96caed88143bdfd03983a1a293ea90c0e672d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 06:30:32.892107) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 06:30:32.892568) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 06:30:32.892851) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 06:30:32.949073) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 06:30:32.949334) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 06:30:33-- 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.7M=0s 2016-07-06 06:30:33 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.162927 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 06:30:33.170186) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 06:30:33.170480) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.092179 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 06:30:33.271697) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-06 06:30:33.272007) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5dc96caed88143bdfd03983a1a293ea90c0e672d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 5dc96caed88143bdfd03983a1a293ea90c0e672d --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=17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 06:30:33,345 truncating revision to first 12 chars 2016-07-06 06:30:33,345 Setting DEBUG logging. 2016-07-06 06:30:33,345 attempt 1/10 2016-07-06 06:30:33,345 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5dc96caed881?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 06:30:35,525 unpacking tar archive at: fx-team-5dc96caed881/testing/mozharness/ program finished with exit code 0 elapsedTime=2.676254 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-07-06 06:30:35.962113) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 06:30:35.962445) ========= script_repo_revision: 5dc96caed88143bdfd03983a1a293ea90c0e672d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 06:30:35.962884) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 06:30:35.963241) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 06:30:35.974215) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-06 06:30:35.974488) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:30:36 INFO - MultiFileLogger online at 20160706 06:30:36 in /builds/slave/test 06:30:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 06:30:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:30:36 INFO - {'append_to_log': False, 06:30:36 INFO - 'base_work_dir': '/builds/slave/test', 06:30:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 06:30:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:30:36 INFO - 'branch': 'Fx-Team-Non-PGO', 06:30:36 INFO - 'buildbot_json_path': 'buildprops.json', 06:30:36 INFO - 'config_files': ('talos/linux_config.py',), 06:30:36 INFO - 'default_actions': ('clobber', 06:30:36 INFO - 'read-buildbot-config', 06:30:36 INFO - 'download-and-extract', 06:30:36 INFO - 'populate-webroot', 06:30:36 INFO - 'create-virtualenv', 06:30:36 INFO - 'install', 06:30:36 INFO - 'run-tests'), 06:30:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:30:36 INFO - 'download_minidump_stackwalk': True, 06:30:36 INFO - 'download_symbols': 'ondemand', 06:30:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:30:36 INFO - 'tooltool.py': '/tools/tooltool.py', 06:30:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:30:36 INFO - '/tools/misc-python/virtualenv.py')}, 06:30:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:30:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:30:36 INFO - 'installer_path': 'installer.exe', 06:30:36 INFO - 'log_level': 'info', 06:30:36 INFO - 'log_name': 'talos', 06:30:36 INFO - 'log_to_console': True, 06:30:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:30:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:30:36 INFO - 'opt_config_files': (), 06:30:36 INFO - 'pip_index': False, 06:30:36 INFO - 'sps_profile': False, 06:30:36 INFO - 'sps_profile_interval': 0, 06:30:36 INFO - 'suite': 'dromaeojs', 06:30:36 INFO - 'system_bits': '32', 06:30:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:30:36 INFO - 'title': 'talos-linux64-ix-009', 06:30:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:30:36 INFO - 'use_talos_json': True, 06:30:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:30:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:30:36 INFO - 'work_dir': 'build'} 06:30:36 INFO - ##### 06:30:36 INFO - ##### Running clobber step. 06:30:36 INFO - ##### 06:30:36 INFO - Running pre-action listener: _resource_record_pre_action 06:30:36 INFO - Running main action method: clobber 06:30:36 INFO - rmtree: /builds/slave/test/build 06:30:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:30:37 INFO - Running post-action listener: _resource_record_post_action 06:30:37 INFO - ##### 06:30:37 INFO - ##### Finished clobber step (success) 06:30:37 INFO - ##### 06:30:37 INFO - ##### 06:30:37 INFO - ##### Running read-buildbot-config step. 06:30:37 INFO - ##### 06:30:37 INFO - Running pre-action listener: _resource_record_pre_action 06:30:37 INFO - Running main action method: read_buildbot_config 06:30:37 INFO - Using buildbot properties: 06:30:37 INFO - { 06:30:37 INFO - "project": "", 06:30:37 INFO - "product": "firefox", 06:30:37 INFO - "script_repo_revision": "production", 06:30:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:30:37 INFO - "repository": "", 06:30:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 06:30:37 INFO - "buildid": "20160706055522", 06:30:37 INFO - "pgo_build": "False", 06:30:37 INFO - "basedir": "/builds/slave/test", 06:30:37 INFO - "buildnumber": 3134, 06:30:37 INFO - "slavename": "talos-linux64-ix-009", 06:30:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:30:37 INFO - "platform": "ubuntu64_hw", 06:30:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 06:30:37 INFO - "branch": "fx-team", 06:30:37 INFO - "repo_path": "integration/fx-team", 06:30:37 INFO - "revision": "5dc96caed88143bdfd03983a1a293ea90c0e672d", 06:30:37 INFO - "stage_platform": "linux64", 06:30:37 INFO - "builduid": "027fab235eaa4c55b41bab052c3715b2", 06:30:37 INFO - "slavebuilddir": "test" 06:30:37 INFO - } 06:30:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:30:37 INFO - Running post-action listener: _resource_record_post_action 06:30:37 INFO - ##### 06:30:37 INFO - ##### Finished read-buildbot-config step (success) 06:30:37 INFO - ##### 06:30:37 INFO - ##### 06:30:37 INFO - ##### Running download-and-extract step. 06:30:37 INFO - ##### 06:30:37 INFO - Running pre-action listener: _resource_record_pre_action 06:30:37 INFO - Running main action method: download_and_extract 06:30:37 INFO - mkdir: /builds/slave/test/build/tests 06:30: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')]} 06:30:37 INFO - https://queue.taskcluster.net/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:30:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:30:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:30:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/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 06:30:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/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 06:30:41 INFO - Downloaded 1361 bytes. 06:30:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:30:41 INFO - Using the following test package requirements: 06:30:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:30:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:30:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:30:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:41 INFO - u'jsshell-linux-x86_64.zip'], 06:30:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:30:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:30:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:30:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:30:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:30:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:30:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:30:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:30:41 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')]} 06:30:41 INFO - https://queue.taskcluster.net/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:30:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:30:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:30:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/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 06:30:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/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 06:30:43 INFO - Downloaded 22730934 bytes. 06:30:43 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'] 06:30:43 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 06:30:45 INFO - Return code: 0 06:30:45 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 06:30:45 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')]} 06:30:45 INFO - https://queue.taskcluster.net/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:30:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:30:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:30:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/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 06:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/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 06:30:46 INFO - Downloaded 22730934 bytes. 06:30:46 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'] 06:30:46 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 06:30:47 INFO - Return code: 0 06:30:47 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')]} 06:30:47 INFO - https://queue.taskcluster.net/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:30:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:30:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:30:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/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 06:30:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/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 06:30:48 INFO - Downloaded 14403333 bytes. 06:30:48 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'] 06:30:48 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 06:30:49 INFO - Return code: 0 06:30: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')]} 06:30:49 INFO - https://queue.taskcluster.net/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:30:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:30:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:30:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/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 06:30:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GUxMnFd7TquR4OmlSur3Mw/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 06:30:50 INFO - Downloaded 56474139 bytes. 06:30:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:30:50 INFO - mkdir: /builds/slave/test/properties 06:30:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:30:50 INFO - Writing to file /builds/slave/test/properties/build_url 06:30:50 INFO - Contents: 06:30:50 INFO - build_url:https://queue.taskcluster.net/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:30:51 INFO - Running post-action listener: _resource_record_post_action 06:30:51 INFO - Running post-action listener: set_extra_try_arguments 06:30:51 INFO - ##### 06:30:51 INFO - ##### Finished download-and-extract step (success) 06:30:51 INFO - ##### 06:30:51 INFO - ##### 06:30:51 INFO - ##### Running populate-webroot step. 06:30:51 INFO - ##### 06:30:51 INFO - Running pre-action listener: _resource_record_pre_action 06:30:51 INFO - Running main action method: populate_webroot 06:30:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:30:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:30:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:30:51 INFO - '--tppagecycles', 06:30:51 INFO - '7'], 06:30:51 INFO - 'tests': ['tsvgm']}}, 06:30:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:30:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:30:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:30:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:30:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:30:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:30:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['damp', 'tps']}, 06:30:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'tests': ['damp', 'tps']}, 06:30:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['dromaeo_dom']}, 06:30:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:30:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['basic_compositor_video']}, 06:30:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:30:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['a11yr', 06:30:51 INFO - 'ts_paint', 06:30:51 INFO - 'tpaint', 06:30:51 INFO - 'sessionrestore', 06:30:51 INFO - 'sessionrestore_no_auto_restore', 06:30:51 INFO - 'tabpaint']}, 06:30:51 INFO - 'other-e10s': {'tests': ['a11yr', 06:30:51 INFO - 'ts_paint', 06:30:51 INFO - 'tpaint', 06:30:51 INFO - 'sessionrestore', 06:30:51 INFO - 'sessionrestore_no_auto_restore', 06:30:51 INFO - 'tabpaint']}, 06:30:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:30:51 INFO - 'ts_paint', 06:30:51 INFO - 'tpaint', 06:30:51 INFO - 'sessionrestore', 06:30:51 INFO - 'sessionrestore_no_auto_restore', 06:30:51 INFO - 'tabpaint']}, 06:30:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:30:51 INFO - 'ts_paint', 06:30:51 INFO - 'tpaint', 06:30:51 INFO - 'sessionrestore', 06:30:51 INFO - 'sessionrestore_no_auto_restore', 06:30:51 INFO - 'tabpaint']}, 06:30:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['a11yr', 06:30:51 INFO - 'ts_paint', 06:30:51 INFO - 'tpaint', 06:30:51 INFO - 'sessionrestore', 06:30:51 INFO - 'sessionrestore_no_auto_restore', 06:30:51 INFO - 'tabpaint']}, 06:30:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['a11yr', 06:30:51 INFO - 'ts_paint', 06:30:51 INFO - 'tpaint', 06:30:51 INFO - 'sessionrestore', 06:30:51 INFO - 'sessionrestore_no_auto_restore', 06:30:51 INFO - 'tabpaint']}, 06:30:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['tsvgx', 06:30:51 INFO - 'tsvgr_opacity', 06:30:51 INFO - 'tart', 06:30:51 INFO - 'tscrollx', 06:30:51 INFO - 'cart']}, 06:30:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:30:51 INFO - 'tsvgr_opacity', 06:30:51 INFO - 'tart', 06:30:51 INFO - 'tscrollx', 06:30:51 INFO - 'cart']}, 06:30:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'talos_options': ['--disable-e10s'], 06:30:51 INFO - 'tests': ['tp5o']}, 06:30:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'tests': ['tp5o']}, 06:30:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'talos_options': ['--disable-e10s', 06:30:51 INFO - '--xperf_path', 06:30:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:30:51 INFO - 'tests': ['tp5n']}, 06:30:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:30:51 INFO - 'talos_options': ['--xperf_path', 06:30:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:30:51 INFO - 'tests': ['tp5n']}}, 06:30:51 INFO - 'talos.zip': {'path': '', 06:30:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:30:51 INFO - Running post-action listener: _resource_record_post_action 06:30:51 INFO - ##### 06:30:51 INFO - ##### Finished populate-webroot step (success) 06:30:51 INFO - ##### 06:30:51 INFO - ##### 06:30:51 INFO - ##### Running create-virtualenv step. 06:30:51 INFO - ##### 06:30:51 INFO - Running pre-action listener: _resource_record_pre_action 06:30:51 INFO - Running main action method: create_virtualenv 06:30:51 INFO - Creating virtualenv /builds/slave/test/build/venv 06:30:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:30:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:30:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:30:51 INFO - Using real prefix '/usr' 06:30:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:30:52 INFO - Installing distribute.............................................................................................................................................................................................done. 06:30:54 INFO - Installing pip.................done. 06:30:54 INFO - Return code: 0 06:30:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:30:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:30:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593b0>, '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 0xf5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', '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 06:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:30:54 INFO - Using env: {'DISPLAY': ':0', 06:30:54 INFO - 'HOME': '/home/cltbld', 06:30:54 INFO - 'LANG': 'en_US.UTF-8', 06:30:54 INFO - 'LANGUAGE': 'en_US:en', 06:30:54 INFO - 'LOGNAME': 'cltbld', 06:30:54 INFO - 'MAIL': '/var/mail/cltbld', 06:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:54 INFO - 'MOZ_NO_REMOTE': '1', 06:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:54 INFO - 'NO_EM_RESTART': '1', 06:30:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:54 INFO - 'PWD': '/builds/slave/test', 06:30:54 INFO - 'SHELL': '/bin/bash', 06:30:54 INFO - 'SHLVL': '1', 06:30:54 INFO - 'TERM': 'linux', 06:30:54 INFO - 'TMOUT': '86400', 06:30:54 INFO - 'USER': 'cltbld', 06:30:54 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', 06:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:54 INFO - '_': '/tools/buildbot/bin/python'} 06:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:55 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 06:30:55 INFO - Cleaning up... 06:30:55 INFO - Return code: 0 06:30:55 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:30: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')]} 06:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30: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')]} 06:30:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:55 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 0xc9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593b0>, '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 0xf5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', '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 06:30:55 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 06:30:55 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 06:30:55 INFO - Using env: {'DISPLAY': ':0', 06:30:55 INFO - 'HOME': '/home/cltbld', 06:30:55 INFO - 'LANG': 'en_US.UTF-8', 06:30:55 INFO - 'LANGUAGE': 'en_US:en', 06:30:55 INFO - 'LOGNAME': 'cltbld', 06:30:55 INFO - 'MAIL': '/var/mail/cltbld', 06:30:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:55 INFO - 'MOZ_NO_REMOTE': '1', 06:30:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:55 INFO - 'NO_EM_RESTART': '1', 06:30:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:55 INFO - 'PWD': '/builds/slave/test', 06:30:55 INFO - 'SHELL': '/bin/bash', 06:30:55 INFO - 'SHLVL': '1', 06:30:55 INFO - 'TERM': 'linux', 06:30:55 INFO - 'TMOUT': '86400', 06:30:55 INFO - 'USER': 'cltbld', 06:30:55 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', 06:30:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:55 INFO - '_': '/tools/buildbot/bin/python'} 06:30:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:55 INFO - Downloading/unpacking psutil>=3.1.1 06:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:30:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:30:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:30:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:30:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:30:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:30:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:30:57 INFO - Installing collected packages: psutil 06:30:57 INFO - Running setup.py install for psutil 06:30:57 INFO - building 'psutil._psutil_linux' extension 06:30:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:30:58 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 06:30:58 INFO - building 'psutil._psutil_posix' extension 06:30:58 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 06:30:58 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 06:30:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:30:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:30:58 INFO - Successfully installed psutil 06:30:58 INFO - Cleaning up... 06:30:58 INFO - Return code: 0 06:30:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:30: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')]} 06:30:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:30:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30: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')]} 06:30:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:30:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:30:58 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 0xc9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593b0>, '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 0xf5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', '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 06:30:58 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 06:30:58 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 06:30:58 INFO - Using env: {'DISPLAY': ':0', 06:30:58 INFO - 'HOME': '/home/cltbld', 06:30:58 INFO - 'LANG': 'en_US.UTF-8', 06:30:58 INFO - 'LANGUAGE': 'en_US:en', 06:30:58 INFO - 'LOGNAME': 'cltbld', 06:30:58 INFO - 'MAIL': '/var/mail/cltbld', 06:30:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:30:58 INFO - 'MOZ_NO_REMOTE': '1', 06:30:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:30:58 INFO - 'NO_EM_RESTART': '1', 06:30:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:30:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:30:58 INFO - 'PWD': '/builds/slave/test', 06:30:58 INFO - 'SHELL': '/bin/bash', 06:30:58 INFO - 'SHLVL': '1', 06:30:58 INFO - 'TERM': 'linux', 06:30:58 INFO - 'TMOUT': '86400', 06:30:58 INFO - 'USER': 'cltbld', 06:30:58 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', 06:30:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:30:58 INFO - '_': '/tools/buildbot/bin/python'} 06:30:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:30:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:30:59 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 06:30:59 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 06:30:59 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 06:30:59 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 06:30:59 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 06:30:59 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 06:31:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:31:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:31:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:31:01 INFO - Installing collected packages: mozsystemmonitor 06:31:01 INFO - Running setup.py install for mozsystemmonitor 06:31:01 INFO - Successfully installed mozsystemmonitor 06:31:01 INFO - Cleaning up... 06:31:01 INFO - Return code: 0 06:31:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:01 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 0xc9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593b0>, '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 0xf5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', '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 06:31:01 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 06:31:01 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 06:31:01 INFO - Using env: {'DISPLAY': ':0', 06:31:01 INFO - 'HOME': '/home/cltbld', 06:31:01 INFO - 'LANG': 'en_US.UTF-8', 06:31:01 INFO - 'LANGUAGE': 'en_US:en', 06:31:01 INFO - 'LOGNAME': 'cltbld', 06:31:01 INFO - 'MAIL': '/var/mail/cltbld', 06:31:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:01 INFO - 'MOZ_NO_REMOTE': '1', 06:31:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:01 INFO - 'NO_EM_RESTART': '1', 06:31:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:01 INFO - 'PWD': '/builds/slave/test', 06:31:01 INFO - 'SHELL': '/bin/bash', 06:31:01 INFO - 'SHLVL': '1', 06:31:01 INFO - 'TERM': 'linux', 06:31:01 INFO - 'TMOUT': '86400', 06:31:01 INFO - 'USER': 'cltbld', 06:31:01 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', 06:31:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:01 INFO - '_': '/tools/buildbot/bin/python'} 06:31:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:01 INFO - Downloading/unpacking jsonschema==2.5.1 06:31:01 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 06:31:01 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 06:31:01 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 06:31:01 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 06:31:01 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 06:31:01 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 06:31:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:31:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:31:03 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 06:31:03 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 06:31:03 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 06:31:03 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 06:31:03 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 06:31:03 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 06:31:03 INFO - Downloading functools32-3.2.3-2.tar.gz 06:31:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:31:03 INFO - warning: no files found matching '*.txt' 06:31:03 INFO - no previously-included directories found matching 'build' 06:31:03 INFO - no previously-included directories found matching 'dist' 06:31:03 INFO - no previously-included directories found matching '.git*' 06:31:03 INFO - Installing collected packages: jsonschema, functools32 06:31:03 INFO - Running setup.py install for functools32 06:31:03 INFO - warning: no files found matching '*.txt' 06:31:03 INFO - no previously-included directories found matching 'build' 06:31:03 INFO - no previously-included directories found matching 'dist' 06:31:03 INFO - no previously-included directories found matching '.git*' 06:31:03 INFO - Successfully installed jsonschema functools32 06:31:03 INFO - Cleaning up... 06:31:03 INFO - Return code: 0 06:31:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:03 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 0xc9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593b0>, '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 0xf5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', '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 06:31:03 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 06:31:03 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 06:31:03 INFO - Using env: {'DISPLAY': ':0', 06:31:03 INFO - 'HOME': '/home/cltbld', 06:31:03 INFO - 'LANG': 'en_US.UTF-8', 06:31:03 INFO - 'LANGUAGE': 'en_US:en', 06:31:03 INFO - 'LOGNAME': 'cltbld', 06:31:03 INFO - 'MAIL': '/var/mail/cltbld', 06:31:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:03 INFO - 'MOZ_NO_REMOTE': '1', 06:31:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:03 INFO - 'NO_EM_RESTART': '1', 06:31:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:03 INFO - 'PWD': '/builds/slave/test', 06:31:03 INFO - 'SHELL': '/bin/bash', 06:31:03 INFO - 'SHLVL': '1', 06:31:03 INFO - 'TERM': 'linux', 06:31:03 INFO - 'TMOUT': '86400', 06:31:03 INFO - 'USER': 'cltbld', 06:31:03 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', 06:31:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:03 INFO - '_': '/tools/buildbot/bin/python'} 06:31:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:04 INFO - Downloading/unpacking blobuploader==1.2.4 06:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:31:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:31:05 INFO - Downloading blobuploader-1.2.4.tar.gz 06:31:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:31:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:31:06 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 06:31:06 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 06:31:06 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 06:31:06 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 06:31:06 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 06:31:06 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 06:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:31:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:31:06 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 06:31:06 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 06:31:06 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 06:31:06 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 06:31:06 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 06:31:06 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 06:31:06 INFO - Downloading docopt-0.6.1.tar.gz 06:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:31:06 INFO - Installing collected packages: blobuploader, requests, docopt 06:31:06 INFO - Running setup.py install for blobuploader 06:31:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:31:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:31:06 INFO - Running setup.py install for requests 06:31:07 INFO - Running setup.py install for docopt 06:31:07 INFO - Successfully installed blobuploader requests docopt 06:31:07 INFO - Cleaning up... 06:31:07 INFO - Return code: 0 06:31:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:07 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')]} 06:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:07 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')]} 06:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:07 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 0xc9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593b0>, '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 0xf5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', '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 06:31:07 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 06:31:07 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 06:31:07 INFO - Using env: {'DISPLAY': ':0', 06:31:07 INFO - 'HOME': '/home/cltbld', 06:31:07 INFO - 'LANG': 'en_US.UTF-8', 06:31:07 INFO - 'LANGUAGE': 'en_US:en', 06:31:07 INFO - 'LOGNAME': 'cltbld', 06:31:07 INFO - 'MAIL': '/var/mail/cltbld', 06:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:07 INFO - 'MOZ_NO_REMOTE': '1', 06:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:07 INFO - 'NO_EM_RESTART': '1', 06:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:07 INFO - 'PWD': '/builds/slave/test', 06:31:07 INFO - 'SHELL': '/bin/bash', 06:31:07 INFO - 'SHLVL': '1', 06:31:07 INFO - 'TERM': 'linux', 06:31:07 INFO - 'TMOUT': '86400', 06:31:07 INFO - 'USER': 'cltbld', 06:31:07 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', 06:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:07 INFO - '_': '/tools/buildbot/bin/python'} 06:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:31:07 INFO - Running setup.py (path:/tmp/pip-fLJsia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:31:07 INFO - Running setup.py (path:/tmp/pip-b2U4zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:31:07 INFO - Running setup.py (path:/tmp/pip-Mnj_vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:31:07 INFO - Running setup.py (path:/tmp/pip-fo0KGy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:31:07 INFO - Running setup.py (path:/tmp/pip-GdnJLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:31:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:31:07 INFO - Running setup.py (path:/tmp/pip-cbbsCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:31:08 INFO - Running setup.py (path:/tmp/pip-CUm0TF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:31:08 INFO - Running setup.py (path:/tmp/pip-TYNDYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:31:08 INFO - Running setup.py (path:/tmp/pip-zdma6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:31:08 INFO - Running setup.py (path:/tmp/pip-T2SUqb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:31:08 INFO - Running setup.py (path:/tmp/pip-iX4XzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:31:08 INFO - Running setup.py (path:/tmp/pip-iJnWFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:31:08 INFO - Running setup.py (path:/tmp/pip-MqwpUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:31:08 INFO - Running setup.py (path:/tmp/pip-UO51gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:08 INFO - Running setup.py (path:/tmp/pip-48qmNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:31:08 INFO - Running setup.py (path:/tmp/pip-_ULh9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:31:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:31:08 INFO - Running setup.py (path:/tmp/pip-DROm8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:31:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:31:08 INFO - Running setup.py install for manifestparser 06:31:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:31:08 INFO - Running setup.py install for mozcrash 06:31:09 INFO - Running setup.py install for mozdebug 06:31:09 INFO - Running setup.py install for mozdevice 06:31:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:31:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:31:09 INFO - Running setup.py install for mozfile 06:31:09 INFO - Running setup.py install for mozhttpd 06:31:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:31:09 INFO - Running setup.py install for mozinfo 06:31:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:31:09 INFO - Running setup.py install for mozInstall 06:31:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:31:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:31:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:31:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:31:09 INFO - Running setup.py install for mozleak 06:31:09 INFO - Running setup.py install for mozlog 06:31:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:31:09 INFO - Running setup.py install for moznetwork 06:31:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:31:09 INFO - Running setup.py install for mozprocess 06:31:10 INFO - Running setup.py install for mozprofile 06:31:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:31:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:31:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:31:10 INFO - Running setup.py install for mozrunner 06:31:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:31:10 INFO - Running setup.py install for mozscreenshot 06:31:10 INFO - Running setup.py install for moztest 06:31:10 INFO - Running setup.py install for mozversion 06:31:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:31:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:31:10 INFO - Cleaning up... 06:31:10 INFO - Return code: 0 06:31:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:10 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 0xc9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593b0>, '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 0xf5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', '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 06:31:10 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 06:31:10 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 06:31:10 INFO - Using env: {'DISPLAY': ':0', 06:31:10 INFO - 'HOME': '/home/cltbld', 06:31:10 INFO - 'LANG': 'en_US.UTF-8', 06:31:10 INFO - 'LANGUAGE': 'en_US:en', 06:31:10 INFO - 'LOGNAME': 'cltbld', 06:31:10 INFO - 'MAIL': '/var/mail/cltbld', 06:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:10 INFO - 'MOZ_NO_REMOTE': '1', 06:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:10 INFO - 'NO_EM_RESTART': '1', 06:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:10 INFO - 'PWD': '/builds/slave/test', 06:31:10 INFO - 'SHELL': '/bin/bash', 06:31:10 INFO - 'SHLVL': '1', 06:31:10 INFO - 'TERM': 'linux', 06:31:10 INFO - 'TMOUT': '86400', 06:31:10 INFO - 'USER': 'cltbld', 06:31:10 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', 06:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:10 INFO - '_': '/tools/buildbot/bin/python'} 06:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:31:10 INFO - Running setup.py (path:/tmp/pip-BA0nqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:31:10 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)) 06:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:31:10 INFO - Running setup.py (path:/tmp/pip-sWZtpX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:31:10 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)) 06:31:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:31:10 INFO - Running setup.py (path:/tmp/pip-5Isdvx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:31:11 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)) 06:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:31:11 INFO - Running setup.py (path:/tmp/pip-sLM60m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:31:11 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)) 06:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:31:11 INFO - Running setup.py (path:/tmp/pip-OE_vO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:31:11 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)) 06:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:31:11 INFO - Running setup.py (path:/tmp/pip-79YCoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:31:11 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)) 06:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:31:11 INFO - Running setup.py (path:/tmp/pip-JCcCr5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:31:11 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)) 06:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:31:11 INFO - Running setup.py (path:/tmp/pip-bBZdw7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:31:11 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)) 06:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:31:11 INFO - Running setup.py (path:/tmp/pip-koUpji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:31:11 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)) 06:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:31:11 INFO - Running setup.py (path:/tmp/pip-Zvhw8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:31:11 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)) 06:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:31:11 INFO - Running setup.py (path:/tmp/pip-k7Pazt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:31:11 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)) 06:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:31:11 INFO - Running setup.py (path:/tmp/pip-Dj2USQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:31:11 INFO - Running setup.py (path:/tmp/pip-MAtKYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:31:11 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)) 06:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:31:11 INFO - Running setup.py (path:/tmp/pip-2p5bdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:31:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:11 INFO - Running setup.py (path:/tmp/pip-yU0zkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:31:11 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)) 06:31:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:31:11 INFO - Running setup.py (path:/tmp/pip-gnGCAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:31:12 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)) 06:31:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:31:12 INFO - Running setup.py (path:/tmp/pip-Bxwrfa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:31:12 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)) 06:31:12 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)) 06:31:12 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)) 06:31:12 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)) 06:31:12 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)) 06:31:12 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)) 06:31:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:31:12 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 06:31:12 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 06:31:12 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 06:31:12 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 06:31:12 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 06:31:12 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 06:31:13 INFO - Downloading blessings-1.6.tar.gz 06:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:31:14 INFO - Installing collected packages: blessings 06:31:14 INFO - Running setup.py install for blessings 06:31:14 INFO - Successfully installed blessings 06:31:14 INFO - Cleaning up... 06:31:14 INFO - Return code: 0 06:31:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:31:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:14 INFO - Reading from file tmpfile_stdout 06:31:14 INFO - Current package versions: 06:31:14 INFO - argparse == 1.2.1 06:31:14 INFO - blessings == 1.6 06:31:14 INFO - blobuploader == 1.2.4 06:31:14 INFO - docopt == 0.6.1 06:31:14 INFO - functools32 == 3.2.3-2 06:31:14 INFO - jsonschema == 2.5.1 06:31:14 INFO - manifestparser == 1.1 06:31:14 INFO - mozInstall == 1.12 06:31:14 INFO - mozcrash == 0.17 06:31:14 INFO - mozdebug == 0.1 06:31:14 INFO - mozdevice == 0.48 06:31:14 INFO - mozfile == 1.2 06:31:14 INFO - mozhttpd == 0.7 06:31:14 INFO - mozinfo == 0.9 06:31:14 INFO - mozleak == 0.1 06:31:14 INFO - mozlog == 3.2 06:31:14 INFO - moznetwork == 0.27 06:31:14 INFO - mozprocess == 0.22 06:31:14 INFO - mozprofile == 0.28 06:31:14 INFO - mozrunner == 6.11 06:31:14 INFO - mozscreenshot == 0.1 06:31:14 INFO - mozsystemmonitor == 0.3 06:31:14 INFO - moztest == 0.7 06:31:14 INFO - mozversion == 1.4 06:31:14 INFO - psutil == 3.1.1 06:31:14 INFO - requests == 1.2.3 06:31:14 INFO - wsgiref == 0.1.2 06:31:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:31:14 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')]} 06:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:14 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')]} 06:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:14 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 0xc9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593b0>, '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 0xf5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', '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 06:31:14 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 06:31:14 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 06:31:14 INFO - Using env: {'DISPLAY': ':0', 06:31:14 INFO - 'HOME': '/home/cltbld', 06:31:14 INFO - 'LANG': 'en_US.UTF-8', 06:31:14 INFO - 'LANGUAGE': 'en_US:en', 06:31:14 INFO - 'LOGNAME': 'cltbld', 06:31:14 INFO - 'MAIL': '/var/mail/cltbld', 06:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:14 INFO - 'MOZ_NO_REMOTE': '1', 06:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:14 INFO - 'NO_EM_RESTART': '1', 06:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:14 INFO - 'PWD': '/builds/slave/test', 06:31:14 INFO - 'SHELL': '/bin/bash', 06:31:14 INFO - 'SHLVL': '1', 06:31:14 INFO - 'TERM': 'linux', 06:31:14 INFO - 'TMOUT': '86400', 06:31:14 INFO - 'USER': 'cltbld', 06:31:14 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', 06:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:14 INFO - '_': '/tools/buildbot/bin/python'} 06:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:14 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)) 06:31:14 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)) 06:31:14 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)) 06:31:14 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)) 06:31:14 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)) 06:31:14 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)) 06:31:14 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)) 06:31:14 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)) 06:31:14 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)) 06:31:14 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)) 06:31:14 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)) 06:31:14 INFO - Cleaning up... 06:31:14 INFO - Return code: 0 06:31:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:31:14 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')]} 06:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:14 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')]} 06:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:31:14 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 0xc9a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdfd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf5b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf593b0>, '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 0xf5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a740>, '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': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', '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 06:31:14 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 06:31:14 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 06:31:14 INFO - Using env: {'DISPLAY': ':0', 06:31:14 INFO - 'HOME': '/home/cltbld', 06:31:14 INFO - 'LANG': 'en_US.UTF-8', 06:31:14 INFO - 'LANGUAGE': 'en_US:en', 06:31:14 INFO - 'LOGNAME': 'cltbld', 06:31:14 INFO - 'MAIL': '/var/mail/cltbld', 06:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:14 INFO - 'MOZ_NO_REMOTE': '1', 06:31:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:14 INFO - 'NO_EM_RESTART': '1', 06:31:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:14 INFO - 'PWD': '/builds/slave/test', 06:31:14 INFO - 'SHELL': '/bin/bash', 06:31:14 INFO - 'SHLVL': '1', 06:31:14 INFO - 'TERM': 'linux', 06:31:14 INFO - 'TMOUT': '86400', 06:31:14 INFO - 'USER': 'cltbld', 06:31:14 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', 06:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:14 INFO - '_': '/tools/buildbot/bin/python'} 06:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:31:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:31:14 INFO - Cleaning up... 06:31:14 INFO - Return code: 0 06:31:14 INFO - Running post-action listener: _resource_record_post_action 06:31:14 INFO - Running post-action listener: _start_resource_monitoring 06:31:15 INFO - Starting resource monitoring. 06:31:15 INFO - ##### 06:31:15 INFO - ##### Finished create-virtualenv step (success) 06:31:15 INFO - ##### 06:31:15 INFO - ##### 06:31:15 INFO - ##### Running install step. 06:31:15 INFO - ##### 06:31:15 INFO - Running pre-action listener: _resource_record_pre_action 06:31:15 INFO - Running main action method: install 06:31:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:31:15 INFO - Reading from file tmpfile_stdout 06:31:15 INFO - Detecting whether we're running mozinstall >=1.0... 06:31:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:31:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:31:15 INFO - Reading from file tmpfile_stdout 06:31:15 INFO - Output received: 06:31:15 INFO - Usage: mozinstall [options] installer 06:31:15 INFO - Options: 06:31:15 INFO - -h, --help show this help message and exit 06:31:15 INFO - -d DEST, --destination=DEST 06:31:15 INFO - Directory to install application into. [default: 06:31:15 INFO - "/builds/slave/test"] 06:31:15 INFO - --app=APP Application being installed. [default: firefox] 06:31:15 INFO - mkdir: /builds/slave/test/build/application 06:31:15 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'] 06:31:15 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 06:31:31 INFO - Reading from file tmpfile_stdout 06:31:31 INFO - Output received: 06:31:31 INFO - /builds/slave/test/build/application/firefox/firefox 06:31:31 INFO - Running post-action listener: _resource_record_post_action 06:31:31 INFO - ##### 06:31:31 INFO - ##### Finished install step (success) 06:31:31 INFO - ##### 06:31:31 INFO - ##### 06:31:31 INFO - ##### Running run-tests step. 06:31:31 INFO - ##### 06:31:31 INFO - Running pre-action listener: _resource_record_pre_action 06:31:31 INFO - Running main action method: run_tests 06:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:31:31 INFO - Python 2.7.3 06:31:31 INFO - Return code: 0 06:31:31 INFO - grabbing minidump binary from tooltool 06:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:31:31 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 0xf593b0>, '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 0xf5a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf5a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:31:31 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 06:31:31 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 06:31:31 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 06:31:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:31:31 INFO - Return code: 0 06:31:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:31:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:31:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:31:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:31:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 06:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-009 --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 06:31:31 INFO - Using env: {'DISPLAY': ':0', 06:31:31 INFO - 'HOME': '/home/cltbld', 06:31:31 INFO - 'LANG': 'en_US.UTF-8', 06:31:31 INFO - 'LANGUAGE': 'en_US:en', 06:31:31 INFO - 'LOGNAME': 'cltbld', 06:31:31 INFO - 'MAIL': '/var/mail/cltbld', 06:31:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:31:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:31:31 INFO - 'MOZ_NO_REMOTE': '1', 06:31:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:31:31 INFO - 'NO_EM_RESTART': '1', 06:31:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:31:31 INFO - 'PWD': '/builds/slave/test', 06:31:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:31:31 INFO - 'SHELL': '/bin/bash', 06:31:31 INFO - 'SHLVL': '1', 06:31:31 INFO - 'TERM': 'linux', 06:31:31 INFO - 'TMOUT': '86400', 06:31:31 INFO - 'USER': 'cltbld', 06:31:31 INFO - 'XDG_SESSION_COOKIE': '17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235', 06:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:31:31 INFO - '_': '/tools/buildbot/bin/python'} 06:31:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-009', '--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 06:31:31 INFO - mozversion application_buildid: 20160706055522 06:31:31 INFO - mozversion application_changeset: 5dc96caed88143bdfd03983a1a293ea90c0e672d 06:31:31 INFO - mozversion application_display_name: Nightly 06:31:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:31:31 INFO - mozversion application_name: Firefox 06:31:31 INFO - mozversion application_remotingname: firefox 06:31:31 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:31:31 INFO - mozversion application_vendor: Mozilla 06:31:31 INFO - mozversion application_version: 50.0a1 06:31:31 INFO - mozversion platform_buildid: 20160706055522 06:31:31 INFO - mozversion platform_changeset: 5dc96caed88143bdfd03983a1a293ea90c0e672d 06:31:31 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:31:31 INFO - mozversion platform_version: 50.0a1 06:31:31 INFO - using testdate: 1467811891 06:31:31 INFO - actual date: 1467811891 06:31:31 INFO - starting webserver on 'localhost:34348' 06:31:31 INFO - SUITE-START | Running 2 tests 06:31:31 INFO - TEST-START | dromaeo_css 06:31:31 INFO - operating with platform_type : linux_ 06:31:31 INFO - Initialising browser for dromaeo_css test... 06:31:31 INFO - TEST-INFO | started process 3309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpafiKtA/profile http://localhost:34348/getInfo.html) 06:31:38 INFO - PROCESS | 3309 | __metrics Screen width/height:1600/1200 06:31:38 INFO - PROCESS | 3309 | colorDepth:24 06:31:38 INFO - PROCESS | 3309 | Browser inner width/height: 1024/697 06:31:38 INFO - PROCESS | 3309 | __metrics 06:31:39 INFO - PROCESS | 3309 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:31:40 INFO - TEST-INFO | 3309: exit 0 06:31:40 INFO - Browser initialized. 06:31:40 INFO - Running cycle 1/1 for dromaeo_css test... 06:31:40 INFO - TEST-INFO | started process 3392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpafiKtA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:31:52 INFO - PROCESS | 3392 | RSS: Main: 158552064 06:31:52 INFO - PROCESS | 3392 | 06:32:43 INFO - PROCESS | 3392 | 1467811963781 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] 06:34:57 INFO - PROCESS | 3392 | Cycle 1(1): loaded http://localhost:34348/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34348/tests/dromaeo/cssquery-ext.html) 06:34:58 INFO - PROCESS | 3392 | RSS: Main: 251514880 06:34:58 INFO - PROCESS | 3392 | 06:38:01 INFO - PROCESS | 3392 | Cycle 1(1): loaded http://localhost:34348/tests/dromaeo/cssquery-ext.html (next: http://localhost:34348/tests/dromaeo/cssquery-jquery.html) 06:38:01 INFO - PROCESS | 3392 | RSS: Main: 243159040 06:38:01 INFO - PROCESS | 3392 | 06:41:03 INFO - PROCESS | 3392 | Cycle 1(1): loaded http://localhost:34348/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34348/tests/dromaeo/cssquery-mootools.html) 06:41:04 INFO - PROCESS | 3392 | RSS: Main: 241274880 06:41:04 INFO - PROCESS | 3392 | 06:44:06 INFO - PROCESS | 3392 | Cycle 1(1): loaded http://localhost:34348/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34348/tests/dromaeo/cssquery-prototype.html) 06:44:07 INFO - PROCESS | 3392 | RSS: Main: 233914368 06:44:07 INFO - PROCESS | 3392 | 06:47:10 INFO - PROCESS | 3392 | Cycle 1(1): loaded http://localhost:34348/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34348/tests/dromaeo/cssquery-yui.html) 06:47:10 INFO - PROCESS | 3392 | RSS: Main: 214228992 06:47:10 INFO - PROCESS | 3392 | 06:50:13 INFO - PROCESS | 3392 | Cycle 1(1): loaded http://localhost:34348/tests/dromaeo/cssquery-yui.html (next: http://localhost:34348/tests/dromaeo/cssquery-dojo.html) 06:50:13 INFO - PROCESS | 3392 | RSS: Main: 266641408 06:50:13 INFO - PROCESS | 3392 | 06:50:13 INFO - PROCESS | 3392 | __start_tp_report 06:50:13 INFO - PROCESS | 3392 | _x_x_mozilla_page_load 06:50:13 INFO - PROCESS | 3392 | _x_x_mozilla_page_load_details 06:50:13 INFO - PROCESS | 3392 | |i|pagename|runs| 06:50:13 INFO - PROCESS | 3392 | |0;dojo.html;2646.510395576818;2647.3381654586356;2692.071235423779;2702.9999999999986;2704.7700945419624;4698.342232087511;4775.212090005145;4829.517048295169;4831.734254615999;4868.610511159108;4758.238681810911;4777.6177905767545;4795.568398844103;4818.734969576672;4836.903261934768;4431.1802316571375;4446.510883802787;4461.687681862271;4478.126765280772;4497.347884556737;4387.319965405367;4392.428984232045;4420.182266280733;4455.955440445603;4491.910161796778;4414.646828253748;4445.799939002753;4476.820927162909;4483.237849565566;4494.68537202396;4280.764557949312;4353.238183317939;4374.431323927901;4385.934210986838;4501.504834468222;4298.699091063627;4314.158739045887;4324.437823083011;4338.913221735579;4397.538258482878;4757.9286310705365;4767.976160119212;4803.063402636452;4805.279208118775;4810.11012962603;5043.823466178703;5101.846944591631;5110.770015349318;5138.948610513884;5146.897062058775;5131.307273518065;5143.5113664201845;5193.818216362409;5212.6611770235195;5233.947660523384;4815.061063092733;4832.95167048325;4851.10254602896;4861.951380486221;4865.513448655106;5121.411037730709;5169.043726910533;5219.5041471060185;5355.22349259363;5361.517463428232;5008.774605142778;5025.47232540578;5030.471800460972;5074.188129899198;5108.080545501845;5142.871428214325;5149.536541711264;5178.042062218502;5194.298769666047;5195.090859099642;5000.224965130411;5068.822591209364;5105.642605017613;5106.336176297058;5106.974465127725;5086.567641750418;5107.974460127675;5122.385313762373;5151.22731590257;5159.716215608178;4257.148570285955;4269.231538323132;4270.167317373144;4321.632661223768;4322.481302243751;3706.4625629283605;3723.106454450912;3743.232637309345;3760.4359346098304;3767.340715374853;4373.1472362888935;4405.29515277554;4429.446319210098;4434.3348497724955;4455.6658250631335;5123.513266239701;5139.794408223629;5140.228965655107;5142.331496905454;5182.896342073137;4298.032942587893;4420.7126536775;4425.84509542171;4428.645708343325;4472.955270447319;4533.77331133442;4575.3823233863;4585.1746685596245;4590.54094590545;4592.88517787058;4877.95122048775;4891.926621100615;4893.657443978887;4897.95102048975;4934.235193545006;4997.525235102659;5079.619028572945;5168.431472538093;5187.221916712523;5192.9740351298005;4811.855644330676;4830.033993201304;4851.054044461296;4854.514548545118;4895.7062576245535;5054.671446355975;5058.6206034548295;5060.240963855304;5064.366954130734;5078.619103567321;4879.926801097916;5033.521815427529;5068.265101560327;5112;5178.741062946762;4921.753912304299;4932.8766780830765;4935.259711043373;4945.727984960718;4976.054549635558;4918;4927.359443272495;4934.728589927445;4936.062148191832;4967.379077615298;4824.179889418737;4874.488178741323;4888.144574699342;4912.189488734319;4932.038252540864;5015.147424937696;5018.021485810232;5024.974875125601;5040.243963405518;5089.389273287081;4939.234418665113;4944.75276236194;4950.108980383421;4954.479779623088;5004.699718016931 06:50:13 INFO - PROCESS | 3392 | |1;ext.html;555.026656511805;575.7409165875357;584.4301805739407;585.487698264019;598.5869749872587;27933.441331173366;40093.19813603726;41565;41633.58366416335;41729.58270417295;41517.16965660685;42029.7898510507;42090.579094209046;42150.789246053806;42169.36745948813;7822.765317040484;7949.880751788728;7959.403044771636;7967.44227904047;7968.04383473981;7845.686172553091;7921.524708517479;7926.405519586026;7927.801804954894;7931.484453510532;7910.169432209622;7968.840623187532;7973.441859069868;7976.561289129096;7977.720779772709;7835.921640783633;7890.132085470594;7901.328387087105;7904.683812647487;7916.604169791487;7853.410994175402;7922;7924.366050715929;7924.4849084809875;7926.128125906146;39750;40091.39862902059;40178.799106004575;40195.59804401977;40232;2953.1288269960414;3091.0417770490994;3184.070699690342;3385.238321377695;3781.9243615127543;30008.249793755112;30150.24624384386;30167;30359.24101897448;30535.389292214255;3492;3523.4010218262956;3534.1871369584883;3551.6803487686234;3584.874529391459;248240.75879620668;249067;249546;249999;250337;32179.51730724041;33305.16737081544;33362.8331858344;52095;52633.73683131636;33649.625548678516;33699.15752106217;33836.154096147795;33843.66156338405;33885.32229355399;13433.596992090253;13632.454701812016;13650;13654.453821847213;13661.658458538417;10981.61564345244;11176.832347514794;11178.44107794607;11195.888041119484;11201.159913006393;7865.646045927947;7881.290683838482;7881.724139655199;7940.28537431634;7950.3242224410415;3089.474789285827;3102.674219206996;3119.953200701991;3133.8903138390046;3136.5138403547485;887.4054383563029;915.8992510823804;980.3921568627496;993.1756641987133;1038.5741845843168;28034.43931121366;28585.57121643177;29100.563491547644;29224.707752922623;29488.705112949025;800.5796956597833;945.3996712087736;957.3250858144991;982.7985263021063;1035.7100011996654;14364.497242596459;14862.70274594502;15093;15216.315265812844;15254.38982440712;383694;387390;389028;390160;391844;50710.74644626827;50748.23877641838;50910.490895091316;50945.49054509481;51357.743211283705;1028.861103750999;1157.2709193208225;1187.709011292239;1198.922070065443;1205.2647884790272;27959.860200698866;29310.560341594468;29518.852405737834;29544;30196.24509387195;42182.156356872074;42799.7860010698;42815.571844281156;42869;42869.57130428656;294501;299323;299717;300152;300603;22511.32466026022;23061.423464413525;23070.884645576665;24352.26943191707;24365.39086522851;38154;42351.78824105983;44129.77935110304;47504.762476187396;48514.75742621264;37235;37464;37480.437793432575;37846.62153378541;37940.43089353607;36406.81796591;37646;37734.43398348972;38000.80999594984;38500;36067;36560.26879462343;36976.63023369732;37369.25261494809;37478.81260593679;32398.760123988355;33770.8311458451;34484.137896552784;36958.445623315136;37579.436308454846;25779.226623201335;25855.870720647028;25917.52061984504;25940.48119037571;26067 06:50:13 INFO - PROCESS | 3392 | |2;jquery.html;355.8772223582863;372.7577074901314;377.211627698111;382.23171425434884;396.5518963571166;13048.412821423035;13322.134061286022;17951.91024044881;17956.012419316932;17986.4604061878;16506.339746410158;17677.82322176778;17679.204435800388;17679.55801104973;17689.734653980202;3794.354959656865;5081.060003899282;5283.392409872856;5284.207368894658;5285.445028272034;5943.078822782476;6318.71565779541;6325.114483972225;6339.778107766229;6403.039544068381;6080.908786368208;6268.780592679257;6286.559940804123;6294.779682711106;6297.6536290504;6304.779332723356;6326.620402775849;6332.208473940757;6333.524985626096;6351.618902865843;5274.077036518633;5397.46025397461;5400.351957765054;5401.918971215435;5402.540784033362;21305.360839174693;21471.248506302203;21838.23566175192;22239;22428.551428971492;1850.2691436882355;1900.9714854277197;1902.3817259390614;1924.653562358775;1939.3115444017312;9292.488913109777;9409.247260219166;9627.603997420334;10831.783364332749;14354.425822967069;1594.673092016134;1608.2923513653955;1620.870330373579;1628.9755653665204;1699.5411238965535;65537;65809.67095164493;68555;76942;80904.19095809026;15853.445129420415;17069.7439538407;17126.14369281531;17302.480925572254;17516.824831751775;29015.85492072526;29062.41875162527;29274.414511710074;29283.414331713248;29323.560146597818;9110;9397.624095036123;9531.99914009033;9579.760505987406;9600.66397676092;7729.381649468029;7797.454178207585;7918.524888506593;8002.279794818494;8022.478538894953;8614.26778723803;8631.482111073356;8879.467231966102;8932.598033088527;9132.360734748503;3186.729128024144;3249.447593909041;3347.916302092467;3414.4195486767308;3503.5095086687884;703.3537004656308;742.5025233093841;766.5439063757055;839.6179738219096;866.2117473099576;17775;18160.18279177414;18400.079996000415;18647.347342842935;18774.718379224323;850.7107583421542;859.621766422772;887.7203680840514;906.4425378392241;944.7071407863584;9579.856302155473;9742.853857192147;10012.949935250277;10208.081272685495;10229.079382855578;403347;417102;418823;419194;422791;84628;87461.12538874529;87517;87965.56017220001;87983.56008219918;901.3375169250595;915.3775432705824;920.5305294299822;933.3000249812641;934.7990182110879;15843.207839607743;15978.520644380687;16104.436344727877;16110.758338625164;16495;39919.60080399159;40521.79739101286;40741;40794.592054079076;41100;50859;51862.22206666828;52482;53424;53775.92448150937;7972.36221102322;8026.400147109077;8237.135100814328;8304;8374.2881855043;10779;12721.300328482022;12754.936225318814;12839.535778340996;12901.935490322863;10557.366558006544;10711.196660250669;10821.56713731442;10837.024667779937;11171.38557379352;11120;11165.38590377537;11183.161262905478;11308;11370.260933039326;10144.340617859816;10991.835122473009;11415.486303116213;11421.828672570084;11629.88370116288;7834.294913457816;8022.879656805269;8098.352131829557;8299;8370.790730231793;6864.107666003388;9140.268778497571;9980.60077596888;11130.276532025393;11400.201985860911 06:50:13 INFO - PROCESS | 3392 | |3;mootools.html;1391.7842734376175;1444.4655477473334;1511.5540915429947;1690.8816382853206;1710.7433884917252;7671.6547755351;8171;8250;8251.257386835183;8260.215279548449;6860.073890024845;7620.733274335399;7793.961030194855;7844.450888437812;8069.354451643869;2222.5221577360862;2250.5273892482596;2252.76345983671;2253.43664083979;2254.6843441918145;2237.8209743220586;2240.19353032908;2274.5223503064294;2279.6010698127843;2280.464090938628;1907.1417861962102;2162.23240749534;2230.453538882976;2238.541099074694;2258.22091378475;2217.268301460514;2220.888955552224;2233.4304752288226;2242.0807468937737;2253.019936327686;2196.1654571262816;2200.262911924507;2201.6477363621743;2204.9779502205092;2205.349421920537;8029.638666260033;8097.919020809834;8102.878456823093;8108.75673729789;8123.18768123183;4572.291294849304;4737.478877323491;4751.786169622341;4751.952480475185;4752;2795.9720402795915;2817.4646817104685;2917.693642167563;2921.8539073046477;2926.590277361171;886.902440731519;904.5206040798388;917.8898532176181;919.9172074513326;929.7861491856911;11022.724431889266;11053.834192487118;11058.060064894493;11060.723481912935;11065.225434219527;4081.714280000431;4192.161567686475;4325.048489332342;4360.280553708666;4365.628921541641;9423.811523769486;9489.383190092622;9500.667476638422;9503.28725345602;9527.428354298625;4732.621390288768;4756.929690819538;4757.738324392191;4764.595009424169;4780.760961951889;4185.6232939035635;4316.892077698083;4321.935170972438;4339.1104823511105;4352.978235108804;3703.4629978653484;3753.2305877295635;3834.501514803058;3844.75009124406;3856.2287542491613;1090.1605763562172;1172.0623501199007;1182.8935395814417;1183.6271574454192;1189.5301355964345;616.8180386785909;729.7628270812007;791.5804623549528;799.5682331540903;805.399977017126;5010;5221.6344855859725;5224.582033437316;5258.158694608845;5279.208118782213;434.7956460463577;438.79157400234635;444.87988243174163;446.9486009108929;608.0666177417643;3381.7801842880135;3428.0401487583517;3455.291665208626;3465.28961562879;3484.8431820568135;9696.806063878683;9805.166560842408;10016.098551130433;10022.649207277711;10030.147437467751;9890.851637225447;9905.405675659484;9960.35257708261;9973.401595904268;9973.650922217832;7217.097862767154;7529.510581812165;7533.397328213729;7551;7652.579108149105;5286.867234008531;5302.920456193237;5498.752556135064;5501.614886957875;5732.71336433185;9144.58849351794;9157.313201510047;9357.953210233905;9362.765930851783;9371.671991480265;8993.865092023756;9360.672376466791;9391.29565282593;9394.201492873182;9458.527073646152;6902.309769023058;6973.47698922593;7033;7038.577685338896;7039.542429742255;7448.702051917862;7476.214997425192;7521.548707077593;7654.425918056279;7688.423368247292;5839.0949402842625;6354.301026887131;6873.725050997904;7111.573305601681;7113.0753002109395;6928.896066559107;7018.157821061505;7034.648267586703;7071.893921591078;7101.147862256562;6264.342244064308;6291.842703932438;6325.019621958604;6326.304106548184;6327.746890124344;4316.374125751811;4317.546657600907;4466.28539433702;4481.910361792811;4555.658325625657;4515.164694531522;4536.72779633223;4571.634269258385;4596.287575425815;4623.7225766452775 06:50:13 INFO - PROCESS | 3392 | |4;prototype.html;300.71732571382904;306.9923251918703;309.5295151369919;310.11771510053904;313.5688428410935;4770.95229047709;4787.44944331402;4791.7604119794005;4806.639502037344;4857.51424857514;4720.8347707830235;4730.894751835434;4769.523047695228;4772.475027746945;4773.307870358796;3624.2207925296057;3633.981830090846;3724.5530536335677;3769.302679004379;3847.1343947611845;3797.1456422305037;3804.2771873344113;3812.6759225465867;3829.8468061277517;3830.195658911632;3595.334863050344;3770.057485628593;3789.9009287306785;3793.2223894101644;3811.8856434307013;3652;3751.2497500499735;3760.417135344026;3772.4718539404507;3773.811309434517;3357.1439282982683;3365.990202939133;3372.730181585467;3373.2747459296124;3380.6281309055985;4614.930776038362;4619.584237418615;4623;4635.5364463553715;4643.953560464386;4181.226473102486;4294.7423154610515;4296.548862369437;4305;4310.568943105664;4932.988737308843;4959.628027897922;4960.479149689303;4960.809405742596;4961.9751901240625;3648.5621725392857;3654.543182102237;3655.3968595181764;3675.4303083022173;3691.5754688210664;4968.627352948507;5204.843854684365;5208.713520756357;5210.140326846104;5219.243209734567;3731.2350968051483;3739.2147648994014;3745.382011968049;3749.887503374903;3753.793541355252;3789.9388171312075;3796.6393192646656;3799.2211596622624;3800.8217452589784;3802.6387493188104;4269.829206831754;4273.743575385487;4278.700490965664;4282.678799090018;4282.764447955392;4745.335653008581;4985.451600323961;5023.799048038038;5025.246213067996;5058.595312375001;1274.184521905981;1275.3686924972012;1275.4324325674986;1278.7506436245028;1283.525095714573;815.233680340478;815.6533473273835;861.6208868098017;889.7864512517078;891.5542228885557;4388.5830846069575;4393.055493069006;4406.140802543538;4444.355568442557;4444.377787109807;5111.936010871366;5119.180931051014;5123.3339665843205;5123.641345105882;5128.897422051538;4301.849435269751;4405.735655860594;4424.491183513873;4426.756528390905;4430;2698.231004163804;2707.7156898525373;2716.7283271672673;2720.055160560209;2722.564389697639;4828.223771331428;4835.588974937099;4841.426536375692;4843.612510999112;4847.903041939141;5021.221710634857;5203.401608814959;5207.843764687065;5218.478152184827;5260.605454590921;4909.754512274372;4932.802687892444;4948.282499037619;4949.232868905326;4964.379452568429;5176.171812509981;5178.679436743757;5187.714675692722;5192.3769147701005;5198.882240318349;4842.878928026827;5103.92344114846;5104.566111880532;5113.360829896263;5113.590912726899;4890;4918.2376731606655;4927.359443272351;4934.827281045146;4949.777260023379;3799.582045974885;3834.5206849143856;3843.2121415110396;3846.442265871489;3853.2293541292415;5025.170846810235;5117.8976420470635;5125.589952803842;5156.9742151289;5166.2767212589515;4956.430010548689;4959.380077490314;4971.701697898137;4977.104121258209;4987.077390682735;4962.156433406258;4969.900601988013;4969.975150124226;4990.80036798524;4992.775325110306;4734.928976065293;4880.170371037003;4885.096257192431;4931.876703082452;4937.185364414831;4841.700192408578;4930.654854160174;5023.874403139951;5057.8229761958155;5064.392272927273;4916.7541622919425;4927.802887884444;4927.802887884588;4941.555260026615;4977.502249774993 06:50:13 INFO - PROCESS | 3392 | |5;yui.html;652.8433176037751;723.9457040721944;736.502860569116;751.9725693054876;761.3794757272818;11247.831282530748;11939.104567157465;12355.135140540166;12368.07239457041;12383.69040773981;11899.52401903925;12014.699632509191;12036.097292703038;12045.939770301158;12050.819237711441;630.105250544226;763.8472305538887;770.9730159444421;788.3456730913329;793.3296364571928;795.4988357334871;797.4417907464768;797.6370751308141;797.924197201265;798.632628990665;832.7751507093081;834.6577903059747;835.6615570693879;836.7991681996308;836.8451836410253;654.8002859127964;801.6072124658933;821.9260266575977;824.983500329996;831.6756464978663;601.4076135007015;602.7950496831055;603.8550747820535;604.3533419241413;605.2978544887953;11763.294202347886;11836.46735896878;11852.585159519376;11863.288202707865;11882.168248222628;11845.94077029618;12198.695032624166;12228.449719762542;12457.128001039931;12609.117361784678;10845.783084338347;11014.50434730431;11089.112870970303;11108.777824443547;11147.219694621379;3157.778955473118;3227.5804145461175;3356.6978971892645;3398.796072235674;4021.959780402217;53566.46433535654;53730.73134634302;53889;60852;60930.69534652298;10026.498675066217;10153.847692284622;10255.538500767483;10272;10649.414282214397;17987;18039.909800450914;18088;18109.185086671132;18173.63652726938;6461.709223084972;6558.770443034471;6693.364130407604;6825.726970921207;6965.82585435358;3818.9427158592644;3865;3872.380419132925;3877.1470276539117;3982.920341593152;2984.5523171524446;3082.152408087794;3083.9074827755203;3086.706762857525;3088.5212792017273;521.5540712690671;521.6426747677853;529.1454301303368;532.2601583798523;533.7224643185522;468.3466564143001;550.1884720037912;551.7131091832305;552.4917076289823;603.9547033972469;8112.351011919032;8296.83406331882;8402.579871006425;8489.617967191367;8555.786105347415;483.7822979659097;497.74366201406303;518.8547206782107;531.4685314685315;544.6949708163362;3936.6653834423823;4008.238434697398;4057.9797101014306;4161.209370219649;4187.288161012635;51790;81996.18003820005;91909.54045229731;100052.49973750231;103245.48377258066;49587.76030599192;54712;80068;83156;84414.46756597311;46734.53265467302;62350.37649623446;63370.36629633737;65216.34783652198;66514.66742666256;8112.1076681566165;8885.511296878734;8892.377533572588;8937.59780809878;8978.775530611525;31119.68880311168;34873.47689784604;36083;42631.786841065594;42946.35580466358;60282;64844.351556485715;64846.675766620865;66004;66402.66798665976;10941.83587246208;11341.546338146713;11568.652940411801;11596.884031159918;11599.76800464003;12757.74484510286;12877.549285774952;12925.418356173806;13321.200727956353;13642.386092626055;11658.18392712502;11962.282263064244;12167.148299618942;12174.665281223348;12239.265644061385;12413.689657758629;12418.130730848754;12495.750084998068;12602.55891043809;13217.735645286848;11560.6531804046;11737.706557335794;11866.525338986688;12373.381330933596;12446.626601201979;10300.175985920958;10566;10705.8929410708;10773.946130269298;11033.834492482458;10047.246456515644;10055.49722513886;10423.950612350933;10528.947355263175;10596.841047384141 06:50:13 INFO - PROCESS | 3392 | __end_tp_report 06:50:13 INFO - PROCESS | 3392 | __start_cc_report 06:50:13 INFO - PROCESS | 3392 | _x_x_mozilla_cycle_collect,949 06:50:13 INFO - PROCESS | 3392 | __end_cc_report 06:50:13 INFO - PROCESS | 3392 | __startTimestamp1467813013895__endTimestamp 06:50:13 INFO - PROCESS | 3392 | 06:50:13 INFO - PROCESS | 3392 | ------- Summary: start ------- 06:50:13 INFO - PROCESS | 3392 | Number of tests: 6 06:50:13 INFO - PROCESS | 3392 | 06:50:13 INFO - PROCESS | 3392 | [#0] dojo.html Cycles:165 Average:4735.53 Median:4879.93 stddev:501.14 (10.3%) stddev-sans-first:475.13 06:50:13 INFO - PROCESS | 3392 | Values: 2646.5 2647.3 2692.1 2703.0 2704.8 4698.3 4775.2 4829.5 4831.7 4868.6 4758.2 4777.6 4795.6 4818.7 4836.9 4431.2 4446.5 4461.7 4478.1 4497.3 4387.3 4392.4 4420.2 4456.0 4491.9 4414.6 4445.8 4476.8 4483.2 4494.7 4280.8 4353.2 4374.4 4385.9 4501.5 4298.7 4314.2 4324.4 4338.9 4397.5 4757.9 4768.0 4803.1 4805.3 4810.1 5043.8 5101.8 5110.8 5138.9 5146.9 5131.3 5143.5 5193.8 5212.7 5233.9 4815.1 4833.0 4851.1 4862.0 4865.5 5121.4 5169.0 5219.5 5355.2 5361.5 5008.8 5025.5 5030.5 5074.2 5108.1 5142.9 5149.5 5178.0 5194.3 5195.1 5000.2 5068.8 5105.6 5106.3 5107.0 5086.6 5108.0 5122.4 5151.2 5159.7 4257.1 4269.2 4270.2 4321.6 4322.5 3706.5 3723.1 3743.2 3760.4 3767.3 4373.1 4405.3 4429.4 4434.3 4455.7 5123.5 5139.8 5140.2 5142.3 5182.9 4298.0 4420.7 4425.8 4428.6 4473.0 4533.8 4575.4 4585.2 4590.5 4592.9 4878.0 4891.9 4893.7 4898.0 4934.2 4997.5 5079.6 5168.4 5187.2 5193.0 4811.9 4830.0 4851.1 4854.5 4895.7 5054.7 5058.6 5060.2 5064.4 5078.6 4879.9 5033.5 5068.3 5112.0 5178.7 4921.8 4932.9 4935.3 4945.7 4976.1 4918.0 4927.4 4934.7 4936.1 4967.4 4824.2 4874.5 4888.1 4912.2 4932.0 5015.1 5018.0 5025.0 5040.2 5089.4 4939.2 4944.8 4950.1 4954.5 5004.7 06:50:13 INFO - PROCESS | 3392 | 06:50:13 INFO - PROCESS | 3392 | [#1] ext.html Cycles:180 Average:45985.00 Median:37471.41 stddev:83675.34 (223.3%) stddev-sans-first:83840.55 06:50:13 INFO - PROCESS | 3392 | Values: 555.0 575.7 584.4 585.5 598.6 27933.4 40093.2 41565.0 41633.6 41729.6 41517.2 42029.8 42090.6 42150.8 42169.4 7822.8 7949.9 7959.4 7967.4 7968.0 7845.7 7921.5 7926.4 7927.8 7931.5 7910.2 7968.8 7973.4 7976.6 7977.7 7835.9 7890.1 7901.3 7904.7 7916.6 7853.4 7922.0 7924.4 7924.5 7926.1 39750.0 40091.4 40178.8 40195.6 40232.0 2953.1 3091.0 3184.1 3385.2 3781.9 30008.2 30150.2 30167.0 30359.2 30535.4 3492.0 3523.4 3534.2 3551.7 3584.9 248240.8 249067.0 249546.0 249999.0 250337.0 32179.5 33305.2 33362.8 52095.0 52633.7 33649.6 33699.2 33836.2 33843.7 33885.3 13433.6 13632.5 13650.0 13654.5 13661.7 10981.6 11176.8 11178.4 11195.9 11201.2 7865.6 7881.3 7881.7 7940.3 7950.3 3089.5 3102.7 3120.0 3133.9 3136.5 887.4 915.9 980.4 993.2 1038.6 28034.4 28585.6 29100.6 29224.7 29488.7 800.6 945.4 957.3 982.8 1035.7 14364.5 14862.7 15093.0 15216.3 15254.4 383694.0 387390.0 389028.0 390160.0 391844.0 50710.7 50748.2 50910.5 50945.5 51357.7 1028.9 1157.3 1187.7 1198.9 1205.3 27959.9 29310.6 29518.9 29544.0 30196.2 42182.2 42799.8 42815.6 42869.0 42869.6 294501.0 299323.0 299717.0 300152.0 300603.0 22511.3 23061.4 23070.9 24352.3 24365.4 38154.0 42351.8 44129.8 47504.8 48514.8 37235.0 37464.0 37480.4 37846.6 37940.4 36406.8 37646.0 37734.4 38000.8 38500.0 36067.0 36560.3 36976.6 37369.3 37478.8 32398.8 33770.8 34484.1 36958.4 37579.4 25779.2 25855.9 25917.5 25940.5 26067.0 06:50:13 INFO - PROCESS | 3392 | 06:50:13 INFO - PROCESS | 3392 | [#2] jquery.html Cycles:180 Average:26705.82 Median:419008.50 stddev:68699.29 (16.4%) stddev-sans-first:68863.52 06:50:13 INFO - PROCESS | 3392 | Values: 355.9 372.8 377.2 382.2 396.6 13048.4 13322.1 17951.9 17956.0 17986.5 16506.3 17677.8 17679.2 17679.6 17689.7 3794.4 5081.1 5283.4 5284.2 5285.4 5943.1 6318.7 6325.1 6339.8 6403.0 6080.9 6268.8 6286.6 6294.8 6297.7 6304.8 6326.6 6332.2 6333.5 6351.6 5274.1 5397.5 5400.4 5401.9 5402.5 21305.4 21471.2 21838.2 22239.0 22428.6 1850.3 1901.0 1902.4 1924.7 1939.3 9292.5 9409.2 9627.6 10831.8 14354.4 1594.7 1608.3 1620.9 1629.0 1699.5 65537.0 65809.7 68555.0 76942.0 80904.2 15853.4 17069.7 17126.1 17302.5 17516.8 29015.9 29062.4 29274.4 29283.4 29323.6 9110.0 9397.6 9532.0 9579.8 9600.7 7729.4 7797.5 7918.5 8002.3 8022.5 8614.3 8631.5 8879.5 8932.6 9132.4 3186.7 3249.4 3347.9 3414.4 3503.5 703.4 742.5 766.5 839.6 866.2 17775.0 18160.2 18400.1 18647.3 18774.7 850.7 859.6 887.7 906.4 944.7 9579.9 9742.9 10012.9 10208.1 10229.1 403347.0 417102.0 418823.0 419194.0 422791.0 84628.0 87461.1 87517.0 87965.6 87983.6 901.3 915.4 920.5 933.3 934.8 15843.2 15978.5 16104.4 16110.8 16495.0 39919.6 40521.8 40741.0 40794.6 41100.0 50859.0 51862.2 52482.0 53424.0 53775.9 7972.4 8026.4 8237.1 8304.0 8374.3 10779.0 12721.3 12754.9 12839.5 12901.9 10557.4 10711.2 10821.6 10837.0 11171.4 11120.0 11165.4 11183.2 11308.0 11370.3 10144.3 10991.8 11415.5 11421.8 11629.9 7834.3 8022.9 8098.4 8299.0 8370.8 6864.1 9140.3 9980.6 11130.3 11400.2 06:50:13 INFO - PROCESS | 3392 | 06:50:13 INFO - PROCESS | 3392 | [#3] mootools.html Cycles:180 Average:5240.64 Median:4772.68 stddev:3005.35 (63.0%) stddev-sans-first:2999.86 06:50:13 INFO - PROCESS | 3392 | Values: 1391.8 1444.5 1511.6 1690.9 1710.7 7671.7 8171.0 8250.0 8251.3 8260.2 6860.1 7620.7 7794.0 7844.5 8069.4 2222.5 2250.5 2252.8 2253.4 2254.7 2237.8 2240.2 2274.5 2279.6 2280.5 1907.1 2162.2 2230.5 2238.5 2258.2 2217.3 2220.9 2233.4 2242.1 2253.0 2196.2 2200.3 2201.6 2205.0 2205.3 8029.6 8097.9 8102.9 8108.8 8123.2 4572.3 4737.5 4751.8 4752.0 4752.0 2796.0 2817.5 2917.7 2921.9 2926.6 886.9 904.5 917.9 919.9 929.8 11022.7 11053.8 11058.1 11060.7 11065.2 4081.7 4192.2 4325.0 4360.3 4365.6 9423.8 9489.4 9500.7 9503.3 9527.4 4732.6 4756.9 4757.7 4764.6 4780.8 4185.6 4316.9 4321.9 4339.1 4353.0 3703.5 3753.2 3834.5 3844.8 3856.2 1090.2 1172.1 1182.9 1183.6 1189.5 616.8 729.8 791.6 799.6 805.4 5010.0 5221.6 5224.6 5258.2 5279.2 434.8 438.8 444.9 446.9 608.1 3381.8 3428.0 3455.3 3465.3 3484.8 9696.8 9805.2 10016.1 10022.6 10030.1 9890.9 9905.4 9960.4 9973.4 9973.7 7217.1 7529.5 7533.4 7551.0 7652.6 5286.9 5302.9 5498.8 5501.6 5732.7 9144.6 9157.3 9358.0 9362.8 9371.7 8993.9 9360.7 9391.3 9394.2 9458.5 6902.3 6973.5 7033.0 7038.6 7039.5 7448.7 7476.2 7521.5 7654.4 7688.4 5839.1 6354.3 6873.7 7111.6 7113.1 6928.9 7018.2 7034.6 7071.9 7101.1 6264.3 6291.8 6325.0 6326.3 6327.7 4316.4 4317.5 4466.3 4481.9 4555.7 4515.2 4536.7 4571.6 4596.3 4623.7 06:50:13 INFO - PROCESS | 3392 | 06:50:13 INFO - PROCESS | 3392 | [#4] prototype.html Cycles:180 Average:4176.21 Median:4771.71 stddev:1194.83 (25.0%) stddev-sans-first:1162.24 06:50:13 INFO - PROCESS | 3392 | Values: 300.7 307.0 309.5 310.1 313.6 4771.0 4787.4 4791.8 4806.6 4857.5 4720.8 4730.9 4769.5 4772.5 4773.3 3624.2 3634.0 3724.6 3769.3 3847.1 3797.1 3804.3 3812.7 3829.8 3830.2 3595.3 3770.1 3789.9 3793.2 3811.9 3652.0 3751.2 3760.4 3772.5 3773.8 3357.1 3366.0 3372.7 3373.3 3380.6 4614.9 4619.6 4623.0 4635.5 4644.0 4181.2 4294.7 4296.5 4305.0 4310.6 4933.0 4959.6 4960.5 4960.8 4962.0 3648.6 3654.5 3655.4 3675.4 3691.6 4968.6 5204.8 5208.7 5210.1 5219.2 3731.2 3739.2 3745.4 3749.9 3753.8 3789.9 3796.6 3799.2 3800.8 3802.6 4269.8 4273.7 4278.7 4282.7 4282.8 4745.3 4985.5 5023.8 5025.2 5058.6 1274.2 1275.4 1275.4 1278.8 1283.5 815.2 815.7 861.6 889.8 891.6 4388.6 4393.1 4406.1 4444.4 4444.4 5111.9 5119.2 5123.3 5123.6 5128.9 4301.8 4405.7 4424.5 4426.8 4430.0 2698.2 2707.7 2716.7 2720.1 2722.6 4828.2 4835.6 4841.4 4843.6 4847.9 5021.2 5203.4 5207.8 5218.5 5260.6 4909.8 4932.8 4948.3 4949.2 4964.4 5176.2 5178.7 5187.7 5192.4 5198.9 4842.9 5103.9 5104.6 5113.4 5113.6 4890.0 4918.2 4927.4 4934.8 4949.8 3799.6 3834.5 3843.2 3846.4 3853.2 5025.2 5117.9 5125.6 5157.0 5166.3 4956.4 4959.4 4971.7 4977.1 4987.1 4962.2 4969.9 4970.0 4990.8 4992.8 4734.9 4880.2 4885.1 4931.9 4937.2 4841.7 4930.7 5023.9 5057.8 5064.4 4916.8 4927.8 4927.8 4941.6 4977.5 06:50:13 INFO - PROCESS | 3392 | 06:50:13 INFO - PROCESS | 3392 | [#5] yui.html Cycles:180 Average:16381.98 Median:4015.10 stddev:22509.75 (560.6%) stddev-sans-first:22541.91 06:50:13 INFO - PROCESS | 3392 | Values: 652.8 723.9 736.5 752.0 761.4 11247.8 11939.1 12355.1 12368.1 12383.7 11899.5 12014.7 12036.1 12045.9 12050.8 630.1 763.8 771.0 788.3 793.3 795.5 797.4 797.6 797.9 798.6 832.8 834.7 835.7 836.8 836.8 654.8 801.6 821.9 825.0 831.7 601.4 602.8 603.9 604.4 605.3 11763.3 11836.5 11852.6 11863.3 11882.2 11845.9 12198.7 12228.4 12457.1 12609.1 10845.8 11014.5 11089.1 11108.8 11147.2 3157.8 3227.6 3356.7 3398.8 4022.0 53566.5 53730.7 53889.0 60852.0 60930.7 10026.5 10153.8 10255.5 10272.0 10649.4 17987.0 18039.9 18088.0 18109.2 18173.6 6461.7 6558.8 6693.4 6825.7 6965.8 3818.9 3865.0 3872.4 3877.1 3982.9 2984.6 3082.2 3083.9 3086.7 3088.5 521.6 521.6 529.1 532.3 533.7 468.3 550.2 551.7 552.5 604.0 8112.4 8296.8 8402.6 8489.6 8555.8 483.8 497.7 518.9 531.5 544.7 3936.7 4008.2 4058.0 4161.2 4187.3 51790.0 81996.2 91909.5 100052.5 103245.5 49587.8 54712.0 80068.0 83156.0 84414.5 46734.5 62350.4 63370.4 65216.3 66514.7 8112.1 8885.5 8892.4 8937.6 8978.8 31119.7 34873.5 36083.0 42631.8 42946.4 60282.0 64844.4 64846.7 66004.0 66402.7 10941.8 11341.5 11568.7 11596.9 11599.8 12757.7 12877.5 12925.4 13321.2 13642.4 11658.2 11962.3 12167.1 12174.7 12239.3 12413.7 12418.1 12495.8 12602.6 13217.7 11560.7 11737.7 11866.5 12373.4 12446.6 10300.2 10566.0 10705.9 10773.9 11033.8 10047.2 10055.5 10424.0 10528.9 10596.8 06:50:13 INFO - PROCESS | 3392 | -------- Summary: end -------- 06:50:13 INFO - PROCESS | 3392 | 06:50:14 INFO - TEST-INFO | 3392: exit 0 06:50:14 INFO - TEST-OK | dromaeo_css | took 1122697ms 06:50:14 INFO - TEST-START | kraken 06:50:14 INFO - operating with platform_type : linux_ 06:50:14 INFO - Initialising browser for kraken test... 06:50:14 INFO - TEST-INFO | started process 3576 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD7PQ1v/profile http://localhost:34348/getInfo.html) 06:50:19 INFO - PROCESS | 3576 | __metrics Screen width/height:1600/1200 06:50:19 INFO - PROCESS | 3576 | colorDepth:24 06:50:19 INFO - PROCESS | 3576 | Browser inner width/height: 1024/697 06:50:19 INFO - PROCESS | 3576 | __metrics 06:50:20 INFO - PROCESS | 3576 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:50:21 INFO - TEST-INFO | 3576: exit 0 06:50:21 INFO - Browser initialized. 06:50:21 INFO - Running cycle 1/1 for kraken test... 06:50:21 INFO - TEST-INFO | started process 3654 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpD7PQ1v/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:50:33 INFO - PROCESS | 3654 | RSS: Main: 158863360 06:50:33 INFO - PROCESS | 3654 | 06:50:35 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34348/tests/kraken/driver.html?testName=audio-beat-detection) 06:50:36 INFO - PROCESS | 3654 | RSS: Main: 216395776 06:50:36 INFO - PROCESS | 3654 | 06:50:39 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34348/tests/kraken/driver.html?testName=audio-dft) 06:50:39 INFO - PROCESS | 3654 | RSS: Main: 205123584 06:50:39 INFO - PROCESS | 3654 | 06:50:43 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34348/tests/kraken/driver.html?testName=audio-fft) 06:50:43 INFO - PROCESS | 3654 | RSS: Main: 270675968 06:50:43 INFO - PROCESS | 3654 | 06:50:45 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34348/tests/kraken/driver.html?testName=audio-oscillator) 06:50:46 INFO - PROCESS | 3654 | RSS: Main: 181882880 06:50:46 INFO - PROCESS | 3654 | 06:50:48 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34348/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:50:49 INFO - PROCESS | 3654 | RSS: Main: 186208256 06:50:49 INFO - PROCESS | 3654 | 06:50:52 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34348/tests/kraken/driver.html?testName=imaging-darkroom) 06:50:53 INFO - PROCESS | 3654 | RSS: Main: 222101504 06:50:53 INFO - PROCESS | 3654 | 06:50:56 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34348/tests/kraken/driver.html?testName=imaging-desaturate) 06:50:57 INFO - PROCESS | 3654 | RSS: Main: 222474240 06:50:57 INFO - PROCESS | 3654 | 06:51:00 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34348/tests/kraken/driver.html?testName=json-parse-financial) 06:51:00 INFO - PROCESS | 3654 | RSS: Main: 222646272 06:51:00 INFO - PROCESS | 3654 | 06:51:02 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34348/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:51:03 INFO - PROCESS | 3654 | RSS: Main: 210636800 06:51:03 INFO - PROCESS | 3654 | 06:51:04 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34348/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:51:05 INFO - PROCESS | 3654 | RSS: Main: 215793664 06:51:05 INFO - PROCESS | 3654 | 06:51:07 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34348/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:51:08 INFO - PROCESS | 3654 | RSS: Main: 212963328 06:51:08 INFO - PROCESS | 3654 | 06:51:11 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:51:11 INFO - PROCESS | 3654 | RSS: Main: 225177600 06:51:11 INFO - PROCESS | 3654 | 06:51:14 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:51:15 INFO - PROCESS | 3654 | RSS: Main: 226811904 06:51:15 INFO - PROCESS | 3654 | 06:51:16 INFO - PROCESS | 3654 | Cycle 1(1): loaded http://localhost:34348/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34348/tests/kraken/driver.html?testName=ai-astar) 06:51:17 INFO - PROCESS | 3654 | RSS: Main: 268419072 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | __start_tp_report 06:51:17 INFO - PROCESS | 3654 | _x_x_mozilla_page_load 06:51:17 INFO - PROCESS | 3654 | _x_x_mozilla_page_load_details 06:51:17 INFO - PROCESS | 3654 | |i|pagename|runs| 06:51:17 INFO - PROCESS | 3654 | |0;ai-astar;104;115;113;113;112;112;111;111;110;112 06:51:17 INFO - PROCESS | 3654 | |1;audio-beat-detection;154;125;123;175;122;132;145;121;168;124 06:51:17 INFO - PROCESS | 3654 | |2;audio-dft;161;161;161;161;161;161;164;161;163;162 06:51:17 INFO - PROCESS | 3654 | |3;audio-fft;78;76;76;122;76;76;75;76;104;75 06:51:17 INFO - PROCESS | 3654 | |4;audio-oscillator;86;84;122;86;86;84;129;84;85;121 06:51:17 INFO - PROCESS | 3654 | |5;imaging-gaussian-blur;117;116;117;117;118;117;117;117;117;117 06:51:17 INFO - PROCESS | 3654 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 06:51:17 INFO - PROCESS | 3654 | |7;imaging-desaturate;95;95;95;95;96;95;96;95;95;95 06:51:17 INFO - PROCESS | 3654 | |8;json-parse-financial;65;64;62;63;64;64;64;64;63;62 06:51:17 INFO - PROCESS | 3654 | |9;json-stringify-tinderbox;64;65;64;64;65;64;63;64;64;65 06:51:17 INFO - PROCESS | 3654 | |10;stanford-crypto-aes;78;79;78;77;83;79;86;78;77;81 06:51:17 INFO - PROCESS | 3654 | |11;stanford-crypto-ccm;130;136;130;136;137;132;129;131;204;132 06:51:17 INFO - PROCESS | 3654 | |12;stanford-crypto-pbkdf2;165;168;167;164;163;166;164;164;162;163 06:51:17 INFO - PROCESS | 3654 | |13;stanford-crypto-sha256-iterative;67;66;66;65;66;65;66;66;65;65 06:51:17 INFO - PROCESS | 3654 | __end_tp_report 06:51:17 INFO - PROCESS | 3654 | __start_cc_report 06:51:17 INFO - PROCESS | 3654 | _x_x_mozilla_cycle_collect,1920 06:51:17 INFO - PROCESS | 3654 | __end_cc_report 06:51:17 INFO - PROCESS | 3654 | __startTimestamp1467813077159__endTimestamp 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | ------- Summary: start ------- 06:51:17 INFO - PROCESS | 3654 | Number of tests: 14 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.91 (2.6%) stddev-sans-first:1.45 06:51:17 INFO - PROCESS | 3654 | Values: 104.0 115.0 113.0 113.0 112.0 112.0 111.0 111.0 110.0 112.0 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:138.50 stddev:20.38 (14.7%) stddev-sans-first:20.87 06:51:17 INFO - PROCESS | 3654 | Values: 154.0 125.0 123.0 175.0 122.0 132.0 145.0 121.0 168.0 124.0 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.00 stddev:1.07 (0.7%) stddev-sans-first:1.12 06:51:17 INFO - PROCESS | 3654 | Values: 161.0 161.0 161.0 161.0 161.0 161.0 164.0 161.0 163.0 162.0 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:16.19 (21.3%) stddev-sans-first:17.05 06:51:17 INFO - PROCESS | 3654 | Values: 78.0 76.0 76.0 122.0 76.0 76.0 75.0 76.0 104.0 75.0 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#4] audio-oscillator Cycles:10 Average:96.70 Median:84.50 stddev:18.97 (22.4%) stddev-sans-first:19.72 06:51:17 INFO - PROCESS | 3654 | Values: 86.0 84.0 122.0 86.0 86.0 84.0 129.0 84.0 85.0 121.0 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 06:51:17 INFO - PROCESS | 3654 | Values: 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 06:51:17 INFO - PROCESS | 3654 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:51:17 INFO - PROCESS | 3654 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 95.0 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#8] json-parse-financial Cycles:10 Average:63.50 Median:64.00 stddev:0.97 (1.5%) stddev-sans-first:0.87 06:51:17 INFO - PROCESS | 3654 | Values: 65.0 64.0 62.0 63.0 64.0 64.0 64.0 64.0 63.0 62.0 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 06:51:17 INFO - PROCESS | 3654 | Values: 64.0 65.0 64.0 64.0 65.0 64.0 63.0 64.0 64.0 65.0 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:2.91 (3.7%) stddev-sans-first:3.03 06:51:17 INFO - PROCESS | 3654 | Values: 78.0 79.0 78.0 77.0 83.0 79.0 86.0 78.0 77.0 81.0 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:134.00 stddev:22.77 (17.0%) stddev-sans-first:23.88 06:51:17 INFO - PROCESS | 3654 | Values: 130.0 136.0 130.0 136.0 137.0 132.0 129.0 131.0 204.0 132.0 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:164.50 stddev:1.90 (1.2%) stddev-sans-first:2.01 06:51:17 INFO - PROCESS | 3654 | Values: 165.0 168.0 167.0 164.0 163.0 166.0 164.0 164.0 162.0 163.0 06:51:17 INFO - PROCESS | 3654 | 06:51:17 INFO - PROCESS | 3654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.53 06:51:17 INFO - PROCESS | 3654 | Values: 67.0 66.0 66.0 65.0 66.0 65.0 66.0 66.0 65.0 65.0 06:51:17 INFO - PROCESS | 3654 | -------- Summary: end -------- 06:51:17 INFO - PROCESS | 3654 | 06:51:18 INFO - TEST-INFO | 3654: exit 0 06:51:18 INFO - TEST-OK | kraken | took 63571ms 06:51:18 INFO - SUITE-END | took 1186s 06:51:18 INFO - Completed test suite (00:19:46) 06:51:18 INFO - javascript benchmark 06:51:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2646.510395576818, 2647.3381654586356, 2692.071235423779, 2702.9999999999986, 2704.7700945419624, 4698.342232087511, 4775.212090005145, 4829.517048295169, 4831.734254615999, 4868.610511159108, 4758.238681810911, 4777.6177905767545, 4795.568398844103, 4818.734969576672, 4836.903261934768, 4431.1802316571375, 4446.510883802787, 4461.687681862271, 4478.126765280772, 4497.347884556737, 4387.319965405367, 4392.428984232045, 4420.182266280733, 4455.955440445603, 4491.910161796778, 4414.646828253748, 4445.799939002753, 4476.820927162909, 4483.237849565566, 4494.68537202396, 4280.764557949312, 4353.238183317939, 4374.431323927901, 4385.934210986838, 4501.504834468222, 4298.699091063627, 4314.158739045887, 4324.437823083011, 4338.913221735579, 4397.538258482878, 4757.9286310705365, 4767.976160119212, 4803.063402636452, 4805.279208118775, 4810.11012962603, 5043.823466178703, 5101.846944591631, 5110.770015349318, 5138.948610513884, 5146.897062058775, 5131.307273518065, 5143.5113664201845, 5193.818216362409, 5212.6611770235195, 5233.947660523384, 4815.061063092733, 4832.95167048325, 4851.10254602896, 4861.951380486221, 4865.513448655106, 5121.411037730709, 5169.043726910533, 5219.5041471060185, 5355.22349259363, 5361.517463428232, 5008.774605142778, 5025.47232540578, 5030.471800460972, 5074.188129899198, 5108.080545501845, 5142.871428214325, 5149.536541711264, 5178.042062218502, 5194.298769666047, 5195.090859099642, 5000.224965130411, 5068.822591209364, 5105.642605017613, 5106.336176297058, 5106.974465127725, 5086.567641750418, 5107.974460127675, 5122.385313762373, 5151.22731590257, 5159.716215608178, 4257.148570285955, 4269.231538323132, 4270.167317373144, 4321.632661223768, 4322.481302243751, 3706.4625629283605, 3723.106454450912, 3743.232637309345, 3760.4359346098304, 3767.340715374853, 4373.1472362888935, 4405.29515277554, 4429.446319210098, 4434.3348497724955, 4455.6658250631335, 5123.513266239701, 5139.794408223629, 5140.228965655107, 5142.331496905454, 5182.896342073137, 4298.032942587893, 4420.7126536775, 4425.84509542171, 4428.645708343325, 4472.955270447319, 4533.77331133442, 4575.3823233863, 4585.1746685596245, 4590.54094590545, 4592.88517787058, 4877.95122048775, 4891.926621100615, 4893.657443978887, 4897.95102048975, 4934.235193545006, 4997.525235102659, 5079.619028572945, 5168.431472538093, 5187.221916712523, 5192.9740351298005, 4811.855644330676, 4830.033993201304, 4851.054044461296, 4854.514548545118, 4895.7062576245535, 5054.671446355975, 5058.6206034548295, 5060.240963855304, 5064.366954130734, 5078.619103567321, 4879.926801097916, 5033.521815427529, 5068.265101560327, 5112.0, 5178.741062946762, 4921.753912304299, 4932.8766780830765, 4935.259711043373, 4945.727984960718, 4976.054549635558, 4918.0, 4927.359443272495, 4934.728589927445, 4936.062148191832, 4967.379077615298, 4824.179889418737, 4874.488178741323, 4888.144574699342, 4912.189488734319, 4932.038252540864, 5015.147424937696, 5018.021485810232, 5024.974875125601, 5040.243963405518, 5089.389273287081, 4939.234418665113, 4944.75276236194, 4950.108980383421, 4954.479779623088, 5004.699718016931], "value": 4703.209216361146, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.026656511805, 575.7409165875357, 584.4301805739407, 585.487698264019, 598.5869749872587, 27933.441331173366, 40093.19813603726, 41565.0, 41633.58366416335, 41729.58270417295, 41517.16965660685, 42029.7898510507, 42090.579094209046, 42150.789246053806, 42169.36745948813, 7822.765317040484, 7949.880751788728, 7959.403044771636, 7967.44227904047, 7968.04383473981, 7845.686172553091, 7921.524708517479, 7926.405519586026, 7927.801804954894, 7931.484453510532, 7910.169432209622, 7968.840623187532, 7973.441859069868, 7976.561289129096, 7977.720779772709, 7835.921640783633, 7890.132085470594, 7901.328387087105, 7904.683812647487, 7916.604169791487, 7853.410994175402, 7922.0, 7924.366050715929, 7924.4849084809875, 7926.128125906146, 39750.0, 40091.39862902059, 40178.799106004575, 40195.59804401977, 40232.0, 2953.1288269960414, 3091.0417770490994, 3184.070699690342, 3385.238321377695, 3781.9243615127543, 30008.249793755112, 30150.24624384386, 30167.0, 30359.24101897448, 30535.389292214255, 3492.0, 3523.4010218262956, 3534.1871369584883, 3551.6803487686234, 3584.874529391459, 248240.75879620668, 249067.0, 249546.0, 249999.0, 250337.0, 32179.51730724041, 33305.16737081544, 33362.8331858344, 52095.0, 52633.73683131636, 33649.625548678516, 33699.15752106217, 33836.154096147795, 33843.66156338405, 33885.32229355399, 13433.596992090253, 13632.454701812016, 13650.0, 13654.453821847213, 13661.658458538417, 10981.61564345244, 11176.832347514794, 11178.44107794607, 11195.888041119484, 11201.159913006393, 7865.646045927947, 7881.290683838482, 7881.724139655199, 7940.28537431634, 7950.3242224410415, 3089.474789285827, 3102.674219206996, 3119.953200701991, 3133.8903138390046, 3136.5138403547485, 887.4054383563029, 915.8992510823804, 980.3921568627496, 993.1756641987133, 1038.5741845843168, 28034.43931121366, 28585.57121643177, 29100.563491547644, 29224.707752922623, 29488.705112949025, 800.5796956597833, 945.3996712087736, 957.3250858144991, 982.7985263021063, 1035.7100011996654, 14364.497242596459, 14862.70274594502, 15093.0, 15216.315265812844, 15254.38982440712, 383694.0, 387390.0, 389028.0, 390160.0, 391844.0, 50710.74644626827, 50748.23877641838, 50910.490895091316, 50945.49054509481, 51357.743211283705, 1028.861103750999, 1157.2709193208225, 1187.709011292239, 1198.922070065443, 1205.2647884790272, 27959.860200698866, 29310.560341594468, 29518.852405737834, 29544.0, 30196.24509387195, 42182.156356872074, 42799.7860010698, 42815.571844281156, 42869.0, 42869.57130428656, 294501.0, 299323.0, 299717.0, 300152.0, 300603.0, 22511.32466026022, 23061.423464413525, 23070.884645576665, 24352.26943191707, 24365.39086522851, 38154.0, 42351.78824105983, 44129.77935110304, 47504.762476187396, 48514.75742621264, 37235.0, 37464.0, 37480.437793432575, 37846.62153378541, 37940.43089353607, 36406.81796591, 37646.0, 37734.43398348972, 38000.80999594984, 38500.0, 36067.0, 36560.26879462343, 36976.63023369732, 37369.25261494809, 37478.81260593679, 32398.760123988355, 33770.8311458451, 34484.137896552784, 36958.445623315136, 37579.436308454846, 25779.226623201335, 25855.870720647028, 25917.52061984504, 25940.48119037571, 26067.0], "value": 16619.83061392518, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.8772223582863, 372.7577074901314, 377.211627698111, 382.23171425434884, 396.5518963571166, 13048.412821423035, 13322.134061286022, 17951.91024044881, 17956.012419316932, 17986.4604061878, 16506.339746410158, 17677.82322176778, 17679.204435800388, 17679.55801104973, 17689.734653980202, 3794.354959656865, 5081.060003899282, 5283.392409872856, 5284.207368894658, 5285.445028272034, 5943.078822782476, 6318.71565779541, 6325.114483972225, 6339.778107766229, 6403.039544068381, 6080.908786368208, 6268.780592679257, 6286.559940804123, 6294.779682711106, 6297.6536290504, 6304.779332723356, 6326.620402775849, 6332.208473940757, 6333.524985626096, 6351.618902865843, 5274.077036518633, 5397.46025397461, 5400.351957765054, 5401.918971215435, 5402.540784033362, 21305.360839174693, 21471.248506302203, 21838.23566175192, 22239.0, 22428.551428971492, 1850.2691436882355, 1900.9714854277197, 1902.3817259390614, 1924.653562358775, 1939.3115444017312, 9292.488913109777, 9409.247260219166, 9627.603997420334, 10831.783364332749, 14354.425822967069, 1594.673092016134, 1608.2923513653955, 1620.870330373579, 1628.9755653665204, 1699.5411238965535, 65537.0, 65809.67095164493, 68555.0, 76942.0, 80904.19095809026, 15853.445129420415, 17069.7439538407, 17126.14369281531, 17302.480925572254, 17516.824831751775, 29015.85492072526, 29062.41875162527, 29274.414511710074, 29283.414331713248, 29323.560146597818, 9110.0, 9397.624095036123, 9531.99914009033, 9579.760505987406, 9600.66397676092, 7729.381649468029, 7797.454178207585, 7918.524888506593, 8002.279794818494, 8022.478538894953, 8614.26778723803, 8631.482111073356, 8879.467231966102, 8932.598033088527, 9132.360734748503, 3186.729128024144, 3249.447593909041, 3347.916302092467, 3414.4195486767308, 3503.5095086687884, 703.3537004656308, 742.5025233093841, 766.5439063757055, 839.6179738219096, 866.2117473099576, 17775.0, 18160.18279177414, 18400.079996000415, 18647.347342842935, 18774.718379224323, 850.7107583421542, 859.621766422772, 887.7203680840514, 906.4425378392241, 944.7071407863584, 9579.856302155473, 9742.853857192147, 10012.949935250277, 10208.081272685495, 10229.079382855578, 403347.0, 417102.0, 418823.0, 419194.0, 422791.0, 84628.0, 87461.12538874529, 87517.0, 87965.56017220001, 87983.56008219918, 901.3375169250595, 915.3775432705824, 920.5305294299822, 933.3000249812641, 934.7990182110879, 15843.207839607743, 15978.520644380687, 16104.436344727877, 16110.758338625164, 16495.0, 39919.60080399159, 40521.79739101286, 40741.0, 40794.592054079076, 41100.0, 50859.0, 51862.22206666828, 52482.0, 53424.0, 53775.92448150937, 7972.36221102322, 8026.400147109077, 8237.135100814328, 8304.0, 8374.2881855043, 10779.0, 12721.300328482022, 12754.936225318814, 12839.535778340996, 12901.935490322863, 10557.366558006544, 10711.196660250669, 10821.56713731442, 10837.024667779937, 11171.38557379352, 11120.0, 11165.38590377537, 11183.161262905478, 11308.0, 11370.260933039326, 10144.340617859816, 10991.835122473009, 11415.486303116213, 11421.828672570084, 11629.88370116288, 7834.294913457816, 8022.879656805269, 8098.352131829557, 8299.0, 8370.790730231793, 6864.107666003388, 9140.268778497571, 9980.60077596888, 11130.276532025393, 11400.201985860911], "value": 9258.998842392477, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1391.7842734376175, 1444.4655477473334, 1511.5540915429947, 1690.8816382853206, 1710.7433884917252, 7671.6547755351, 8171.0, 8250.0, 8251.257386835183, 8260.215279548449, 6860.073890024845, 7620.733274335399, 7793.961030194855, 7844.450888437812, 8069.354451643869, 2222.5221577360862, 2250.5273892482596, 2252.76345983671, 2253.43664083979, 2254.6843441918145, 2237.8209743220586, 2240.19353032908, 2274.5223503064294, 2279.6010698127843, 2280.464090938628, 1907.1417861962102, 2162.23240749534, 2230.453538882976, 2238.541099074694, 2258.22091378475, 2217.268301460514, 2220.888955552224, 2233.4304752288226, 2242.0807468937737, 2253.019936327686, 2196.1654571262816, 2200.262911924507, 2201.6477363621743, 2204.9779502205092, 2205.349421920537, 8029.638666260033, 8097.919020809834, 8102.878456823093, 8108.75673729789, 8123.18768123183, 4572.291294849304, 4737.478877323491, 4751.786169622341, 4751.952480475185, 4752.0, 2795.9720402795915, 2817.4646817104685, 2917.693642167563, 2921.8539073046477, 2926.590277361171, 886.902440731519, 904.5206040798388, 917.8898532176181, 919.9172074513326, 929.7861491856911, 11022.724431889266, 11053.834192487118, 11058.060064894493, 11060.723481912935, 11065.225434219527, 4081.714280000431, 4192.161567686475, 4325.048489332342, 4360.280553708666, 4365.628921541641, 9423.811523769486, 9489.383190092622, 9500.667476638422, 9503.28725345602, 9527.428354298625, 4732.621390288768, 4756.929690819538, 4757.738324392191, 4764.595009424169, 4780.760961951889, 4185.6232939035635, 4316.892077698083, 4321.935170972438, 4339.1104823511105, 4352.978235108804, 3703.4629978653484, 3753.2305877295635, 3834.501514803058, 3844.75009124406, 3856.2287542491613, 1090.1605763562172, 1172.0623501199007, 1182.8935395814417, 1183.6271574454192, 1189.5301355964345, 616.8180386785909, 729.7628270812007, 791.5804623549528, 799.5682331540903, 805.399977017126, 5010.0, 5221.6344855859725, 5224.582033437316, 5258.158694608845, 5279.208118782213, 434.7956460463577, 438.79157400234635, 444.87988243174163, 446.9486009108929, 608.0666177417643, 3381.7801842880135, 3428.0401487583517, 3455.291665208626, 3465.28961562879, 3484.8431820568135, 9696.806063878683, 9805.166560842408, 10016.098551130433, 10022.649207277711, 10030.147437467751, 9890.851637225447, 9905.405675659484, 9960.35257708261, 9973.401595904268, 9973.650922217832, 7217.097862767154, 7529.510581812165, 7533.397328213729, 7551.0, 7652.579108149105, 5286.867234008531, 5302.920456193237, 5498.752556135064, 5501.614886957875, 5732.71336433185, 9144.58849351794, 9157.313201510047, 9357.953210233905, 9362.765930851783, 9371.671991480265, 8993.865092023756, 9360.672376466791, 9391.29565282593, 9394.201492873182, 9458.527073646152, 6902.309769023058, 6973.47698922593, 7033.0, 7038.577685338896, 7039.542429742255, 7448.702051917862, 7476.214997425192, 7521.548707077593, 7654.425918056279, 7688.423368247292, 5839.0949402842625, 6354.301026887131, 6873.725050997904, 7111.573305601681, 7113.0753002109395, 6928.896066559107, 7018.157821061505, 7034.648267586703, 7071.893921591078, 7101.147862256562, 6264.342244064308, 6291.842703932438, 6325.019621958604, 6326.304106548184, 6327.746890124344, 4316.374125751811, 4317.546657600907, 4466.28539433702, 4481.910361792811, 4555.658325625657, 4515.164694531522, 4536.72779633223, 4571.634269258385, 4596.287575425815, 4623.7225766452775], "value": 4128.93246142494, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.71732571382904, 306.9923251918703, 309.5295151369919, 310.11771510053904, 313.5688428410935, 4770.95229047709, 4787.44944331402, 4791.7604119794005, 4806.639502037344, 4857.51424857514, 4720.8347707830235, 4730.894751835434, 4769.523047695228, 4772.475027746945, 4773.307870358796, 3624.2207925296057, 3633.981830090846, 3724.5530536335677, 3769.302679004379, 3847.1343947611845, 3797.1456422305037, 3804.2771873344113, 3812.6759225465867, 3829.8468061277517, 3830.195658911632, 3595.334863050344, 3770.057485628593, 3789.9009287306785, 3793.2223894101644, 3811.8856434307013, 3652.0, 3751.2497500499735, 3760.417135344026, 3772.4718539404507, 3773.811309434517, 3357.1439282982683, 3365.990202939133, 3372.730181585467, 3373.2747459296124, 3380.6281309055985, 4614.930776038362, 4619.584237418615, 4623.0, 4635.5364463553715, 4643.953560464386, 4181.226473102486, 4294.7423154610515, 4296.548862369437, 4305.0, 4310.568943105664, 4932.988737308843, 4959.628027897922, 4960.479149689303, 4960.809405742596, 4961.9751901240625, 3648.5621725392857, 3654.543182102237, 3655.3968595181764, 3675.4303083022173, 3691.5754688210664, 4968.627352948507, 5204.843854684365, 5208.713520756357, 5210.140326846104, 5219.243209734567, 3731.2350968051483, 3739.2147648994014, 3745.382011968049, 3749.887503374903, 3753.793541355252, 3789.9388171312075, 3796.6393192646656, 3799.2211596622624, 3800.8217452589784, 3802.6387493188104, 4269.829206831754, 4273.743575385487, 4278.700490965664, 4282.678799090018, 4282.764447955392, 4745.335653008581, 4985.451600323961, 5023.799048038038, 5025.246213067996, 5058.595312375001, 1274.184521905981, 1275.3686924972012, 1275.4324325674986, 1278.7506436245028, 1283.525095714573, 815.233680340478, 815.6533473273835, 861.6208868098017, 889.7864512517078, 891.5542228885557, 4388.5830846069575, 4393.055493069006, 4406.140802543538, 4444.355568442557, 4444.377787109807, 5111.936010871366, 5119.180931051014, 5123.3339665843205, 5123.641345105882, 5128.897422051538, 4301.849435269751, 4405.735655860594, 4424.491183513873, 4426.756528390905, 4430.0, 2698.231004163804, 2707.7156898525373, 2716.7283271672673, 2720.055160560209, 2722.564389697639, 4828.223771331428, 4835.588974937099, 4841.426536375692, 4843.612510999112, 4847.903041939141, 5021.221710634857, 5203.401608814959, 5207.843764687065, 5218.478152184827, 5260.605454590921, 4909.754512274372, 4932.802687892444, 4948.282499037619, 4949.232868905326, 4964.379452568429, 5176.171812509981, 5178.679436743757, 5187.714675692722, 5192.3769147701005, 5198.882240318349, 4842.878928026827, 5103.92344114846, 5104.566111880532, 5113.360829896263, 5113.590912726899, 4890.0, 4918.2376731606655, 4927.359443272351, 4934.827281045146, 4949.777260023379, 3799.582045974885, 3834.5206849143856, 3843.2121415110396, 3846.442265871489, 3853.2293541292415, 5025.170846810235, 5117.8976420470635, 5125.589952803842, 5156.9742151289, 5166.2767212589515, 4956.430010548689, 4959.380077490314, 4971.701697898137, 4977.104121258209, 4987.077390682735, 4962.156433406258, 4969.900601988013, 4969.975150124226, 4990.80036798524, 4992.775325110306, 4734.928976065293, 4880.170371037003, 4885.096257192431, 4931.876703082452, 4937.185364414831, 4841.700192408578, 4930.654854160174, 5023.874403139951, 5057.8229761958155, 5064.392272927273, 4916.7541622919425, 4927.802887884444, 4927.802887884588, 4941.555260026615, 4977.502249774993], "value": 3797.7917469273984, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.8433176037751, 723.9457040721944, 736.502860569116, 751.9725693054876, 761.3794757272818, 11247.831282530748, 11939.104567157465, 12355.135140540166, 12368.07239457041, 12383.69040773981, 11899.52401903925, 12014.699632509191, 12036.097292703038, 12045.939770301158, 12050.819237711441, 630.105250544226, 763.8472305538887, 770.9730159444421, 788.3456730913329, 793.3296364571928, 795.4988357334871, 797.4417907464768, 797.6370751308141, 797.924197201265, 798.632628990665, 832.7751507093081, 834.6577903059747, 835.6615570693879, 836.7991681996308, 836.8451836410253, 654.8002859127964, 801.6072124658933, 821.9260266575977, 824.983500329996, 831.6756464978663, 601.4076135007015, 602.7950496831055, 603.8550747820535, 604.3533419241413, 605.2978544887953, 11763.294202347886, 11836.46735896878, 11852.585159519376, 11863.288202707865, 11882.168248222628, 11845.94077029618, 12198.695032624166, 12228.449719762542, 12457.128001039931, 12609.117361784678, 10845.783084338347, 11014.50434730431, 11089.112870970303, 11108.777824443547, 11147.219694621379, 3157.778955473118, 3227.5804145461175, 3356.6978971892645, 3398.796072235674, 4021.959780402217, 53566.46433535654, 53730.73134634302, 53889.0, 60852.0, 60930.69534652298, 10026.498675066217, 10153.847692284622, 10255.538500767483, 10272.0, 10649.414282214397, 17987.0, 18039.909800450914, 18088.0, 18109.185086671132, 18173.63652726938, 6461.709223084972, 6558.770443034471, 6693.364130407604, 6825.726970921207, 6965.82585435358, 3818.9427158592644, 3865.0, 3872.380419132925, 3877.1470276539117, 3982.920341593152, 2984.5523171524446, 3082.152408087794, 3083.9074827755203, 3086.706762857525, 3088.5212792017273, 521.5540712690671, 521.6426747677853, 529.1454301303368, 532.2601583798523, 533.7224643185522, 468.3466564143001, 550.1884720037912, 551.7131091832305, 552.4917076289823, 603.9547033972469, 8112.351011919032, 8296.83406331882, 8402.579871006425, 8489.617967191367, 8555.786105347415, 483.7822979659097, 497.74366201406303, 518.8547206782107, 531.4685314685315, 544.6949708163362, 3936.6653834423823, 4008.238434697398, 4057.9797101014306, 4161.209370219649, 4187.288161012635, 51790.0, 81996.18003820005, 91909.54045229731, 100052.49973750231, 103245.48377258066, 49587.76030599192, 54712.0, 80068.0, 83156.0, 84414.46756597311, 46734.53265467302, 62350.37649623446, 63370.36629633737, 65216.34783652198, 66514.66742666256, 8112.1076681566165, 8885.511296878734, 8892.377533572588, 8937.59780809878, 8978.775530611525, 31119.68880311168, 34873.47689784604, 36083.0, 42631.786841065594, 42946.35580466358, 60282.0, 64844.351556485715, 64846.675766620865, 66004.0, 66402.66798665976, 10941.83587246208, 11341.546338146713, 11568.652940411801, 11596.884031159918, 11599.76800464003, 12757.74484510286, 12877.549285774952, 12925.418356173806, 13321.200727956353, 13642.386092626055, 11658.18392712502, 11962.282263064244, 12167.148299618942, 12174.665281223348, 12239.265644061385, 12413.689657758629, 12418.130730848754, 12495.750084998068, 12602.55891043809, 13217.735645286848, 11560.6531804046, 11737.706557335794, 11866.525338986688, 12373.381330933596, 12446.626601201979, 10300.175985920958, 10566.0, 10705.8929410708, 10773.946130269298, 11033.834492482458, 10047.246456515644, 10055.49722513886, 10423.950612350933, 10528.947355263175, 10596.841047384141], "value": 6447.666866978933, "unit": "score"}], "name": "dromaeo_css", "value": 6467.468143664947, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 113.0, 113.0, 112.0, 112.0, 111.0, 111.0, 110.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 123.0, 175.0, 122.0, 132.0, 145.0, 121.0, 168.0, 124.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 161.0, 161.0, 164.0, 161.0, 163.0, 162.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 76.0, 76.0, 122.0, 76.0, 76.0, 75.0, 76.0, 104.0, 75.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 122.0, 86.0, 86.0, 84.0, 129.0, 84.0, 85.0, 121.0], "value": 96.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.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, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 62.0, 63.0, 64.0, 64.0, 64.0, 64.0, 63.0, 62.0], "value": 63.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0, 64.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 77.0, 83.0, 79.0, 86.0, 78.0, 77.0, 81.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 136.0, 130.0, 136.0, 137.0, 132.0, 129.0, 131.0, 204.0, 132.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 167.0, 164.0, 163.0, 166.0, 164.0, 164.0, 162.0, 163.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1527.3999999999999, "alertThreshold": 2.0}]} 06:51:18 INFO - Return code: 0 06:51:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:51:18 INFO - # TBPL SUCCESS # 06:51:18 INFO - Running post-action listener: _resource_record_post_action 06:51:18 INFO - ##### 06:51:18 INFO - ##### Finished run-tests step (success) 06:51:18 INFO - ##### 06:51:18 INFO - Running post-run listener: _resource_record_post_run 06:51:18 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 7766016; Write bytes: 420515840; Read time: 1284; Write time: 445004 06:51:18 INFO - TinderboxPrint: CPU usage
13.0% 06:51:18 INFO - TinderboxPrint: I/O read bytes / time
7,766,016 / 1,284 06:51:18 INFO - TinderboxPrint: I/O write bytes / time
420,515,840 / 445,004 06:51:18 INFO - TinderboxPrint: CPU idle
8,357.5 (87.0%) 06:51:18 INFO - TinderboxPrint: CPU user
1,198.0 (12.5%) 06:51:18 INFO - TinderboxPrint: Swap in / out
0 / 0 06:51:18 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 51740672; Read time: 116; Write time: 29192 06:51:18 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 5537792; Write bytes: 368775168; Read time: 956; Write time: 415812 06:51:19 INFO - Running post-run listener: _upload_blobber_files 06:51:19 INFO - Blob upload gear active. 06:51:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:51:19 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 06:51:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:51:19 INFO - (blobuploader) - INFO - Open directory for files ... 06:51:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:51:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:51:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:20 INFO - (blobuploader) - INFO - Done attempting. 06:51:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:51:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:51:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:20 INFO - (blobuploader) - INFO - Done attempting. 06:51:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:51:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:51:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:51:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:51:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:51:24 INFO - (blobuploader) - INFO - Done attempting. 06:51:24 INFO - (blobuploader) - INFO - Iteration through files over. 06:51:24 INFO - Return code: 0 06:51:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:51:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:51:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d8dafbeb90544b4cc580fbdb0df3f6af1682c79870eacce896ff1e7dc4d720d203c64dfdd3a16347e244ddb674d5ab69c0b3737cd0944564162bbbfa14ddac1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a72feb4fa68e532b7f5407f28d591d82833a999ffd39c3c5be97456109e14ceb8c33d1c4f2c731e2c76f1f0cedb21f520c4b8eb45150e7c64dd41c4db2848f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/122f30b0d6157bb8446b6362dc70c3dd22cad549738793dec0928c1b516db8126a35a8cd3079751c8f32c50a6d54efc5676df3526cfbaeb20d82382dd92ae2ef"} 06:51:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:51:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:51:24 INFO - Contents: 06:51:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d8dafbeb90544b4cc580fbdb0df3f6af1682c79870eacce896ff1e7dc4d720d203c64dfdd3a16347e244ddb674d5ab69c0b3737cd0944564162bbbfa14ddac1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a72feb4fa68e532b7f5407f28d591d82833a999ffd39c3c5be97456109e14ceb8c33d1c4f2c731e2c76f1f0cedb21f520c4b8eb45150e7c64dd41c4db2848f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/122f30b0d6157bb8446b6362dc70c3dd22cad549738793dec0928c1b516db8126a35a8cd3079751c8f32c50a6d54efc5676df3526cfbaeb20d82382dd92ae2ef"} 06:51:24 INFO - Running post-run listener: copy_logs_to_upload_dir 06:51:24 INFO - Copying logs to upload dir... 06:51:24 INFO - mkdir: /builds/slave/test/build/upload/logs 06:51:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.481467 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-07-06 06:51:24.472408) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 06:51:24.475502) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d8dafbeb90544b4cc580fbdb0df3f6af1682c79870eacce896ff1e7dc4d720d203c64dfdd3a16347e244ddb674d5ab69c0b3737cd0944564162bbbfa14ddac1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a72feb4fa68e532b7f5407f28d591d82833a999ffd39c3c5be97456109e14ceb8c33d1c4f2c731e2c76f1f0cedb21f520c4b8eb45150e7c64dd41c4db2848f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/122f30b0d6157bb8446b6362dc70c3dd22cad549738793dec0928c1b516db8126a35a8cd3079751c8f32c50a6d54efc5676df3526cfbaeb20d82382dd92ae2ef"} build_url:https://queue.taskcluster.net/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011222 build_url: 'https://queue.taskcluster.net/v1/task/GUxMnFd7TquR4OmlSur3Mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1d8dafbeb90544b4cc580fbdb0df3f6af1682c79870eacce896ff1e7dc4d720d203c64dfdd3a16347e244ddb674d5ab69c0b3737cd0944564162bbbfa14ddac1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a72feb4fa68e532b7f5407f28d591d82833a999ffd39c3c5be97456109e14ceb8c33d1c4f2c731e2c76f1f0cedb21f520c4b8eb45150e7c64dd41c4db2848f7a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/122f30b0d6157bb8446b6362dc70c3dd22cad549738793dec0928c1b516db8126a35a8cd3079751c8f32c50a6d54efc5676df3526cfbaeb20d82382dd92ae2ef"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 06:51:24.502238) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 06:51:24.502625) ========= 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=17051fcd5208b27b50bedfeb000001dd-1467806547.19923-1106069235 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004648 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 06:51:24.584932) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 06:51:24.585256) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 06:51:24.585547) ========= ========= Total master_lag: 0.19 =========