builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-043 starttime: 1468046385.23 results: success (0) buildid: 20160708203025 builduid: f8eaf2e6efad48bcaf0947038d75a7ca revision: 57d42a4e2ff190b3699fd210891bd5026cc40c22 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.230481) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.231300) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.231643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.274895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.275242) ========= 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=d2a8c569965ab8367867b893000001a1-1468045967.228956-285650581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-08 23:39:45-- 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% 42.8M=0s 2016-07-08 23:39:45 (42.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.128647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.422951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.423236) ========= 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=d2a8c569965ab8367867b893000001a1-1468045967.228956-285650581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019804 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:45.478923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-08 23:39:45.479239) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 57d42a4e2ff190b3699fd210891bd5026cc40c22 --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 57d42a4e2ff190b3699fd210891bd5026cc40c22 --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=d2a8c569965ab8367867b893000001a1-1468045967.228956-285650581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-08 23:39:46,062 truncating revision to first 12 chars 2016-07-08 23:39:46,062 Setting DEBUG logging. 2016-07-08 23:39:46,062 attempt 1/10 2016-07-08 23:39:46,062 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/57d42a4e2ff1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 23:39:48,100 unpacking tar archive at: fx-team-57d42a4e2ff1/testing/mozharness/ program finished with exit code 0 elapsedTime=2.388566 ========= master_lag: 0.81 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-07-08 23:39:48.679157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:48.679491) ========= script_repo_revision: 57d42a4e2ff190b3699fd210891bd5026cc40c22 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:48.683959) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:48.684248) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 23:39:48.698190) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-08 23:39:48.698637) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1468045967.228956-285650581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:39:49 INFO - MultiFileLogger online at 20160708 23:39:49 in /builds/slave/test 23:39:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:39:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:39:49 INFO - {'append_to_log': False, 23:39:49 INFO - 'base_work_dir': '/builds/slave/test', 23:39:49 INFO - 'blob_upload_branch': 'Fx-Team', 23:39:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:39:49 INFO - 'branch': 'Fx-Team', 23:39:49 INFO - 'buildbot_json_path': 'buildprops.json', 23:39:49 INFO - 'config_files': ('talos/linux_config.py',), 23:39:49 INFO - 'default_actions': ('clobber', 23:39:49 INFO - 'read-buildbot-config', 23:39:49 INFO - 'download-and-extract', 23:39:49 INFO - 'populate-webroot', 23:39:49 INFO - 'create-virtualenv', 23:39:49 INFO - 'install', 23:39:49 INFO - 'run-tests'), 23:39:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:39:49 INFO - 'download_minidump_stackwalk': True, 23:39:49 INFO - 'download_symbols': 'ondemand', 23:39:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:39:49 INFO - 'tooltool.py': '/tools/tooltool.py', 23:39:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:39:49 INFO - '/tools/misc-python/virtualenv.py')}, 23:39:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:39:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:39:49 INFO - 'installer_path': 'installer.exe', 23:39:49 INFO - 'log_level': 'info', 23:39:49 INFO - 'log_name': 'talos', 23:39:49 INFO - 'log_to_console': True, 23:39:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:39:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:39:49 INFO - 'opt_config_files': (), 23:39:49 INFO - 'pip_index': False, 23:39:49 INFO - 'sps_profile': False, 23:39:49 INFO - 'sps_profile_interval': 0, 23:39:49 INFO - 'suite': 'dromaeojs-e10s', 23:39:49 INFO - 'system_bits': '32', 23:39:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:39:49 INFO - 'title': 'talos-linux64-ix-043', 23:39:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:39:49 INFO - 'use_talos_json': True, 23:39:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:39:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:39:49 INFO - 'work_dir': 'build'} 23:39:49 INFO - ##### 23:39:49 INFO - ##### Running clobber step. 23:39:49 INFO - ##### 23:39:49 INFO - Running pre-action listener: _resource_record_pre_action 23:39:49 INFO - Running main action method: clobber 23:39:49 INFO - rmtree: /builds/slave/test/build 23:39:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:39:49 INFO - Running post-action listener: _resource_record_post_action 23:39:49 INFO - ##### 23:39:49 INFO - ##### Finished clobber step (success) 23:39:49 INFO - ##### 23:39:49 INFO - ##### 23:39:49 INFO - ##### Running read-buildbot-config step. 23:39:49 INFO - ##### 23:39:49 INFO - Running pre-action listener: _resource_record_pre_action 23:39:49 INFO - Running main action method: read_buildbot_config 23:39:49 INFO - Using buildbot properties: 23:39:49 INFO - { 23:39:49 INFO - "project": "", 23:39:49 INFO - "product": "firefox", 23:39:49 INFO - "script_repo_revision": "production", 23:39:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:39:49 INFO - "repository": "", 23:39:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:39:49 INFO - "buildid": "20160708203025", 23:39:49 INFO - "pgo_build": "True", 23:39:49 INFO - "basedir": "/builds/slave/test", 23:39:49 INFO - "buildnumber": 558, 23:39:49 INFO - "slavename": "talos-linux64-ix-043", 23:39:49 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:39:49 INFO - "platform": "ubuntu64_hw", 23:39:49 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:39:49 INFO - "branch": "fx-team", 23:39:49 INFO - "repo_path": "integration/fx-team", 23:39:49 INFO - "revision": "57d42a4e2ff190b3699fd210891bd5026cc40c22", 23:39:49 INFO - "stage_platform": "linux64-pgo", 23:39:49 INFO - "builduid": "f8eaf2e6efad48bcaf0947038d75a7ca", 23:39:49 INFO - "slavebuilddir": "test" 23:39:49 INFO - } 23:39:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:39:49 INFO - Running post-action listener: _resource_record_post_action 23:39:49 INFO - ##### 23:39:49 INFO - ##### Finished read-buildbot-config step (success) 23:39:49 INFO - ##### 23:39:49 INFO - ##### 23:39:49 INFO - ##### Running download-and-extract step. 23:39:49 INFO - ##### 23:39:49 INFO - Running pre-action listener: _resource_record_pre_action 23:39:49 INFO - Running main action method: download_and_extract 23:39:49 INFO - mkdir: /builds/slave/test/build/tests 23:39: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')]} 23:39:49 INFO - https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:39:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:39:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:39:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:50 INFO - Downloaded 1361 bytes. 23:39:50 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:39:50 INFO - Using the following test package requirements: 23:39:50 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:39:50 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:39:50 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:39:50 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:50 INFO - u'jsshell-linux-x86_64.zip'], 23:39:50 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:39:50 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:39:50 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:39:50 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:39:50 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:39:50 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:39:50 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:39:50 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:39:50 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')]} 23:39:50 INFO - https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:39:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:51 INFO - Downloaded 24305278 bytes. 23:39:51 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'] 23:39:51 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 23:39:52 INFO - Return code: 0 23:39:52 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 23:39:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:52 INFO - https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:39:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:39:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:54 INFO - Downloaded 24305278 bytes. 23:39:54 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'] 23:39:54 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 23:39:56 INFO - Return code: 0 23:39:56 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')]} 23:39:56 INFO - https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:39:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:39:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:39:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:57 INFO - Downloaded 14403333 bytes. 23:39:57 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'] 23:39:57 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 23:39:57 INFO - Return code: 0 23:39:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:57 INFO - https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:39:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:39:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:39:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GuK9A80mQHKmHNR3Bz6V9w/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 23:39:59 INFO - Downloaded 60434394 bytes. 23:39:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:39:59 INFO - mkdir: /builds/slave/test/properties 23:39:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:39:59 INFO - Writing to file /builds/slave/test/properties/build_url 23:39:59 INFO - Contents: 23:39:59 INFO - build_url:https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:40:02 INFO - Running post-action listener: _resource_record_post_action 23:40:02 INFO - Running post-action listener: set_extra_try_arguments 23:40:02 INFO - ##### 23:40:02 INFO - ##### Finished download-and-extract step (success) 23:40:02 INFO - ##### 23:40:02 INFO - ##### 23:40:02 INFO - ##### Running populate-webroot step. 23:40:02 INFO - ##### 23:40:02 INFO - Running pre-action listener: _resource_record_pre_action 23:40:02 INFO - Running main action method: populate_webroot 23:40:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:40:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:40:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:40:02 INFO - '--tppagecycles', 23:40:02 INFO - '7'], 23:40:02 INFO - 'tests': ['tsvgm']}}, 23:40:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:40:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:40:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:40:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:40:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:40:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:40:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:02 INFO - 'talos_options': ['--disable-e10s'], 23:40:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:40:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:40:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:02 INFO - 'talos_options': ['--disable-e10s'], 23:40:02 INFO - 'tests': ['damp', 'tps']}, 23:40:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:02 INFO - 'tests': ['damp', 'tps']}, 23:40:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:40:02 INFO - 'tests': ['dromaeo_dom']}, 23:40:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:40:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:40:02 INFO - 'tests': ['basic_compositor_video']}, 23:40:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:40:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:40:02 INFO - 'tests': ['a11yr', 23:40:02 INFO - 'ts_paint', 23:40:02 INFO - 'tpaint', 23:40:02 INFO - 'sessionrestore', 23:40:02 INFO - 'sessionrestore_no_auto_restore', 23:40:02 INFO - 'tabpaint']}, 23:40:02 INFO - 'other-e10s': {'tests': ['a11yr', 23:40:02 INFO - 'ts_paint', 23:40:02 INFO - 'tpaint', 23:40:02 INFO - 'sessionrestore', 23:40:02 INFO - 'sessionrestore_no_auto_restore', 23:40:02 INFO - 'tabpaint']}, 23:40:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:40:02 INFO - 'ts_paint', 23:40:02 INFO - 'tpaint', 23:40:02 INFO - 'sessionrestore', 23:40:02 INFO - 'sessionrestore_no_auto_restore', 23:40:02 INFO - 'tabpaint']}, 23:40:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:40:02 INFO - 'ts_paint', 23:40:02 INFO - 'tpaint', 23:40:02 INFO - 'sessionrestore', 23:40:02 INFO - 'sessionrestore_no_auto_restore', 23:40:02 INFO - 'tabpaint']}, 23:40:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:40:02 INFO - 'tests': ['a11yr', 23:40:02 INFO - 'ts_paint', 23:40:02 INFO - 'tpaint', 23:40:02 INFO - 'sessionrestore', 23:40:02 INFO - 'sessionrestore_no_auto_restore', 23:40:02 INFO - 'tabpaint']}, 23:40:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:40:02 INFO - 'tests': ['a11yr', 23:40:02 INFO - 'ts_paint', 23:40:02 INFO - 'tpaint', 23:40:02 INFO - 'sessionrestore', 23:40:02 INFO - 'sessionrestore_no_auto_restore', 23:40:02 INFO - 'tabpaint']}, 23:40:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:40:02 INFO - 'tests': ['tsvgx', 23:40:02 INFO - 'tsvgr_opacity', 23:40:02 INFO - 'tart', 23:40:02 INFO - 'tscrollx', 23:40:02 INFO - 'cart']}, 23:40:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:40:02 INFO - 'tsvgr_opacity', 23:40:02 INFO - 'tart', 23:40:02 INFO - 'tscrollx', 23:40:02 INFO - 'cart']}, 23:40:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:02 INFO - 'talos_options': ['--disable-e10s'], 23:40:02 INFO - 'tests': ['tp5o']}, 23:40:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:02 INFO - 'tests': ['tp5o']}, 23:40:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:02 INFO - 'talos_options': ['--disable-e10s', 23:40:02 INFO - '--xperf_path', 23:40:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:40:02 INFO - 'tests': ['tp5n']}, 23:40:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:40:02 INFO - 'talos_options': ['--xperf_path', 23:40:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:40:02 INFO - 'tests': ['tp5n']}}, 23:40:02 INFO - 'talos.zip': {'path': '', 23:40:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:40:02 INFO - Running post-action listener: _resource_record_post_action 23:40:02 INFO - ##### 23:40:02 INFO - ##### Finished populate-webroot step (success) 23:40:02 INFO - ##### 23:40:02 INFO - ##### 23:40:02 INFO - ##### Running create-virtualenv step. 23:40:02 INFO - ##### 23:40:02 INFO - Running pre-action listener: _resource_record_pre_action 23:40:02 INFO - Running main action method: create_virtualenv 23:40:02 INFO - Creating virtualenv /builds/slave/test/build/venv 23:40:02 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 23:40:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:40:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:40:02 INFO - Using real prefix '/usr' 23:40:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:40:03 INFO - Installing distribute.............................................................................................................................................................................................done. 23:40:05 INFO - Installing pip.................done. 23:40:05 INFO - Return code: 0 23:40:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:05 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 0x2322030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e13b0>, '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 0x25e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2740>, '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': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', '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 23:40:05 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 23:40:05 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 23:40:05 INFO - Using env: {'DISPLAY': ':0', 23:40:05 INFO - 'HOME': '/home/cltbld', 23:40:05 INFO - 'LANG': 'en_US.UTF-8', 23:40:05 INFO - 'LANGUAGE': 'en_US:en', 23:40:05 INFO - 'LOGNAME': 'cltbld', 23:40:05 INFO - 'MAIL': '/var/mail/cltbld', 23:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:05 INFO - 'MOZ_NO_REMOTE': '1', 23:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:05 INFO - 'NO_EM_RESTART': '1', 23:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:05 INFO - 'PWD': '/builds/slave/test', 23:40:05 INFO - 'SHELL': '/bin/bash', 23:40:05 INFO - 'SHLVL': '1', 23:40:05 INFO - 'TERM': 'linux', 23:40:05 INFO - 'TMOUT': '86400', 23:40:05 INFO - 'USER': 'cltbld', 23:40:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', 23:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:05 INFO - '_': '/tools/buildbot/bin/python'} 23:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:05 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 23:40:05 INFO - Cleaning up... 23:40:05 INFO - Return code: 0 23:40:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:05 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 0x2322030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e13b0>, '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 0x25e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2740>, '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': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', '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 23:40:05 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 23:40:05 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 23:40:05 INFO - Using env: {'DISPLAY': ':0', 23:40:05 INFO - 'HOME': '/home/cltbld', 23:40:05 INFO - 'LANG': 'en_US.UTF-8', 23:40:05 INFO - 'LANGUAGE': 'en_US:en', 23:40:05 INFO - 'LOGNAME': 'cltbld', 23:40:05 INFO - 'MAIL': '/var/mail/cltbld', 23:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:05 INFO - 'MOZ_NO_REMOTE': '1', 23:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:05 INFO - 'NO_EM_RESTART': '1', 23:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:05 INFO - 'PWD': '/builds/slave/test', 23:40:05 INFO - 'SHELL': '/bin/bash', 23:40:05 INFO - 'SHLVL': '1', 23:40:05 INFO - 'TERM': 'linux', 23:40:05 INFO - 'TMOUT': '86400', 23:40:05 INFO - 'USER': 'cltbld', 23:40:05 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', 23:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:05 INFO - '_': '/tools/buildbot/bin/python'} 23:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:05 INFO - Downloading/unpacking psutil>=3.1.1 23:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:40:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:40:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:40:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:40:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:40:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:40:07 INFO - Installing collected packages: psutil 23:40:07 INFO - Running setup.py install for psutil 23:40:07 INFO - building 'psutil._psutil_linux' extension 23:40:07 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 23:40:07 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 23:40:07 INFO - building 'psutil._psutil_posix' extension 23:40:07 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 23:40:07 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 23:40:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:40:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:40:07 INFO - Successfully installed psutil 23:40:07 INFO - Cleaning up... 23:40:08 INFO - Return code: 0 23:40:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:08 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 0x2322030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e13b0>, '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 0x25e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2740>, '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': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', '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 23:40:08 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 23:40:08 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 23:40:08 INFO - Using env: {'DISPLAY': ':0', 23:40:08 INFO - 'HOME': '/home/cltbld', 23:40:08 INFO - 'LANG': 'en_US.UTF-8', 23:40:08 INFO - 'LANGUAGE': 'en_US:en', 23:40:08 INFO - 'LOGNAME': 'cltbld', 23:40:08 INFO - 'MAIL': '/var/mail/cltbld', 23:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:08 INFO - 'MOZ_NO_REMOTE': '1', 23:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:08 INFO - 'NO_EM_RESTART': '1', 23:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:08 INFO - 'PWD': '/builds/slave/test', 23:40:08 INFO - 'SHELL': '/bin/bash', 23:40:08 INFO - 'SHLVL': '1', 23:40:08 INFO - 'TERM': 'linux', 23:40:08 INFO - 'TMOUT': '86400', 23:40:08 INFO - 'USER': 'cltbld', 23:40:08 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', 23:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:08 INFO - '_': '/tools/buildbot/bin/python'} 23:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:40:08 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 23:40:08 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 23:40:08 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 23:40:08 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 23:40:08 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 23:40:08 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 23:40:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:40:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:40:10 INFO - Installing collected packages: mozsystemmonitor 23:40:10 INFO - Running setup.py install for mozsystemmonitor 23:40:10 INFO - Successfully installed mozsystemmonitor 23:40:10 INFO - Cleaning up... 23:40:10 INFO - Return code: 0 23:40:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:40: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')]} 23:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40: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')]} 23:40:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:10 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 0x2322030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e13b0>, '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 0x25e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2740>, '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': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', '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 23:40:10 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 23:40:10 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 23:40:10 INFO - Using env: {'DISPLAY': ':0', 23:40:10 INFO - 'HOME': '/home/cltbld', 23:40:10 INFO - 'LANG': 'en_US.UTF-8', 23:40:10 INFO - 'LANGUAGE': 'en_US:en', 23:40:10 INFO - 'LOGNAME': 'cltbld', 23:40:10 INFO - 'MAIL': '/var/mail/cltbld', 23:40:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:10 INFO - 'MOZ_NO_REMOTE': '1', 23:40:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:10 INFO - 'NO_EM_RESTART': '1', 23:40:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:10 INFO - 'PWD': '/builds/slave/test', 23:40:10 INFO - 'SHELL': '/bin/bash', 23:40:10 INFO - 'SHLVL': '1', 23:40:10 INFO - 'TERM': 'linux', 23:40:10 INFO - 'TMOUT': '86400', 23:40:10 INFO - 'USER': 'cltbld', 23:40:10 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', 23:40:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:10 INFO - '_': '/tools/buildbot/bin/python'} 23:40:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:10 INFO - Downloading/unpacking jsonschema==2.5.1 23:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:40:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:40:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:40:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:40:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:40:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:40:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:40: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 23:40: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 23:40: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 23:40: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 23:40: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 23:40: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 23:40:12 INFO - Downloading functools32-3.2.3-2.tar.gz 23:40:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:40:12 INFO - warning: no files found matching '*.txt' 23:40:12 INFO - no previously-included directories found matching 'build' 23:40:12 INFO - no previously-included directories found matching 'dist' 23:40:12 INFO - no previously-included directories found matching '.git*' 23:40:12 INFO - Installing collected packages: jsonschema, functools32 23:40:12 INFO - Running setup.py install for functools32 23:40:12 INFO - warning: no files found matching '*.txt' 23:40:12 INFO - no previously-included directories found matching 'build' 23:40:12 INFO - no previously-included directories found matching 'dist' 23:40:12 INFO - no previously-included directories found matching '.git*' 23:40:12 INFO - Successfully installed jsonschema functools32 23:40:12 INFO - Cleaning up... 23:40:12 INFO - Return code: 0 23:40:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:40:12 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')]} 23:40:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:12 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')]} 23:40:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:12 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 0x2322030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e13b0>, '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 0x25e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2740>, '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': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', '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 23:40:12 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 23:40:12 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 23:40:12 INFO - Using env: {'DISPLAY': ':0', 23:40:12 INFO - 'HOME': '/home/cltbld', 23:40:12 INFO - 'LANG': 'en_US.UTF-8', 23:40:12 INFO - 'LANGUAGE': 'en_US:en', 23:40:12 INFO - 'LOGNAME': 'cltbld', 23:40:12 INFO - 'MAIL': '/var/mail/cltbld', 23:40:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:12 INFO - 'MOZ_NO_REMOTE': '1', 23:40:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:12 INFO - 'NO_EM_RESTART': '1', 23:40:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:12 INFO - 'PWD': '/builds/slave/test', 23:40:12 INFO - 'SHELL': '/bin/bash', 23:40:12 INFO - 'SHLVL': '1', 23:40:12 INFO - 'TERM': 'linux', 23:40:12 INFO - 'TMOUT': '86400', 23:40:12 INFO - 'USER': 'cltbld', 23:40:12 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', 23:40:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:12 INFO - '_': '/tools/buildbot/bin/python'} 23:40:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:13 INFO - Downloading/unpacking blobuploader==1.2.4 23:40:13 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 23:40:13 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 23:40:13 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 23:40:13 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 23:40:13 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 23:40:13 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 23:40:15 INFO - Downloading blobuploader-1.2.4.tar.gz 23:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:40:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:40:15 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 23:40:15 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 23:40:15 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 23:40:15 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 23:40:15 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 23:40:15 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 23:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:40:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:40:15 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 23:40:15 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 23:40:15 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 23:40:15 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 23:40:15 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 23:40:15 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 23:40:15 INFO - Downloading docopt-0.6.1.tar.gz 23:40:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:40:16 INFO - Installing collected packages: blobuploader, requests, docopt 23:40:16 INFO - Running setup.py install for blobuploader 23:40:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:40:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:40:16 INFO - Running setup.py install for requests 23:40:16 INFO - Running setup.py install for docopt 23:40:16 INFO - Successfully installed blobuploader requests docopt 23:40:16 INFO - Cleaning up... 23:40:16 INFO - Return code: 0 23:40:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:16 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 0x2322030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e13b0>, '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 0x25e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2740>, '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': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', '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 23:40:16 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 23:40:16 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 23:40:16 INFO - Using env: {'DISPLAY': ':0', 23:40:16 INFO - 'HOME': '/home/cltbld', 23:40:16 INFO - 'LANG': 'en_US.UTF-8', 23:40:16 INFO - 'LANGUAGE': 'en_US:en', 23:40:16 INFO - 'LOGNAME': 'cltbld', 23:40:16 INFO - 'MAIL': '/var/mail/cltbld', 23:40:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:16 INFO - 'MOZ_NO_REMOTE': '1', 23:40:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:16 INFO - 'NO_EM_RESTART': '1', 23:40:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:16 INFO - 'PWD': '/builds/slave/test', 23:40:16 INFO - 'SHELL': '/bin/bash', 23:40:16 INFO - 'SHLVL': '1', 23:40:16 INFO - 'TERM': 'linux', 23:40:16 INFO - 'TMOUT': '86400', 23:40:16 INFO - 'USER': 'cltbld', 23:40:16 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', 23:40:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:16 INFO - '_': '/tools/buildbot/bin/python'} 23:40:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:40:16 INFO - Running setup.py (path:/tmp/pip-Np7zCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:40:16 INFO - Running setup.py (path:/tmp/pip-1Ueax1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:40:16 INFO - Running setup.py (path:/tmp/pip-92hY9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:40:17 INFO - Running setup.py (path:/tmp/pip-ZBL7XO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:40:17 INFO - Running setup.py (path:/tmp/pip-8XXVV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:40:17 INFO - Running setup.py (path:/tmp/pip-qO9A_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:40:17 INFO - Running setup.py (path:/tmp/pip-u80E3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:40:17 INFO - Running setup.py (path:/tmp/pip-dqf1Qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:40:17 INFO - Running setup.py (path:/tmp/pip-z7Y9LI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:40:17 INFO - Running setup.py (path:/tmp/pip-WMg44q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:40:17 INFO - Running setup.py (path:/tmp/pip-62kO6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:40:17 INFO - Running setup.py (path:/tmp/pip-JJVmNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:40:17 INFO - Running setup.py (path:/tmp/pip-HuzrzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:40:17 INFO - Running setup.py (path:/tmp/pip-kI7pTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:40:17 INFO - Running setup.py (path:/tmp/pip-0S5JUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:40:17 INFO - Running setup.py (path:/tmp/pip-QXL1b2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:40:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:40:17 INFO - Running setup.py (path:/tmp/pip-31Ivm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:40:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:40:18 INFO - Running setup.py install for manifestparser 23:40:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:40:18 INFO - Running setup.py install for mozcrash 23:40:18 INFO - Running setup.py install for mozdebug 23:40:18 INFO - Running setup.py install for mozdevice 23:40:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:40:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:40:18 INFO - Running setup.py install for mozfile 23:40:18 INFO - Running setup.py install for mozhttpd 23:40:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:40:18 INFO - Running setup.py install for mozinfo 23:40:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:40:18 INFO - Running setup.py install for mozInstall 23:40:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:40:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:40:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:40:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:40:18 INFO - Running setup.py install for mozleak 23:40:18 INFO - Running setup.py install for mozlog 23:40:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:40:19 INFO - Running setup.py install for moznetwork 23:40:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:40:19 INFO - Running setup.py install for mozprocess 23:40:19 INFO - Running setup.py install for mozprofile 23:40:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:40:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:40:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:40:19 INFO - Running setup.py install for mozrunner 23:40:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:40:19 INFO - Running setup.py install for mozscreenshot 23:40:19 INFO - Running setup.py install for moztest 23:40:19 INFO - Running setup.py install for mozversion 23:40:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:40:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:40:19 INFO - Cleaning up... 23:40:19 INFO - Return code: 0 23:40:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:19 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 0x2322030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e13b0>, '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 0x25e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2740>, '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': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', '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 23:40:19 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 23:40:19 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 23:40:19 INFO - Using env: {'DISPLAY': ':0', 23:40:19 INFO - 'HOME': '/home/cltbld', 23:40:19 INFO - 'LANG': 'en_US.UTF-8', 23:40:19 INFO - 'LANGUAGE': 'en_US:en', 23:40:19 INFO - 'LOGNAME': 'cltbld', 23:40:19 INFO - 'MAIL': '/var/mail/cltbld', 23:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:19 INFO - 'MOZ_NO_REMOTE': '1', 23:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:19 INFO - 'NO_EM_RESTART': '1', 23:40:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:19 INFO - 'PWD': '/builds/slave/test', 23:40:19 INFO - 'SHELL': '/bin/bash', 23:40:19 INFO - 'SHLVL': '1', 23:40:19 INFO - 'TERM': 'linux', 23:40:19 INFO - 'TMOUT': '86400', 23:40:19 INFO - 'USER': 'cltbld', 23:40:19 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', 23:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:19 INFO - '_': '/tools/buildbot/bin/python'} 23:40:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:40:20 INFO - Running setup.py (path:/tmp/pip-LSqygx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:40:20 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)) 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:40:20 INFO - Running setup.py (path:/tmp/pip-0Jz_to-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:40:20 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)) 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:40:20 INFO - Running setup.py (path:/tmp/pip-c2WSbS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:40:20 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)) 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:40:20 INFO - Running setup.py (path:/tmp/pip-fzzrVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:40:20 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)) 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:40:20 INFO - Running setup.py (path:/tmp/pip-eUhYNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:40:20 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)) 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:40:20 INFO - Running setup.py (path:/tmp/pip-r7h2CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:40:20 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)) 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:40:20 INFO - Running setup.py (path:/tmp/pip-pFX412-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:40:20 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)) 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:40:20 INFO - Running setup.py (path:/tmp/pip-tvMelo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:40:20 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)) 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:40:20 INFO - Running setup.py (path:/tmp/pip-Ne3ASk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:40:20 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)) 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:40:20 INFO - Running setup.py (path:/tmp/pip-xm7Zby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:40:20 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)) 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:40:20 INFO - Running setup.py (path:/tmp/pip-IMAJbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:40:20 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)) 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:40:20 INFO - Running setup.py (path:/tmp/pip-chtz2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:40:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:40:20 INFO - Running setup.py (path:/tmp/pip-JHj4sR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:40:20 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)) 23:40:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:40:21 INFO - Running setup.py (path:/tmp/pip-UWf9eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:40:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:40:21 INFO - Running setup.py (path:/tmp/pip-DqgDCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:40:21 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)) 23:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:40:21 INFO - Running setup.py (path:/tmp/pip-d53pbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:40:21 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)) 23:40:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:40:21 INFO - Running setup.py (path:/tmp/pip-40wHm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:40:21 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)) 23:40:21 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)) 23:40:21 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)) 23:40:21 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)) 23:40:21 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)) 23:40:21 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)) 23:40:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:40:21 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 23:40:21 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 23:40:21 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 23:40:21 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 23:40:21 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 23:40:21 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 23:40:23 INFO - Downloading blessings-1.6.tar.gz 23:40:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:40:23 INFO - Installing collected packages: blessings 23:40:23 INFO - Running setup.py install for blessings 23:40:23 INFO - Successfully installed blessings 23:40:23 INFO - Cleaning up... 23:40:23 INFO - Return code: 0 23:40:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:40:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:40:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:40:23 INFO - Reading from file tmpfile_stdout 23:40:23 INFO - Current package versions: 23:40:23 INFO - argparse == 1.2.1 23:40:23 INFO - blessings == 1.6 23:40:23 INFO - blobuploader == 1.2.4 23:40:23 INFO - docopt == 0.6.1 23:40:23 INFO - functools32 == 3.2.3-2 23:40:23 INFO - jsonschema == 2.5.1 23:40:23 INFO - manifestparser == 1.1 23:40:23 INFO - mozInstall == 1.12 23:40:23 INFO - mozcrash == 0.17 23:40:23 INFO - mozdebug == 0.1 23:40:23 INFO - mozdevice == 0.48 23:40:23 INFO - mozfile == 1.2 23:40:23 INFO - mozhttpd == 0.7 23:40:23 INFO - mozinfo == 0.9 23:40:23 INFO - mozleak == 0.1 23:40:23 INFO - mozlog == 3.2 23:40:23 INFO - moznetwork == 0.27 23:40:23 INFO - mozprocess == 0.23 23:40:23 INFO - mozprofile == 0.28 23:40:23 INFO - mozrunner == 6.12 23:40:23 INFO - mozscreenshot == 0.1 23:40:23 INFO - mozsystemmonitor == 0.3 23:40:23 INFO - moztest == 0.7 23:40:23 INFO - mozversion == 1.4 23:40:23 INFO - psutil == 3.1.1 23:40:23 INFO - requests == 1.2.3 23:40:23 INFO - wsgiref == 0.1.2 23:40:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:40:23 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')]} 23:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:23 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')]} 23:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:23 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 0x2322030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e13b0>, '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 0x25e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2740>, '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': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', '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 23:40:23 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 23:40:23 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 23:40:23 INFO - Using env: {'DISPLAY': ':0', 23:40:23 INFO - 'HOME': '/home/cltbld', 23:40:23 INFO - 'LANG': 'en_US.UTF-8', 23:40:23 INFO - 'LANGUAGE': 'en_US:en', 23:40:23 INFO - 'LOGNAME': 'cltbld', 23:40:23 INFO - 'MAIL': '/var/mail/cltbld', 23:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:23 INFO - 'MOZ_NO_REMOTE': '1', 23:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:23 INFO - 'NO_EM_RESTART': '1', 23:40:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:23 INFO - 'PWD': '/builds/slave/test', 23:40:23 INFO - 'SHELL': '/bin/bash', 23:40:23 INFO - 'SHLVL': '1', 23:40:23 INFO - 'TERM': 'linux', 23:40:23 INFO - 'TMOUT': '86400', 23:40:23 INFO - 'USER': 'cltbld', 23:40:23 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', 23:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:23 INFO - '_': '/tools/buildbot/bin/python'} 23:40:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:23 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)) 23:40:23 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)) 23:40:23 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)) 23:40:23 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)) 23:40:23 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)) 23:40:23 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)) 23:40:23 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)) 23:40:23 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)) 23:40:23 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)) 23:40:23 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)) 23:40:23 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)) 23:40:23 INFO - Cleaning up... 23:40:23 INFO - Return code: 0 23:40:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:40:23 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')]} 23:40:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:40:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:23 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')]} 23:40:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:40:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:40:23 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 0x2322030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25e3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25e13b0>, '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 0x25e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2740>, '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': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', '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 23:40:23 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 23:40:23 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 23:40:23 INFO - Using env: {'DISPLAY': ':0', 23:40:23 INFO - 'HOME': '/home/cltbld', 23:40:23 INFO - 'LANG': 'en_US.UTF-8', 23:40:23 INFO - 'LANGUAGE': 'en_US:en', 23:40:23 INFO - 'LOGNAME': 'cltbld', 23:40:23 INFO - 'MAIL': '/var/mail/cltbld', 23:40:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:23 INFO - 'MOZ_NO_REMOTE': '1', 23:40:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:23 INFO - 'NO_EM_RESTART': '1', 23:40:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:23 INFO - 'PWD': '/builds/slave/test', 23:40:23 INFO - 'SHELL': '/bin/bash', 23:40:23 INFO - 'SHLVL': '1', 23:40:23 INFO - 'TERM': 'linux', 23:40:23 INFO - 'TMOUT': '86400', 23:40:23 INFO - 'USER': 'cltbld', 23:40:23 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', 23:40:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:23 INFO - '_': '/tools/buildbot/bin/python'} 23:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:40:24 INFO - Cleaning up... 23:40:24 INFO - Return code: 0 23:40:24 INFO - Running post-action listener: _resource_record_post_action 23:40:24 INFO - Running post-action listener: _start_resource_monitoring 23:40:24 INFO - Starting resource monitoring. 23:40:24 INFO - ##### 23:40:24 INFO - ##### Finished create-virtualenv step (success) 23:40:24 INFO - ##### 23:40:24 INFO - ##### 23:40:24 INFO - ##### Running install step. 23:40:24 INFO - ##### 23:40:24 INFO - Running pre-action listener: _resource_record_pre_action 23:40:24 INFO - Running main action method: install 23:40:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:40:24 INFO - Reading from file tmpfile_stdout 23:40:24 INFO - Detecting whether we're running mozinstall >=1.0... 23:40:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:40:24 INFO - Reading from file tmpfile_stdout 23:40:24 INFO - Output received: 23:40:24 INFO - Usage: mozinstall [options] installer 23:40:24 INFO - Options: 23:40:24 INFO - -h, --help show this help message and exit 23:40:24 INFO - -d DEST, --destination=DEST 23:40:24 INFO - Directory to install application into. [default: 23:40:24 INFO - "/builds/slave/test"] 23:40:24 INFO - --app=APP Application being installed. [default: firefox] 23:40:24 INFO - mkdir: /builds/slave/test/build/application 23:40:24 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'] 23:40:24 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 23:40:41 INFO - Reading from file tmpfile_stdout 23:40:41 INFO - Output received: 23:40:41 INFO - /builds/slave/test/build/application/firefox/firefox 23:40:41 INFO - Running post-action listener: _resource_record_post_action 23:40:41 INFO - ##### 23:40:41 INFO - ##### Finished install step (success) 23:40:41 INFO - ##### 23:40:41 INFO - ##### 23:40:41 INFO - ##### Running run-tests step. 23:40:41 INFO - ##### 23:40:41 INFO - Running pre-action listener: _resource_record_pre_action 23:40:41 INFO - Running main action method: run_tests 23:40:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:40:41 INFO - Python 2.7.3 23:40:41 INFO - Return code: 0 23:40:41 INFO - grabbing minidump binary from tooltool 23:40: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')]} 23:40:41 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 0x25e13b0>, '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 0x25e22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25e2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:40:41 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 23:40:41 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 23:40:41 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 23:40:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:40:41 INFO - Return code: 0 23:40:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:40:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:40:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:40:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:40:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:40:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:40:41 INFO - Using env: {'DISPLAY': ':0', 23:40:41 INFO - 'HOME': '/home/cltbld', 23:40:41 INFO - 'LANG': 'en_US.UTF-8', 23:40:41 INFO - 'LANGUAGE': 'en_US:en', 23:40:41 INFO - 'LOGNAME': 'cltbld', 23:40:41 INFO - 'MAIL': '/var/mail/cltbld', 23:40:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:40:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:40:41 INFO - 'MOZ_NO_REMOTE': '1', 23:40:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:40:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:40:41 INFO - 'NO_EM_RESTART': '1', 23:40:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:40:41 INFO - 'PWD': '/builds/slave/test', 23:40:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:40:41 INFO - 'SHELL': '/bin/bash', 23:40:41 INFO - 'SHLVL': '1', 23:40:41 INFO - 'TERM': 'linux', 23:40:41 INFO - 'TMOUT': '86400', 23:40:41 INFO - 'USER': 'cltbld', 23:40:41 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1468045967.228956-285650581', 23:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:40:41 INFO - '_': '/tools/buildbot/bin/python'} 23:40:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:40:41 INFO - mozversion application_buildid: 20160708203025 23:40:41 INFO - mozversion application_changeset: 57d42a4e2ff190b3699fd210891bd5026cc40c22 23:40:41 INFO - mozversion application_display_name: Nightly 23:40:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:40:41 INFO - mozversion application_name: Firefox 23:40:41 INFO - mozversion application_remotingname: firefox 23:40:41 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:40:41 INFO - mozversion application_vendor: Mozilla 23:40:41 INFO - mozversion application_version: 50.0a1 23:40:41 INFO - mozversion platform_buildid: 20160708203025 23:40:41 INFO - mozversion platform_changeset: 57d42a4e2ff190b3699fd210891bd5026cc40c22 23:40:41 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:40:41 INFO - mozversion platform_version: 50.0a1 23:40:41 INFO - using testdate: 1468046441 23:40:41 INFO - actual date: 1468046441 23:40:41 INFO - starting webserver on 'localhost:60033' 23:40:41 INFO - SUITE-START | Running 2 tests 23:40:41 INFO - TEST-START | dromaeo_css 23:40:41 INFO - operating with platform_type : linux_ 23:40:41 INFO - Initialising browser for dromaeo_css test... 23:40:41 INFO - TEST-INFO | started process 6339 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPKyg0J/profile http://localhost:60033/getInfo.html) 23:40:46 INFO - PROCESS | 6339 | __metrics Screen width/height:1600/1200 23:40:46 INFO - PROCESS | 6339 | colorDepth:24 23:40:46 INFO - PROCESS | 6339 | Browser inner width/height: 1024/697 23:40:46 INFO - PROCESS | 6339 | __metrics 23:40:47 ERROR - PROCESS | 6339 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 23:40:48 INFO - TEST-INFO | 6339: exit 0 23:40:48 INFO - Browser initialized. 23:40:48 INFO - Running cycle 1/1 for dromaeo_css test... 23:40:48 INFO - TEST-INFO | started process 6459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPKyg0J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:40:59 INFO - PROCESS | 6459 | RSS: Main: 167694336 23:40:59 INFO - PROCESS | 6459 | 23:41:49 INFO - PROCESS | 6459 | 1468046509593 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] 23:43:56 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:60033/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60033/tests/dromaeo/cssquery-ext.html) 23:43:57 INFO - PROCESS | 6459 | RSS: Main: 170762240 23:43:57 INFO - PROCESS | 6459 | 23:46:59 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:60033/tests/dromaeo/cssquery-ext.html (next: http://localhost:60033/tests/dromaeo/cssquery-jquery.html) 23:47:00 INFO - PROCESS | 6459 | RSS: Main: 168427520 23:47:00 INFO - PROCESS | 6459 | 23:50:02 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:60033/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60033/tests/dromaeo/cssquery-mootools.html) 23:50:03 INFO - PROCESS | 6459 | RSS: Main: 170909696 23:50:03 INFO - PROCESS | 6459 | 23:53:04 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:60033/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60033/tests/dromaeo/cssquery-prototype.html) 23:53:05 INFO - PROCESS | 6459 | RSS: Main: 166850560 23:53:05 INFO - PROCESS | 6459 | 23:56:07 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:60033/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60033/tests/dromaeo/cssquery-yui.html) 23:56:08 INFO - PROCESS | 6459 | RSS: Main: 169328640 23:56:08 INFO - PROCESS | 6459 | 23:59:10 INFO - PROCESS | 6459 | Cycle 1(1): loaded http://localhost:60033/tests/dromaeo/cssquery-yui.html (next: http://localhost:60033/tests/dromaeo/cssquery-dojo.html) 23:59:11 INFO - PROCESS | 6459 | RSS: Main: 170532864 23:59:11 INFO - PROCESS | 6459 | 23:59:11 INFO - PROCESS | 6459 | __start_tp_report 23:59:11 INFO - PROCESS | 6459 | _x_x_mozilla_page_load 23:59:11 INFO - PROCESS | 6459 | _x_x_mozilla_page_load_details 23:59:11 INFO - PROCESS | 6459 | |i|pagename|runs| 23:59:11 INFO - PROCESS | 6459 | |0;dojo.html;3052.9542056869145;3057.205126667066;3092.752579793617;3097.6747441518646;3101.968980310199;5451.972740136299;5465.836024919254;5507.697076660782;5557.290659686585;5587.189857470675;5386.138217885139;5458.153986132146;5469.781208751655;5512.283403157594;5541.168824676301;4967.453580106186;5034.748262586874;5051.520105589963;5059.2916991621205;5129.512696293846;5070.74646267687;5123.692578445287;5131.230315452674;5135.204043373283;5174.35320584925;12.92776075024104;5014.297998280225;5054.974725126369;5056.089903817311;5069.442361340287;5043.722595257259;5049.368828896388;5050.4697006814495;5059.139946209153;5087.364079490064;5007.349044624212;5014.824481143179;5037.068142393632;5047.318611987408;5050.646454748169;5299.682019078868;5357.785688572452;5527.143292789584;5564.360098588673;5572.0527510323345;5967.194428752106;5980.372060933626;5994.400559944014;5995.100734889757;5995.490383317423;5803.274590676166;5846.123081537761;6026.9095963560585;6039.214902062748;6043.848903777441;5470.890582188374;5534.557235421197;5575.8884822303735;5576.693281869496;5625.09998400254;6066.7269972850445;6071.848203794852;6078;6081;6094.908576371358;5642.322921249394;5733.197352370671;5775.335836378787;5855.297364316224;5872;5912.23140991677;5913.497352725067;5915.438033386821;5916.497097746654;5960.7019649017375;5839.708014599253;5895.469407753323;5897.882042359129;5909.438603332676;5914.112883067488;5718.399568045378;5804.6807425592;5853.414658534112;5863.970680146572;5867.853303667357;4379.671524635665;4436.977815110969;4448.332750087513;4459.888502787457;4497.752623605733;3976.1451287973223;3988.062805240766;4023.396490526386;4035.3139966205817;4075.7554546726697;5498.697571633518;5661.3206415229615;5683.602147849693;5694.288213973254;5711.371749107595;5917.142014407887;5998.820035398945;6011.458968692838;6013.4888534474185;6017.759289628453;5705.172749951317;5740.65556066629;5754.251947246915;5757.596968212185;5758;5018.673786203885;5061.924071138936;5105.2086926526445;5114.28400023997;5131.1277082895995;6143.385661433821;6198.2252218472695;6208.068789681584;6208.379162083756;6219.751209951552;5957.702114894238;5974.1934838796205;5982.192404025401;5982.670953097621;5982.7307771149535;5999.400059993965;6102.206713127265;6106.2061931948565;6115.088229002436;6209.844753881189;5803.709814509173;5825.417458254141;5830.416958304136;5834.18321434991;5896.115582662635;5712.200291959046;5869.559783016205;5924.052151655715;5947.464728174485;5951.285845698544;5569.470900264469;5669.206311116364;5716.942830571641;5726.169705392778;5763.164341170591;5724.313082430135;5739;5752.223449834219;5767.250257466502;5772.451617096369;5545.528630066489;5681.943180568307;5714.971425142848;5722.885542289047;5724.084146536534;5630.915536266877;5701.828945131652;5795.94204057954;5813.09896965971;5823.155642431909;5601.383847776823;5624.85937851557;5699.230603868425;5712.42875712442;5722.5135863450405 23:59:11 INFO - PROCESS | 6459 | |1;ext.html;566.646199070739;576.3487259396882;598.4135547163783;600.6576251536626;606.0333767640611;30582;42491.57508424915;43722.56277437224;43803;43842.56157438425;45435;45678;45926;45964.540354596444;46062;8819.823603527942;8938.731838044869;8953.015168331478;8997.415168014091;8998.325125615573;8782.38523303369;8847.77880552985;8860.291176705849;8912.242459390927;8916.974547927006;8928.55357232139;8942.55287235639;8945.150210730002;8981.820363592724;8990.505522196276;8809.38334316598;8851.33614978879;8907.59915803784;8907.73276801697;8958.641654333851;8763.824723505559;8807.64769409223;8843.955780221122;8847.73456796297;8848.424852384638;42360;42612.78693606543;42677.146457070994;42725.57274427247;42814.57185428137;3506.3162683276773;3553.982230088859;3597.964020359789;3743.906402339936;3962.920741585152;32754.344913101842;32978.34043319144;33110;33483;33537.3292534148;4075.796210189508;4262.680298977589;4270.444842170498;4308.569143085698;4412.624926881219;345874;347860;348484;348687;350065;34063.489047664305;59646.40353596495;59745.10382344268;60040;60188;34574;34682.82658586691;34690;34725.652743472245;34759.4786078209;15421.768673469907;15583.06501609907;15644.608884777745;15676.529704108894;15676.843231567538;11807.17349785524;11861.11041671878;11864.94067529674;11872.465739041763;11913.344766037777;8120.106788253287;8244.917550824415;8252.33981281508;8292.460990035628;8319.292860106958;3275.5905511811025;3285.83570821458;3293.390722716257;3326.9500957485657;3360.6135294440965;1019.1948360794889;1068.823644098715;1075.5697720911699;1079.1906070447164;1083.0415082651753;32399.218043007862;32579.18552036218;33065.338693226004;33201.501977470354;33429.83285083559;1126.9887301127048;1149.8217776244696;1165.6211731187398;1188.7028242939266;1295.8768916953063;17082.743758843626;17095.65808683844;17225.655486890442;17264.223109960083;17295.56761080983;594585;597803;601996;602066;606577;56228.437715623135;57588.13617795736;58085.419145808846;58141.12788308179;58161.709191453774;1337.9130356526794;1361.9853209358894;1378.73803977244;1379.0691283383676;1382.3088455772113;30492.085237442912;31686.841565792023;32123;32331.838340808146;32686.83656581702;45086.549134508234;45094.77452612716;45211.321830173234;45263.321050183615;45420;462334;467460;467564;467718;473467;27308.59037114405;27659.723402766518;28356.71643283541;28442;28480.715192848635;48186.27720584124;48371.758141209066;48643.513564865316;49166.28483773919;49459.25811112908;41338;41760.3735943955;41762.791186043876;42270;43111;40400.39399408952;41034.79482602568;41125.588744112174;41845.581544185385;42481.15037699167;34829.477557836144;39983.80008099941;40089;40868.79565602153;40891.1821763569;35739.14086872992;37589.812050940665;37667.81166094152;37946.43080353852;38141.237175256894;28519;28579.28551786222;28620.28449288701;28659.37987954528;28678.283042924093 23:59:11 INFO - PROCESS | 6459 | |2;jquery.html;386.6597394293022;390.9257241124186;392.3232424068482;396.1482811954299;415.2774172939085;14303.356348964295;18795.71806422903;19844.702329465035;20408.693869591967;20485.897570512163;19557.315493957714;19607.117679704414;19897;20708;20824.271150509736;5681.517071048966;5710.343310519292;5846.7862630455265;5871.765129394819;5883.76464941404;5746.425357464262;5757.078867381219;5758.222639943596;5763.250777398932;5780.653160810344;5669;6092.208012958309;6392.808215753535;6424.972004479284;6522.7390904364;5798.739056742456;5873.148393482921;5896.469317761422;6344.841378965517;6399.456046236076;5693.686847223401;5712.314522257314;5723.141528770676;5754.108113242454;5791.710414479259;23593;23804.880975595184;23860;24175;24441.755582444304;2334.2647066174272;2454.2269185206783;2701.878415471289;2705.6753189617175;3009.653889802679;10100.595976160945;10213.182945364353;10444.947775261151;12180.269183848997;14458.06022608527;1826.7442558041885;1833.1292635997795;1844.1885570349004;1857.58204404008;1915.5115445561432;70237.64881175612;74802;83307.58346208291;86853.56573217093;91163.54418227932;10493.632722854816;10731.678049658523;10817;10854.131669466424;11185.832212516818;14873.776893346609;14912.70174596502;15011.624709382135;15019.849801502063;15020.62448438776;8062.314703250172;8433.662653493791;8468.32253419725;8551.657933682707;8602.91397086021;8321.916780832114;8343.08226095129;8344.62449189788;8404.663813447516;8487.490750554987;4557.587147984135;4578.107269082563;4670.392848929618;4673.228917228687;4700.059988002345;1891.6027634196698;1893.337331933812;1906.4376009077077;1949.6393167264102;1970.5566247594463;472.98581042568776;1001.6344034427527;1021.8722659667542;1038.7558923652934;1081.0162751895894;11840.940795295968;11963.64109076729;12428.689282767822;12487.562935297221;12951.222926624432;453.555515594719;454.53192143941516;463.46006901959515;469.15786163836;473.1176356095925;6662.300458451793;6863.210730765926;6869.587824730432;6876.484263680244;6913.412359949461;553820;554384;560891;565375;567387;100734;101412;103023.48488257661;103064.48467757764;103387.4830625842;449.58638052991324;458.05640380816294;460.47735819844047;462.03895896535124;462.79174371532946;10034.448105353984;10856.185786065918;11305.71735706614;11325.64583892032;11420.94289528547;42634.98704921349;42687.3596896053;42992.57007430011;43498.34752478652;43896.56103438925;57329;62670;63474;63587.682061589396;63742.04386934107;12258.080643951562;12949.733796585371;13112.606621801362;13169.407376668265;13234.867651323748;14762.261886905826;14802.481913132988;15427.61430964235;15550.144742038843;15559.37762489533;13156.276404797827;13248.933755331162;13409.396577153857;13562.321883905963;13605;12580.056495763038;12594.24434533931;12721.618351449471;12729.55446559366;12901.548445804352;12838.16551924122;13159;13215;13357.866421335662;13696.794548081587;13081.934590326988;13284.202947823162;13429.127106738031;13540.526081587097;13635.931820340835;13132.540361087316;13212.339383031001;13219;13365.799513007507;13411.463541458232 23:59:11 INFO - PROCESS | 6459 | |3;mootools.html;1493.1638282561767;1508.5474357692692;1671.481840629405;1810.1220907859695;1832.935847245346;7958.482698624585;8600.784980375494;8655.177758112977;9257.7685557861;9261.907380926197;8979.59591818368;9011.459312441259;9066.09339066093;9089.091090890908;9107.499087550183;2318.2002209237785;2345.3433038749176;2351.694279743631;2355.281639100074;2366.148186652804;2298.9195378161767;2323.082382458928;2328.0687724910003;2342.969093598811;2366.2782851230368;2278.5329007553496;2308.2152068296778;2313.097891822191;2335.4511689752894;2356.057576969209;2294.2314324701247;2302.3668491164894;2307.492351682619;2310.514791893704;2312.1098377124927;2253.121282699732;2258.48054947363;2267.7958983691383;2267.807236384893;2281.269993602048;8967.237784788302;8984.28125749945;9064.637414503411;9072.727818165466;9074.727758167266;5080.59355251579;5169.741512924376;5191.636585439021;5204.167333226704;5215.061288968022;3095.272610936428;3144.9528257076163;3154.274516861112;3159.7156255936848;3190.744740420761;1031.1080915008463;1035.073609119841;1045.6915210013065;1066.5413872035022;1077.946102694862;12560.937195314056;12583.370831458482;12589.244645321218;12654.304013279267;12660.79722426368;4399.6920215584605;4479.843205487792;4588.105319462673;4641.143542582994;4653.395058642355;10229.693109206735;10263.384196948207;10271;10305.072543471124;10347.741306467247;5251.973740131351;5256.947430525723;5284;5285.127953887565;5308.575313974873;4248.426462427595;4818.7831547580445;4910.116179087799;4974.925376119361;4988.975055124701;3799.2401519696173;3944.8027598619956;3968.3055465294037;3975.3241948868763;3988.262171498282;1294.766941950439;1305.6278960496213;1310.5478609879576;1316.9802452963213;1327.6680829792551;883.8718385834018;997;1004.3020101029714;1023.5394072667181;1033.2302434686208;6050.57645964787;6207.720652570555;6284.842878928063;6312.084747711648;6354.523410744213;437.5078037208141;438.51106016791687;448.76215605729016;456.57766565926386;464.49602181633304;4282.48610166782;4330.761808100522;4330.891727706832;4337.804798784062;4342.804573794124;10982.890171098186;11252.831207531894;11313.094952403788;11321.830172547418;11383.487743051583;11144.888551114385;11215.439228038565;11245.550177992789;11257;11296.152788540892;8037.115917249098;8353.958230208931;8384.916150838535;8528.232459078838;8597.312215022783;6157.815265542041;6380.649064301508;6433.260175079926;6493.772717954849;6519.315471875574;10307.587696492057;10365.9481702591;10481.895181048092;10534.42060686639;10548.947255263674;9829.557669904729;9992.850107248252;10126.949365253127;10473.528691209067;10529.262951593315;7161.355478007004;7626.275503827128;7779.4554381192775;8038.758837234892;8210.096889342287;8744.169303916373;8763.298936085226;8800.251978581893;8834.602442889956;8851.513166775889;7670.463067585216;7868.331191848528;7909.564973926489;7974.242446967529;7974.960125199337;7612.352949999312;7735.574543399942;7792.805179870322;7805.765827025199;7876.684932602631;6869.519133660596;7048.506604537633;7134.357907788324;7137;7141.071660684078;5191.454897235887;5221.791128354823;5324.094903866429;5372.811951581676;5374.596905232045;5075.822346217865;5173.301604283373;5222.817201397933;5254.763535640982;5325.094733895325 23:59:11 INFO - PROCESS | 6459 | |4;prototype.html;326.616225934527;334.3330056537208;337.8664580332983;340.4569711310459;346.79365777362494;5372.650777699447;5505.394406615279;5529.419410961847;5629.29633795775;5640.097584386499;5537.224788529599;5552.472515111068;5555.500014995949;5563.165525171226;5563.276774019382;4358.2808836541935;4361.760103194331;4374.387585737999;4384;4387.583179597949;4069.8779036628803;4314.719543229696;4320.805563749623;4377.496587892401;4377.978110109445;4209.284421648312;4231.534531201565;4253.1493701259715;4254.85119017865;4293.742375457467;4276.957230427687;4278.550752171009;4287.764172970486;4292.098659281539;4298.656107511407;3586.7309951753464;3766.114962983724;3774.094082488326;3785.7539259948016;3791.7724936503623;5421.647592906448;5424.674519528841;5431.429699881534;5454.40923053869;5455.509004189642;4893.6329775266995;4920.532549407801;4926.310316555685;4936.827211047632;4956.430010548761;5491.341039075297;5786.714247872067;5792.971035144839;5795.159701843251;5804.970975145139;4072.7556346619003;4102.200070986159;4102.794860256975;4114.547399786021;4115.691323150776;6004.5796794224425;6012.827498637767;6016.187814645011;6027.276726792813;6063.545234107415;4144.730592511477;4161.854335098257;4176.686748493875;4267.338562522814;4278.529361770203;4211.220924129046;4234.089670720809;4236.364545318165;4236.834870410662;4241.151769646083;4802.711837289774;4866.489018653061;4872.196087645499;4887;4918.3360246367;5265.947340526545;5817.214676018683;5850.882982340329;5856.38949288949;5858.414158584107;1452.3319273134477;1459.0297452194384;1464.6484843637663;1467.3030310602378;1467.8458761829854;919.1543779722671;940.431039221275;954.3319676226669;957.9808403832023;958.1233171647864;5007.474215207423;5008.549230569266;5043.218301163325;5053.84838454847;5060.342155519759;5253.763580638881;5271.65734227274;5303.522682958475;5314.335708036496;5335.733213339317;5056.216286475602;5071.340725705709;5077.568406685399;5331.4401987790725;5813.273340832396;3190.4735718606635;3206.4549026665522;3210.6033875264334;3211.5022171563446;3214.6624604416666;6074.210352654215;6158.815235542941;6273.9372606273355;6324.430801227912;6337.683115844189;6116.174316467309;6129.84675383119;6133.264008318941;6155.122687580241;6159.81520554384;6272.749090036439;6302.905456418157;6309.432151106331;6322.810315690444;6335.23977122739;5812.82561523155;6048.429417497634;6065.636061836304;6081.93566125935;6083.482903953213;5906.793262235801;5964.343922168471;5967.552433567413;5970.910436343545;5981.910271346021;6061.636301821904;6260.434891277181;6278.843028924313;6308.27454842699;6323.936760632335;4263.978680106579;4266.616004559481;4269.7224680395675;4282.914341713211;4289.91420171601;5707.286589176353;5764.884702305846;5932.4957378621575;5974.731137098754;6031.909521357271;5802.506786923159;5817.331006934257;5822.854428639318;5823.82528524145;5826.300843898759;5759.222504961944;5841.18223448709;5873.794417195378;5876.324222714443;5884.235049443716;5606.579506537108;5795.7391917362975;5800.9419905800405;5802.912956305574;5813.726910720532;5888.439563515757;5895.20414744004;5903.203067585992;5913.852153696192;5922.200502932049;5658.943410565842;5727.334505916134;5732.942670573241;5763.279590051244;5782.074868021096 23:59:11 INFO - PROCESS | 6459 | |5;yui.html;736.0909277042855;737.7381029734444;754.3814072460581;783.3772151139841;800.4516905919444;15364.308606112723;16465.588360291;16567.088810115438;16654.417095401648;16689.24898379573;14536.927315363408;14715.043522171052;14742.926285368585;14768.704625907476;14773.261336933165;662.7448432353531;792.453207286973;816.1960468938091;817.4523069543391;825.84721826462;817.1256755271861;821.650798410673;824.3734761581211;824.6495239523209;825.2325337436182;875.1423604867234;875.8117004843957;878.0429332028089;883.0022075055178;883.4213590098464;865.1564724393729;869.5608717597636;870.0299166429448;873.9694110706126;875.4528419737663;636.5162476517834;637.384923548773;638.8690318484746;639.1626968671055;641.3618449642589;14867;14904;14931.552053438305;15036.699266014728;15050;13751.381187846571;14170.149791012573;14407.135571865721;15531.5340539784;15668.764968525482;12397.070219733556;12957.157784743962;13344.933275333658;13451.260180690058;13460.528881489101;4535.274356103041;4561.885952851172;4563.520830312836;4568.611668008223;4638.698484598491;77064.22935770682;77239;77239.61380193119;77776.8333475004;77798;11323.43382830855;11413.201075924771;11492.827607585892;11580.305181688957;11586.188966772414;20354.28759993393;20371.388858334274;20381.79618203799;20389.490262743253;20502.17991280332;8138.43030987837;8267.338612910953;8446.282066024456;8496.320294376435;8499.320054395757;4797.712137271775;4815.2054910940005;4869.853904382874;4915.778789954461;4921.655484116149;3508.2632647144387;3592.2276710507367;3595.388783906742;3617.0234036809916;3622.4747411625167;612.3600837125126;614.7786796753165;615.0343959982873;617.1144407774857;628.0955424189244;540.5137359912709;574.9741261643236;636.3413866647998;669.1501792723311;680.8876535371609;8374;9043.77390565228;9066.456012639263;9176.816463670822;9413.858792118124;653.9869202615921;663.4062514049995;675.4933799650262;683.2450142592364;727.6980053277937;4557.635389168859;4608.470025946992;4627.213373726475;4647.512011238839;4694.201985662446;112236.43881780702;117939.41030294965;119944;121578.3921080389;123513;104175;104836.58046936084;105110.47444762728;107172.85654287027;107510;91088;93574;93969;95011.0498895016;95387.52306238425;8356.87464688018;8442.282405995558;8722.563871806511;8899.777505562413;8947.463152210888;53304.2004369927;54134.18798717944;54435.45564544462;54777.45222547883;56465.71767141138;74190;79224;80497;80664.19335806802;82494.58752706199;11517.712057198638;11600.245984011011;11781.587644432404;11901.107416943936;11903.166778325434;12586.685332866751;12918.741625167631;13037.543685970946;13074.477020919057;13215.074944753775;11787.351695656822;11991.400429978641;12351.320677362472;12590.559330423392;12875.742485150431;12331.630051098482;12422.751544969231;12439.378031098227;12834.486620535448;12935.935320323715;11352.262102963281;11415.942920285346;11453;11497;11653.76692466129;9387.249020078514;9490;9689.031096890536;9717.708468745948;9801.9019809801;10678.572857085941;10705.143588512745;10881.727956801144;10999.780004400027;11001.22991390595 23:59:11 INFO - PROCESS | 6459 | __end_tp_report 23:59:11 INFO - PROCESS | 6459 | __start_cc_report 23:59:11 INFO - PROCESS | 6459 | _x_x_mozilla_cycle_collect,338 23:59:11 INFO - PROCESS | 6459 | __end_cc_report 23:59:11 INFO - PROCESS | 6459 | __startTimestamp1468047551139__endTimestamp 23:59:11 INFO - PROCESS | 6459 | 23:59:11 INFO - PROCESS | 6459 | ------- Summary: start ------- 23:59:11 INFO - PROCESS | 6459 | Number of tests: 6 23:59:11 INFO - PROCESS | 6459 | 23:59:11 INFO - PROCESS | 6459 | [#0] dojo.html Cycles:165 Average:5463.63 Median:5712.43 stddev:771.03 (13.5%) stddev-sans-first:749.84 23:59:11 INFO - PROCESS | 6459 | Values: 3053.0 3057.2 3092.8 3097.7 3102.0 5452.0 5465.8 5507.7 5557.3 5587.2 5386.1 5458.2 5469.8 5512.3 5541.2 4967.5 5034.7 5051.5 5059.3 5129.5 5070.7 5123.7 5131.2 5135.2 5174.4 12.9 5014.3 5055.0 5056.1 5069.4 5043.7 5049.4 5050.5 5059.1 5087.4 5007.3 5014.8 5037.1 5047.3 5050.6 5299.7 5357.8 5527.1 5564.4 5572.1 5967.2 5980.4 5994.4 5995.1 5995.5 5803.3 5846.1 6026.9 6039.2 6043.8 5470.9 5534.6 5575.9 5576.7 5625.1 6066.7 6071.8 6078.0 6081.0 6094.9 5642.3 5733.2 5775.3 5855.3 5872.0 5912.2 5913.5 5915.4 5916.5 5960.7 5839.7 5895.5 5897.9 5909.4 5914.1 5718.4 5804.7 5853.4 5864.0 5867.9 4379.7 4437.0 4448.3 4459.9 4497.8 3976.1 3988.1 4023.4 4035.3 4075.8 5498.7 5661.3 5683.6 5694.3 5711.4 5917.1 5998.8 6011.5 6013.5 6017.8 5705.2 5740.7 5754.3 5757.6 5758.0 5018.7 5061.9 5105.2 5114.3 5131.1 6143.4 6198.2 6208.1 6208.4 6219.8 5957.7 5974.2 5982.2 5982.7 5982.7 5999.4 6102.2 6106.2 6115.1 6209.8 5803.7 5825.4 5830.4 5834.2 5896.1 5712.2 5869.6 5924.1 5947.5 5951.3 5569.5 5669.2 5716.9 5726.2 5763.2 5724.3 5739.0 5752.2 5767.3 5772.5 5545.5 5681.9 5715.0 5722.9 5724.1 5630.9 5701.8 5795.9 5813.1 5823.2 5601.4 5624.9 5699.2 5712.4 5722.5 23:59:11 INFO - PROCESS | 6459 | 23:59:11 INFO - PROCESS | 6459 | [#1] ext.html Cycles:180 Average:61514.75 Median:41231.79 stddev:128877.96 (312.6%) stddev-sans-first:129158.26 23:59:11 INFO - PROCESS | 6459 | Values: 566.6 576.3 598.4 600.7 606.0 30582.0 42491.6 43722.6 43803.0 43842.6 45435.0 45678.0 45926.0 45964.5 46062.0 8819.8 8938.7 8953.0 8997.4 8998.3 8782.4 8847.8 8860.3 8912.2 8917.0 8928.6 8942.6 8945.2 8981.8 8990.5 8809.4 8851.3 8907.6 8907.7 8958.6 8763.8 8807.6 8844.0 8847.7 8848.4 42360.0 42612.8 42677.1 42725.6 42814.6 3506.3 3554.0 3598.0 3743.9 3962.9 32754.3 32978.3 33110.0 33483.0 33537.3 4075.8 4262.7 4270.4 4308.6 4412.6 345874.0 347860.0 348484.0 348687.0 350065.0 34063.5 59646.4 59745.1 60040.0 60188.0 34574.0 34682.8 34690.0 34725.7 34759.5 15421.8 15583.1 15644.6 15676.5 15676.8 11807.2 11861.1 11864.9 11872.5 11913.3 8120.1 8244.9 8252.3 8292.5 8319.3 3275.6 3285.8 3293.4 3327.0 3360.6 1019.2 1068.8 1075.6 1079.2 1083.0 32399.2 32579.2 33065.3 33201.5 33429.8 1127.0 1149.8 1165.6 1188.7 1295.9 17082.7 17095.7 17225.7 17264.2 17295.6 594585.0 597803.0 601996.0 602066.0 606577.0 56228.4 57588.1 58085.4 58141.1 58161.7 1337.9 1362.0 1378.7 1379.1 1382.3 30492.1 31686.8 32123.0 32331.8 32686.8 45086.5 45094.8 45211.3 45263.3 45420.0 462334.0 467460.0 467564.0 467718.0 473467.0 27308.6 27659.7 28356.7 28442.0 28480.7 48186.3 48371.8 48643.5 49166.3 49459.3 41338.0 41760.4 41762.8 42270.0 43111.0 40400.4 41034.8 41125.6 41845.6 42481.2 34829.5 39983.8 40089.0 40868.8 40891.2 35739.1 37589.8 37667.8 37946.4 38141.2 28519.0 28579.3 28620.3 28659.4 28678.3 23:59:11 INFO - PROCESS | 6459 | 23:59:11 INFO - PROCESS | 6459 | [#2] jquery.html Cycles:180 Average:31483.80 Median:23698.94 stddev:92299.68 (389.5%) stddev-sans-first:92529.07 23:59:11 INFO - PROCESS | 6459 | Values: 386.7 390.9 392.3 396.1 415.3 14303.4 18795.7 19844.7 20408.7 20485.9 19557.3 19607.1 19897.0 20708.0 20824.3 5681.5 5710.3 5846.8 5871.8 5883.8 5746.4 5757.1 5758.2 5763.3 5780.7 5669.0 6092.2 6392.8 6425.0 6522.7 5798.7 5873.1 5896.5 6344.8 6399.5 5693.7 5712.3 5723.1 5754.1 5791.7 23593.0 23804.9 23860.0 24175.0 24441.8 2334.3 2454.2 2701.9 2705.7 3009.7 10100.6 10213.2 10444.9 12180.3 14458.1 1826.7 1833.1 1844.2 1857.6 1915.5 70237.6 74802.0 83307.6 86853.6 91163.5 10493.6 10731.7 10817.0 10854.1 11185.8 14873.8 14912.7 15011.6 15019.8 15020.6 8062.3 8433.7 8468.3 8551.7 8602.9 8321.9 8343.1 8344.6 8404.7 8487.5 4557.6 4578.1 4670.4 4673.2 4700.1 1891.6 1893.3 1906.4 1949.6 1970.6 473.0 1001.6 1021.9 1038.8 1081.0 11840.9 11963.6 12428.7 12487.6 12951.2 453.6 454.5 463.5 469.2 473.1 6662.3 6863.2 6869.6 6876.5 6913.4 553820.0 554384.0 560891.0 565375.0 567387.0 100734.0 101412.0 103023.5 103064.5 103387.5 449.6 458.1 460.5 462.0 462.8 10034.4 10856.2 11305.7 11325.6 11420.9 42635.0 42687.4 42992.6 43498.3 43896.6 57329.0 62670.0 63474.0 63587.7 63742.0 12258.1 12949.7 13112.6 13169.4 13234.9 14762.3 14802.5 15427.6 15550.1 15559.4 13156.3 13248.9 13409.4 13562.3 13605.0 12580.1 12594.2 12721.6 12729.6 12901.5 12838.2 13159.0 13215.0 13357.9 13696.8 13081.9 13284.2 13429.1 13540.5 13635.9 13132.5 13212.3 13219.0 13365.8 13411.5 23:59:11 INFO - PROCESS | 6459 | 23:59:11 INFO - PROCESS | 6459 | [#3] mootools.html Cycles:180 Average:5885.39 Median:2464.30 stddev:3406.62 (138.2%) stddev-sans-first:3400.19 23:59:11 INFO - PROCESS | 6459 | Values: 1493.2 1508.5 1671.5 1810.1 1832.9 7958.5 8600.8 8655.2 9257.8 9261.9 8979.6 9011.5 9066.1 9089.1 9107.5 2318.2 2345.3 2351.7 2355.3 2366.1 2298.9 2323.1 2328.1 2343.0 2366.3 2278.5 2308.2 2313.1 2335.5 2356.1 2294.2 2302.4 2307.5 2310.5 2312.1 2253.1 2258.5 2267.8 2267.8 2281.3 8967.2 8984.3 9064.6 9072.7 9074.7 5080.6 5169.7 5191.6 5204.2 5215.1 3095.3 3145.0 3154.3 3159.7 3190.7 1031.1 1035.1 1045.7 1066.5 1077.9 12560.9 12583.4 12589.2 12654.3 12660.8 4399.7 4479.8 4588.1 4641.1 4653.4 10229.7 10263.4 10271.0 10305.1 10347.7 5252.0 5256.9 5284.0 5285.1 5308.6 4248.4 4818.8 4910.1 4974.9 4989.0 3799.2 3944.8 3968.3 3975.3 3988.3 1294.8 1305.6 1310.5 1317.0 1327.7 883.9 997.0 1004.3 1023.5 1033.2 6050.6 6207.7 6284.8 6312.1 6354.5 437.5 438.5 448.8 456.6 464.5 4282.5 4330.8 4330.9 4337.8 4342.8 10982.9 11252.8 11313.1 11321.8 11383.5 11144.9 11215.4 11245.6 11257.0 11296.2 8037.1 8354.0 8384.9 8528.2 8597.3 6157.8 6380.6 6433.3 6493.8 6519.3 10307.6 10365.9 10481.9 10534.4 10548.9 9829.6 9992.9 10126.9 10473.5 10529.3 7161.4 7626.3 7779.5 8038.8 8210.1 8744.2 8763.3 8800.3 8834.6 8851.5 7670.5 7868.3 7909.6 7974.2 7975.0 7612.4 7735.6 7792.8 7805.8 7876.7 6869.5 7048.5 7134.4 7137.0 7141.1 5191.5 5221.8 5324.1 5372.8 5374.6 5075.8 5173.3 5222.8 5254.8 5325.1 23:59:11 INFO - PROCESS | 6459 | 23:59:11 INFO - PROCESS | 6459 | [#4] prototype.html Cycles:180 Average:4860.40 Median:5473.43 stddev:1445.46 (26.4%) stddev-sans-first:1408.89 23:59:11 INFO - PROCESS | 6459 | Values: 326.6 334.3 337.9 340.5 346.8 5372.7 5505.4 5529.4 5629.3 5640.1 5537.2 5552.5 5555.5 5563.2 5563.3 4358.3 4361.8 4374.4 4384.0 4387.6 4069.9 4314.7 4320.8 4377.5 4378.0 4209.3 4231.5 4253.1 4254.9 4293.7 4277.0 4278.6 4287.8 4292.1 4298.7 3586.7 3766.1 3774.1 3785.8 3791.8 5421.6 5424.7 5431.4 5454.4 5455.5 4893.6 4920.5 4926.3 4936.8 4956.4 5491.3 5786.7 5793.0 5795.2 5805.0 4072.8 4102.2 4102.8 4114.5 4115.7 6004.6 6012.8 6016.2 6027.3 6063.5 4144.7 4161.9 4176.7 4267.3 4278.5 4211.2 4234.1 4236.4 4236.8 4241.2 4802.7 4866.5 4872.2 4887.0 4918.3 5265.9 5817.2 5850.9 5856.4 5858.4 1452.3 1459.0 1464.6 1467.3 1467.8 919.2 940.4 954.3 958.0 958.1 5007.5 5008.5 5043.2 5053.8 5060.3 5253.8 5271.7 5303.5 5314.3 5335.7 5056.2 5071.3 5077.6 5331.4 5813.3 3190.5 3206.5 3210.6 3211.5 3214.7 6074.2 6158.8 6273.9 6324.4 6337.7 6116.2 6129.8 6133.3 6155.1 6159.8 6272.7 6302.9 6309.4 6322.8 6335.2 5812.8 6048.4 6065.6 6081.9 6083.5 5906.8 5964.3 5967.6 5970.9 5981.9 6061.6 6260.4 6278.8 6308.3 6323.9 4264.0 4266.6 4269.7 4282.9 4289.9 5707.3 5764.9 5932.5 5974.7 6031.9 5802.5 5817.3 5822.9 5823.8 5826.3 5759.2 5841.2 5873.8 5876.3 5884.2 5606.6 5795.7 5800.9 5802.9 5813.7 5888.4 5895.2 5903.2 5913.9 5922.2 5658.9 5727.3 5732.9 5763.3 5782.1 23:59:11 INFO - PROCESS | 6459 | 23:59:11 INFO - PROCESS | 6459 | [#5] yui.html Cycles:180 Average:21326.11 Median:4806.46 stddev:31715.32 (659.8%) stddev-sans-first:31766.61 23:59:11 INFO - PROCESS | 6459 | Values: 736.1 737.7 754.4 783.4 800.5 15364.3 16465.6 16567.1 16654.4 16689.2 14536.9 14715.0 14742.9 14768.7 14773.3 662.7 792.5 816.2 817.5 825.8 817.1 821.7 824.4 824.6 825.2 875.1 875.8 878.0 883.0 883.4 865.2 869.6 870.0 874.0 875.5 636.5 637.4 638.9 639.2 641.4 14867.0 14904.0 14931.6 15036.7 15050.0 13751.4 14170.1 14407.1 15531.5 15668.8 12397.1 12957.2 13344.9 13451.3 13460.5 4535.3 4561.9 4563.5 4568.6 4638.7 77064.2 77239.0 77239.6 77776.8 77798.0 11323.4 11413.2 11492.8 11580.3 11586.2 20354.3 20371.4 20381.8 20389.5 20502.2 8138.4 8267.3 8446.3 8496.3 8499.3 4797.7 4815.2 4869.9 4915.8 4921.7 3508.3 3592.2 3595.4 3617.0 3622.5 612.4 614.8 615.0 617.1 628.1 540.5 575.0 636.3 669.2 680.9 8374.0 9043.8 9066.5 9176.8 9413.9 654.0 663.4 675.5 683.2 727.7 4557.6 4608.5 4627.2 4647.5 4694.2 112236.4 117939.4 119944.0 121578.4 123513.0 104175.0 104836.6 105110.5 107172.9 107510.0 91088.0 93574.0 93969.0 95011.0 95387.5 8356.9 8442.3 8722.6 8899.8 8947.5 53304.2 54134.2 54435.5 54777.5 56465.7 74190.0 79224.0 80497.0 80664.2 82494.6 11517.7 11600.2 11781.6 11901.1 11903.2 12586.7 12918.7 13037.5 13074.5 13215.1 11787.4 11991.4 12351.3 12590.6 12875.7 12331.6 12422.8 12439.4 12834.5 12935.9 11352.3 11415.9 11453.0 11497.0 11653.8 9387.2 9490.0 9689.0 9717.7 9801.9 10678.6 10705.1 10881.7 10999.8 11001.2 23:59:11 INFO - PROCESS | 6459 | -------- Summary: end -------- 23:59:11 INFO - PROCESS | 6459 | 23:59:11 INFO - TEST-INFO | 6459: exit 0 23:59:11 INFO - TEST-OK | dromaeo_css | took 1109988ms 23:59:11 INFO - TEST-START | kraken 23:59:11 INFO - operating with platform_type : linux_ 23:59:11 INFO - Initialising browser for kraken test... 23:59:11 INFO - TEST-INFO | started process 6705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd0Yoy_/profile http://localhost:60033/getInfo.html) 23:59:16 INFO - PROCESS | 6705 | __metrics Screen width/height:1600/1200 23:59:16 INFO - PROCESS | 6705 | colorDepth:24 23:59:16 INFO - PROCESS | 6705 | Browser inner width/height: 1024/697 23:59:16 INFO - PROCESS | 6705 | __metrics 23:59:17 ERROR - PROCESS | 6705 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 23:59:18 INFO - TEST-INFO | 6705: exit 0 23:59:18 INFO - Browser initialized. 23:59:18 INFO - Running cycle 1/1 for kraken test... 23:59:18 INFO - TEST-INFO | started process 6829 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd0Yoy_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:59:30 INFO - PROCESS | 6829 | RSS: Main: 167964672 23:59:30 INFO - PROCESS | 6829 | 23:59:32 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60033/tests/kraken/driver.html?testName=audio-beat-detection) 23:59:33 INFO - PROCESS | 6829 | RSS: Main: 173400064 23:59:33 INFO - PROCESS | 6829 | 23:59:36 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60033/tests/kraken/driver.html?testName=audio-dft) 23:59:36 INFO - PROCESS | 6829 | RSS: Main: 172654592 23:59:36 INFO - PROCESS | 6829 | 23:59:39 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60033/tests/kraken/driver.html?testName=audio-fft) 23:59:40 INFO - PROCESS | 6829 | RSS: Main: 167436288 23:59:40 INFO - PROCESS | 6829 | 23:59:42 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60033/tests/kraken/driver.html?testName=audio-oscillator) 23:59:43 INFO - PROCESS | 6829 | RSS: Main: 168099840 23:59:43 INFO - PROCESS | 6829 | 23:59:45 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60033/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:59:45 INFO - PROCESS | 6829 | RSS: Main: 168570880 23:59:45 INFO - PROCESS | 6829 | 23:59:49 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60033/tests/kraken/driver.html?testName=imaging-darkroom) 23:59:49 INFO - PROCESS | 6829 | RSS: Main: 168345600 23:59:49 INFO - PROCESS | 6829 | 23:59:53 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60033/tests/kraken/driver.html?testName=imaging-desaturate) 23:59:53 INFO - PROCESS | 6829 | RSS: Main: 166813696 23:59:53 INFO - PROCESS | 6829 | 23:59:56 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60033/tests/kraken/driver.html?testName=json-parse-financial) 23:59:57 INFO - PROCESS | 6829 | RSS: Main: 168464384 23:59:57 INFO - PROCESS | 6829 | 23:59:58 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60033/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:59:59 INFO - PROCESS | 6829 | RSS: Main: 168595456 23:59:59 INFO - PROCESS | 6829 | 00:00:01 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:00:01 INFO - PROCESS | 6829 | RSS: Main: 168337408 00:00:01 INFO - PROCESS | 6829 | 00:00:03 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:00:04 INFO - PROCESS | 6829 | RSS: Main: 169066496 00:00:04 INFO - PROCESS | 6829 | 00:00:07 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:00:07 INFO - PROCESS | 6829 | RSS: Main: 168992768 00:00:07 INFO - PROCESS | 6829 | 00:00:10 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:00:11 INFO - PROCESS | 6829 | RSS: Main: 169271296 00:00:11 INFO - PROCESS | 6829 | 00:00:12 INFO - PROCESS | 6829 | Cycle 1(1): loaded http://localhost:60033/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60033/tests/kraken/driver.html?testName=ai-astar) 00:00:13 INFO - PROCESS | 6829 | RSS: Main: 169897984 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | __start_tp_report 00:00:13 INFO - PROCESS | 6829 | _x_x_mozilla_page_load 00:00:13 INFO - PROCESS | 6829 | _x_x_mozilla_page_load_details 00:00:13 INFO - PROCESS | 6829 | |i|pagename|runs| 00:00:13 INFO - PROCESS | 6829 | |0;ai-astar;101;111;105;110;111;112;113;109;110;111 00:00:13 INFO - PROCESS | 6829 | |1;audio-beat-detection;147;117;146;175;118;143;150;121;171;122 00:00:13 INFO - PROCESS | 6829 | |2;audio-dft;164;162;163;161;164;167;167;169;162;162 00:00:13 INFO - PROCESS | 6829 | |3;audio-fft;76;74;75;142;77;75;76;75;171;76 00:00:13 INFO - PROCESS | 6829 | |4;audio-oscillator;86;84;157;84;84;84;138;85;84;147 00:00:13 INFO - PROCESS | 6829 | |5;imaging-gaussian-blur;118;119;118;117;118;118;117;117;120;117 00:00:13 INFO - PROCESS | 6829 | |6;imaging-darkroom;148;147;147;147;149;147;148;148;147;148 00:00:13 INFO - PROCESS | 6829 | |7;imaging-desaturate;95;97;96;96;96;97;95;96;95;96 00:00:13 INFO - PROCESS | 6829 | |8;json-parse-financial;56;59;56;55;57;57;55;56;56;63 00:00:13 INFO - PROCESS | 6829 | |9;json-stringify-tinderbox;62;62;62;62;62;62;62;64;66;63 00:00:13 INFO - PROCESS | 6829 | |10;stanford-crypto-aes;77;77;78;81;82;75;76;78;77;75 00:00:13 INFO - PROCESS | 6829 | |11;stanford-crypto-ccm;138;122;122;137;137;138;121;130;161;124 00:00:13 INFO - PROCESS | 6829 | |12;stanford-crypto-pbkdf2;157;163;157;156;159;157;166;165;162;156 00:00:13 INFO - PROCESS | 6829 | |13;stanford-crypto-sha256-iterative;63;64;64;63;67;63;64;64;64;61 00:00:13 INFO - PROCESS | 6829 | __end_tp_report 00:00:13 INFO - PROCESS | 6829 | __start_cc_report 00:00:13 INFO - PROCESS | 6829 | _x_x_mozilla_cycle_collect,913 00:00:13 INFO - PROCESS | 6829 | __end_cc_report 00:00:13 INFO - PROCESS | 6829 | __startTimestamp1468047613095__endTimestamp 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | ------- Summary: start ------- 00:00:13 INFO - PROCESS | 6829 | Number of tests: 14 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#0] ai-astar Cycles:10 Average:109.30 Median:111.00 stddev:3.62 (3.3%) stddev-sans-first:2.28 00:00:13 INFO - PROCESS | 6829 | Values: 101.0 111.0 105.0 110.0 111.0 112.0 113.0 109.0 110.0 111.0 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:146.50 stddev:21.26 (14.5%) stddev-sans-first:22.44 00:00:13 INFO - PROCESS | 6829 | Values: 147.0 117.0 146.0 175.0 118.0 143.0 150.0 121.0 171.0 122.0 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.69 (1.6%) stddev-sans-first:2.85 00:00:13 INFO - PROCESS | 6829 | Values: 164.0 162.0 163.0 161.0 164.0 167.0 167.0 169.0 162.0 162.0 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#3] audio-fft Cycles:10 Average:91.70 Median:75.50 stddev:34.84 (46.1%) stddev-sans-first:36.49 00:00:13 INFO - PROCESS | 6829 | Values: 76.0 74.0 75.0 142.0 77.0 75.0 76.0 75.0 171.0 76.0 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:84.00 stddev:30.72 (36.6%) stddev-sans-first:31.94 00:00:13 INFO - PROCESS | 6829 | Values: 86.0 84.0 157.0 84.0 84.0 84.0 138.0 85.0 84.0 147.0 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.99 (0.8%) stddev-sans-first:1.05 00:00:13 INFO - PROCESS | 6829 | Values: 118.0 119.0 118.0 117.0 118.0 118.0 117.0 117.0 120.0 117.0 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 00:00:13 INFO - PROCESS | 6829 | Values: 148.0 147.0 147.0 147.0 149.0 147.0 148.0 148.0 147.0 148.0 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 00:00:13 INFO - PROCESS | 6829 | Values: 95.0 97.0 96.0 96.0 96.0 97.0 95.0 96.0 95.0 96.0 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:56.50 stddev:2.40 (4.3%) stddev-sans-first:2.52 00:00:13 INFO - PROCESS | 6829 | Values: 56.0 59.0 56.0 55.0 57.0 57.0 55.0 56.0 56.0 63.0 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:62.00 stddev:1.34 (2.2%) stddev-sans-first:1.39 00:00:13 INFO - PROCESS | 6829 | Values: 62.0 62.0 62.0 62.0 62.0 62.0 62.0 64.0 66.0 63.0 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.50 stddev:2.32 (3.0%) stddev-sans-first:2.45 00:00:13 INFO - PROCESS | 6829 | Values: 77.0 77.0 78.0 81.0 82.0 75.0 76.0 78.0 77.0 75.0 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:137.00 stddev:12.21 (8.9%) stddev-sans-first:12.82 00:00:13 INFO - PROCESS | 6829 | Values: 138.0 122.0 122.0 137.0 137.0 138.0 121.0 130.0 161.0 124.0 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.80 Median:160.50 stddev:3.85 (2.4%) stddev-sans-first:3.95 00:00:13 INFO - PROCESS | 6829 | Values: 157.0 163.0 157.0 156.0 159.0 157.0 166.0 165.0 162.0 156.0 00:00:13 INFO - PROCESS | 6829 | 00:00:13 INFO - PROCESS | 6829 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.70 Median:64.00 stddev:1.49 (2.3%) stddev-sans-first:1.56 00:00:13 INFO - PROCESS | 6829 | Values: 63.0 64.0 64.0 63.0 67.0 63.0 64.0 64.0 64.0 61.0 00:00:13 INFO - PROCESS | 6829 | -------- Summary: end -------- 00:00:13 INFO - PROCESS | 6829 | 00:00:14 INFO - TEST-INFO | 6829: exit 0 00:00:14 INFO - TEST-OK | kraken | took 62300ms 00:00:14 INFO - SUITE-END | took 1172s 00:00:14 INFO - Completed test suite (00:19:32) 00:00:14 INFO - javascript benchmark 00:00:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7209.714477813116, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3052.9542056869145, 3057.205126667066, 3092.752579793617, 3097.6747441518646, 3101.968980310199, 5451.972740136299, 5465.836024919254, 5507.697076660782, 5557.290659686585, 5587.189857470675, 5386.138217885139, 5458.153986132146, 5469.781208751655, 5512.283403157594, 5541.168824676301, 4967.453580106186, 5034.748262586874, 5051.520105589963, 5059.2916991621205, 5129.512696293846, 5070.74646267687, 5123.692578445287, 5131.230315452674, 5135.204043373283, 5174.35320584925, 12.92776075024104, 5014.297998280225, 5054.974725126369, 5056.089903817311, 5069.442361340287, 5043.722595257259, 5049.368828896388, 5050.4697006814495, 5059.139946209153, 5087.364079490064, 5007.349044624212, 5014.824481143179, 5037.068142393632, 5047.318611987408, 5050.646454748169, 5299.682019078868, 5357.785688572452, 5527.143292789584, 5564.360098588673, 5572.0527510323345, 5967.194428752106, 5980.372060933626, 5994.400559944014, 5995.100734889757, 5995.490383317423, 5803.274590676166, 5846.123081537761, 6026.9095963560585, 6039.214902062748, 6043.848903777441, 5470.890582188374, 5534.557235421197, 5575.8884822303735, 5576.693281869496, 5625.09998400254, 6066.7269972850445, 6071.848203794852, 6078.0, 6081.0, 6094.908576371358, 5642.322921249394, 5733.197352370671, 5775.335836378787, 5855.297364316224, 5872.0, 5912.23140991677, 5913.497352725067, 5915.438033386821, 5916.497097746654, 5960.7019649017375, 5839.708014599253, 5895.469407753323, 5897.882042359129, 5909.438603332676, 5914.112883067488, 5718.399568045378, 5804.6807425592, 5853.414658534112, 5863.970680146572, 5867.853303667357, 4379.671524635665, 4436.977815110969, 4448.332750087513, 4459.888502787457, 4497.752623605733, 3976.1451287973223, 3988.062805240766, 4023.396490526386, 4035.3139966205817, 4075.7554546726697, 5498.697571633518, 5661.3206415229615, 5683.602147849693, 5694.288213973254, 5711.371749107595, 5917.142014407887, 5998.820035398945, 6011.458968692838, 6013.4888534474185, 6017.759289628453, 5705.172749951317, 5740.65556066629, 5754.251947246915, 5757.596968212185, 5758.0, 5018.673786203885, 5061.924071138936, 5105.2086926526445, 5114.28400023997, 5131.1277082895995, 6143.385661433821, 6198.2252218472695, 6208.068789681584, 6208.379162083756, 6219.751209951552, 5957.702114894238, 5974.1934838796205, 5982.192404025401, 5982.670953097621, 5982.7307771149535, 5999.400059993965, 6102.206713127265, 6106.2061931948565, 6115.088229002436, 6209.844753881189, 5803.709814509173, 5825.417458254141, 5830.416958304136, 5834.18321434991, 5896.115582662635, 5712.200291959046, 5869.559783016205, 5924.052151655715, 5947.464728174485, 5951.285845698544, 5569.470900264469, 5669.206311116364, 5716.942830571641, 5726.169705392778, 5763.164341170591, 5724.313082430135, 5739.0, 5752.223449834219, 5767.250257466502, 5772.451617096369, 5545.528630066489, 5681.943180568307, 5714.971425142848, 5722.885542289047, 5724.084146536534, 5630.915536266877, 5701.828945131652, 5795.94204057954, 5813.09896965971, 5823.155642431909, 5601.383847776823, 5624.85937851557, 5699.230603868425, 5712.42875712442, 5722.5135863450405], "value": 5411.996666906967, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.646199070739, 576.3487259396882, 598.4135547163783, 600.6576251536626, 606.0333767640611, 30582.0, 42491.57508424915, 43722.56277437224, 43803.0, 43842.56157438425, 45435.0, 45678.0, 45926.0, 45964.540354596444, 46062.0, 8819.823603527942, 8938.731838044869, 8953.015168331478, 8997.415168014091, 8998.325125615573, 8782.38523303369, 8847.77880552985, 8860.291176705849, 8912.242459390927, 8916.974547927006, 8928.55357232139, 8942.55287235639, 8945.150210730002, 8981.820363592724, 8990.505522196276, 8809.38334316598, 8851.33614978879, 8907.59915803784, 8907.73276801697, 8958.641654333851, 8763.824723505559, 8807.64769409223, 8843.955780221122, 8847.73456796297, 8848.424852384638, 42360.0, 42612.78693606543, 42677.146457070994, 42725.57274427247, 42814.57185428137, 3506.3162683276773, 3553.982230088859, 3597.964020359789, 3743.906402339936, 3962.920741585152, 32754.344913101842, 32978.34043319144, 33110.0, 33483.0, 33537.3292534148, 4075.796210189508, 4262.680298977589, 4270.444842170498, 4308.569143085698, 4412.624926881219, 345874.0, 347860.0, 348484.0, 348687.0, 350065.0, 34063.489047664305, 59646.40353596495, 59745.10382344268, 60040.0, 60188.0, 34574.0, 34682.82658586691, 34690.0, 34725.652743472245, 34759.4786078209, 15421.768673469907, 15583.06501609907, 15644.608884777745, 15676.529704108894, 15676.843231567538, 11807.17349785524, 11861.11041671878, 11864.94067529674, 11872.465739041763, 11913.344766037777, 8120.106788253287, 8244.917550824415, 8252.33981281508, 8292.460990035628, 8319.292860106958, 3275.5905511811025, 3285.83570821458, 3293.390722716257, 3326.9500957485657, 3360.6135294440965, 1019.1948360794889, 1068.823644098715, 1075.5697720911699, 1079.1906070447164, 1083.0415082651753, 32399.218043007862, 32579.18552036218, 33065.338693226004, 33201.501977470354, 33429.83285083559, 1126.9887301127048, 1149.8217776244696, 1165.6211731187398, 1188.7028242939266, 1295.8768916953063, 17082.743758843626, 17095.65808683844, 17225.655486890442, 17264.223109960083, 17295.56761080983, 594585.0, 597803.0, 601996.0, 602066.0, 606577.0, 56228.437715623135, 57588.13617795736, 58085.419145808846, 58141.12788308179, 58161.709191453774, 1337.9130356526794, 1361.9853209358894, 1378.73803977244, 1379.0691283383676, 1382.3088455772113, 30492.085237442912, 31686.841565792023, 32123.0, 32331.838340808146, 32686.83656581702, 45086.549134508234, 45094.77452612716, 45211.321830173234, 45263.321050183615, 45420.0, 462334.0, 467460.0, 467564.0, 467718.0, 473467.0, 27308.59037114405, 27659.723402766518, 28356.71643283541, 28442.0, 28480.715192848635, 48186.27720584124, 48371.758141209066, 48643.513564865316, 49166.28483773919, 49459.25811112908, 41338.0, 41760.3735943955, 41762.791186043876, 42270.0, 43111.0, 40400.39399408952, 41034.79482602568, 41125.588744112174, 41845.581544185385, 42481.15037699167, 34829.477557836144, 39983.80008099941, 40089.0, 40868.79565602153, 40891.1821763569, 35739.14086872992, 37589.812050940665, 37667.81166094152, 37946.43080353852, 38141.237175256894, 28519.0, 28579.28551786222, 28620.28449288701, 28659.37987954528, 28678.283042924093], "value": 18980.327611980025, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.6597394293022, 390.9257241124186, 392.3232424068482, 396.1482811954299, 415.2774172939085, 14303.356348964295, 18795.71806422903, 19844.702329465035, 20408.693869591967, 20485.897570512163, 19557.315493957714, 19607.117679704414, 19897.0, 20708.0, 20824.271150509736, 5681.517071048966, 5710.343310519292, 5846.7862630455265, 5871.765129394819, 5883.76464941404, 5746.425357464262, 5757.078867381219, 5758.222639943596, 5763.250777398932, 5780.653160810344, 5669.0, 6092.208012958309, 6392.808215753535, 6424.972004479284, 6522.7390904364, 5798.739056742456, 5873.148393482921, 5896.469317761422, 6344.841378965517, 6399.456046236076, 5693.686847223401, 5712.314522257314, 5723.141528770676, 5754.108113242454, 5791.710414479259, 23593.0, 23804.880975595184, 23860.0, 24175.0, 24441.755582444304, 2334.2647066174272, 2454.2269185206783, 2701.878415471289, 2705.6753189617175, 3009.653889802679, 10100.595976160945, 10213.182945364353, 10444.947775261151, 12180.269183848997, 14458.06022608527, 1826.7442558041885, 1833.1292635997795, 1844.1885570349004, 1857.58204404008, 1915.5115445561432, 70237.64881175612, 74802.0, 83307.58346208291, 86853.56573217093, 91163.54418227932, 10493.632722854816, 10731.678049658523, 10817.0, 10854.131669466424, 11185.832212516818, 14873.776893346609, 14912.70174596502, 15011.624709382135, 15019.849801502063, 15020.62448438776, 8062.314703250172, 8433.662653493791, 8468.32253419725, 8551.657933682707, 8602.91397086021, 8321.916780832114, 8343.08226095129, 8344.62449189788, 8404.663813447516, 8487.490750554987, 4557.587147984135, 4578.107269082563, 4670.392848929618, 4673.228917228687, 4700.059988002345, 1891.6027634196698, 1893.337331933812, 1906.4376009077077, 1949.6393167264102, 1970.5566247594463, 472.98581042568776, 1001.6344034427527, 1021.8722659667542, 1038.7558923652934, 1081.0162751895894, 11840.940795295968, 11963.64109076729, 12428.689282767822, 12487.562935297221, 12951.222926624432, 453.555515594719, 454.53192143941516, 463.46006901959515, 469.15786163836, 473.1176356095925, 6662.300458451793, 6863.210730765926, 6869.587824730432, 6876.484263680244, 6913.412359949461, 553820.0, 554384.0, 560891.0, 565375.0, 567387.0, 100734.0, 101412.0, 103023.48488257661, 103064.48467757764, 103387.4830625842, 449.58638052991324, 458.05640380816294, 460.47735819844047, 462.03895896535124, 462.79174371532946, 10034.448105353984, 10856.185786065918, 11305.71735706614, 11325.64583892032, 11420.94289528547, 42634.98704921349, 42687.3596896053, 42992.57007430011, 43498.34752478652, 43896.56103438925, 57329.0, 62670.0, 63474.0, 63587.682061589396, 63742.04386934107, 12258.080643951562, 12949.733796585371, 13112.606621801362, 13169.407376668265, 13234.867651323748, 14762.261886905826, 14802.481913132988, 15427.61430964235, 15550.144742038843, 15559.37762489533, 13156.276404797827, 13248.933755331162, 13409.396577153857, 13562.321883905963, 13605.0, 12580.056495763038, 12594.24434533931, 12721.618351449471, 12729.55446559366, 12901.548445804352, 12838.16551924122, 13159.0, 13215.0, 13357.866421335662, 13696.794548081587, 13081.934590326988, 13284.202947823162, 13429.127106738031, 13540.526081587097, 13635.931820340835, 13132.540361087316, 13212.339383031001, 13219.0, 13365.799513007507, 13411.463541458232], "value": 9043.783929234261, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.1638282561767, 1508.5474357692692, 1671.481840629405, 1810.1220907859695, 1832.935847245346, 7958.482698624585, 8600.784980375494, 8655.177758112977, 9257.7685557861, 9261.907380926197, 8979.59591818368, 9011.459312441259, 9066.09339066093, 9089.091090890908, 9107.499087550183, 2318.2002209237785, 2345.3433038749176, 2351.694279743631, 2355.281639100074, 2366.148186652804, 2298.9195378161767, 2323.082382458928, 2328.0687724910003, 2342.969093598811, 2366.2782851230368, 2278.5329007553496, 2308.2152068296778, 2313.097891822191, 2335.4511689752894, 2356.057576969209, 2294.2314324701247, 2302.3668491164894, 2307.492351682619, 2310.514791893704, 2312.1098377124927, 2253.121282699732, 2258.48054947363, 2267.7958983691383, 2267.807236384893, 2281.269993602048, 8967.237784788302, 8984.28125749945, 9064.637414503411, 9072.727818165466, 9074.727758167266, 5080.59355251579, 5169.741512924376, 5191.636585439021, 5204.167333226704, 5215.061288968022, 3095.272610936428, 3144.9528257076163, 3154.274516861112, 3159.7156255936848, 3190.744740420761, 1031.1080915008463, 1035.073609119841, 1045.6915210013065, 1066.5413872035022, 1077.946102694862, 12560.937195314056, 12583.370831458482, 12589.244645321218, 12654.304013279267, 12660.79722426368, 4399.6920215584605, 4479.843205487792, 4588.105319462673, 4641.143542582994, 4653.395058642355, 10229.693109206735, 10263.384196948207, 10271.0, 10305.072543471124, 10347.741306467247, 5251.973740131351, 5256.947430525723, 5284.0, 5285.127953887565, 5308.575313974873, 4248.426462427595, 4818.7831547580445, 4910.116179087799, 4974.925376119361, 4988.975055124701, 3799.2401519696173, 3944.8027598619956, 3968.3055465294037, 3975.3241948868763, 3988.262171498282, 1294.766941950439, 1305.6278960496213, 1310.5478609879576, 1316.9802452963213, 1327.6680829792551, 883.8718385834018, 997.0, 1004.3020101029714, 1023.5394072667181, 1033.2302434686208, 6050.57645964787, 6207.720652570555, 6284.842878928063, 6312.084747711648, 6354.523410744213, 437.5078037208141, 438.51106016791687, 448.76215605729016, 456.57766565926386, 464.49602181633304, 4282.48610166782, 4330.761808100522, 4330.891727706832, 4337.804798784062, 4342.804573794124, 10982.890171098186, 11252.831207531894, 11313.094952403788, 11321.830172547418, 11383.487743051583, 11144.888551114385, 11215.439228038565, 11245.550177992789, 11257.0, 11296.152788540892, 8037.115917249098, 8353.958230208931, 8384.916150838535, 8528.232459078838, 8597.312215022783, 6157.815265542041, 6380.649064301508, 6433.260175079926, 6493.772717954849, 6519.315471875574, 10307.587696492057, 10365.9481702591, 10481.895181048092, 10534.42060686639, 10548.947255263674, 9829.557669904729, 9992.850107248252, 10126.949365253127, 10473.528691209067, 10529.262951593315, 7161.355478007004, 7626.275503827128, 7779.4554381192775, 8038.758837234892, 8210.096889342287, 8744.169303916373, 8763.298936085226, 8800.251978581893, 8834.602442889956, 8851.513166775889, 7670.463067585216, 7868.331191848528, 7909.564973926489, 7974.242446967529, 7974.960125199337, 7612.352949999312, 7735.574543399942, 7792.805179870322, 7805.765827025199, 7876.684932602631, 6869.519133660596, 7048.506604537633, 7134.357907788324, 7137.0, 7141.071660684078, 5191.454897235887, 5221.791128354823, 5324.094903866429, 5372.811951581676, 5374.596905232045, 5075.822346217865, 5173.301604283373, 5222.817201397933, 5254.763535640982, 5325.094733895325], "value": 4602.002535543673, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.616225934527, 334.3330056537208, 337.8664580332983, 340.4569711310459, 346.79365777362494, 5372.650777699447, 5505.394406615279, 5529.419410961847, 5629.29633795775, 5640.097584386499, 5537.224788529599, 5552.472515111068, 5555.500014995949, 5563.165525171226, 5563.276774019382, 4358.2808836541935, 4361.760103194331, 4374.387585737999, 4384.0, 4387.583179597949, 4069.8779036628803, 4314.719543229696, 4320.805563749623, 4377.496587892401, 4377.978110109445, 4209.284421648312, 4231.534531201565, 4253.1493701259715, 4254.85119017865, 4293.742375457467, 4276.957230427687, 4278.550752171009, 4287.764172970486, 4292.098659281539, 4298.656107511407, 3586.7309951753464, 3766.114962983724, 3774.094082488326, 3785.7539259948016, 3791.7724936503623, 5421.647592906448, 5424.674519528841, 5431.429699881534, 5454.40923053869, 5455.509004189642, 4893.6329775266995, 4920.532549407801, 4926.310316555685, 4936.827211047632, 4956.430010548761, 5491.341039075297, 5786.714247872067, 5792.971035144839, 5795.159701843251, 5804.970975145139, 4072.7556346619003, 4102.200070986159, 4102.794860256975, 4114.547399786021, 4115.691323150776, 6004.5796794224425, 6012.827498637767, 6016.187814645011, 6027.276726792813, 6063.545234107415, 4144.730592511477, 4161.854335098257, 4176.686748493875, 4267.338562522814, 4278.529361770203, 4211.220924129046, 4234.089670720809, 4236.364545318165, 4236.834870410662, 4241.151769646083, 4802.711837289774, 4866.489018653061, 4872.196087645499, 4887.0, 4918.3360246367, 5265.947340526545, 5817.214676018683, 5850.882982340329, 5856.38949288949, 5858.414158584107, 1452.3319273134477, 1459.0297452194384, 1464.6484843637663, 1467.3030310602378, 1467.8458761829854, 919.1543779722671, 940.431039221275, 954.3319676226669, 957.9808403832023, 958.1233171647864, 5007.474215207423, 5008.549230569266, 5043.218301163325, 5053.84838454847, 5060.342155519759, 5253.763580638881, 5271.65734227274, 5303.522682958475, 5314.335708036496, 5335.733213339317, 5056.216286475602, 5071.340725705709, 5077.568406685399, 5331.4401987790725, 5813.273340832396, 3190.4735718606635, 3206.4549026665522, 3210.6033875264334, 3211.5022171563446, 3214.6624604416666, 6074.210352654215, 6158.815235542941, 6273.9372606273355, 6324.430801227912, 6337.683115844189, 6116.174316467309, 6129.84675383119, 6133.264008318941, 6155.122687580241, 6159.81520554384, 6272.749090036439, 6302.905456418157, 6309.432151106331, 6322.810315690444, 6335.23977122739, 5812.82561523155, 6048.429417497634, 6065.636061836304, 6081.93566125935, 6083.482903953213, 5906.793262235801, 5964.343922168471, 5967.552433567413, 5970.910436343545, 5981.910271346021, 6061.636301821904, 6260.434891277181, 6278.843028924313, 6308.27454842699, 6323.936760632335, 4263.978680106579, 4266.616004559481, 4269.7224680395675, 4282.914341713211, 4289.91420171601, 5707.286589176353, 5764.884702305846, 5932.4957378621575, 5974.731137098754, 6031.909521357271, 5802.506786923159, 5817.331006934257, 5822.854428639318, 5823.82528524145, 5826.300843898759, 5759.222504961944, 5841.18223448709, 5873.794417195378, 5876.324222714443, 5884.235049443716, 5606.579506537108, 5795.7391917362975, 5800.9419905800405, 5802.912956305574, 5813.726910720532, 5888.439563515757, 5895.20414744004, 5903.203067585992, 5913.852153696192, 5922.200502932049, 5658.943410565842, 5727.334505916134, 5732.942670573241, 5763.279590051244, 5782.074868021096], "value": 4395.794513010548, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.0909277042855, 737.7381029734444, 754.3814072460581, 783.3772151139841, 800.4516905919444, 15364.308606112723, 16465.588360291, 16567.088810115438, 16654.417095401648, 16689.24898379573, 14536.927315363408, 14715.043522171052, 14742.926285368585, 14768.704625907476, 14773.261336933165, 662.7448432353531, 792.453207286973, 816.1960468938091, 817.4523069543391, 825.84721826462, 817.1256755271861, 821.650798410673, 824.3734761581211, 824.6495239523209, 825.2325337436182, 875.1423604867234, 875.8117004843957, 878.0429332028089, 883.0022075055178, 883.4213590098464, 865.1564724393729, 869.5608717597636, 870.0299166429448, 873.9694110706126, 875.4528419737663, 636.5162476517834, 637.384923548773, 638.8690318484746, 639.1626968671055, 641.3618449642589, 14867.0, 14904.0, 14931.552053438305, 15036.699266014728, 15050.0, 13751.381187846571, 14170.149791012573, 14407.135571865721, 15531.5340539784, 15668.764968525482, 12397.070219733556, 12957.157784743962, 13344.933275333658, 13451.260180690058, 13460.528881489101, 4535.274356103041, 4561.885952851172, 4563.520830312836, 4568.611668008223, 4638.698484598491, 77064.22935770682, 77239.0, 77239.61380193119, 77776.8333475004, 77798.0, 11323.43382830855, 11413.201075924771, 11492.827607585892, 11580.305181688957, 11586.188966772414, 20354.28759993393, 20371.388858334274, 20381.79618203799, 20389.490262743253, 20502.17991280332, 8138.43030987837, 8267.338612910953, 8446.282066024456, 8496.320294376435, 8499.320054395757, 4797.712137271775, 4815.2054910940005, 4869.853904382874, 4915.778789954461, 4921.655484116149, 3508.2632647144387, 3592.2276710507367, 3595.388783906742, 3617.0234036809916, 3622.4747411625167, 612.3600837125126, 614.7786796753165, 615.0343959982873, 617.1144407774857, 628.0955424189244, 540.5137359912709, 574.9741261643236, 636.3413866647998, 669.1501792723311, 680.8876535371609, 8374.0, 9043.77390565228, 9066.456012639263, 9176.816463670822, 9413.858792118124, 653.9869202615921, 663.4062514049995, 675.4933799650262, 683.2450142592364, 727.6980053277937, 4557.635389168859, 4608.470025946992, 4627.213373726475, 4647.512011238839, 4694.201985662446, 112236.43881780702, 117939.41030294965, 119944.0, 121578.3921080389, 123513.0, 104175.0, 104836.58046936084, 105110.47444762728, 107172.85654287027, 107510.0, 91088.0, 93574.0, 93969.0, 95011.0498895016, 95387.52306238425, 8356.87464688018, 8442.282405995558, 8722.563871806511, 8899.777505562413, 8947.463152210888, 53304.2004369927, 54134.18798717944, 54435.45564544462, 54777.45222547883, 56465.71767141138, 74190.0, 79224.0, 80497.0, 80664.19335806802, 82494.58752706199, 11517.712057198638, 11600.245984011011, 11781.587644432404, 11901.107416943936, 11903.166778325434, 12586.685332866751, 12918.741625167631, 13037.543685970946, 13074.477020919057, 13215.074944753775, 11787.351695656822, 11991.400429978641, 12351.320677362472, 12590.559330423392, 12875.742485150431, 12331.630051098482, 12422.751544969231, 12439.378031098227, 12834.486620535448, 12935.935320323715, 11352.262102963281, 11415.942920285346, 11453.0, 11497.0, 11653.76692466129, 9387.249020078514, 9490.0, 9689.031096890536, 9717.708468745948, 9801.9019809801, 10678.572857085941, 10705.143588512745, 10881.727956801144, 10999.780004400027, 11001.22991390595], "value": 7472.600356689726, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 105.0, 110.0, 111.0, 112.0, 113.0, 109.0, 110.0, 111.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 117.0, 146.0, 175.0, 118.0, 143.0, 150.0, 121.0, 171.0, 122.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 161.0, 164.0, 167.0, 167.0, 169.0, 162.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 142.0, 77.0, 75.0, 76.0, 75.0, 171.0, 76.0], "value": 91.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 157.0, 84.0, 84.0, 84.0, 138.0, 85.0, 84.0, 147.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 120.0, 117.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 149.0, 147.0, 148.0, 148.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 96.0, 97.0, 95.0, 96.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 59.0, 56.0, 55.0, 57.0, 57.0, 55.0, 56.0, 56.0, 63.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 64.0, 66.0, 63.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 78.0, 81.0, 82.0, 75.0, 76.0, 78.0, 77.0, 75.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 122.0, 122.0, 137.0, 137.0, 138.0, 121.0, 130.0, 161.0, 124.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 163.0, 157.0, 156.0, 159.0, 157.0, 166.0, 165.0, 162.0, 156.0], "value": 159.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 67.0, 63.0, 64.0, 64.0, 64.0, 61.0], "value": 63.7, "unit": "score"}]}]} 00:00:14 INFO - Return code: 0 00:00:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:00:14 ERROR - # TBPL SUCCESS # 00:00:14 INFO - Running post-action listener: _resource_record_post_action 00:00:14 INFO - ##### 00:00:14 INFO - ##### Finished run-tests step (success) 00:00:14 INFO - ##### 00:00:14 INFO - Running post-run listener: _resource_record_post_run 00:00:14 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 559382528; Read time: 0; Write time: 550388 00:00:14 INFO - TinderboxPrint: CPU usage
13.3% 00:00:14 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 00:00:14 INFO - TinderboxPrint: I/O write bytes / time
559,382,528 / 550,388 00:00:14 INFO - TinderboxPrint: CPU idle
8,231.7 (86.7%) 00:00:14 INFO - TinderboxPrint: CPU user
1,206.4 (12.7%) 00:00:14 INFO - TinderboxPrint: Swap in / out
0 / 0 00:00:14 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 264388608; Read time: 0; Write time: 259432 00:00:14 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 294469632; Read time: 0; Write time: 290924 00:00:15 INFO - Running post-run listener: _upload_blobber_files 00:00:15 INFO - Blob upload gear active. 00:00:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:00:15 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 00:00:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:00:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:00:15 INFO - (blobuploader) - INFO - Open directory for files ... 00:00:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:00:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:00:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:00:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:00:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:00:16 INFO - (blobuploader) - INFO - Done attempting. 00:00:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:00:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:00:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:00:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:00:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:00:19 INFO - (blobuploader) - INFO - Done attempting. 00:00:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:00:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:00:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:00:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:00:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:00:20 INFO - (blobuploader) - INFO - Done attempting. 00:00:20 INFO - (blobuploader) - INFO - Iteration through files over. 00:00:20 INFO - Return code: 0 00:00:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:00:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:00:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3f255d0484c2a7f106c65c46d0c6cc1b17572c79ae1c1b45a11c3bcba7d35dabe8a6e4ffb457c7b06807483d697f89eba7ea8e42f5568ff511d5c6fa06c9e6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/504b338eb1b480c5fd6d36e1ec97fa07c11cbdb36c0ff3759638c4e31a84c04df2cea7f2b559efbf95a7031e81e5735d4306a3e0f5053a86066391567587ec9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7261cc2eda129c3fda3d59ef62cf0a3568e28c9eb19cd37ce64d56e941e91c898fb0ac8e287fb4d31d7f8baa5397241dad63bfafcc55ad46948a220f924a610"} 00:00:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:00:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:00:20 INFO - Contents: 00:00:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3f255d0484c2a7f106c65c46d0c6cc1b17572c79ae1c1b45a11c3bcba7d35dabe8a6e4ffb457c7b06807483d697f89eba7ea8e42f5568ff511d5c6fa06c9e6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/504b338eb1b480c5fd6d36e1ec97fa07c11cbdb36c0ff3759638c4e31a84c04df2cea7f2b559efbf95a7031e81e5735d4306a3e0f5053a86066391567587ec9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7261cc2eda129c3fda3d59ef62cf0a3568e28c9eb19cd37ce64d56e941e91c898fb0ac8e287fb4d31d7f8baa5397241dad63bfafcc55ad46948a220f924a610"} 00:00:20 INFO - Running post-run listener: copy_logs_to_upload_dir 00:00:20 INFO - Copying logs to upload dir... 00:00:20 INFO - mkdir: /builds/slave/test/build/upload/logs 00:00:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.105570 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2016-07-09 00:00:19.832490) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 00:00:19.836471) ========= 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=d2a8c569965ab8367867b893000001a1-1468045967.228956-285650581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3f255d0484c2a7f106c65c46d0c6cc1b17572c79ae1c1b45a11c3bcba7d35dabe8a6e4ffb457c7b06807483d697f89eba7ea8e42f5568ff511d5c6fa06c9e6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/504b338eb1b480c5fd6d36e1ec97fa07c11cbdb36c0ff3759638c4e31a84c04df2cea7f2b559efbf95a7031e81e5735d4306a3e0f5053a86066391567587ec9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7261cc2eda129c3fda3d59ef62cf0a3568e28c9eb19cd37ce64d56e941e91c898fb0ac8e287fb4d31d7f8baa5397241dad63bfafcc55ad46948a220f924a610"} build_url:https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/GuK9A80mQHKmHNR3Bz6V9w/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3f255d0484c2a7f106c65c46d0c6cc1b17572c79ae1c1b45a11c3bcba7d35dabe8a6e4ffb457c7b06807483d697f89eba7ea8e42f5568ff511d5c6fa06c9e6b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/504b338eb1b480c5fd6d36e1ec97fa07c11cbdb36c0ff3759638c4e31a84c04df2cea7f2b559efbf95a7031e81e5735d4306a3e0f5053a86066391567587ec9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b7261cc2eda129c3fda3d59ef62cf0a3568e28c9eb19cd37ce64d56e941e91c898fb0ac8e287fb4d31d7f8baa5397241dad63bfafcc55ad46948a220f924a610"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-09 00:00:19.870643) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 00:00:19.871301) ========= 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=d2a8c569965ab8367867b893000001a1-1468045967.228956-285650581 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004435 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-09 00:00:19.954567) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 00:00:19.955239) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-09 00:00:19.955909) ========= ========= Total master_lag: 1.00 =========