builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1467385819.51 results: success (0) buildid: 20160701053013 builduid: c68b6e2fc3944ac3b7d2a07845c3598d revision: adfe23aae513a339ef042d5ff4255500e452114a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:19.510674) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:19.511176) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:19.511471) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:19.543054) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:19.543620) ========= 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=5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 08:10:19-- 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% 81.5M=0s 2016-07-01 08:10:19 (81.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.101019 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:19.659550) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:19.659879) ========= 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=5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013965 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:19.709161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:19.709529) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev adfe23aae513a339ef042d5ff4255500e452114a --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 adfe23aae513a339ef042d5ff4255500e452114a --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=5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 08:10:20,013 truncating revision to first 12 chars 2016-07-01 08:10:20,013 Setting DEBUG logging. 2016-07-01 08:10:20,013 attempt 1/10 2016-07-01 08:10:20,013 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/adfe23aae513?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 08:10:20,339 unpacking tar archive at: fx-team-adfe23aae513/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679215 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:20.404159) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:20.404486) ========= script_repo_revision: adfe23aae513a339ef042d5ff4255500e452114a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:20.404886) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:20.405156) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 08:10:20.413746) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-01 08:10:20.414071) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:10:20 INFO - MultiFileLogger online at 20160701 08:10:20 in /builds/slave/test 08:10:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:10:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:10:20 INFO - {'append_to_log': False, 08:10:20 INFO - 'base_work_dir': '/builds/slave/test', 08:10:20 INFO - 'blob_upload_branch': 'Fx-Team', 08:10:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:10:20 INFO - 'branch': 'Fx-Team', 08:10:20 INFO - 'buildbot_json_path': 'buildprops.json', 08:10:20 INFO - 'config_files': ('talos/linux_config.py',), 08:10:20 INFO - 'default_actions': ('clobber', 08:10:20 INFO - 'read-buildbot-config', 08:10:20 INFO - 'download-and-extract', 08:10:20 INFO - 'populate-webroot', 08:10:20 INFO - 'create-virtualenv', 08:10:20 INFO - 'install', 08:10:20 INFO - 'run-tests'), 08:10:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:10:20 INFO - 'download_minidump_stackwalk': True, 08:10:20 INFO - 'download_symbols': 'ondemand', 08:10:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:10:20 INFO - 'tooltool.py': '/tools/tooltool.py', 08:10:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:10:20 INFO - '/tools/misc-python/virtualenv.py')}, 08:10:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:10:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:10:20 INFO - 'installer_path': 'installer.exe', 08:10:20 INFO - 'log_level': 'info', 08:10:20 INFO - 'log_name': 'talos', 08:10:20 INFO - 'log_to_console': True, 08:10:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:10:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:10:20 INFO - 'opt_config_files': (), 08:10:20 INFO - 'pip_index': False, 08:10:20 INFO - 'sps_profile': False, 08:10:20 INFO - 'sps_profile_interval': 0, 08:10:20 INFO - 'suite': 'dromaeojs', 08:10:20 INFO - 'system_bits': '32', 08:10:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:10:20 INFO - 'title': 'talos-linux64-ix-011', 08:10:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:10:20 INFO - 'use_talos_json': True, 08:10:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:10:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:10:20 INFO - 'work_dir': 'build'} 08:10:20 INFO - ##### 08:10:20 INFO - ##### Running clobber step. 08:10:20 INFO - ##### 08:10:20 INFO - Running pre-action listener: _resource_record_pre_action 08:10:20 INFO - Running main action method: clobber 08:10:20 INFO - rmtree: /builds/slave/test/build 08:10:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:10:21 INFO - Running post-action listener: _resource_record_post_action 08:10:21 INFO - ##### 08:10:21 INFO - ##### Finished clobber step (success) 08:10:21 INFO - ##### 08:10:21 INFO - ##### 08:10:21 INFO - ##### Running read-buildbot-config step. 08:10:21 INFO - ##### 08:10:21 INFO - Running pre-action listener: _resource_record_pre_action 08:10:21 INFO - Running main action method: read_buildbot_config 08:10:21 INFO - Using buildbot properties: 08:10:21 INFO - { 08:10:21 INFO - "project": "", 08:10:21 INFO - "product": "firefox", 08:10:21 INFO - "script_repo_revision": "production", 08:10:21 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:10:21 INFO - "repository": "", 08:10:21 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 08:10:21 INFO - "buildid": "20160701053013", 08:10:21 INFO - "pgo_build": "True", 08:10:21 INFO - "basedir": "/builds/slave/test", 08:10:21 INFO - "buildnumber": 851, 08:10:21 INFO - "slavename": "talos-linux64-ix-011", 08:10:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:10:21 INFO - "platform": "ubuntu64_hw", 08:10:21 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:10:21 INFO - "branch": "fx-team", 08:10:21 INFO - "repo_path": "integration/fx-team", 08:10:21 INFO - "revision": "adfe23aae513a339ef042d5ff4255500e452114a", 08:10:21 INFO - "stage_platform": "linux64-pgo", 08:10:21 INFO - "builduid": "c68b6e2fc3944ac3b7d2a07845c3598d", 08:10:21 INFO - "slavebuilddir": "test" 08:10:21 INFO - } 08:10:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:10:21 INFO - Running post-action listener: _resource_record_post_action 08:10:21 INFO - ##### 08:10:21 INFO - ##### Finished read-buildbot-config step (success) 08:10:21 INFO - ##### 08:10:21 INFO - ##### 08:10:21 INFO - ##### Running download-and-extract step. 08:10:21 INFO - ##### 08:10:21 INFO - Running pre-action listener: _resource_record_pre_action 08:10:21 INFO - Running main action method: download_and_extract 08:10:21 INFO - mkdir: /builds/slave/test/build/tests 08:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:21 INFO - https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:10:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 08:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 08:10:21 INFO - Downloaded 1361 bytes. 08:10:21 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:10:21 INFO - Using the following test package requirements: 08:10:21 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:10:21 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:10:21 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:10:21 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:21 INFO - u'jsshell-linux-x86_64.zip'], 08:10:21 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:10:21 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:10:21 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:10:21 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:10:21 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:10:21 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:10:21 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:10:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:10:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:21 INFO - https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:10:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 08:10:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 08:10:23 INFO - Downloaded 24270733 bytes. 08:10:23 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'] 08:10:23 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 08:10:24 INFO - Return code: 0 08:10:24 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 08:10:24 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')]} 08:10:24 INFO - https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:10:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:10:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 08:10:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 08:10:26 INFO - Downloaded 24270733 bytes. 08:10:26 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'] 08:10:26 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 08:10:27 INFO - Return code: 0 08:10:27 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')]} 08:10:27 INFO - https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:10:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:10:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:10:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 08:10:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 08:10:28 INFO - Downloaded 14405242 bytes. 08:10:28 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'] 08:10:28 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 08:10:28 INFO - Return code: 0 08:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:28 INFO - https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:10:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 08:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HnK2meMqRLSW-83BDvR3Qw/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 08:10:30 INFO - Downloaded 60316904 bytes. 08:10:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:30 INFO - mkdir: /builds/slave/test/properties 08:10:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:10:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:10:30 INFO - Contents: 08:10:30 INFO - build_url:https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:10:30 INFO - Running post-action listener: _resource_record_post_action 08:10:30 INFO - Running post-action listener: set_extra_try_arguments 08:10:30 INFO - ##### 08:10:30 INFO - ##### Finished download-and-extract step (success) 08:10:30 INFO - ##### 08:10:30 INFO - ##### 08:10:30 INFO - ##### Running populate-webroot step. 08:10:30 INFO - ##### 08:10:30 INFO - Running pre-action listener: _resource_record_pre_action 08:10:30 INFO - Running main action method: populate_webroot 08:10:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:10:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:10:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:10:30 INFO - '--tppagecycles', 08:10:30 INFO - '7'], 08:10:30 INFO - 'tests': ['tsvgm']}}, 08:10:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:10:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:10:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:10:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:10:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:10:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:10:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:30 INFO - 'talos_options': ['--disable-e10s'], 08:10:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:10:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:30 INFO - 'talos_options': ['--disable-e10s'], 08:10:30 INFO - 'tests': ['damp', 'tps']}, 08:10:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:30 INFO - 'tests': ['damp', 'tps']}, 08:10:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:10:30 INFO - 'tests': ['dromaeo_dom']}, 08:10:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:10:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:10:30 INFO - 'tests': ['basic_compositor_video']}, 08:10:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:10:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:10:30 INFO - 'tests': ['a11yr', 08:10:30 INFO - 'ts_paint', 08:10:30 INFO - 'tpaint', 08:10:30 INFO - 'sessionrestore', 08:10:30 INFO - 'sessionrestore_no_auto_restore', 08:10:30 INFO - 'tabpaint']}, 08:10:30 INFO - 'other-e10s': {'tests': ['a11yr', 08:10:30 INFO - 'ts_paint', 08:10:30 INFO - 'tpaint', 08:10:30 INFO - 'sessionrestore', 08:10:30 INFO - 'sessionrestore_no_auto_restore', 08:10:30 INFO - 'tabpaint']}, 08:10:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:10:30 INFO - 'ts_paint', 08:10:30 INFO - 'tpaint', 08:10:30 INFO - 'sessionrestore', 08:10:30 INFO - 'sessionrestore_no_auto_restore', 08:10:30 INFO - 'tabpaint']}, 08:10:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:10:30 INFO - 'ts_paint', 08:10:30 INFO - 'tpaint', 08:10:30 INFO - 'sessionrestore', 08:10:30 INFO - 'sessionrestore_no_auto_restore', 08:10:30 INFO - 'tabpaint']}, 08:10:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:10:30 INFO - 'tests': ['a11yr', 08:10:30 INFO - 'ts_paint', 08:10:30 INFO - 'tpaint', 08:10:30 INFO - 'sessionrestore', 08:10:30 INFO - 'sessionrestore_no_auto_restore', 08:10:30 INFO - 'tabpaint']}, 08:10:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:10:30 INFO - 'tests': ['a11yr', 08:10:30 INFO - 'ts_paint', 08:10:30 INFO - 'tpaint', 08:10:30 INFO - 'sessionrestore', 08:10:30 INFO - 'sessionrestore_no_auto_restore', 08:10:30 INFO - 'tabpaint']}, 08:10:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:10:30 INFO - 'tests': ['tsvgx', 08:10:30 INFO - 'tsvgr_opacity', 08:10:30 INFO - 'tart', 08:10:30 INFO - 'tscrollx', 08:10:30 INFO - 'cart']}, 08:10:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:10:30 INFO - 'tsvgr_opacity', 08:10:30 INFO - 'tart', 08:10:30 INFO - 'tscrollx', 08:10:30 INFO - 'cart']}, 08:10:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:30 INFO - 'talos_options': ['--disable-e10s'], 08:10:30 INFO - 'tests': ['tp5o']}, 08:10:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:30 INFO - 'tests': ['tp5o']}, 08:10:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:30 INFO - 'talos_options': ['--disable-e10s', 08:10:30 INFO - '--xperf_path', 08:10:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:30 INFO - 'tests': ['tp5n']}, 08:10:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:10:30 INFO - 'talos_options': ['--xperf_path', 08:10:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:10:30 INFO - 'tests': ['tp5n']}}, 08:10:30 INFO - 'talos.zip': {'path': '', 08:10:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:10:30 INFO - Running post-action listener: _resource_record_post_action 08:10:30 INFO - ##### 08:10:30 INFO - ##### Finished populate-webroot step (success) 08:10:30 INFO - ##### 08:10:30 INFO - ##### 08:10:30 INFO - ##### Running create-virtualenv step. 08:10:30 INFO - ##### 08:10:30 INFO - Running pre-action listener: _resource_record_pre_action 08:10:30 INFO - Running main action method: create_virtualenv 08:10:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:10:30 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 08:10:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:10:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:10:31 INFO - Using real prefix '/usr' 08:10:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:10:31 INFO - Installing distribute.............................................................................................................................................................................................done. 08:10:33 INFO - Installing pip.................done. 08:10:33 INFO - Return code: 0 08:10:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:33 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 0x2381030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2642180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, '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 0x26412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2641740>, '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': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', '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 08:10:33 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 08:10:33 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 08:10:33 INFO - Using env: {'DISPLAY': ':0', 08:10:33 INFO - 'HOME': '/home/cltbld', 08:10:33 INFO - 'LANG': 'en_US.UTF-8', 08:10:33 INFO - 'LANGUAGE': 'en_US:en', 08:10:33 INFO - 'LOGNAME': 'cltbld', 08:10:33 INFO - 'MAIL': '/var/mail/cltbld', 08:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:33 INFO - 'MOZ_NO_REMOTE': '1', 08:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:33 INFO - 'NO_EM_RESTART': '1', 08:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:33 INFO - 'PWD': '/builds/slave/test', 08:10:33 INFO - 'SHELL': '/bin/bash', 08:10:33 INFO - 'SHLVL': '1', 08:10:33 INFO - 'TERM': 'linux', 08:10:33 INFO - 'TMOUT': '86400', 08:10:33 INFO - 'USER': 'cltbld', 08:10:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', 08:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:33 INFO - '_': '/tools/buildbot/bin/python'} 08:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:33 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 08:10:33 INFO - Cleaning up... 08:10:33 INFO - Return code: 0 08:10:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:33 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 0x2381030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2642180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, '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 0x26412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2641740>, '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': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', '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 08:10:33 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 08:10:33 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 08:10:33 INFO - Using env: {'DISPLAY': ':0', 08:10:33 INFO - 'HOME': '/home/cltbld', 08:10:33 INFO - 'LANG': 'en_US.UTF-8', 08:10:33 INFO - 'LANGUAGE': 'en_US:en', 08:10:33 INFO - 'LOGNAME': 'cltbld', 08:10:33 INFO - 'MAIL': '/var/mail/cltbld', 08:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:33 INFO - 'MOZ_NO_REMOTE': '1', 08:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:33 INFO - 'NO_EM_RESTART': '1', 08:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:33 INFO - 'PWD': '/builds/slave/test', 08:10:33 INFO - 'SHELL': '/bin/bash', 08:10:33 INFO - 'SHLVL': '1', 08:10:33 INFO - 'TERM': 'linux', 08:10:33 INFO - 'TMOUT': '86400', 08:10:33 INFO - 'USER': 'cltbld', 08:10:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', 08:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:33 INFO - '_': '/tools/buildbot/bin/python'} 08:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:34 INFO - Downloading/unpacking psutil>=3.1.1 08:10:34 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 08:10:34 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 08:10:34 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 08:10:34 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 08:10:34 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 08:10:34 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 08:10:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:10:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:36 INFO - Installing collected packages: psutil 08:10:36 INFO - Running setup.py install for psutil 08:10:36 INFO - building 'psutil._psutil_linux' extension 08:10:36 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 08:10:36 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 08:10:36 INFO - building 'psutil._psutil_posix' extension 08:10:36 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 08:10:36 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 08:10:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:10:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:10:36 INFO - Successfully installed psutil 08:10:36 INFO - Cleaning up... 08:10:36 INFO - Return code: 0 08:10:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2381030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2642180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, '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 0x26412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2641740>, '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': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', '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 08:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:10:36 INFO - Using env: {'DISPLAY': ':0', 08:10:36 INFO - 'HOME': '/home/cltbld', 08:10:36 INFO - 'LANG': 'en_US.UTF-8', 08:10:36 INFO - 'LANGUAGE': 'en_US:en', 08:10:36 INFO - 'LOGNAME': 'cltbld', 08:10:36 INFO - 'MAIL': '/var/mail/cltbld', 08:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:36 INFO - 'MOZ_NO_REMOTE': '1', 08:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:36 INFO - 'NO_EM_RESTART': '1', 08:10:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:36 INFO - 'PWD': '/builds/slave/test', 08:10:36 INFO - 'SHELL': '/bin/bash', 08:10:36 INFO - 'SHLVL': '1', 08:10:36 INFO - 'TERM': 'linux', 08:10:36 INFO - 'TMOUT': '86400', 08:10:36 INFO - 'USER': 'cltbld', 08:10:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', 08:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:36 INFO - '_': '/tools/buildbot/bin/python'} 08:10:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:10:36 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 08:10:36 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 08:10:36 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 08:10:36 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 08:10:36 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 08:10:36 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 08:10:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:10:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:10:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:10:38 INFO - Installing collected packages: mozsystemmonitor 08:10:38 INFO - Running setup.py install for mozsystemmonitor 08:10:38 INFO - Successfully installed mozsystemmonitor 08:10:38 INFO - Cleaning up... 08:10:38 INFO - Return code: 0 08:10:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:10:38 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')]} 08:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:38 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')]} 08:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:38 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 0x2381030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2642180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, '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 0x26412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2641740>, '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': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', '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 08:10:38 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 08:10:38 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 08:10:38 INFO - Using env: {'DISPLAY': ':0', 08:10:38 INFO - 'HOME': '/home/cltbld', 08:10:38 INFO - 'LANG': 'en_US.UTF-8', 08:10:38 INFO - 'LANGUAGE': 'en_US:en', 08:10:38 INFO - 'LOGNAME': 'cltbld', 08:10:38 INFO - 'MAIL': '/var/mail/cltbld', 08:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:38 INFO - 'MOZ_NO_REMOTE': '1', 08:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:38 INFO - 'NO_EM_RESTART': '1', 08:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:38 INFO - 'PWD': '/builds/slave/test', 08:10:38 INFO - 'SHELL': '/bin/bash', 08:10:38 INFO - 'SHLVL': '1', 08:10:38 INFO - 'TERM': 'linux', 08:10:38 INFO - 'TMOUT': '86400', 08:10:38 INFO - 'USER': 'cltbld', 08:10:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', 08:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:38 INFO - '_': '/tools/buildbot/bin/python'} 08:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:39 INFO - Downloading/unpacking jsonschema==2.5.1 08:10:39 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 08:10:39 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 08:10:39 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 08:10:39 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 08:10:39 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 08:10:39 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 08:10:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:10:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 INFO - Downloading functools32-3.2.3-2.tar.gz 08:10:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:10:41 INFO - warning: no files found matching '*.txt' 08:10:41 INFO - no previously-included directories found matching 'build' 08:10:41 INFO - no previously-included directories found matching 'dist' 08:10:41 INFO - no previously-included directories found matching '.git*' 08:10:41 INFO - Installing collected packages: jsonschema, functools32 08:10:41 INFO - Running setup.py install for functools32 08:10:41 INFO - warning: no files found matching '*.txt' 08:10:41 INFO - no previously-included directories found matching 'build' 08:10:41 INFO - no previously-included directories found matching 'dist' 08:10:41 INFO - no previously-included directories found matching '.git*' 08:10:41 INFO - Successfully installed jsonschema functools32 08:10:41 INFO - Cleaning up... 08:10:41 INFO - Return code: 0 08:10:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:10: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')]} 08:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10: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')]} 08:10:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:41 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 0x2381030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2642180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, '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 0x26412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2641740>, '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': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', '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 08:10:41 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 08:10:41 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 08:10:41 INFO - Using env: {'DISPLAY': ':0', 08:10:41 INFO - 'HOME': '/home/cltbld', 08:10:41 INFO - 'LANG': 'en_US.UTF-8', 08:10:41 INFO - 'LANGUAGE': 'en_US:en', 08:10:41 INFO - 'LOGNAME': 'cltbld', 08:10:41 INFO - 'MAIL': '/var/mail/cltbld', 08:10:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:41 INFO - 'MOZ_NO_REMOTE': '1', 08:10:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:41 INFO - 'NO_EM_RESTART': '1', 08:10:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:41 INFO - 'PWD': '/builds/slave/test', 08:10:41 INFO - 'SHELL': '/bin/bash', 08:10:41 INFO - 'SHLVL': '1', 08:10:41 INFO - 'TERM': 'linux', 08:10:41 INFO - 'TMOUT': '86400', 08:10:41 INFO - 'USER': 'cltbld', 08:10:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', 08:10:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:41 INFO - '_': '/tools/buildbot/bin/python'} 08:10:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:41 INFO - Downloading/unpacking blobuploader==1.2.4 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 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 08:10:41 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 08:10:43 INFO - Downloading blobuploader-1.2.4.tar.gz 08:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:10:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:10:43 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 08:10:43 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 08:10:43 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 08:10:43 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 08:10:43 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 08:10:43 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 08:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:10:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:44 INFO - Downloading docopt-0.6.1.tar.gz 08:10:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:10:44 INFO - Installing collected packages: blobuploader, requests, docopt 08:10:44 INFO - Running setup.py install for blobuploader 08:10:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:10:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:10:44 INFO - Running setup.py install for requests 08:10:44 INFO - Running setup.py install for docopt 08:10:44 INFO - Successfully installed blobuploader requests docopt 08:10:44 INFO - Cleaning up... 08:10:45 INFO - Return code: 0 08:10:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:45 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 0x2381030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2642180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, '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 0x26412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2641740>, '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': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', '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 08:10:45 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 08:10:45 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 08:10:45 INFO - Using env: {'DISPLAY': ':0', 08:10:45 INFO - 'HOME': '/home/cltbld', 08:10:45 INFO - 'LANG': 'en_US.UTF-8', 08:10:45 INFO - 'LANGUAGE': 'en_US:en', 08:10:45 INFO - 'LOGNAME': 'cltbld', 08:10:45 INFO - 'MAIL': '/var/mail/cltbld', 08:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:45 INFO - 'MOZ_NO_REMOTE': '1', 08:10:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:45 INFO - 'NO_EM_RESTART': '1', 08:10:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:45 INFO - 'PWD': '/builds/slave/test', 08:10:45 INFO - 'SHELL': '/bin/bash', 08:10:45 INFO - 'SHLVL': '1', 08:10:45 INFO - 'TERM': 'linux', 08:10:45 INFO - 'TMOUT': '86400', 08:10:45 INFO - 'USER': 'cltbld', 08:10:45 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', 08:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:45 INFO - '_': '/tools/buildbot/bin/python'} 08:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:45 INFO - Running setup.py (path:/tmp/pip-ZAm9ro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:45 INFO - Running setup.py (path:/tmp/pip-tXb2ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:45 INFO - Running setup.py (path:/tmp/pip-GSjCvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:45 INFO - Running setup.py (path:/tmp/pip-J2AA_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:45 INFO - Running setup.py (path:/tmp/pip-IcAjVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:45 INFO - Running setup.py (path:/tmp/pip-FCV8MF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:45 INFO - Running setup.py (path:/tmp/pip-JLuKJQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:45 INFO - Running setup.py (path:/tmp/pip-YEkHTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:45 INFO - Running setup.py (path:/tmp/pip-HwzBUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:45 INFO - Running setup.py (path:/tmp/pip-5nOKwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:45 INFO - Running setup.py (path:/tmp/pip-UiIKUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:46 INFO - Running setup.py (path:/tmp/pip-xeHZWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:46 INFO - Running setup.py (path:/tmp/pip-1D4KE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:46 INFO - Running setup.py (path:/tmp/pip-bdS9Ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:46 INFO - Running setup.py (path:/tmp/pip-Mr6x7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:46 INFO - Running setup.py (path:/tmp/pip-7YVgIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:46 INFO - Running setup.py (path:/tmp/pip-xLxP0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:10:46 INFO - Running setup.py install for manifestparser 08:10:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:10:46 INFO - Running setup.py install for mozcrash 08:10:46 INFO - Running setup.py install for mozdebug 08:10:46 INFO - Running setup.py install for mozdevice 08:10:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:10:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:10:46 INFO - Running setup.py install for mozfile 08:10:47 INFO - Running setup.py install for mozhttpd 08:10:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Running setup.py install for mozinfo 08:10:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Running setup.py install for mozInstall 08:10:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Running setup.py install for mozleak 08:10:47 INFO - Running setup.py install for mozlog 08:10:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Running setup.py install for moznetwork 08:10:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Running setup.py install for mozprocess 08:10:47 INFO - Running setup.py install for mozprofile 08:10:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Running setup.py install for mozrunner 08:10:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:10:47 INFO - Running setup.py install for mozscreenshot 08:10:48 INFO - Running setup.py install for moztest 08:10:48 INFO - Running setup.py install for mozversion 08:10:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:10:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:10:48 INFO - Cleaning up... 08:10:48 INFO - Return code: 0 08:10:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:48 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 0x2381030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2642180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, '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 0x26412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2641740>, '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': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', '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 08:10:48 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 08:10:48 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 08:10:48 INFO - Using env: {'DISPLAY': ':0', 08:10:48 INFO - 'HOME': '/home/cltbld', 08:10:48 INFO - 'LANG': 'en_US.UTF-8', 08:10:48 INFO - 'LANGUAGE': 'en_US:en', 08:10:48 INFO - 'LOGNAME': 'cltbld', 08:10:48 INFO - 'MAIL': '/var/mail/cltbld', 08:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:48 INFO - 'MOZ_NO_REMOTE': '1', 08:10:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:48 INFO - 'NO_EM_RESTART': '1', 08:10:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:48 INFO - 'PWD': '/builds/slave/test', 08:10:48 INFO - 'SHELL': '/bin/bash', 08:10:48 INFO - 'SHLVL': '1', 08:10:48 INFO - 'TERM': 'linux', 08:10:48 INFO - 'TMOUT': '86400', 08:10:48 INFO - 'USER': 'cltbld', 08:10:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', 08:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:48 INFO - '_': '/tools/buildbot/bin/python'} 08:10:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:10:48 INFO - Running setup.py (path:/tmp/pip-TGDRSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:10:48 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)) 08:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:10:48 INFO - Running setup.py (path:/tmp/pip-Fr54LS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:10:48 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)) 08:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:10:48 INFO - Running setup.py (path:/tmp/pip-GZOFT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:10:48 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)) 08:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:10:48 INFO - Running setup.py (path:/tmp/pip-YBTYTf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:10:48 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)) 08:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:10:48 INFO - Running setup.py (path:/tmp/pip-TGCIwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:10:48 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)) 08:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:10:48 INFO - Running setup.py (path:/tmp/pip-DGF0jM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:10:48 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)) 08:10:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:10:48 INFO - Running setup.py (path:/tmp/pip-TJBAh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:10:49 INFO - Running setup.py (path:/tmp/pip-Q49QMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:10:49 INFO - Running setup.py (path:/tmp/pip-48E2fZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:10:49 INFO - Running setup.py (path:/tmp/pip-eXsHib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:10:49 INFO - Running setup.py (path:/tmp/pip-7k2jM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:10:49 INFO - Running setup.py (path:/tmp/pip-7e5jvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:10:49 INFO - Running setup.py (path:/tmp/pip-U0oNhR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:10:49 INFO - Running setup.py (path:/tmp/pip-4aXPfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:49 INFO - Running setup.py (path:/tmp/pip-Szj11j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:10:49 INFO - Running setup.py (path:/tmp/pip-kMiX8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:10:49 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)) 08:10:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:10:49 INFO - Running setup.py (path:/tmp/pip-1xNNAZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:10:49 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)) 08:10:49 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)) 08:10:49 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)) 08:10:49 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)) 08:10:49 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)) 08:10:49 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)) 08:10:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:10:51 INFO - Downloading blessings-1.6.tar.gz 08:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:10:51 INFO - Installing collected packages: blessings 08:10:51 INFO - Running setup.py install for blessings 08:10:51 INFO - Successfully installed blessings 08:10:51 INFO - Cleaning up... 08:10:51 INFO - Return code: 0 08:10:51 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:10:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:52 INFO - Reading from file tmpfile_stdout 08:10:52 INFO - Current package versions: 08:10:52 INFO - argparse == 1.2.1 08:10:52 INFO - blessings == 1.6 08:10:52 INFO - blobuploader == 1.2.4 08:10:52 INFO - docopt == 0.6.1 08:10:52 INFO - functools32 == 3.2.3-2 08:10:52 INFO - jsonschema == 2.5.1 08:10:52 INFO - manifestparser == 1.1 08:10:52 INFO - mozInstall == 1.12 08:10:52 INFO - mozcrash == 0.17 08:10:52 INFO - mozdebug == 0.1 08:10:52 INFO - mozdevice == 0.48 08:10:52 INFO - mozfile == 1.2 08:10:52 INFO - mozhttpd == 0.7 08:10:52 INFO - mozinfo == 0.9 08:10:52 INFO - mozleak == 0.1 08:10:52 INFO - mozlog == 3.2 08:10:52 INFO - moznetwork == 0.27 08:10:52 INFO - mozprocess == 0.22 08:10:52 INFO - mozprofile == 0.28 08:10:52 INFO - mozrunner == 6.11 08:10:52 INFO - mozscreenshot == 0.1 08:10:52 INFO - mozsystemmonitor == 0.3 08:10:52 INFO - moztest == 0.7 08:10:52 INFO - mozversion == 1.4 08:10:52 INFO - psutil == 3.1.1 08:10:52 INFO - requests == 1.2.3 08:10:52 INFO - wsgiref == 0.1.2 08:10:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:10: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')]} 08:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10: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')]} 08:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 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 0x2381030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2642180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, '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 0x26412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2641740>, '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': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', '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 08:10:52 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 08:10:52 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 08:10:52 INFO - Using env: {'DISPLAY': ':0', 08:10:52 INFO - 'HOME': '/home/cltbld', 08:10:52 INFO - 'LANG': 'en_US.UTF-8', 08:10:52 INFO - 'LANGUAGE': 'en_US:en', 08:10:52 INFO - 'LOGNAME': 'cltbld', 08:10:52 INFO - 'MAIL': '/var/mail/cltbld', 08:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:52 INFO - 'MOZ_NO_REMOTE': '1', 08:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:52 INFO - 'NO_EM_RESTART': '1', 08:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:52 INFO - 'PWD': '/builds/slave/test', 08:10:52 INFO - 'SHELL': '/bin/bash', 08:10:52 INFO - 'SHLVL': '1', 08:10:52 INFO - 'TERM': 'linux', 08:10:52 INFO - 'TMOUT': '86400', 08:10:52 INFO - 'USER': 'cltbld', 08:10:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', 08:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:52 INFO - '_': '/tools/buildbot/bin/python'} 08:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 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)) 08:10:52 INFO - Cleaning up... 08:10:52 INFO - Return code: 0 08:10:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:10: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')]} 08:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10: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')]} 08:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:10:52 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 0x2381030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2642180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26403b0>, '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 0x26412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2641740>, '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': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', '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 08:10:52 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 08:10:52 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 08:10:52 INFO - Using env: {'DISPLAY': ':0', 08:10:52 INFO - 'HOME': '/home/cltbld', 08:10:52 INFO - 'LANG': 'en_US.UTF-8', 08:10:52 INFO - 'LANGUAGE': 'en_US:en', 08:10:52 INFO - 'LOGNAME': 'cltbld', 08:10:52 INFO - 'MAIL': '/var/mail/cltbld', 08:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:52 INFO - 'MOZ_NO_REMOTE': '1', 08:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:52 INFO - 'NO_EM_RESTART': '1', 08:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:52 INFO - 'PWD': '/builds/slave/test', 08:10:52 INFO - 'SHELL': '/bin/bash', 08:10:52 INFO - 'SHLVL': '1', 08:10:52 INFO - 'TERM': 'linux', 08:10:52 INFO - 'TMOUT': '86400', 08:10:52 INFO - 'USER': 'cltbld', 08:10:52 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', 08:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:52 INFO - '_': '/tools/buildbot/bin/python'} 08:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:10:52 INFO - Cleaning up... 08:10:52 INFO - Return code: 0 08:10:52 INFO - Running post-action listener: _resource_record_post_action 08:10:52 INFO - Running post-action listener: _start_resource_monitoring 08:10:52 INFO - Starting resource monitoring. 08:10:52 INFO - ##### 08:10:52 INFO - ##### Finished create-virtualenv step (success) 08:10:52 INFO - ##### 08:10:52 INFO - ##### 08:10:52 INFO - ##### Running install step. 08:10:52 INFO - ##### 08:10:52 INFO - Running pre-action listener: _resource_record_pre_action 08:10:52 INFO - Running main action method: install 08:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:10:52 INFO - Reading from file tmpfile_stdout 08:10:52 INFO - Detecting whether we're running mozinstall >=1.0... 08:10:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:10:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:10:52 INFO - Reading from file tmpfile_stdout 08:10:52 INFO - Output received: 08:10:52 INFO - Usage: mozinstall [options] installer 08:10:52 INFO - Options: 08:10:52 INFO - -h, --help show this help message and exit 08:10:52 INFO - -d DEST, --destination=DEST 08:10:52 INFO - Directory to install application into. [default: 08:10:52 INFO - "/builds/slave/test"] 08:10:52 INFO - --app=APP Application being installed. [default: firefox] 08:10:52 INFO - mkdir: /builds/slave/test/build/application 08:10:52 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'] 08:10:52 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 08:11:10 INFO - Reading from file tmpfile_stdout 08:11:10 INFO - Output received: 08:11:10 INFO - /builds/slave/test/build/application/firefox/firefox 08:11:10 INFO - Running post-action listener: _resource_record_post_action 08:11:10 INFO - ##### 08:11:10 INFO - ##### Finished install step (success) 08:11:10 INFO - ##### 08:11:10 INFO - ##### 08:11:10 INFO - ##### Running run-tests step. 08:11:10 INFO - ##### 08:11:10 INFO - Running pre-action listener: _resource_record_pre_action 08:11:10 INFO - Running main action method: run_tests 08:11:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:11:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:11:10 INFO - Python 2.7.3 08:11:10 INFO - Return code: 0 08:11:10 INFO - grabbing minidump binary from tooltool 08:11: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')]} 08:11:10 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 0x26403b0>, '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 0x26412b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2641740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:11:10 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 08:11:10 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 08:11:10 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 08:11:10 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:11:10 INFO - Return code: 0 08:11:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:11:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:11:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:11:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:11:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:11:10 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:11:10 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:11:10 INFO - Using env: {'DISPLAY': ':0', 08:11:10 INFO - 'HOME': '/home/cltbld', 08:11:10 INFO - 'LANG': 'en_US.UTF-8', 08:11:10 INFO - 'LANGUAGE': 'en_US:en', 08:11:10 INFO - 'LOGNAME': 'cltbld', 08:11:10 INFO - 'MAIL': '/var/mail/cltbld', 08:11:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:11:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:11:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:11:10 INFO - 'MOZ_NO_REMOTE': '1', 08:11:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:11:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:11:10 INFO - 'NO_EM_RESTART': '1', 08:11:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:11:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:11:10 INFO - 'PWD': '/builds/slave/test', 08:11:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:11:10 INFO - 'SHELL': '/bin/bash', 08:11:10 INFO - 'SHLVL': '1', 08:11:10 INFO - 'TERM': 'linux', 08:11:10 INFO - 'TMOUT': '86400', 08:11:10 INFO - 'USER': 'cltbld', 08:11:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264', 08:11:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:11:10 INFO - '_': '/tools/buildbot/bin/python'} 08:11:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:11:11 INFO - mozversion application_buildid: 20160701053013 08:11:11 INFO - mozversion application_changeset: adfe23aae513a339ef042d5ff4255500e452114a 08:11:11 INFO - mozversion application_display_name: Nightly 08:11:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:11:11 INFO - mozversion application_name: Firefox 08:11:11 INFO - mozversion application_remotingname: firefox 08:11:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:11:11 INFO - mozversion application_vendor: Mozilla 08:11:11 INFO - mozversion application_version: 50.0a1 08:11:11 INFO - mozversion platform_buildid: 20160701053013 08:11:11 INFO - mozversion platform_changeset: adfe23aae513a339ef042d5ff4255500e452114a 08:11:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:11:11 INFO - mozversion platform_version: 50.0a1 08:11:11 INFO - using testdate: 1467385871 08:11:11 INFO - actual date: 1467385871 08:11:11 INFO - starting webserver on 'localhost:39609' 08:11:11 INFO - SUITE-START | Running 2 tests 08:11:11 INFO - TEST-START | dromaeo_css 08:11:11 INFO - operating with platform_type : linux_ 08:11:11 INFO - Initialising browser for dromaeo_css test... 08:11:11 INFO - TEST-INFO | started process 30618 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeWTp3l/profile http://localhost:39609/getInfo.html) 08:11:16 INFO - PROCESS | 30618 | __metrics Screen width/height:1600/1200 08:11:16 INFO - PROCESS | 30618 | colorDepth:24 08:11:16 INFO - PROCESS | 30618 | Browser inner width/height: 1024/697 08:11:16 INFO - PROCESS | 30618 | __metrics 08:11:18 INFO - PROCESS | 30618 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:11:19 INFO - TEST-INFO | 30618: exit 0 08:11:19 INFO - Browser initialized. 08:11:19 INFO - Running cycle 1/1 for dromaeo_css test... 08:11:19 INFO - TEST-INFO | started process 30703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpeWTp3l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:11:31 INFO - PROCESS | 30703 | RSS: Main: 157655040 08:11:31 INFO - PROCESS | 30703 | 08:12:22 INFO - PROCESS | 30703 | 1467385942795 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] 08:14:31 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39609/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39609/tests/dromaeo/cssquery-ext.html) 08:14:32 INFO - PROCESS | 30703 | RSS: Main: 259371008 08:14:32 INFO - PROCESS | 30703 | 08:17:34 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39609/tests/dromaeo/cssquery-ext.html (next: http://localhost:39609/tests/dromaeo/cssquery-jquery.html) 08:17:35 INFO - PROCESS | 30703 | RSS: Main: 244023296 08:17:35 INFO - PROCESS | 30703 | 08:20:37 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39609/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39609/tests/dromaeo/cssquery-mootools.html) 08:20:37 INFO - PROCESS | 30703 | RSS: Main: 244908032 08:20:37 INFO - PROCESS | 30703 | 08:23:39 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39609/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39609/tests/dromaeo/cssquery-prototype.html) 08:23:40 INFO - PROCESS | 30703 | RSS: Main: 236122112 08:23:40 INFO - PROCESS | 30703 | 08:26:43 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39609/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39609/tests/dromaeo/cssquery-yui.html) 08:26:43 INFO - PROCESS | 30703 | RSS: Main: 212221952 08:26:43 INFO - PROCESS | 30703 | 08:29:46 INFO - PROCESS | 30703 | Cycle 1(1): loaded http://localhost:39609/tests/dromaeo/cssquery-yui.html (next: http://localhost:39609/tests/dromaeo/cssquery-dojo.html) 08:29:46 INFO - PROCESS | 30703 | RSS: Main: 277766144 08:29:46 INFO - PROCESS | 30703 | 08:29:46 INFO - PROCESS | 30703 | __start_tp_report 08:29:46 INFO - PROCESS | 30703 | _x_x_mozilla_page_load 08:29:46 INFO - PROCESS | 30703 | _x_x_mozilla_page_load_details 08:29:46 INFO - PROCESS | 30703 | |i|pagename|runs| 08:29:46 INFO - PROCESS | 30703 | |0;dojo.html;3112.128603990882;3114.252579380949;3142.6543080261167;3151.0231828133265;3188.6970737779916;5246.632735708502;5248.895022099565;5315.734213289339;5369.463053694633;5424.674519528826;5328.094223981922;5372.7313634318325;5397.379301380342;5406.756695948682;5410.134378499441;4852.854414367565;4913;4924;4934.827281045164;5067.923981140286;4977.651564390494;4984.975075124619;5028.622853286;5040.420351659551;5050.570701490359;4814.494478079786;4818.7831547580445;4827.806887724487;4829.10661527615;4880.6095512358925;4806.182948898696;4827.927581086286;4885.804567817283;4887.975560122177;4937.506249375069;4842.467328593852;4844.66087373884;4863.537963893425;4869.074875773627;4915;5239.318888544503;5270.077736396115;5308.495692909168;5355.491228333302;5374.543163831079;5697.344805347397;5719.456651618089;5720.971395143039;5724.542036637059;5727.9427205727825;5682.346530149003;5763.250777398911;5776.046952252873;5793.507551858055;5822.737976791054;5361.088614935431;5365.490278423583;5423.05096608092;5468.7265636718;5497.697626630534;5991.370906054802;5998.520118390518;6002.729877155539;6007.189029481052;6010.639361638316;5513.2005859151;5566.721663916869;5758.165066065397;5796.188533605298;5798.159266906275;5696.886062278814;5832.650040997553;5834.3290521589715;5836.649801011953;5840.415958404125;5703.315602127688;5754.1944127822135;5765.365809760923;5766.192733017381;5770.826875193667;5593.720313984284;5736.4550367715;5775.797847075332;5781.768729250783;5798.1302804579655;4438.090191510732;4443.022535042285;4451;4487.035287413222;4490.371348011281;3936.3111455495173;3948.6841052715713;3953.090789118519;3984;3987.601239876047;5296.973515132399;5381.9461805382225;5382.434844341366;5487.012337779238;5492.5605951523785;5827.737751801179;5845.532357411397;5854.619449735754;5857.7949771757785;5885.852853678693;5505.779768809283;5507.339119305629;5514.365847927459;5517.944820551824;5519.751611177507;4857.247126695368;4905.558499735041;4948.826791062295;4953.826616068421;4965.354503914468;5971.0744834550715;5979.970100149471;5981.0729336952845;5983.132445795335;5985.431384018511;5638.37977822431;5731.312242530923;5742.827715168552;5746.051901436216;5747.770089196385;5949.137375080502;5975.163477113295;5977.820665380045;6029.939700602938;6052;5642.887142257214;5687.402822703557;5692.601517893708;5696.829095127153;5699.088145896637;5651.971740141273;5661.377248502579;5799.652020878761;5806.303243610625;5806.65160090396;5545.473180047889;5561.443855614568;5572.832815015556;5577.051901176728;5628.183913332462;5532.3637781655625;5551.7779288828;5555.22226888244;5556.472135147154;5558.471945165203;5382.973085134549;5410.053240682786;5499.340079190362;5529.944700552943;5552.028395030773;5729.2265544151005;5736.082226843685;5750.396208398058;5799.710014499174;5804.448577385142;5607.07483265273;5622.465865742748;5623.746931388179;5625.859353516031;5628.634138780966 08:29:46 INFO - PROCESS | 30703 | |1;ext.html;600.05790908274;612.2561088277743;626.139058794158;629.5750368501264;648.9772857949972;32956.50565241523;35874.46188307177;43721;45001.77499112508;45040;45749.313760293626;46287.53712462875;46305.53694463054;46313.305300420434;46508;8888.55557222138;9021.323400744937;9034.819303613956;9039;9046.457212567268;8934.195922366986;9027.097290270985;9027.413218140833;9030.096990300983;9030.232430243404;9005.684801031965;9037.502937338444;9069.138431848964;9075.183233508982;9076.22852057576;8983.640654373818;8985.101489851028;8997.910020899773;9015.098490150966;9034.322425818056;8920.464772113693;8987.910120898772;8990.011098779129;8990.910090899139;8993.505357205351;44015;44023.339649905276;44165.337519937224;44199.558004419865;44468.55531444709;3554.7689400189165;3582.444721068239;3634.745567810254;3652.9086772830624;3876.2247550490015;33280.833595831864;33723.325533489435;33986.6601333986;34241.828790855885;35053.649463505295;4241.787910604488;4307.181635489247;4336.176126535979;4367.039251364695;4367.126574685076;370569;370863;371106;373024;375255;35876.820615897275;60659.39340606538;61186.388136118956;61241.693791531645;61260.387396125465;37730;39813.80093099516;39830.80084599558;39836.2032759349;39880.202395952496;14559.636009099857;14697.265136743334;14722.484713034992;14725.926370368079;14733.852661473462;12514.937425312997;12596.055295852664;12597.496100155891;12603;12607.369631518388;8807.295416366675;8908.643654253758;8954.686585969459;8958.552072396355;9037.548122593844;3398.6431424700545;3417.8461969211444;3427.2288735034417;3464.2032332563654;3468.9306213876084;905.063259526387;971.4074414607084;975.4439969217619;996.7209181429212;1022.0494939705997;32662;33123.66876331254;33146.50280245798;33196.66803331936;33272.83363583167;1059.3379138038727;1071.276888100529;1090.1224514266091;1106.2366966793047;1212.6240865331774;16625.50123496297;17158.48524544266;17536.82463175352;17571.209295581728;17649.38227162043;594309;598779;600935;601877;602106;60334;60826.087608685906;60989.69505152535;61037.55849765959;61104.38895611076;1207.130865776657;1314.3625341709264;1360.088740543838;1369.301656155368;1380.3857283508944;33215;33349.33301334008;34773.304533909686;34854.65145348514;35177.64822351846;53499.7325013388;59583.404165957785;59711.70144149425;59779.402205979124;59836;519773;522247;524437;524544;524555;44604.33093503535;45925;46287.305690413996;46714.29928551142;46782.064358713316;51636.74181629218;51849.740751296005;51926.74036629793;52762;52847.47152528579;43519.34720979251;44202.55797442113;44322.778386107864;44415;45047;43678.26385468374;43825;44018;44511.33233001572;45086.77456612696;38163.80918095392;38944.80527597457;43358;43481.13037739291;43756.56243437525;34916;37827;38047.61952380441;38810;38871.6112838868;28123;28430;28539;28852.855735721187;28857.422851542433 08:29:46 INFO - PROCESS | 30703 | |2;jquery.html;379.3532027892444;408.6648947862754;416.47524119609295;418.65042689354385;432.14866712576213;15753.369865205392;19468.451491324977;19686.606267874635;19803.108860101274;21195.092441680245;18686;18825.905870470662;18995.62008759824;19167.137478813453;19224.51938701533;5787.768489260425;5909.793157239508;6027.849303767397;6033.728482218289;6125.234345706786;5970.8805823883495;6022.427869352427;6027.306859711123;6030.608010479326;6059.121427393025;5759.971200143993;5997;5997.310309314441;6054.243219597551;6152.969235153841;6151.138840562325;6151.846203844895;6154.169187159721;6163.075538669213;6435.613863168178;5926;5956.344802071769;5968.403159683997;5977.880442391128;5978.461938425519;14569.198694071822;18263.54341141482;24388.390290242707;24482.14312499072;24787.752122478723;2306.7923886850263;2333.101755824003;2484.4534202475606;2577.4329647477525;2710.783137349007;15696.293666785023;16435.09606971616;16454.506364809076;16771.2452939618;17209.569760755956;2094.4973206430345;2100.369889033284;2124.6706760452153;2153.9246126385656;2269.273832373641;90327;95460;103254.96745032529;104554.47722761337;105395;18161.545961350806;18284.360047398277;18400.50139774566;18434.354797582022;18545.90727046383;33238.3352332952;33399;33598.664013360045;33722.325553488794;33732;9498.382605130644;9530.90469095314;9541.093596108498;9604.807903842024;9893.752656183653;7648;7769.689212431439;7868.370530357558;7886.738121900468;7898.526088434713;9174.917161862906;9190.85965589982;9274.489903055262;9280.675176368795;9356.812863742824;3497.8251087445524;3556.982215088908;3605.549306336708;3616.403293456603;3628.6189950054863;901.5170045275485;905.2124651553191;906.9954650226707;928.2434815625379;943.3160958305311;19416.902915485614;20052.59894802125;20137.39587812368;20222.494437639176;20542.07560659774;950.6625148072472;974.9951250243845;979.8628192053118;1025.266934142092;1052.6578861869923;10662.840057399146;11152.609658661908;11167.385793781257;11211.831822522669;11223.102151827834;468265;471253;477807;478371;479143;97062.51468742752;104173;104706.47646761718;105319;106816;1007.9496025198711;1017.8880323164447;1035.1098055672117;1040.1314902056868;1073.350622873166;18768.343107991153;18826.905865470584;19199.136038878005;19204.519887002938;19234.326798562543;43998.340024900295;44608.553914461736;44762.55237447584;44978.55021449875;45865.31202032039;61874;62146.68926655338;62656.686716566124;62866.685666573205;62956.68521657363;8451.66193352259;8918.10818918129;9020.413673111227;9057.728268151966;9219.86170207434;13517.526886559317;13564.253966031964;14187.0014019368;14998.250087495364;15125.319360628579;12605.054620903285;12830.743385132431;12909.612711618667;12916.354182291036;13136.256166992362;12493.75012499763;12692.809607856074;12722.173058751152;12889.613311600291;13138.540151094665;12883.677908052374;12979.675508112372;13120.409581568661;13124.34378281063;13320.33398330099;9171.908280917105;9195;9198.724038278862;9235.307351948497;9303.185878753578;9688.467134307399;12402.689932751393;12907;13081.084324097603;13155.53955611549 08:29:46 INFO - PROCESS | 30703 | |3;mootools.html;1355.5255660518826;1419.5173640962073;1454.425501926739;1574.6614477887251;1786.892786432814;8648.351373646978;9039.231665308449;9094.681686140986;9390.48352340621;9395.791988882607;9149.451032938028;9319.394239374436;9325.487098209596;9341.813163736739;9354.485503297316;2092.665173572221;2309.6304591265402;2374.252110585169;2392.545416370884;2423.8424502407374;2445.6820613320333;2447.0945750072497;2453;2453.6074228123503;2455.6439316299125;2368.656544801003;2397.496525729599;2398.4963157736897;2400.1239547565187;2405.7353691093967;2082.2816128435666;2255.22194842779;2328.685627440291;2343.367290831466;2351.611984022643;2367.633016882369;2390.8565486070893;2407.337982054931;2412.433078226615;2413.80689544836;9345.626174952993;9373.625054997792;9404.05959404061;9406.576704048335;9425.151736343762;5316.415194328621;5364.409914909357;5364.953834002371;5367.919481207785;5382.30030096085;3314.9171270718184;3384.2385463270566;3478.617352091268;3507.0706262840367;3527.1005893496995;1150.5972909481613;1156.7570810129882;1173.1142987044811;1187.0503597122267;1203.2419575667361;13193.538226162134;13248;13275.46898124074;13293.534726284533;13333.06668533203;4678.2982552616695;4745.525447455296;4770.099356524768;4798.7840547175465;4895.094407534618;10742.892571074346;10794.244402891722;10795.352278863293;10818.891811081945;10829.891701083046;5343.0649636314265;5347.144456886879;5354.812581559705;5372.355317361941;5387.838364849061;4357.9564204358185;4843;4975.751212439363;5016.072026675077;5033.144365457881;4167.624913757776;4170.562090980464;4238.237117318912;4278.914421711548;4294.141171765659;1235.6293112066344;1310.5347601601295;1331.1813234860685;1364.242845220912;1380.151207007683;884.0761404332488;902.9232515236279;907.1880666803174;912.3203213605906;920.9723708288763;6088.665123418255;6107.709059668548;6171.475424588871;6199.3490683478485;6222.502199824004;899.0155779421523;912.598456679059;931.9860202096974;958.4153666263574;959.472290240365;3997.700172487017;4065.89835254121;4101.753894766323;4110.876673699794;4129.215449064668;11585.131115166396;11828.585999489977;11929.463174157183;11941.880581194251;11945.402729863472;11589.188756787113;11698.824517632242;11783.057355411547;11820.94089529564;11868.525258989544;8553.230209281195;8602.268807151337;8758;8765.649374024968;8771.429857059271;5818.883622327445;5991.520678345809;6061.696915154313;6102.7253773579405;6236.75052997875;10160;10698.572057117628;10989.890101099207;10996.945015274872;11055.170862185207;10869.728256793644;10964.232503724663;11112.555497779998;11131.332120072822;11204.943975280072;8321;8461.06928237881;8485.745427637181;8495.150484951455;8506.97916250054;8914.777130571529;8986.820263594822;9106.408083474553;9132.863007055032;9148.817023659356;6596.340365963365;7932.801679958047;7968.0836703779805;8424.663013479392;8432.367572432215;7943.801404964922;7955.84088318242;8000.759977200693;8061.516309021477;8157.102718701057;6600.9339906602245;6799.422049125879;6840.31596840312;6978.197507286727;7090.397316228178;5131.486851314988;5256.132738098171;5292.576593872558;5305.31030965972;5316.787328506816;5048.64659473848;5105.617078719037;5125.92311115341;5158.252053452304;5261.210818377274 08:29:46 INFO - PROCESS | 30703 | |4;prototype.html;332.6008789452657;340.9914752131197;351.75904505413786;352.768936346693;353.1084012867509;5342.412334643196;5358.946410535894;5374.811881584141;5377.274068000828;5397.865053373658;5250.369955605323;5280.709560974145;5311.48622642547;5317.5480084192795;5335.546478549319;3941.4284928685465;4150.8962275943195;4153.048067408313;4208.621224089831;4213.9869992954955;4127.050778320973;4127.504699436072;4134.069834287291;4139.737380099069;4176.310908700061;4108.650764685005;4127.752334859903;4156.916861662765;4159.563245859186;4169.770662613555;3921.627445392683;3999.180168065554;4099.877003689894;4101.26177288088;4126.236646220429;3600.71194304455;3605.7115430765475;3605.981970090159;3631.2192878530977;3631.511080457;4943.629227807929;5167.147420675584;5181.300524429192;5194.71429071401;5199.662021968597;4571.337156112379;4689.155951928651;4699.130660827758;4705.55297246761;4719;5482.725863706839;5485.670859748428;5494.423085575997;5519.889602207973;5531.308586426697;3827.4258861171047;3973.7417067890783;3994.7802870842092;3996.6403023728003;4001;5703.287089113861;5715.771369145229;5728.474505140934;5730.197772311838;5732.570057245682;4086.366613174963;4087.4073259377224;4088.4259560069586;4089.5705950875326;4090.6091928744368;4140.855070072533;4141.461609990682;4142.772147531915;4176.1230141669985;4187.623113919762;4535.954640453553;4710.364100846342;4717.693349932243;4723.220668589644;4769.642276829251;5486.506214440639;5532.861678458071;5538.778448862;5559.471850174308;5560.77756889728;1420.472991534105;1439.201243309973;1441.6612096157394;1445.9204743738985;1450;940.7695114696943;983.1692220074026;986.5511192407438;988.8912219655977;991.3209451525584;5166.638335316567;5282.837775689342;5344.599155063386;5349.518543331041;5364.51719345253;5614.438556144434;5620.718964051781;5630.662160270315;5632.887342253214;5650.609634219435;5055.191169412877;5178.649934055412;5189.7405129743365;5308.893822123536;5310.8141215057285;2888.2057434205763;2899.3911278631304;2917.3727648555237;2998.6401631803888;3006.181260337464;5737.684427356536;5901.144334071536;5905.911411328833;5929.229200203946;5931.970340148272;5765.106408506688;5788.189653448437;5791.913121303184;5794.246747922827;5796.652200867877;5870.706464676749;5898.174255604219;5903.144044113579;5908.615939963888;5920.171176035445;5440.367889633173;5658.434156584473;5669.971650141723;5734.2258795062135;5748.798792042258;5620.4098569649595;5640.574552942274;5646.548276137982;5656.321241451053;5683.175939488834;5705.37240903492;5905.5570832186895;5946.256717910262;5971.790987315423;6017.458428741435;4081.714260008088;4094.1197642507004;4114.7119701620595;4122.587741225853;4128.587141285848;5693.28833895763;5701.714914254354;5709.543236540983;5711.200431939449;5720.227769251098;5487.64330318528;5545.528630066489;5603.403030136392;5616.326040875121;5626.465485778845;5533.889322213614;5537.640053396677;5547.528460080938;5553.527950124123;5561.7463783687;5392.568594512508;5463.836084917459;5483.8080667176455;5488.890222195613;5493.945060549343;5385.488378604026;5561.388247292875;5564.248826408383;5577.191307260506;5611.466910643482;5432.429594892479;5437.178545187407;5459.563234941115;5473.425290344457;5475.561955043667 08:29:46 INFO - PROCESS | 30703 | |5;yui.html;729.5185177782663;749.8162950077228;750.2647405542572;752.3417010116149;762.1387831750121;15046.924765376172;15918.363265469367;16304.429344972914;16353.83646163538;16442.588935276595;14139.08095973761;14218.360173792178;14220.644483887882;14296.714065718705;14300.213488258141;649.428502917432;782.788647065292;787.8227398835273;805.899262592176;806.0408114343912;807.0235015631093;817.2603793566802;817.5013241922422;820.6143112737004;821.1337039423406;852.8294341131767;858.5235194467068;859.2095272349422;859.6776208921655;859.879616853641;692.1002696494537;807.4872455990429;830.2444775254489;853.0871966995318;853.5348235211825;604.2507290959223;605.6820169411051;606.7633622887078;607.2318517075903;607.3622696169049;15581.376744930189;15654.217289135611;15679.059256444536;15694.686106277924;15761.133137677423;14829.77755333671;14832.332545035499;15032.849671503254;15080.849191508163;15139;12892.742145157044;12942;12987.285699286536;13074.019448541398;13135.474581016748;4665.09030739006;4717.693349932243;4765.189917713997;4849.4908034656555;4861.319415281863;75826.24173758303;76111.23888761096;76543.23456765417;77111.61444192744;79271.20728792695;12180.208286461351;12249.755004899853;12285.815712764315;12293.332404583409;12305.69235769095;21744.456388590414;21953.780462195173;22318.665220021714;22323;22378.552428951654;9126.863097053549;9258;9404.15362617354;9434.386764860263;9544.236461083097;4987.251912213124;5022.296878437021;5044.54599086084;5049.949500505021;5116.309298244763;3514.68367846895;3580.3018411410044;3632.2553876455263;3634.7819130852236;3637.654422829827;613.576632123842;640.1134428816123;640.8686219325027;659.7196191618543;661.986760264792;672.5191488085944;679.1510611735331;707.6320313436984;746.2462912458456;747.137056699513;10008.499575021366;10043.748906277402;10147.64483243083;10430.122577935892;10706.785864282827;548.9752961116759;632.3297304856867;636.6148480169524;727.7962170592243;729.3909585496064;4775.689580177347;4894.412670479494;4920.6555541111775;4931.137051016058;4933.333999910038;108069.45965270123;117525;118384.40807796078;119717;121651.39174304249;104554.47722761337;105743.47128264309;106057;107481;109494.45252773844;93226;94042;94224.99999999863;94398.5280073609;95664.52167739117;9249.583768730557;9484.193843523102;9541.666041688508;9606.135447809731;9649.807003859743;55236.72381638066;55519.167212492655;55931.72034139803;56317.43682563286;57114.42885571258;48299.275510868065;53164.73417632887;54793.45206548043;74170;81274.59362703149;12111.75776484483;12315.93842030784;12408.56570020081;12503.499860005499;12523.123381363217;13085.869141308465;13644.590662280147;13725.107867988549;14211;14394.424223030961;13307.135036222615;13690.31548422555;13691.794623080463;13704.451821927012;14373.712525749635;13824.93087534596;14056.016078874381;14643.194624295766;15119.773203402177;15150.393984240507;13702.246376449391;14642.414303427744;14691.55925322242;14704.852951470777;14828.258587070388;10485.790284194121;10679.946600266949;11169.553217871195;11234.157438192005;12557.62327130151;11300;11873.287602743518;12066.3363515004;12248.387580620754;12363.443645035815 08:29:46 INFO - PROCESS | 30703 | __end_tp_report 08:29:46 INFO - PROCESS | 30703 | __start_cc_report 08:29:46 INFO - PROCESS | 30703 | _x_x_mozilla_cycle_collect,861 08:29:46 INFO - PROCESS | 30703 | __end_cc_report 08:29:46 INFO - PROCESS | 30703 | __startTimestamp1467386986531__endTimestamp 08:29:46 INFO - PROCESS | 30703 | 08:29:46 INFO - PROCESS | 30703 | ------- Summary: start ------- 08:29:46 INFO - PROCESS | 30703 | Number of tests: 6 08:29:46 INFO - PROCESS | 30703 | 08:29:46 INFO - PROCESS | 30703 | [#0] dojo.html Cycles:165 Average:5358.07 Median:5551.78 stddev:607.08 (10.9%) stddev-sans-first:582.81 08:29:46 INFO - PROCESS | 30703 | Values: 3112.1 3114.3 3142.7 3151.0 3188.7 5246.6 5248.9 5315.7 5369.5 5424.7 5328.1 5372.7 5397.4 5406.8 5410.1 4852.9 4913.0 4924.0 4934.8 5067.9 4977.7 4985.0 5028.6 5040.4 5050.6 4814.5 4818.8 4827.8 4829.1 4880.6 4806.2 4827.9 4885.8 4888.0 4937.5 4842.5 4844.7 4863.5 4869.1 4915.0 5239.3 5270.1 5308.5 5355.5 5374.5 5697.3 5719.5 5721.0 5724.5 5727.9 5682.3 5763.3 5776.0 5793.5 5822.7 5361.1 5365.5 5423.1 5468.7 5497.7 5991.4 5998.5 6002.7 6007.2 6010.6 5513.2 5566.7 5758.2 5796.2 5798.2 5696.9 5832.7 5834.3 5836.6 5840.4 5703.3 5754.2 5765.4 5766.2 5770.8 5593.7 5736.5 5775.8 5781.8 5798.1 4438.1 4443.0 4451.0 4487.0 4490.4 3936.3 3948.7 3953.1 3984.0 3987.6 5297.0 5381.9 5382.4 5487.0 5492.6 5827.7 5845.5 5854.6 5857.8 5885.9 5505.8 5507.3 5514.4 5517.9 5519.8 4857.2 4905.6 4948.8 4953.8 4965.4 5971.1 5980.0 5981.1 5983.1 5985.4 5638.4 5731.3 5742.8 5746.1 5747.8 5949.1 5975.2 5977.8 6029.9 6052.0 5642.9 5687.4 5692.6 5696.8 5699.1 5652.0 5661.4 5799.7 5806.3 5806.7 5545.5 5561.4 5572.8 5577.1 5628.2 5532.4 5551.8 5555.2 5556.5 5558.5 5383.0 5410.1 5499.3 5529.9 5552.0 5729.2 5736.1 5750.4 5799.7 5804.4 5607.1 5622.5 5623.7 5625.9 5628.6 08:29:46 INFO - PROCESS | 30703 | 08:29:46 INFO - PROCESS | 30703 | [#1] ext.html Cycles:180 Average:65294.93 Median:44094.34 stddev:135083.59 (306.4%) stddev-sans-first:135375.20 08:29:46 INFO - PROCESS | 30703 | Values: 600.1 612.3 626.1 629.6 649.0 32956.5 35874.5 43721.0 45001.8 45040.0 45749.3 46287.5 46305.5 46313.3 46508.0 8888.6 9021.3 9034.8 9039.0 9046.5 8934.2 9027.1 9027.4 9030.1 9030.2 9005.7 9037.5 9069.1 9075.2 9076.2 8983.6 8985.1 8997.9 9015.1 9034.3 8920.5 8987.9 8990.0 8990.9 8993.5 44015.0 44023.3 44165.3 44199.6 44468.6 3554.8 3582.4 3634.7 3652.9 3876.2 33280.8 33723.3 33986.7 34241.8 35053.6 4241.8 4307.2 4336.2 4367.0 4367.1 370569.0 370863.0 371106.0 373024.0 375255.0 35876.8 60659.4 61186.4 61241.7 61260.4 37730.0 39813.8 39830.8 39836.2 39880.2 14559.6 14697.3 14722.5 14725.9 14733.9 12514.9 12596.1 12597.5 12603.0 12607.4 8807.3 8908.6 8954.7 8958.6 9037.5 3398.6 3417.8 3427.2 3464.2 3468.9 905.1 971.4 975.4 996.7 1022.0 32662.0 33123.7 33146.5 33196.7 33272.8 1059.3 1071.3 1090.1 1106.2 1212.6 16625.5 17158.5 17536.8 17571.2 17649.4 594309.0 598779.0 600935.0 601877.0 602106.0 60334.0 60826.1 60989.7 61037.6 61104.4 1207.1 1314.4 1360.1 1369.3 1380.4 33215.0 33349.3 34773.3 34854.7 35177.6 53499.7 59583.4 59711.7 59779.4 59836.0 519773.0 522247.0 524437.0 524544.0 524555.0 44604.3 45925.0 46287.3 46714.3 46782.1 51636.7 51849.7 51926.7 52762.0 52847.5 43519.3 44202.6 44322.8 44415.0 45047.0 43678.3 43825.0 44018.0 44511.3 45086.8 38163.8 38944.8 43358.0 43481.1 43756.6 34916.0 37827.0 38047.6 38810.0 38871.6 28123.0 28430.0 28539.0 28852.9 28857.4 08:29:46 INFO - PROCESS | 30703 | 08:29:46 INFO - PROCESS | 30703 | [#2] jquery.html Cycles:180 Average:30990.46 Median:33660.49 stddev:78923.39 (234.5%) stddev-sans-first:79111.33 08:29:46 INFO - PROCESS | 30703 | Values: 379.4 408.7 416.5 418.7 432.1 15753.4 19468.5 19686.6 19803.1 21195.1 18686.0 18825.9 18995.6 19167.1 19224.5 5787.8 5909.8 6027.8 6033.7 6125.2 5970.9 6022.4 6027.3 6030.6 6059.1 5760.0 5997.0 5997.3 6054.2 6153.0 6151.1 6151.8 6154.2 6163.1 6435.6 5926.0 5956.3 5968.4 5977.9 5978.5 14569.2 18263.5 24388.4 24482.1 24787.8 2306.8 2333.1 2484.5 2577.4 2710.8 15696.3 16435.1 16454.5 16771.2 17209.6 2094.5 2100.4 2124.7 2153.9 2269.3 90327.0 95460.0 103255.0 104554.5 105395.0 18161.5 18284.4 18400.5 18434.4 18545.9 33238.3 33399.0 33598.7 33722.3 33732.0 9498.4 9530.9 9541.1 9604.8 9893.8 7648.0 7769.7 7868.4 7886.7 7898.5 9174.9 9190.9 9274.5 9280.7 9356.8 3497.8 3557.0 3605.5 3616.4 3628.6 901.5 905.2 907.0 928.2 943.3 19416.9 20052.6 20137.4 20222.5 20542.1 950.7 975.0 979.9 1025.3 1052.7 10662.8 11152.6 11167.4 11211.8 11223.1 468265.0 471253.0 477807.0 478371.0 479143.0 97062.5 104173.0 104706.5 105319.0 106816.0 1007.9 1017.9 1035.1 1040.1 1073.4 18768.3 18826.9 19199.1 19204.5 19234.3 43998.3 44608.6 44762.6 44978.6 45865.3 61874.0 62146.7 62656.7 62866.7 62956.7 8451.7 8918.1 9020.4 9057.7 9219.9 13517.5 13564.3 14187.0 14998.3 15125.3 12605.1 12830.7 12909.6 12916.4 13136.3 12493.8 12692.8 12722.2 12889.6 13138.5 12883.7 12979.7 13120.4 13124.3 13320.3 9171.9 9195.0 9198.7 9235.3 9303.2 9688.5 12402.7 12907.0 13081.1 13155.5 08:29:46 INFO - PROCESS | 30703 | 08:29:46 INFO - PROCESS | 30703 | [#3] mootools.html Cycles:180 Average:6073.53 Median:4869.05 stddev:3570.77 (73.3%) stddev-sans-first:3563.19 08:29:46 INFO - PROCESS | 30703 | Values: 1355.5 1419.5 1454.4 1574.7 1786.9 8648.4 9039.2 9094.7 9390.5 9395.8 9149.5 9319.4 9325.5 9341.8 9354.5 2092.7 2309.6 2374.3 2392.5 2423.8 2445.7 2447.1 2453.0 2453.6 2455.6 2368.7 2397.5 2398.5 2400.1 2405.7 2082.3 2255.2 2328.7 2343.4 2351.6 2367.6 2390.9 2407.3 2412.4 2413.8 9345.6 9373.6 9404.1 9406.6 9425.2 5316.4 5364.4 5365.0 5367.9 5382.3 3314.9 3384.2 3478.6 3507.1 3527.1 1150.6 1156.8 1173.1 1187.1 1203.2 13193.5 13248.0 13275.5 13293.5 13333.1 4678.3 4745.5 4770.1 4798.8 4895.1 10742.9 10794.2 10795.4 10818.9 10829.9 5343.1 5347.1 5354.8 5372.4 5387.8 4358.0 4843.0 4975.8 5016.1 5033.1 4167.6 4170.6 4238.2 4278.9 4294.1 1235.6 1310.5 1331.2 1364.2 1380.2 884.1 902.9 907.2 912.3 921.0 6088.7 6107.7 6171.5 6199.3 6222.5 899.0 912.6 932.0 958.4 959.5 3997.7 4065.9 4101.8 4110.9 4129.2 11585.1 11828.6 11929.5 11941.9 11945.4 11589.2 11698.8 11783.1 11820.9 11868.5 8553.2 8602.3 8758.0 8765.6 8771.4 5818.9 5991.5 6061.7 6102.7 6236.8 10160.0 10698.6 10989.9 10996.9 11055.2 10869.7 10964.2 11112.6 11131.3 11204.9 8321.0 8461.1 8485.7 8495.2 8507.0 8914.8 8986.8 9106.4 9132.9 9148.8 6596.3 7932.8 7968.1 8424.7 8432.4 7943.8 7955.8 8000.8 8061.5 8157.1 6600.9 6799.4 6840.3 6978.2 7090.4 5131.5 5256.1 5292.6 5305.3 5316.8 5048.6 5105.6 5125.9 5158.3 5261.2 08:29:46 INFO - PROCESS | 30703 | 08:29:46 INFO - PROCESS | 30703 | [#4] prototype.html Cycles:180 Average:4673.50 Median:5361.73 stddev:1370.41 (25.6%) stddev-sans-first:1334.96 08:29:46 INFO - PROCESS | 30703 | Values: 332.6 341.0 351.8 352.8 353.1 5342.4 5358.9 5374.8 5377.3 5397.9 5250.4 5280.7 5311.5 5317.5 5335.5 3941.4 4150.9 4153.0 4208.6 4214.0 4127.1 4127.5 4134.1 4139.7 4176.3 4108.7 4127.8 4156.9 4159.6 4169.8 3921.6 3999.2 4099.9 4101.3 4126.2 3600.7 3605.7 3606.0 3631.2 3631.5 4943.6 5167.1 5181.3 5194.7 5199.7 4571.3 4689.2 4699.1 4705.6 4719.0 5482.7 5485.7 5494.4 5519.9 5531.3 3827.4 3973.7 3994.8 3996.6 4001.0 5703.3 5715.8 5728.5 5730.2 5732.6 4086.4 4087.4 4088.4 4089.6 4090.6 4140.9 4141.5 4142.8 4176.1 4187.6 4536.0 4710.4 4717.7 4723.2 4769.6 5486.5 5532.9 5538.8 5559.5 5560.8 1420.5 1439.2 1441.7 1445.9 1450.0 940.8 983.2 986.6 988.9 991.3 5166.6 5282.8 5344.6 5349.5 5364.5 5614.4 5620.7 5630.7 5632.9 5650.6 5055.2 5178.6 5189.7 5308.9 5310.8 2888.2 2899.4 2917.4 2998.6 3006.2 5737.7 5901.1 5905.9 5929.2 5932.0 5765.1 5788.2 5791.9 5794.2 5796.7 5870.7 5898.2 5903.1 5908.6 5920.2 5440.4 5658.4 5670.0 5734.2 5748.8 5620.4 5640.6 5646.5 5656.3 5683.2 5705.4 5905.6 5946.3 5971.8 6017.5 4081.7 4094.1 4114.7 4122.6 4128.6 5693.3 5701.7 5709.5 5711.2 5720.2 5487.6 5545.5 5603.4 5616.3 5626.5 5533.9 5537.6 5547.5 5553.5 5561.7 5392.6 5463.8 5483.8 5488.9 5493.9 5385.5 5561.4 5564.2 5577.2 5611.5 5432.4 5437.2 5459.6 5473.4 5475.6 08:29:46 INFO - PROCESS | 30703 | 08:29:46 INFO - PROCESS | 30703 | [#5] yui.html Cycles:180 Average:21332.08 Median:4691.39 stddev:30853.55 (657.7%) stddev-sans-first:30901.32 08:29:46 INFO - PROCESS | 30703 | Values: 729.5 749.8 750.3 752.3 762.1 15046.9 15918.4 16304.4 16353.8 16442.6 14139.1 14218.4 14220.6 14296.7 14300.2 649.4 782.8 787.8 805.9 806.0 807.0 817.3 817.5 820.6 821.1 852.8 858.5 859.2 859.7 859.9 692.1 807.5 830.2 853.1 853.5 604.3 605.7 606.8 607.2 607.4 15581.4 15654.2 15679.1 15694.7 15761.1 14829.8 14832.3 15032.8 15080.8 15139.0 12892.7 12942.0 12987.3 13074.0 13135.5 4665.1 4717.7 4765.2 4849.5 4861.3 75826.2 76111.2 76543.2 77111.6 79271.2 12180.2 12249.8 12285.8 12293.3 12305.7 21744.5 21953.8 22318.7 22323.0 22378.6 9126.9 9258.0 9404.2 9434.4 9544.2 4987.3 5022.3 5044.5 5049.9 5116.3 3514.7 3580.3 3632.3 3634.8 3637.7 613.6 640.1 640.9 659.7 662.0 672.5 679.2 707.6 746.2 747.1 10008.5 10043.7 10147.6 10430.1 10706.8 549.0 632.3 636.6 727.8 729.4 4775.7 4894.4 4920.7 4931.1 4933.3 108069.5 117525.0 118384.4 119717.0 121651.4 104554.5 105743.5 106057.0 107481.0 109494.5 93226.0 94042.0 94225.0 94398.5 95664.5 9249.6 9484.2 9541.7 9606.1 9649.8 55236.7 55519.2 55931.7 56317.4 57114.4 48299.3 53164.7 54793.5 74170.0 81274.6 12111.8 12315.9 12408.6 12503.5 12523.1 13085.9 13644.6 13725.1 14211.0 14394.4 13307.1 13690.3 13691.8 13704.5 14373.7 13824.9 14056.0 14643.2 15119.8 15150.4 13702.2 14642.4 14691.6 14704.9 14828.3 10485.8 10679.9 11169.6 11234.2 12557.6 11300.0 11873.3 12066.3 12248.4 12363.4 08:29:46 INFO - PROCESS | 30703 | -------- Summary: end -------- 08:29:46 INFO - PROCESS | 30703 | 08:29:47 INFO - TEST-INFO | 30703: exit 0 08:29:47 INFO - TEST-OK | dromaeo_css | took 1116254ms 08:29:47 INFO - TEST-START | kraken 08:29:47 INFO - operating with platform_type : linux_ 08:29:47 INFO - Initialising browser for kraken test... 08:29:47 INFO - TEST-INFO | started process 30900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJUjdbl/profile http://localhost:39609/getInfo.html) 08:29:52 INFO - PROCESS | 30900 | __metrics Screen width/height:1600/1200 08:29:52 INFO - PROCESS | 30900 | colorDepth:24 08:29:52 INFO - PROCESS | 30900 | Browser inner width/height: 1024/697 08:29:52 INFO - PROCESS | 30900 | __metrics 08:29:53 INFO - PROCESS | 30900 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:54 INFO - PROCESS | 30900 | console.error: PushService: 08:29:54 INFO - PROCESS | 30900 | stateChangeProcessEnqueue: Error transitioning state 08:29:54 INFO - PROCESS | 30900 | UnknownError 08:29:54 INFO - TEST-INFO | 30900: exit 0 08:29:54 INFO - Browser initialized. 08:29:54 INFO - Running cycle 1/1 for kraken test... 08:29:54 INFO - TEST-INFO | started process 30983 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJUjdbl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:30:06 INFO - PROCESS | 30983 | RSS: Main: 156844032 08:30:06 INFO - PROCESS | 30983 | 08:30:09 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39609/tests/kraken/driver.html?testName=audio-beat-detection) 08:30:10 INFO - PROCESS | 30983 | RSS: Main: 215310336 08:30:10 INFO - PROCESS | 30983 | 08:30:12 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39609/tests/kraken/driver.html?testName=audio-dft) 08:30:13 INFO - PROCESS | 30983 | RSS: Main: 203808768 08:30:13 INFO - PROCESS | 30983 | 08:30:16 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39609/tests/kraken/driver.html?testName=audio-fft) 08:30:16 INFO - PROCESS | 30983 | RSS: Main: 268955648 08:30:16 INFO - PROCESS | 30983 | 08:30:19 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39609/tests/kraken/driver.html?testName=audio-oscillator) 08:30:19 INFO - PROCESS | 30983 | RSS: Main: 180416512 08:30:19 INFO - PROCESS | 30983 | 08:30:21 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39609/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:30:22 INFO - PROCESS | 30983 | RSS: Main: 184819712 08:30:22 INFO - PROCESS | 30983 | 08:30:25 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39609/tests/kraken/driver.html?testName=imaging-darkroom) 08:30:26 INFO - PROCESS | 30983 | RSS: Main: 219320320 08:30:26 INFO - PROCESS | 30983 | 08:30:29 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39609/tests/kraken/driver.html?testName=imaging-desaturate) 08:30:29 INFO - PROCESS | 30983 | RSS: Main: 220938240 08:30:29 INFO - PROCESS | 30983 | 08:30:32 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39609/tests/kraken/driver.html?testName=json-parse-financial) 08:30:33 INFO - PROCESS | 30983 | RSS: Main: 221093888 08:30:33 INFO - PROCESS | 30983 | 08:30:34 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39609/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:30:35 INFO - PROCESS | 30983 | RSS: Main: 209616896 08:30:35 INFO - PROCESS | 30983 | 08:30:37 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39609/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:30:37 INFO - PROCESS | 30983 | RSS: Main: 213823488 08:30:37 INFO - PROCESS | 30983 | 08:30:39 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39609/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:30:40 INFO - PROCESS | 30983 | RSS: Main: 211243008 08:30:40 INFO - PROCESS | 30983 | 08:30:42 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:30:43 INFO - PROCESS | 30983 | RSS: Main: 221777920 08:30:43 INFO - PROCESS | 30983 | 08:30:46 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:30:46 INFO - PROCESS | 30983 | RSS: Main: 222437376 08:30:46 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | Cycle 1(1): loaded http://localhost:39609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39609/tests/kraken/driver.html?testName=ai-astar) 08:30:48 INFO - PROCESS | 30983 | RSS: Main: 265478144 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | __start_tp_report 08:30:48 INFO - PROCESS | 30983 | _x_x_mozilla_page_load 08:30:48 INFO - PROCESS | 30983 | _x_x_mozilla_page_load_details 08:30:48 INFO - PROCESS | 30983 | |i|pagename|runs| 08:30:48 INFO - PROCESS | 30983 | |0;ai-astar;102;110;109;108;111;111;110;109;110;110 08:30:48 INFO - PROCESS | 30983 | |1;audio-beat-detection;149;116;117;168;131;116;152;115;163;118 08:30:48 INFO - PROCESS | 30983 | |2;audio-dft;162;163;161;161;162;161;162;161;161;161 08:30:48 INFO - PROCESS | 30983 | |3;audio-fft;74;74;75;135;74;76;74;75;117;83 08:30:48 INFO - PROCESS | 30983 | |4;audio-oscillator;84;83;117;83;83;84;122;85;83;139 08:30:48 INFO - PROCESS | 30983 | |5;imaging-gaussian-blur;117;117;117;118;117;117;117;117;117;117 08:30:48 INFO - PROCESS | 30983 | |6;imaging-darkroom;145;145;146;146;145;145;145;145;145;145 08:30:48 INFO - PROCESS | 30983 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;95 08:30:48 INFO - PROCESS | 30983 | |8;json-parse-financial;52;51;52;50;51;52;52;51;52;50 08:30:48 INFO - PROCESS | 30983 | |9;json-stringify-tinderbox;62;61;61;61;60;60;61;62;60;61 08:30:48 INFO - PROCESS | 30983 | |10;stanford-crypto-aes;76;83;73;73;75;74;79;74;77;75 08:30:48 INFO - PROCESS | 30983 | |11;stanford-crypto-ccm;119;117;121;126;121;123;119;118;167;127 08:30:48 INFO - PROCESS | 30983 | |12;stanford-crypto-pbkdf2;158;156;164;160;157;159;158;157;159;154 08:30:48 INFO - PROCESS | 30983 | |13;stanford-crypto-sha256-iterative;63;63;64;62;63;61;62;62;62;62 08:30:48 INFO - PROCESS | 30983 | __end_tp_report 08:30:48 INFO - PROCESS | 30983 | __start_cc_report 08:30:48 INFO - PROCESS | 30983 | _x_x_mozilla_cycle_collect,1609 08:30:48 INFO - PROCESS | 30983 | __end_cc_report 08:30:48 INFO - PROCESS | 30983 | __startTimestamp1467387048695__endTimestamp 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | ------- Summary: start ------- 08:30:48 INFO - PROCESS | 30983 | Number of tests: 14 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.62 (2.4%) stddev-sans-first:0.97 08:30:48 INFO - PROCESS | 30983 | Values: 102.0 110.0 109.0 108.0 111.0 111.0 110.0 109.0 110.0 110.0 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#1] audio-beat-detection Cycles:10 Average:134.50 Median:140.00 stddev:21.36 (15.3%) stddev-sans-first:22.00 08:30:48 INFO - PROCESS | 30983 | Values: 149.0 116.0 117.0 168.0 131.0 116.0 152.0 115.0 163.0 118.0 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 08:30:48 INFO - PROCESS | 30983 | Values: 162.0 163.0 161.0 161.0 162.0 161.0 162.0 161.0 161.0 161.0 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#3] audio-fft Cycles:10 Average:85.70 Median:74.50 stddev:21.83 (29.3%) stddev-sans-first:22.74 08:30:48 INFO - PROCESS | 30983 | Values: 74.0 74.0 75.0 135.0 74.0 76.0 74.0 75.0 117.0 83.0 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:83.00 stddev:21.21 (25.6%) stddev-sans-first:22.03 08:30:48 INFO - PROCESS | 30983 | Values: 84.0 83.0 117.0 83.0 83.0 84.0 122.0 85.0 83.0 139.0 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:30:48 INFO - PROCESS | 30983 | Values: 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 08:30:48 INFO - PROCESS | 30983 | Values: 145.0 145.0 146.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 08:30:48 INFO - PROCESS | 30983 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#8] json-parse-financial Cycles:10 Average:51.30 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.83 08:30:48 INFO - PROCESS | 30983 | Values: 52.0 51.0 52.0 50.0 51.0 52.0 52.0 51.0 52.0 50.0 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#9] json-stringify-tinderbox Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 08:30:48 INFO - PROCESS | 30983 | Values: 62.0 61.0 61.0 61.0 60.0 60.0 61.0 62.0 60.0 61.0 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.50 stddev:3.11 (4.1%) stddev-sans-first:3.30 08:30:48 INFO - PROCESS | 30983 | Values: 76.0 83.0 73.0 73.0 75.0 74.0 79.0 74.0 77.0 75.0 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:122.00 stddev:14.85 (12.2%) stddev-sans-first:15.54 08:30:48 INFO - PROCESS | 30983 | Values: 119.0 117.0 121.0 126.0 121.0 123.0 119.0 118.0 167.0 127.0 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.50 stddev:2.66 (1.7%) stddev-sans-first:2.82 08:30:48 INFO - PROCESS | 30983 | Values: 158.0 156.0 164.0 160.0 157.0 159.0 158.0 157.0 159.0 154.0 08:30:48 INFO - PROCESS | 30983 | 08:30:48 INFO - PROCESS | 30983 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:0.84 (1.3%) stddev-sans-first:0.87 08:30:48 INFO - PROCESS | 30983 | Values: 63.0 63.0 64.0 62.0 63.0 61.0 62.0 62.0 62.0 62.0 08:30:48 INFO - PROCESS | 30983 | -------- Summary: end -------- 08:30:48 INFO - PROCESS | 30983 | 08:30:49 INFO - TEST-INFO | 30983: exit 0 08:30:49 INFO - TEST-OK | kraken | took 62424ms 08:30:49 INFO - SUITE-END | took 1178s 08:30:49 INFO - Completed test suite (00:19:38) 08:30:49 INFO - javascript benchmark 08:30:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.128603990882, 3114.252579380949, 3142.6543080261167, 3151.0231828133265, 3188.6970737779916, 5246.632735708502, 5248.895022099565, 5315.734213289339, 5369.463053694633, 5424.674519528826, 5328.094223981922, 5372.7313634318325, 5397.379301380342, 5406.756695948682, 5410.134378499441, 4852.854414367565, 4913.0, 4924.0, 4934.827281045164, 5067.923981140286, 4977.651564390494, 4984.975075124619, 5028.622853286, 5040.420351659551, 5050.570701490359, 4814.494478079786, 4818.7831547580445, 4827.806887724487, 4829.10661527615, 4880.6095512358925, 4806.182948898696, 4827.927581086286, 4885.804567817283, 4887.975560122177, 4937.506249375069, 4842.467328593852, 4844.66087373884, 4863.537963893425, 4869.074875773627, 4915.0, 5239.318888544503, 5270.077736396115, 5308.495692909168, 5355.491228333302, 5374.543163831079, 5697.344805347397, 5719.456651618089, 5720.971395143039, 5724.542036637059, 5727.9427205727825, 5682.346530149003, 5763.250777398911, 5776.046952252873, 5793.507551858055, 5822.737976791054, 5361.088614935431, 5365.490278423583, 5423.05096608092, 5468.7265636718, 5497.697626630534, 5991.370906054802, 5998.520118390518, 6002.729877155539, 6007.189029481052, 6010.639361638316, 5513.2005859151, 5566.721663916869, 5758.165066065397, 5796.188533605298, 5798.159266906275, 5696.886062278814, 5832.650040997553, 5834.3290521589715, 5836.649801011953, 5840.415958404125, 5703.315602127688, 5754.1944127822135, 5765.365809760923, 5766.192733017381, 5770.826875193667, 5593.720313984284, 5736.4550367715, 5775.797847075332, 5781.768729250783, 5798.1302804579655, 4438.090191510732, 4443.022535042285, 4451.0, 4487.035287413222, 4490.371348011281, 3936.3111455495173, 3948.6841052715713, 3953.090789118519, 3984.0, 3987.601239876047, 5296.973515132399, 5381.9461805382225, 5382.434844341366, 5487.012337779238, 5492.5605951523785, 5827.737751801179, 5845.532357411397, 5854.619449735754, 5857.7949771757785, 5885.852853678693, 5505.779768809283, 5507.339119305629, 5514.365847927459, 5517.944820551824, 5519.751611177507, 4857.247126695368, 4905.558499735041, 4948.826791062295, 4953.826616068421, 4965.354503914468, 5971.0744834550715, 5979.970100149471, 5981.0729336952845, 5983.132445795335, 5985.431384018511, 5638.37977822431, 5731.312242530923, 5742.827715168552, 5746.051901436216, 5747.770089196385, 5949.137375080502, 5975.163477113295, 5977.820665380045, 6029.939700602938, 6052.0, 5642.887142257214, 5687.402822703557, 5692.601517893708, 5696.829095127153, 5699.088145896637, 5651.971740141273, 5661.377248502579, 5799.652020878761, 5806.303243610625, 5806.65160090396, 5545.473180047889, 5561.443855614568, 5572.832815015556, 5577.051901176728, 5628.183913332462, 5532.3637781655625, 5551.7779288828, 5555.22226888244, 5556.472135147154, 5558.471945165203, 5382.973085134549, 5410.053240682786, 5499.340079190362, 5529.944700552943, 5552.028395030773, 5729.2265544151005, 5736.082226843685, 5750.396208398058, 5799.710014499174, 5804.448577385142, 5607.07483265273, 5622.465865742748, 5623.746931388179, 5625.859353516031, 5628.634138780966], "value": 5317.420556002736, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.05790908274, 612.2561088277743, 626.139058794158, 629.5750368501264, 648.9772857949972, 32956.50565241523, 35874.46188307177, 43721.0, 45001.77499112508, 45040.0, 45749.313760293626, 46287.53712462875, 46305.53694463054, 46313.305300420434, 46508.0, 8888.55557222138, 9021.323400744937, 9034.819303613956, 9039.0, 9046.457212567268, 8934.195922366986, 9027.097290270985, 9027.413218140833, 9030.096990300983, 9030.232430243404, 9005.684801031965, 9037.502937338444, 9069.138431848964, 9075.183233508982, 9076.22852057576, 8983.640654373818, 8985.101489851028, 8997.910020899773, 9015.098490150966, 9034.322425818056, 8920.464772113693, 8987.910120898772, 8990.011098779129, 8990.910090899139, 8993.505357205351, 44015.0, 44023.339649905276, 44165.337519937224, 44199.558004419865, 44468.55531444709, 3554.7689400189165, 3582.444721068239, 3634.745567810254, 3652.9086772830624, 3876.2247550490015, 33280.833595831864, 33723.325533489435, 33986.6601333986, 34241.828790855885, 35053.649463505295, 4241.787910604488, 4307.181635489247, 4336.176126535979, 4367.039251364695, 4367.126574685076, 370569.0, 370863.0, 371106.0, 373024.0, 375255.0, 35876.820615897275, 60659.39340606538, 61186.388136118956, 61241.693791531645, 61260.387396125465, 37730.0, 39813.80093099516, 39830.80084599558, 39836.2032759349, 39880.202395952496, 14559.636009099857, 14697.265136743334, 14722.484713034992, 14725.926370368079, 14733.852661473462, 12514.937425312997, 12596.055295852664, 12597.496100155891, 12603.0, 12607.369631518388, 8807.295416366675, 8908.643654253758, 8954.686585969459, 8958.552072396355, 9037.548122593844, 3398.6431424700545, 3417.8461969211444, 3427.2288735034417, 3464.2032332563654, 3468.9306213876084, 905.063259526387, 971.4074414607084, 975.4439969217619, 996.7209181429212, 1022.0494939705997, 32662.0, 33123.66876331254, 33146.50280245798, 33196.66803331936, 33272.83363583167, 1059.3379138038727, 1071.276888100529, 1090.1224514266091, 1106.2366966793047, 1212.6240865331774, 16625.50123496297, 17158.48524544266, 17536.82463175352, 17571.209295581728, 17649.38227162043, 594309.0, 598779.0, 600935.0, 601877.0, 602106.0, 60334.0, 60826.087608685906, 60989.69505152535, 61037.55849765959, 61104.38895611076, 1207.130865776657, 1314.3625341709264, 1360.088740543838, 1369.301656155368, 1380.3857283508944, 33215.0, 33349.33301334008, 34773.304533909686, 34854.65145348514, 35177.64822351846, 53499.7325013388, 59583.404165957785, 59711.70144149425, 59779.402205979124, 59836.0, 519773.0, 522247.0, 524437.0, 524544.0, 524555.0, 44604.33093503535, 45925.0, 46287.305690413996, 46714.29928551142, 46782.064358713316, 51636.74181629218, 51849.740751296005, 51926.74036629793, 52762.0, 52847.47152528579, 43519.34720979251, 44202.55797442113, 44322.778386107864, 44415.0, 45047.0, 43678.26385468374, 43825.0, 44018.0, 44511.33233001572, 45086.77456612696, 38163.80918095392, 38944.80527597457, 43358.0, 43481.13037739291, 43756.56243437525, 34916.0, 37827.0, 38047.61952380441, 38810.0, 38871.6112838868, 28123.0, 28430.0, 28539.0, 28852.855735721187, 28857.422851542433], "value": 19836.014486295975, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.3532027892444, 408.6648947862754, 416.47524119609295, 418.65042689354385, 432.14866712576213, 15753.369865205392, 19468.451491324977, 19686.606267874635, 19803.108860101274, 21195.092441680245, 18686.0, 18825.905870470662, 18995.62008759824, 19167.137478813453, 19224.51938701533, 5787.768489260425, 5909.793157239508, 6027.849303767397, 6033.728482218289, 6125.234345706786, 5970.8805823883495, 6022.427869352427, 6027.306859711123, 6030.608010479326, 6059.121427393025, 5759.971200143993, 5997.0, 5997.310309314441, 6054.243219597551, 6152.969235153841, 6151.138840562325, 6151.846203844895, 6154.169187159721, 6163.075538669213, 6435.613863168178, 5926.0, 5956.344802071769, 5968.403159683997, 5977.880442391128, 5978.461938425519, 14569.198694071822, 18263.54341141482, 24388.390290242707, 24482.14312499072, 24787.752122478723, 2306.7923886850263, 2333.101755824003, 2484.4534202475606, 2577.4329647477525, 2710.783137349007, 15696.293666785023, 16435.09606971616, 16454.506364809076, 16771.2452939618, 17209.569760755956, 2094.4973206430345, 2100.369889033284, 2124.6706760452153, 2153.9246126385656, 2269.273832373641, 90327.0, 95460.0, 103254.96745032529, 104554.47722761337, 105395.0, 18161.545961350806, 18284.360047398277, 18400.50139774566, 18434.354797582022, 18545.90727046383, 33238.3352332952, 33399.0, 33598.664013360045, 33722.325553488794, 33732.0, 9498.382605130644, 9530.90469095314, 9541.093596108498, 9604.807903842024, 9893.752656183653, 7648.0, 7769.689212431439, 7868.370530357558, 7886.738121900468, 7898.526088434713, 9174.917161862906, 9190.85965589982, 9274.489903055262, 9280.675176368795, 9356.812863742824, 3497.8251087445524, 3556.982215088908, 3605.549306336708, 3616.403293456603, 3628.6189950054863, 901.5170045275485, 905.2124651553191, 906.9954650226707, 928.2434815625379, 943.3160958305311, 19416.902915485614, 20052.59894802125, 20137.39587812368, 20222.494437639176, 20542.07560659774, 950.6625148072472, 974.9951250243845, 979.8628192053118, 1025.266934142092, 1052.6578861869923, 10662.840057399146, 11152.609658661908, 11167.385793781257, 11211.831822522669, 11223.102151827834, 468265.0, 471253.0, 477807.0, 478371.0, 479143.0, 97062.51468742752, 104173.0, 104706.47646761718, 105319.0, 106816.0, 1007.9496025198711, 1017.8880323164447, 1035.1098055672117, 1040.1314902056868, 1073.350622873166, 18768.343107991153, 18826.905865470584, 19199.136038878005, 19204.519887002938, 19234.326798562543, 43998.340024900295, 44608.553914461736, 44762.55237447584, 44978.55021449875, 45865.31202032039, 61874.0, 62146.68926655338, 62656.686716566124, 62866.685666573205, 62956.68521657363, 8451.66193352259, 8918.10818918129, 9020.413673111227, 9057.728268151966, 9219.86170207434, 13517.526886559317, 13564.253966031964, 14187.0014019368, 14998.250087495364, 15125.319360628579, 12605.054620903285, 12830.743385132431, 12909.612711618667, 12916.354182291036, 13136.256166992362, 12493.75012499763, 12692.809607856074, 12722.173058751152, 12889.613311600291, 13138.540151094665, 12883.677908052374, 12979.675508112372, 13120.409581568661, 13124.34378281063, 13320.33398330099, 9171.908280917105, 9195.0, 9198.724038278862, 9235.307351948497, 9303.185878753578, 9688.467134307399, 12402.689932751393, 12907.0, 13081.084324097603, 13155.53955611549], "value": 10506.518464720615, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.5255660518826, 1419.5173640962073, 1454.425501926739, 1574.6614477887251, 1786.892786432814, 8648.351373646978, 9039.231665308449, 9094.681686140986, 9390.48352340621, 9395.791988882607, 9149.451032938028, 9319.394239374436, 9325.487098209596, 9341.813163736739, 9354.485503297316, 2092.665173572221, 2309.6304591265402, 2374.252110585169, 2392.545416370884, 2423.8424502407374, 2445.6820613320333, 2447.0945750072497, 2453.0, 2453.6074228123503, 2455.6439316299125, 2368.656544801003, 2397.496525729599, 2398.4963157736897, 2400.1239547565187, 2405.7353691093967, 2082.2816128435666, 2255.22194842779, 2328.685627440291, 2343.367290831466, 2351.611984022643, 2367.633016882369, 2390.8565486070893, 2407.337982054931, 2412.433078226615, 2413.80689544836, 9345.626174952993, 9373.625054997792, 9404.05959404061, 9406.576704048335, 9425.151736343762, 5316.415194328621, 5364.409914909357, 5364.953834002371, 5367.919481207785, 5382.30030096085, 3314.9171270718184, 3384.2385463270566, 3478.617352091268, 3507.0706262840367, 3527.1005893496995, 1150.5972909481613, 1156.7570810129882, 1173.1142987044811, 1187.0503597122267, 1203.2419575667361, 13193.538226162134, 13248.0, 13275.46898124074, 13293.534726284533, 13333.06668533203, 4678.2982552616695, 4745.525447455296, 4770.099356524768, 4798.7840547175465, 4895.094407534618, 10742.892571074346, 10794.244402891722, 10795.352278863293, 10818.891811081945, 10829.891701083046, 5343.0649636314265, 5347.144456886879, 5354.812581559705, 5372.355317361941, 5387.838364849061, 4357.9564204358185, 4843.0, 4975.751212439363, 5016.072026675077, 5033.144365457881, 4167.624913757776, 4170.562090980464, 4238.237117318912, 4278.914421711548, 4294.141171765659, 1235.6293112066344, 1310.5347601601295, 1331.1813234860685, 1364.242845220912, 1380.151207007683, 884.0761404332488, 902.9232515236279, 907.1880666803174, 912.3203213605906, 920.9723708288763, 6088.665123418255, 6107.709059668548, 6171.475424588871, 6199.3490683478485, 6222.502199824004, 899.0155779421523, 912.598456679059, 931.9860202096974, 958.4153666263574, 959.472290240365, 3997.700172487017, 4065.89835254121, 4101.753894766323, 4110.876673699794, 4129.215449064668, 11585.131115166396, 11828.585999489977, 11929.463174157183, 11941.880581194251, 11945.402729863472, 11589.188756787113, 11698.824517632242, 11783.057355411547, 11820.94089529564, 11868.525258989544, 8553.230209281195, 8602.268807151337, 8758.0, 8765.649374024968, 8771.429857059271, 5818.883622327445, 5991.520678345809, 6061.696915154313, 6102.7253773579405, 6236.75052997875, 10160.0, 10698.572057117628, 10989.890101099207, 10996.945015274872, 11055.170862185207, 10869.728256793644, 10964.232503724663, 11112.555497779998, 11131.332120072822, 11204.943975280072, 8321.0, 8461.06928237881, 8485.745427637181, 8495.150484951455, 8506.97916250054, 8914.777130571529, 8986.820263594822, 9106.408083474553, 9132.863007055032, 9148.817023659356, 6596.340365963365, 7932.801679958047, 7968.0836703779805, 8424.663013479392, 8432.367572432215, 7943.801404964922, 7955.84088318242, 8000.759977200693, 8061.516309021477, 8157.102718701057, 6600.9339906602245, 6799.422049125879, 6840.31596840312, 6978.197507286727, 7090.397316228178, 5131.486851314988, 5256.132738098171, 5292.576593872558, 5305.31030965972, 5316.787328506816, 5048.64659473848, 5105.617078719037, 5125.92311115341, 5158.252053452304, 5261.210818377274], "value": 4794.603505068142, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.6008789452657, 340.9914752131197, 351.75904505413786, 352.768936346693, 353.1084012867509, 5342.412334643196, 5358.946410535894, 5374.811881584141, 5377.274068000828, 5397.865053373658, 5250.369955605323, 5280.709560974145, 5311.48622642547, 5317.5480084192795, 5335.546478549319, 3941.4284928685465, 4150.8962275943195, 4153.048067408313, 4208.621224089831, 4213.9869992954955, 4127.050778320973, 4127.504699436072, 4134.069834287291, 4139.737380099069, 4176.310908700061, 4108.650764685005, 4127.752334859903, 4156.916861662765, 4159.563245859186, 4169.770662613555, 3921.627445392683, 3999.180168065554, 4099.877003689894, 4101.26177288088, 4126.236646220429, 3600.71194304455, 3605.7115430765475, 3605.981970090159, 3631.2192878530977, 3631.511080457, 4943.629227807929, 5167.147420675584, 5181.300524429192, 5194.71429071401, 5199.662021968597, 4571.337156112379, 4689.155951928651, 4699.130660827758, 4705.55297246761, 4719.0, 5482.725863706839, 5485.670859748428, 5494.423085575997, 5519.889602207973, 5531.308586426697, 3827.4258861171047, 3973.7417067890783, 3994.7802870842092, 3996.6403023728003, 4001.0, 5703.287089113861, 5715.771369145229, 5728.474505140934, 5730.197772311838, 5732.570057245682, 4086.366613174963, 4087.4073259377224, 4088.4259560069586, 4089.5705950875326, 4090.6091928744368, 4140.855070072533, 4141.461609990682, 4142.772147531915, 4176.1230141669985, 4187.623113919762, 4535.954640453553, 4710.364100846342, 4717.693349932243, 4723.220668589644, 4769.642276829251, 5486.506214440639, 5532.861678458071, 5538.778448862, 5559.471850174308, 5560.77756889728, 1420.472991534105, 1439.201243309973, 1441.6612096157394, 1445.9204743738985, 1450.0, 940.7695114696943, 983.1692220074026, 986.5511192407438, 988.8912219655977, 991.3209451525584, 5166.638335316567, 5282.837775689342, 5344.599155063386, 5349.518543331041, 5364.51719345253, 5614.438556144434, 5620.718964051781, 5630.662160270315, 5632.887342253214, 5650.609634219435, 5055.191169412877, 5178.649934055412, 5189.7405129743365, 5308.893822123536, 5310.8141215057285, 2888.2057434205763, 2899.3911278631304, 2917.3727648555237, 2998.6401631803888, 3006.181260337464, 5737.684427356536, 5901.144334071536, 5905.911411328833, 5929.229200203946, 5931.970340148272, 5765.106408506688, 5788.189653448437, 5791.913121303184, 5794.246747922827, 5796.652200867877, 5870.706464676749, 5898.174255604219, 5903.144044113579, 5908.615939963888, 5920.171176035445, 5440.367889633173, 5658.434156584473, 5669.971650141723, 5734.2258795062135, 5748.798792042258, 5620.4098569649595, 5640.574552942274, 5646.548276137982, 5656.321241451053, 5683.175939488834, 5705.37240903492, 5905.5570832186895, 5946.256717910262, 5971.790987315423, 6017.458428741435, 4081.714260008088, 4094.1197642507004, 4114.7119701620595, 4122.587741225853, 4128.587141285848, 5693.28833895763, 5701.714914254354, 5709.543236540983, 5711.200431939449, 5720.227769251098, 5487.64330318528, 5545.528630066489, 5603.403030136392, 5616.326040875121, 5626.465485778845, 5533.889322213614, 5537.640053396677, 5547.528460080938, 5553.527950124123, 5561.7463783687, 5392.568594512508, 5463.836084917459, 5483.8080667176455, 5488.890222195613, 5493.945060549343, 5385.488378604026, 5561.388247292875, 5564.248826408383, 5577.191307260506, 5611.466910643482, 5432.429594892479, 5437.178545187407, 5459.563234941115, 5473.425290344457, 5475.561955043667], "value": 4243.530083578348, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [729.5185177782663, 749.8162950077228, 750.2647405542572, 752.3417010116149, 762.1387831750121, 15046.924765376172, 15918.363265469367, 16304.429344972914, 16353.83646163538, 16442.588935276595, 14139.08095973761, 14218.360173792178, 14220.644483887882, 14296.714065718705, 14300.213488258141, 649.428502917432, 782.788647065292, 787.8227398835273, 805.899262592176, 806.0408114343912, 807.0235015631093, 817.2603793566802, 817.5013241922422, 820.6143112737004, 821.1337039423406, 852.8294341131767, 858.5235194467068, 859.2095272349422, 859.6776208921655, 859.879616853641, 692.1002696494537, 807.4872455990429, 830.2444775254489, 853.0871966995318, 853.5348235211825, 604.2507290959223, 605.6820169411051, 606.7633622887078, 607.2318517075903, 607.3622696169049, 15581.376744930189, 15654.217289135611, 15679.059256444536, 15694.686106277924, 15761.133137677423, 14829.77755333671, 14832.332545035499, 15032.849671503254, 15080.849191508163, 15139.0, 12892.742145157044, 12942.0, 12987.285699286536, 13074.019448541398, 13135.474581016748, 4665.09030739006, 4717.693349932243, 4765.189917713997, 4849.4908034656555, 4861.319415281863, 75826.24173758303, 76111.23888761096, 76543.23456765417, 77111.61444192744, 79271.20728792695, 12180.208286461351, 12249.755004899853, 12285.815712764315, 12293.332404583409, 12305.69235769095, 21744.456388590414, 21953.780462195173, 22318.665220021714, 22323.0, 22378.552428951654, 9126.863097053549, 9258.0, 9404.15362617354, 9434.386764860263, 9544.236461083097, 4987.251912213124, 5022.296878437021, 5044.54599086084, 5049.949500505021, 5116.309298244763, 3514.68367846895, 3580.3018411410044, 3632.2553876455263, 3634.7819130852236, 3637.654422829827, 613.576632123842, 640.1134428816123, 640.8686219325027, 659.7196191618543, 661.986760264792, 672.5191488085944, 679.1510611735331, 707.6320313436984, 746.2462912458456, 747.137056699513, 10008.499575021366, 10043.748906277402, 10147.64483243083, 10430.122577935892, 10706.785864282827, 548.9752961116759, 632.3297304856867, 636.6148480169524, 727.7962170592243, 729.3909585496064, 4775.689580177347, 4894.412670479494, 4920.6555541111775, 4931.137051016058, 4933.333999910038, 108069.45965270123, 117525.0, 118384.40807796078, 119717.0, 121651.39174304249, 104554.47722761337, 105743.47128264309, 106057.0, 107481.0, 109494.45252773844, 93226.0, 94042.0, 94224.99999999863, 94398.5280073609, 95664.52167739117, 9249.583768730557, 9484.193843523102, 9541.666041688508, 9606.135447809731, 9649.807003859743, 55236.72381638066, 55519.167212492655, 55931.72034139803, 56317.43682563286, 57114.42885571258, 48299.275510868065, 53164.73417632887, 54793.45206548043, 74170.0, 81274.59362703149, 12111.75776484483, 12315.93842030784, 12408.56570020081, 12503.499860005499, 12523.123381363217, 13085.869141308465, 13644.590662280147, 13725.107867988549, 14211.0, 14394.424223030961, 13307.135036222615, 13690.31548422555, 13691.794623080463, 13704.451821927012, 14373.712525749635, 13824.93087534596, 14056.016078874381, 14643.194624295766, 15119.773203402177, 15150.393984240507, 13702.246376449391, 14642.414303427744, 14691.55925322242, 14704.852951470777, 14828.258587070388, 10485.790284194121, 10679.946600266949, 11169.553217871195, 11234.157438192005, 12557.62327130151, 11300.0, 11873.287602743518, 12066.3363515004, 12248.387580620754, 12363.443645035815], "value": 7724.6998396171575, "unit": "score"}], "name": "dromaeo_css", "value": 7473.147152678613, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 110.0, 109.0, 108.0, 111.0, 111.0, 110.0, 109.0, 110.0, 110.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 116.0, 117.0, 168.0, 131.0, 116.0, 152.0, 115.0, 163.0, 118.0], "value": 134.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 161.0, 162.0, 161.0, 162.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 135.0, 74.0, 76.0, 74.0, 75.0, 117.0, 83.0], "value": 85.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 117.0, 83.0, 83.0, 84.0, 122.0, 85.0, 83.0, 139.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 51.0, 52.0, 50.0, 51.0, 52.0, 52.0, 51.0, 52.0, 50.0], "value": 51.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 60.0, 60.0, 61.0, 62.0, 60.0, 61.0], "value": 60.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 73.0, 73.0, 75.0, 74.0, 79.0, 74.0, 77.0, 75.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 121.0, 126.0, 121.0, 123.0, 119.0, 118.0, 167.0, 127.0], "value": 125.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 156.0, 164.0, 160.0, 157.0, 159.0, 158.0, 157.0, 159.0, 154.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 62.0, 63.0, 61.0, 62.0, 62.0, 62.0, 62.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1478.9, "alertThreshold": 2.0}]} 08:30:49 INFO - Return code: 0 08:30:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:30:49 INFO - # TBPL SUCCESS # 08:30:49 INFO - Running post-action listener: _resource_record_post_action 08:30:49 INFO - ##### 08:30:49 INFO - ##### Finished run-tests step (success) 08:30:49 INFO - ##### 08:30:49 INFO - Running post-run listener: _resource_record_post_run 08:30:50 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 564387840; Read time: 0; Write time: 1469928 08:30:50 INFO - TinderboxPrint: CPU usage
13.1% 08:30:50 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:30:50 INFO - TinderboxPrint: I/O write bytes / time
564,387,840 / 1,469,928 08:30:50 INFO - TinderboxPrint: CPU idle
8,305.3 (86.9%) 08:30:50 INFO - TinderboxPrint: CPU user
1,186.4 (12.4%) 08:30:50 INFO - TinderboxPrint: Swap in / out
0 / 0 08:30:50 INFO - install - Wall time: 18s; CPU: 17.0%; Read bytes: 0; Write bytes: 270516224; Read time: 0; Write time: 796184 08:30:50 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 293855232; Read time: 0; Write time: 673744 08:30:50 INFO - Running post-run listener: _upload_blobber_files 08:30:50 INFO - Blob upload gear active. 08:30:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:30:50 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 08:30:50 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'] 08:30:50 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 08:30:51 INFO - (blobuploader) - INFO - Open directory for files ... 08:30:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:30:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:30:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:51 INFO - (blobuploader) - INFO - Done attempting. 08:30:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:30:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:30:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:52 INFO - (blobuploader) - INFO - Done attempting. 08:30:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:30:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:30:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:30:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:30:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:30:55 INFO - (blobuploader) - INFO - Done attempting. 08:30:55 INFO - (blobuploader) - INFO - Iteration through files over. 08:30:56 INFO - Return code: 0 08:30:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:30:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:30:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34cda924face47c27d53099f6950295b768fb59de4f6f5e20c310af338fe48b74f4bf018fe8c3e433c429be83ef7873d7da4258b110b6493b524ded4335c8676", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1bb4814a7e68b27e71da931dc57ec676d30c2e4663ba910c66ad61cc28b58828cd61d2e6e4ec3ea7b4fb7ea705a3dd25c81304c2988a575f2fc8bfd73003166", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44ae69d8da2fdc7f544c25113cdbfafdf5f09b22583b2bd24bd7c4bf542ceab8c3668828f42b878b544dd5cd0f8e98cc7bcb18c42703a7638d48e4611063f9dd"} 08:30:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:30:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:30:56 INFO - Contents: 08:30:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34cda924face47c27d53099f6950295b768fb59de4f6f5e20c310af338fe48b74f4bf018fe8c3e433c429be83ef7873d7da4258b110b6493b524ded4335c8676", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1bb4814a7e68b27e71da931dc57ec676d30c2e4663ba910c66ad61cc28b58828cd61d2e6e4ec3ea7b4fb7ea705a3dd25c81304c2988a575f2fc8bfd73003166", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44ae69d8da2fdc7f544c25113cdbfafdf5f09b22583b2bd24bd7c4bf542ceab8c3668828f42b878b544dd5cd0f8e98cc7bcb18c42703a7638d48e4611063f9dd"} 08:30:56 INFO - Running post-run listener: copy_logs_to_upload_dir 08:30:56 INFO - Copying logs to upload dir... 08:30:56 INFO - mkdir: /builds/slave/test/build/upload/logs 08:30:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.362695 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-01 08:30:55.795460) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 08:30:55.798749) ========= 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=5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34cda924face47c27d53099f6950295b768fb59de4f6f5e20c310af338fe48b74f4bf018fe8c3e433c429be83ef7873d7da4258b110b6493b524ded4335c8676", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1bb4814a7e68b27e71da931dc57ec676d30c2e4663ba910c66ad61cc28b58828cd61d2e6e4ec3ea7b4fb7ea705a3dd25c81304c2988a575f2fc8bfd73003166", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44ae69d8da2fdc7f544c25113cdbfafdf5f09b22583b2bd24bd7c4bf542ceab8c3668828f42b878b544dd5cd0f8e98cc7bcb18c42703a7638d48e4611063f9dd"} build_url:https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011247 build_url: 'https://queue.taskcluster.net/v1/task/HnK2meMqRLSW-83BDvR3Qw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34cda924face47c27d53099f6950295b768fb59de4f6f5e20c310af338fe48b74f4bf018fe8c3e433c429be83ef7873d7da4258b110b6493b524ded4335c8676", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f1bb4814a7e68b27e71da931dc57ec676d30c2e4663ba910c66ad61cc28b58828cd61d2e6e4ec3ea7b4fb7ea705a3dd25c81304c2988a575f2fc8bfd73003166", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44ae69d8da2fdc7f544c25113cdbfafdf5f09b22583b2bd24bd7c4bf542ceab8c3668828f42b878b544dd5cd0f8e98cc7bcb18c42703a7638d48e4611063f9dd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 08:30:55.824240) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:30:55.824575) ========= 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=5cf47e208febbcd81da23b2e0000026f-1467385707.688176-1698834264 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004433 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:30:55.910170) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 08:30:55.910504) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 08:30:55.910812) ========= ========= Total master_lag: 0.18 =========