builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1468325494.99 results: success (0) buildid: 20160712023026 builduid: d91119467f71410c8c4a14d7add2fa89 revision: efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:34.993639) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:34.994656) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:34.995404) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:35.010687) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:35.010994) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-12 05:11:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2016-07-12 05:11:35 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102108 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:35.131420) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:35.132113) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017540 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:35.185718) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 05:11:35.186455) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8 --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 efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8 --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=56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-12 05:11:35,253 truncating revision to first 12 chars 2016-07-12 05:11:35,253 Setting DEBUG logging. 2016-07-12 05:11:35,253 attempt 1/10 2016-07-12 05:11:35,253 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/efc08ad3e8af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-12 05:11:36,204 unpacking tar archive at: fx-team-efc08ad3e8af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.316263 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-12 05:11:36.518124) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:36.518510) ========= script_repo_revision: efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:36.518994) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:36.519321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-12 05:11:36.528745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-12 05:11:36.529114) ========= /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=56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:11:36 INFO - MultiFileLogger online at 20160712 05:11:36 in /builds/slave/test 05:11:36 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 05:11:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:11:36 INFO - {'append_to_log': False, 05:11:36 INFO - 'base_work_dir': '/builds/slave/test', 05:11:36 INFO - 'blob_upload_branch': 'Fx-Team', 05:11:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:11:36 INFO - 'branch': 'Fx-Team', 05:11:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:11:36 INFO - 'config_files': ('talos/linux_config.py',), 05:11:36 INFO - 'default_actions': ('clobber', 05:11:36 INFO - 'read-buildbot-config', 05:11:36 INFO - 'download-and-extract', 05:11:36 INFO - 'populate-webroot', 05:11:36 INFO - 'create-virtualenv', 05:11:36 INFO - 'install', 05:11:36 INFO - 'run-tests'), 05:11:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:11:36 INFO - 'download_minidump_stackwalk': True, 05:11:36 INFO - 'download_symbols': 'ondemand', 05:11:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:11:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:11:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:11:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:11:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:11:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:11:36 INFO - 'installer_path': 'installer.exe', 05:11:36 INFO - 'log_level': 'info', 05:11:36 INFO - 'log_name': 'talos', 05:11:36 INFO - 'log_to_console': True, 05:11:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:11:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:11:36 INFO - 'opt_config_files': (), 05:11:36 INFO - 'pip_index': False, 05:11:36 INFO - 'sps_profile': False, 05:11:36 INFO - 'sps_profile_interval': 0, 05:11:36 INFO - 'suite': 'dromaeojs', 05:11:36 INFO - 'system_bits': '32', 05:11:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:11:36 INFO - 'title': 'talos-linux64-ix-037', 05:11:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:11:36 INFO - 'use_talos_json': True, 05:11:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:11:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:11:36 INFO - 'work_dir': 'build'} 05:11:36 INFO - ##### 05:11:36 INFO - ##### Running clobber step. 05:11:36 INFO - ##### 05:11:36 INFO - Running pre-action listener: _resource_record_pre_action 05:11:36 INFO - Running main action method: clobber 05:11:36 INFO - rmtree: /builds/slave/test/build 05:11:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:11:37 INFO - Running post-action listener: _resource_record_post_action 05:11:37 INFO - ##### 05:11:37 INFO - ##### Finished clobber step (success) 05:11:37 INFO - ##### 05:11:37 INFO - ##### 05:11:37 INFO - ##### Running read-buildbot-config step. 05:11:37 INFO - ##### 05:11:37 INFO - Running pre-action listener: _resource_record_pre_action 05:11:37 INFO - Running main action method: read_buildbot_config 05:11:37 INFO - Using buildbot properties: 05:11:37 INFO - { 05:11:37 INFO - "project": "", 05:11:37 INFO - "product": "firefox", 05:11:37 INFO - "script_repo_revision": "production", 05:11:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:11:37 INFO - "repository": "", 05:11:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:11:37 INFO - "buildid": "20160712023026", 05:11:37 INFO - "pgo_build": "True", 05:11:37 INFO - "basedir": "/builds/slave/test", 05:11:37 INFO - "buildnumber": 892, 05:11:37 INFO - "slavename": "talos-linux64-ix-037", 05:11:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:11:37 INFO - "platform": "ubuntu64_hw", 05:11:37 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:11:37 INFO - "branch": "fx-team", 05:11:37 INFO - "repo_path": "integration/fx-team", 05:11:37 INFO - "revision": "efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8", 05:11:37 INFO - "stage_platform": "linux64-pgo", 05:11:37 INFO - "builduid": "d91119467f71410c8c4a14d7add2fa89", 05:11:37 INFO - "slavebuilddir": "test" 05:11:37 INFO - } 05:11:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 05:11:37 INFO - Running post-action listener: _resource_record_post_action 05:11:37 INFO - ##### 05:11:37 INFO - ##### Finished read-buildbot-config step (success) 05:11:37 INFO - ##### 05:11:37 INFO - ##### 05:11:37 INFO - ##### Running download-and-extract step. 05:11:37 INFO - ##### 05:11:37 INFO - Running pre-action listener: _resource_record_pre_action 05:11:37 INFO - Running main action method: download_and_extract 05:11:37 INFO - mkdir: /builds/slave/test/build/tests 05:11:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:37 INFO - https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:11:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:11:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:11:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/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 05:11:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/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 05:11:38 INFO - Downloaded 1361 bytes. 05:11:38 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 05:11:38 INFO - Using the following test package requirements: 05:11:38 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:38 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:11:38 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:11:38 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:38 INFO - u'jsshell-linux-x86_64.zip'], 05:11:38 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:11:38 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 05:11:38 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:11:38 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:11:38 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:11:38 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 05:11:38 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:11:38 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:11: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')]} 05:11:38 INFO - https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/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 05:11:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/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 05:11:39 INFO - Downloaded 24271052 bytes. 05:11:39 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'] 05:11:39 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 05:11:40 INFO - Return code: 0 05:11:40 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 05:11:40 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')]} 05:11:40 INFO - https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:11:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 05:11:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/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 05:11:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/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 05:11:42 INFO - Downloaded 24271052 bytes. 05:11:42 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'] 05:11:42 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 05:11:43 INFO - Return code: 0 05:11:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:43 INFO - https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:11:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 05:11:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/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 05:11:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/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 05:11:44 INFO - Downloaded 14403317 bytes. 05:11:44 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'] 05:11:44 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 05:11:44 INFO - Return code: 0 05:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:44 INFO - https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:11:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:11:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:11:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/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 05:11:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C2ofgm6FQNKOAGPLPXRkVg/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 05:11:46 INFO - Downloaded 60512571 bytes. 05:11:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:11:46 INFO - mkdir: /builds/slave/test/properties 05:11:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:11:46 INFO - Writing to file /builds/slave/test/properties/build_url 05:11:46 INFO - Contents: 05:11:46 INFO - build_url:https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 05:11:47 INFO - Running post-action listener: _resource_record_post_action 05:11:47 INFO - Running post-action listener: set_extra_try_arguments 05:11:47 INFO - ##### 05:11:47 INFO - ##### Finished download-and-extract step (success) 05:11:47 INFO - ##### 05:11:47 INFO - ##### 05:11:47 INFO - ##### Running populate-webroot step. 05:11:47 INFO - ##### 05:11:47 INFO - Running pre-action listener: _resource_record_pre_action 05:11:47 INFO - Running main action method: populate_webroot 05:11:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:11:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:11:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:11:47 INFO - '--tppagecycles', 05:11:47 INFO - '7'], 05:11:47 INFO - 'tests': ['tsvgm']}}, 05:11:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:11:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:11:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:11:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:11:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:11:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:11:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:47 INFO - 'talos_options': ['--disable-e10s'], 05:11:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:11:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:47 INFO - 'talos_options': ['--disable-e10s'], 05:11:47 INFO - 'tests': ['damp', 'tps']}, 05:11:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:47 INFO - 'tests': ['damp', 'tps']}, 05:11:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:11:47 INFO - 'tests': ['dromaeo_dom']}, 05:11:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:11:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:11:47 INFO - 'tests': ['basic_compositor_video']}, 05:11:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:11:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:11:47 INFO - 'tests': ['a11yr', 05:11:47 INFO - 'ts_paint', 05:11:47 INFO - 'tpaint', 05:11:47 INFO - 'sessionrestore', 05:11:47 INFO - 'sessionrestore_no_auto_restore', 05:11:47 INFO - 'tabpaint']}, 05:11:47 INFO - 'other-e10s': {'tests': ['a11yr', 05:11:47 INFO - 'ts_paint', 05:11:47 INFO - 'tpaint', 05:11:47 INFO - 'sessionrestore', 05:11:47 INFO - 'sessionrestore_no_auto_restore', 05:11:47 INFO - 'tabpaint']}, 05:11:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:11:47 INFO - 'ts_paint', 05:11:47 INFO - 'tpaint', 05:11:47 INFO - 'sessionrestore', 05:11:47 INFO - 'sessionrestore_no_auto_restore', 05:11:47 INFO - 'tabpaint']}, 05:11:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:11:47 INFO - 'ts_paint', 05:11:47 INFO - 'tpaint', 05:11:47 INFO - 'sessionrestore', 05:11:47 INFO - 'sessionrestore_no_auto_restore', 05:11:47 INFO - 'tabpaint']}, 05:11:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:11:47 INFO - 'tests': ['a11yr', 05:11:47 INFO - 'ts_paint', 05:11:47 INFO - 'tpaint', 05:11:47 INFO - 'sessionrestore', 05:11:47 INFO - 'sessionrestore_no_auto_restore', 05:11:47 INFO - 'tabpaint']}, 05:11:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:11:47 INFO - 'tests': ['a11yr', 05:11:47 INFO - 'ts_paint', 05:11:47 INFO - 'tpaint', 05:11:47 INFO - 'sessionrestore', 05:11:47 INFO - 'sessionrestore_no_auto_restore', 05:11:47 INFO - 'tabpaint']}, 05:11:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:11:47 INFO - 'tests': ['tsvgx', 05:11:47 INFO - 'tsvgr_opacity', 05:11:47 INFO - 'tart', 05:11:47 INFO - 'tscrollx', 05:11:47 INFO - 'cart']}, 05:11:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:11:47 INFO - 'tsvgr_opacity', 05:11:47 INFO - 'tart', 05:11:47 INFO - 'tscrollx', 05:11:47 INFO - 'cart']}, 05:11:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:47 INFO - 'talos_options': ['--disable-e10s'], 05:11:47 INFO - 'tests': ['tp5o']}, 05:11:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:47 INFO - 'tests': ['tp5o']}, 05:11:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:47 INFO - 'talos_options': ['--disable-e10s', 05:11:47 INFO - '--xperf_path', 05:11:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:47 INFO - 'tests': ['tp5n']}, 05:11:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:11:47 INFO - 'talos_options': ['--xperf_path', 05:11:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:11:47 INFO - 'tests': ['tp5n']}}, 05:11:47 INFO - 'talos.zip': {'path': '', 05:11:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:11:47 INFO - Running post-action listener: _resource_record_post_action 05:11:47 INFO - ##### 05:11:47 INFO - ##### Finished populate-webroot step (success) 05:11:47 INFO - ##### 05:11:47 INFO - ##### 05:11:47 INFO - ##### Running create-virtualenv step. 05:11:47 INFO - ##### 05:11:47 INFO - Running pre-action listener: _resource_record_pre_action 05:11:47 INFO - Running main action method: create_virtualenv 05:11:47 INFO - Creating virtualenv /builds/slave/test/build/venv 05:11:47 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 05:11:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:11:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:11:47 INFO - Using real prefix '/usr' 05:11:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:11:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:11:50 INFO - Installing pip.................done. 05:11:50 INFO - Return code: 0 05:11:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:50 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 0xd63030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10223b0>, '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 0x10232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', '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 05:11:50 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 05:11:50 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 05:11:50 INFO - Using env: {'DISPLAY': ':0', 05:11:50 INFO - 'HOME': '/home/cltbld', 05:11:50 INFO - 'LANG': 'en_US.UTF-8', 05:11:50 INFO - 'LANGUAGE': 'en_US:en', 05:11:50 INFO - 'LOGNAME': 'cltbld', 05:11:50 INFO - 'MAIL': '/var/mail/cltbld', 05:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:50 INFO - 'MOZ_NO_REMOTE': '1', 05:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:50 INFO - 'NO_EM_RESTART': '1', 05:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:50 INFO - 'PWD': '/builds/slave/test', 05:11:50 INFO - 'SHELL': '/bin/bash', 05:11:50 INFO - 'SHLVL': '1', 05:11:50 INFO - 'TERM': 'linux', 05:11:50 INFO - 'TMOUT': '86400', 05:11:50 INFO - 'USER': 'cltbld', 05:11:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', 05:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:50 INFO - '_': '/tools/buildbot/bin/python'} 05:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:50 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 05:11:50 INFO - Cleaning up... 05:11:50 INFO - Return code: 0 05:11:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:50 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 0xd63030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10223b0>, '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 0x10232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', '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 05:11:50 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 05:11:50 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 05:11:50 INFO - Using env: {'DISPLAY': ':0', 05:11:50 INFO - 'HOME': '/home/cltbld', 05:11:50 INFO - 'LANG': 'en_US.UTF-8', 05:11:50 INFO - 'LANGUAGE': 'en_US:en', 05:11:50 INFO - 'LOGNAME': 'cltbld', 05:11:50 INFO - 'MAIL': '/var/mail/cltbld', 05:11:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:50 INFO - 'MOZ_NO_REMOTE': '1', 05:11:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:50 INFO - 'NO_EM_RESTART': '1', 05:11:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:50 INFO - 'PWD': '/builds/slave/test', 05:11:50 INFO - 'SHELL': '/bin/bash', 05:11:50 INFO - 'SHLVL': '1', 05:11:50 INFO - 'TERM': 'linux', 05:11:50 INFO - 'TMOUT': '86400', 05:11:50 INFO - 'USER': 'cltbld', 05:11:50 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', 05:11:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:50 INFO - '_': '/tools/buildbot/bin/python'} 05:11:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:50 INFO - Downloading/unpacking psutil>=3.1.1 05:11:50 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 05:11:50 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 05:11:50 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 05:11:50 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 05:11:50 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 05:11:50 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 05:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:52 INFO - Installing collected packages: psutil 05:11:52 INFO - Running setup.py install for psutil 05:11:52 INFO - building 'psutil._psutil_linux' extension 05:11:52 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 05:11:52 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 05:11:52 INFO - building 'psutil._psutil_posix' extension 05:11:52 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 05:11:52 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 05:11:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:11:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:11:52 INFO - Successfully installed psutil 05:11:52 INFO - Cleaning up... 05:11:52 INFO - Return code: 0 05:11:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:11: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')]} 05:11:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:53 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')]} 05:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:53 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 0xd63030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10223b0>, '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 0x10232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', '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 05:11:53 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 05:11:53 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 05:11:53 INFO - Using env: {'DISPLAY': ':0', 05:11:53 INFO - 'HOME': '/home/cltbld', 05:11:53 INFO - 'LANG': 'en_US.UTF-8', 05:11:53 INFO - 'LANGUAGE': 'en_US:en', 05:11:53 INFO - 'LOGNAME': 'cltbld', 05:11:53 INFO - 'MAIL': '/var/mail/cltbld', 05:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:53 INFO - 'MOZ_NO_REMOTE': '1', 05:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:53 INFO - 'NO_EM_RESTART': '1', 05:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:53 INFO - 'PWD': '/builds/slave/test', 05:11:53 INFO - 'SHELL': '/bin/bash', 05:11:53 INFO - 'SHLVL': '1', 05:11:53 INFO - 'TERM': 'linux', 05:11:53 INFO - 'TMOUT': '86400', 05:11:53 INFO - 'USER': 'cltbld', 05:11:53 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', 05:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:53 INFO - '_': '/tools/buildbot/bin/python'} 05:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:55 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:11:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:11:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:11:55 INFO - Installing collected packages: mozsystemmonitor 05:11:55 INFO - Running setup.py install for mozsystemmonitor 05:11:55 INFO - Successfully installed mozsystemmonitor 05:11:55 INFO - Cleaning up... 05:11:55 INFO - Return code: 0 05:11:55 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd63030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10223b0>, '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 0x10232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', '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 05:11:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:11:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:11:55 INFO - Using env: {'DISPLAY': ':0', 05:11:55 INFO - 'HOME': '/home/cltbld', 05:11:55 INFO - 'LANG': 'en_US.UTF-8', 05:11:55 INFO - 'LANGUAGE': 'en_US:en', 05:11:55 INFO - 'LOGNAME': 'cltbld', 05:11:55 INFO - 'MAIL': '/var/mail/cltbld', 05:11:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:55 INFO - 'MOZ_NO_REMOTE': '1', 05:11:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:55 INFO - 'NO_EM_RESTART': '1', 05:11:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:55 INFO - 'PWD': '/builds/slave/test', 05:11:55 INFO - 'SHELL': '/bin/bash', 05:11:55 INFO - 'SHLVL': '1', 05:11:55 INFO - 'TERM': 'linux', 05:11:55 INFO - 'TMOUT': '86400', 05:11:55 INFO - 'USER': 'cltbld', 05:11:55 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', 05:11:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:55 INFO - '_': '/tools/buildbot/bin/python'} 05:11:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:55 INFO - Downloading/unpacking jsonschema==2.5.1 05:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:11:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:11:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:11:57 INFO - Downloading functools32-3.2.3-2.tar.gz 05:11:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:11:57 INFO - warning: no files found matching '*.txt' 05:11:57 INFO - no previously-included directories found matching 'build' 05:11:57 INFO - no previously-included directories found matching 'dist' 05:11:57 INFO - no previously-included directories found matching '.git*' 05:11:57 INFO - Installing collected packages: jsonschema, functools32 05:11:57 INFO - Running setup.py install for functools32 05:11:57 INFO - warning: no files found matching '*.txt' 05:11:57 INFO - no previously-included directories found matching 'build' 05:11:57 INFO - no previously-included directories found matching 'dist' 05:11:57 INFO - no previously-included directories found matching '.git*' 05:11:57 INFO - Successfully installed jsonschema functools32 05:11:57 INFO - Cleaning up... 05:11:57 INFO - Return code: 0 05:11:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:11:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:11:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:11:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:11:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd63030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10223b0>, '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 0x10232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', '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 05:11:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:11:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:11:57 INFO - Using env: {'DISPLAY': ':0', 05:11:57 INFO - 'HOME': '/home/cltbld', 05:11:57 INFO - 'LANG': 'en_US.UTF-8', 05:11:57 INFO - 'LANGUAGE': 'en_US:en', 05:11:57 INFO - 'LOGNAME': 'cltbld', 05:11:57 INFO - 'MAIL': '/var/mail/cltbld', 05:11:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:11:57 INFO - 'MOZ_NO_REMOTE': '1', 05:11:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:11:57 INFO - 'NO_EM_RESTART': '1', 05:11:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:11:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:11:57 INFO - 'PWD': '/builds/slave/test', 05:11:57 INFO - 'SHELL': '/bin/bash', 05:11:57 INFO - 'SHLVL': '1', 05:11:57 INFO - 'TERM': 'linux', 05:11:57 INFO - 'TMOUT': '86400', 05:11:57 INFO - 'USER': 'cltbld', 05:11:57 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', 05:11:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:11:57 INFO - '_': '/tools/buildbot/bin/python'} 05:11:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:11:58 INFO - Downloading/unpacking blobuploader==1.2.4 05:11:58 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 05:11:58 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 05:11:58 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 05:11:58 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 05:11:58 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 05:11:58 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 05:11:59 INFO - Downloading blobuploader-1.2.4.tar.gz 05:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:12:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:12:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:00 INFO - Downloading docopt-0.6.1.tar.gz 05:12:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:12:00 INFO - Installing collected packages: blobuploader, requests, docopt 05:12:00 INFO - Running setup.py install for blobuploader 05:12:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:12:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:12:00 INFO - Running setup.py install for requests 05:12:01 INFO - Running setup.py install for docopt 05:12:01 INFO - Successfully installed blobuploader requests docopt 05:12:01 INFO - Cleaning up... 05:12:01 INFO - Return code: 0 05:12:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:01 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 0xd63030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10223b0>, '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 0x10232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', '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 05:12:01 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 05:12:01 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 05:12:01 INFO - Using env: {'DISPLAY': ':0', 05:12:01 INFO - 'HOME': '/home/cltbld', 05:12:01 INFO - 'LANG': 'en_US.UTF-8', 05:12:01 INFO - 'LANGUAGE': 'en_US:en', 05:12:01 INFO - 'LOGNAME': 'cltbld', 05:12:01 INFO - 'MAIL': '/var/mail/cltbld', 05:12:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:01 INFO - 'MOZ_NO_REMOTE': '1', 05:12:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:01 INFO - 'NO_EM_RESTART': '1', 05:12:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:01 INFO - 'PWD': '/builds/slave/test', 05:12:01 INFO - 'SHELL': '/bin/bash', 05:12:01 INFO - 'SHLVL': '1', 05:12:01 INFO - 'TERM': 'linux', 05:12:01 INFO - 'TMOUT': '86400', 05:12:01 INFO - 'USER': 'cltbld', 05:12:01 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', 05:12:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:01 INFO - '_': '/tools/buildbot/bin/python'} 05:12:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:01 INFO - Running setup.py (path:/tmp/pip-vpo5Y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:01 INFO - Running setup.py (path:/tmp/pip-i_O4IH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:01 INFO - Running setup.py (path:/tmp/pip-HwJp8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:01 INFO - Running setup.py (path:/tmp/pip-SRQdU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:01 INFO - Running setup.py (path:/tmp/pip-eCSGW6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:01 INFO - Running setup.py (path:/tmp/pip-wDj_lK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:02 INFO - Running setup.py (path:/tmp/pip-I3K5mS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:02 INFO - Running setup.py (path:/tmp/pip-VcziTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:02 INFO - Running setup.py (path:/tmp/pip-sm4XeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:02 INFO - Running setup.py (path:/tmp/pip-cgUI1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:02 INFO - Running setup.py (path:/tmp/pip-N_VGUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:02 INFO - Running setup.py (path:/tmp/pip-G0abrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:02 INFO - Running setup.py (path:/tmp/pip-BbGaX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:02 INFO - Running setup.py (path:/tmp/pip-XGAcSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:02 INFO - Running setup.py (path:/tmp/pip-lc07mc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:02 INFO - Running setup.py (path:/tmp/pip-OyhzfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:02 INFO - Running setup.py (path:/tmp/pip-yiadKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:12:02 INFO - Running setup.py install for manifestparser 05:12:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:12:02 INFO - Running setup.py install for mozcrash 05:12:02 INFO - Running setup.py install for mozdebug 05:12:03 INFO - Running setup.py install for mozdevice 05:12:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:12:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:12:03 INFO - Running setup.py install for mozfile 05:12:03 INFO - Running setup.py install for mozhttpd 05:12:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:12:03 INFO - Running setup.py install for mozinfo 05:12:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:12:03 INFO - Running setup.py install for mozInstall 05:12:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:12:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:12:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:12:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:12:03 INFO - Running setup.py install for mozleak 05:12:03 INFO - Running setup.py install for mozlog 05:12:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:12:03 INFO - Running setup.py install for moznetwork 05:12:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:12:03 INFO - Running setup.py install for mozprocess 05:12:04 INFO - Running setup.py install for mozprofile 05:12:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:12:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:12:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:12:04 INFO - Running setup.py install for mozrunner 05:12:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:12:04 INFO - Running setup.py install for mozscreenshot 05:12:04 INFO - Running setup.py install for moztest 05:12:04 INFO - Running setup.py install for mozversion 05:12:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:12:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:12:04 INFO - Cleaning up... 05:12:04 INFO - Return code: 0 05:12:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:04 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')]} 05:12:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:04 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')]} 05:12:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:04 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 0xd63030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10223b0>, '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 0x10232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', '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 05:12:04 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 05:12:04 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 05:12:04 INFO - Using env: {'DISPLAY': ':0', 05:12:04 INFO - 'HOME': '/home/cltbld', 05:12:04 INFO - 'LANG': 'en_US.UTF-8', 05:12:04 INFO - 'LANGUAGE': 'en_US:en', 05:12:04 INFO - 'LOGNAME': 'cltbld', 05:12:04 INFO - 'MAIL': '/var/mail/cltbld', 05:12:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:04 INFO - 'MOZ_NO_REMOTE': '1', 05:12:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:04 INFO - 'NO_EM_RESTART': '1', 05:12:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:04 INFO - 'PWD': '/builds/slave/test', 05:12:04 INFO - 'SHELL': '/bin/bash', 05:12:04 INFO - 'SHLVL': '1', 05:12:04 INFO - 'TERM': 'linux', 05:12:04 INFO - 'TMOUT': '86400', 05:12:04 INFO - 'USER': 'cltbld', 05:12:04 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', 05:12:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:04 INFO - '_': '/tools/buildbot/bin/python'} 05:12:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:12:04 INFO - Running setup.py (path:/tmp/pip-zVxGAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:12:04 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)) 05:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:12:04 INFO - Running setup.py (path:/tmp/pip-ZCZ1L5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:12:04 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)) 05:12:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:12:04 INFO - Running setup.py (path:/tmp/pip-b4bIBg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:12:05 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)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:12:05 INFO - Running setup.py (path:/tmp/pip-jQwtjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:12:05 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)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:12:05 INFO - Running setup.py (path:/tmp/pip-DmPoNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:12:05 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)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:12:05 INFO - Running setup.py (path:/tmp/pip-orV_Ow-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:12:05 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)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:12:05 INFO - Running setup.py (path:/tmp/pip-UmyDeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:12:05 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)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:12:05 INFO - Running setup.py (path:/tmp/pip-Fk0kg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:12:05 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)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:12:05 INFO - Running setup.py (path:/tmp/pip-fMlmsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:12:05 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)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:12:05 INFO - Running setup.py (path:/tmp/pip-48R0dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:12:05 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)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:12:05 INFO - Running setup.py (path:/tmp/pip-NVLPo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:12:05 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)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:12:05 INFO - Running setup.py (path:/tmp/pip-UKcGYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:12:05 INFO - Running setup.py (path:/tmp/pip-RaVciJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:12:05 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)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:12:05 INFO - Running setup.py (path:/tmp/pip-HKcANS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:12:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:05 INFO - Running setup.py (path:/tmp/pip-wNb5Dv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:12:05 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)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:12:05 INFO - Running setup.py (path:/tmp/pip-6meDJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:12:05 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)) 05:12:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:12:05 INFO - Running setup.py (path:/tmp/pip-tmL8GA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:12:06 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)) 05:12:06 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)) 05:12:06 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)) 05:12:06 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)) 05:12:06 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)) 05:12:06 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)) 05:12:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:12:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:12:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:12:07 INFO - Downloading blessings-1.6.tar.gz 05:12:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:12:08 INFO - Installing collected packages: blessings 05:12:08 INFO - Running setup.py install for blessings 05:12:08 INFO - Successfully installed blessings 05:12:08 INFO - Cleaning up... 05:12:08 INFO - Return code: 0 05:12:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:08 INFO - Reading from file tmpfile_stdout 05:12:08 INFO - Current package versions: 05:12:08 INFO - argparse == 1.2.1 05:12:08 INFO - blessings == 1.6 05:12:08 INFO - blobuploader == 1.2.4 05:12:08 INFO - docopt == 0.6.1 05:12:08 INFO - functools32 == 3.2.3-2 05:12:08 INFO - jsonschema == 2.5.1 05:12:08 INFO - manifestparser == 1.1 05:12:08 INFO - mozInstall == 1.12 05:12:08 INFO - mozcrash == 0.17 05:12:08 INFO - mozdebug == 0.1 05:12:08 INFO - mozdevice == 0.48 05:12:08 INFO - mozfile == 1.2 05:12:08 INFO - mozhttpd == 0.7 05:12:08 INFO - mozinfo == 0.9 05:12:08 INFO - mozleak == 0.1 05:12:08 INFO - mozlog == 3.2 05:12:08 INFO - moznetwork == 0.27 05:12:08 INFO - mozprocess == 0.23 05:12:08 INFO - mozprofile == 0.28 05:12:08 INFO - mozrunner == 6.12 05:12:08 INFO - mozscreenshot == 0.1 05:12:08 INFO - mozsystemmonitor == 0.3 05:12:08 INFO - moztest == 0.7 05:12:08 INFO - mozversion == 1.4 05:12:08 INFO - psutil == 3.1.1 05:12:08 INFO - requests == 1.2.3 05:12:08 INFO - wsgiref == 0.1.2 05:12:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:08 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 0xd63030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10223b0>, '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 0x10232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', '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 05:12:08 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 05:12:08 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 05:12:08 INFO - Using env: {'DISPLAY': ':0', 05:12:08 INFO - 'HOME': '/home/cltbld', 05:12:08 INFO - 'LANG': 'en_US.UTF-8', 05:12:08 INFO - 'LANGUAGE': 'en_US:en', 05:12:08 INFO - 'LOGNAME': 'cltbld', 05:12:08 INFO - 'MAIL': '/var/mail/cltbld', 05:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:08 INFO - 'MOZ_NO_REMOTE': '1', 05:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:08 INFO - 'NO_EM_RESTART': '1', 05:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:08 INFO - 'PWD': '/builds/slave/test', 05:12:08 INFO - 'SHELL': '/bin/bash', 05:12:08 INFO - 'SHLVL': '1', 05:12:08 INFO - 'TERM': 'linux', 05:12:08 INFO - 'TMOUT': '86400', 05:12:08 INFO - 'USER': 'cltbld', 05:12:08 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', 05:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:08 INFO - '_': '/tools/buildbot/bin/python'} 05:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:08 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)) 05:12:08 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)) 05:12:08 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)) 05:12:08 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)) 05:12:08 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)) 05:12:08 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)) 05:12:08 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)) 05:12:08 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)) 05:12:08 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)) 05:12:08 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)) 05:12:08 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)) 05:12:08 INFO - Cleaning up... 05:12:08 INFO - Return code: 0 05:12:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:12:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:12:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:12:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:12:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd63030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xec68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1024180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10223b0>, '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 0x10232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023740>, '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': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', '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 05:12:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:12:08 INFO - Using env: {'DISPLAY': ':0', 05:12:08 INFO - 'HOME': '/home/cltbld', 05:12:08 INFO - 'LANG': 'en_US.UTF-8', 05:12:08 INFO - 'LANGUAGE': 'en_US:en', 05:12:08 INFO - 'LOGNAME': 'cltbld', 05:12:08 INFO - 'MAIL': '/var/mail/cltbld', 05:12:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:08 INFO - 'MOZ_NO_REMOTE': '1', 05:12:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:08 INFO - 'NO_EM_RESTART': '1', 05:12:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:08 INFO - 'PWD': '/builds/slave/test', 05:12:08 INFO - 'SHELL': '/bin/bash', 05:12:08 INFO - 'SHLVL': '1', 05:12:08 INFO - 'TERM': 'linux', 05:12:08 INFO - 'TMOUT': '86400', 05:12:08 INFO - 'USER': 'cltbld', 05:12:08 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', 05:12:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:08 INFO - '_': '/tools/buildbot/bin/python'} 05:12:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:12:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:12:08 INFO - Cleaning up... 05:12:08 INFO - Return code: 0 05:12:08 INFO - Running post-action listener: _resource_record_post_action 05:12:08 INFO - Running post-action listener: _start_resource_monitoring 05:12:08 INFO - Starting resource monitoring. 05:12:08 INFO - ##### 05:12:08 INFO - ##### Finished create-virtualenv step (success) 05:12:08 INFO - ##### 05:12:08 INFO - ##### 05:12:08 INFO - ##### Running install step. 05:12:08 INFO - ##### 05:12:08 INFO - Running pre-action listener: _resource_record_pre_action 05:12:08 INFO - Running main action method: install 05:12:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:12:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:12:09 INFO - Reading from file tmpfile_stdout 05:12:09 INFO - Detecting whether we're running mozinstall >=1.0... 05:12:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:12:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:12:09 INFO - Reading from file tmpfile_stdout 05:12:09 INFO - Output received: 05:12:09 INFO - Usage: mozinstall [options] installer 05:12:09 INFO - Options: 05:12:09 INFO - -h, --help show this help message and exit 05:12:09 INFO - -d DEST, --destination=DEST 05:12:09 INFO - Directory to install application into. [default: 05:12:09 INFO - "/builds/slave/test"] 05:12:09 INFO - --app=APP Application being installed. [default: firefox] 05:12:09 INFO - mkdir: /builds/slave/test/build/application 05:12:09 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'] 05:12:09 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 05:12:26 INFO - Reading from file tmpfile_stdout 05:12:26 INFO - Output received: 05:12:26 INFO - /builds/slave/test/build/application/firefox/firefox 05:12:26 INFO - Running post-action listener: _resource_record_post_action 05:12:26 INFO - ##### 05:12:26 INFO - ##### Finished install step (success) 05:12:26 INFO - ##### 05:12:26 INFO - ##### 05:12:26 INFO - ##### Running run-tests step. 05:12:26 INFO - ##### 05:12:26 INFO - Running pre-action listener: _resource_record_pre_action 05:12:26 INFO - Running main action method: run_tests 05:12:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:12:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:12:26 INFO - Python 2.7.3 05:12:26 INFO - Return code: 0 05:12:26 INFO - grabbing minidump binary from tooltool 05:12:26 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')]} 05:12:26 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 0x10223b0>, '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 0x10232b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1023740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:12:26 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 05:12:26 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 05:12:26 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 05:12:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:12:26 INFO - Return code: 0 05:12:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:12:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:12:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:12:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:12:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:12:26 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/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 05:12:26 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/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 05:12:26 INFO - Using env: {'DISPLAY': ':0', 05:12:26 INFO - 'HOME': '/home/cltbld', 05:12:26 INFO - 'LANG': 'en_US.UTF-8', 05:12:26 INFO - 'LANGUAGE': 'en_US:en', 05:12:26 INFO - 'LOGNAME': 'cltbld', 05:12:26 INFO - 'MAIL': '/var/mail/cltbld', 05:12:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:12:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:12:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:12:26 INFO - 'MOZ_NO_REMOTE': '1', 05:12:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:12:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:12:26 INFO - 'NO_EM_RESTART': '1', 05:12:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:12:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:12:26 INFO - 'PWD': '/builds/slave/test', 05:12:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:12:26 INFO - 'SHELL': '/bin/bash', 05:12:26 INFO - 'SHLVL': '1', 05:12:26 INFO - 'TERM': 'linux', 05:12:26 INFO - 'TMOUT': '86400', 05:12:26 INFO - 'USER': 'cltbld', 05:12:26 INFO - 'XDG_SESSION_COOKIE': '56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183', 05:12:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:12:26 INFO - '_': '/tools/buildbot/bin/python'} 05:12:26 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/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 05:12:26 INFO - mozversion application_buildid: 20160712023026 05:12:26 INFO - mozversion application_changeset: efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8 05:12:26 INFO - mozversion application_display_name: Nightly 05:12:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:12:26 INFO - mozversion application_name: Firefox 05:12:26 INFO - mozversion application_remotingname: firefox 05:12:26 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:12:26 INFO - mozversion application_vendor: Mozilla 05:12:26 INFO - mozversion application_version: 50.0a1 05:12:26 INFO - mozversion platform_buildid: 20160712023026 05:12:26 INFO - mozversion platform_changeset: efc08ad3e8afd42499a1cd20ade4e7c0cd05e3a8 05:12:26 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:12:26 INFO - mozversion platform_version: 50.0a1 05:12:26 INFO - using testdate: 1468325546 05:12:26 INFO - actual date: 1468325546 05:12:26 INFO - starting webserver on 'localhost:37162' 05:12:26 INFO - SUITE-START | Running 2 tests 05:12:26 INFO - TEST-START | dromaeo_css 05:12:26 INFO - operating with platform_type : linux_ 05:12:26 INFO - Initialising browser for dromaeo_css test... 05:12:26 INFO - TEST-INFO | started process 9661 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphpX0OS/profile http://localhost:37162/getInfo.html) 05:12:30 INFO - PROCESS | 9661 | __metrics Screen width/height:1600/1200 05:12:30 INFO - PROCESS | 9661 | colorDepth:24 05:12:30 INFO - PROCESS | 9661 | Browser inner width/height: 1024/697 05:12:30 INFO - PROCESS | 9661 | __metrics 05:12:31 INFO - PROCESS | 9661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:12:31 INFO - PROCESS | 9661 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:12:32 INFO - TEST-INFO | 9661: exit 0 05:12:32 INFO - Browser initialized. 05:12:32 INFO - Running cycle 1/1 for dromaeo_css test... 05:12:32 INFO - TEST-INFO | started process 9744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphpX0OS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:12:43 INFO - PROCESS | 9744 | RSS: Main: 157229056 05:12:43 INFO - PROCESS | 9744 | 05:13:35 INFO - PROCESS | 9744 | 1468325615457 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] 05:15:43 INFO - PROCESS | 9744 | Cycle 1(1): loaded http://localhost:37162/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37162/tests/dromaeo/cssquery-ext.html) 05:15:44 INFO - PROCESS | 9744 | RSS: Main: 247451648 05:15:44 INFO - PROCESS | 9744 | 05:18:46 INFO - PROCESS | 9744 | Cycle 1(1): loaded http://localhost:37162/tests/dromaeo/cssquery-ext.html (next: http://localhost:37162/tests/dromaeo/cssquery-jquery.html) 05:18:47 INFO - PROCESS | 9744 | RSS: Main: 254504960 05:18:47 INFO - PROCESS | 9744 | 05:21:49 INFO - PROCESS | 9744 | Cycle 1(1): loaded http://localhost:37162/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37162/tests/dromaeo/cssquery-mootools.html) 05:21:49 INFO - PROCESS | 9744 | RSS: Main: 252604416 05:21:49 INFO - PROCESS | 9744 | 05:24:51 INFO - PROCESS | 9744 | Cycle 1(1): loaded http://localhost:37162/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37162/tests/dromaeo/cssquery-prototype.html) 05:24:52 INFO - PROCESS | 9744 | RSS: Main: 243216384 05:24:52 INFO - PROCESS | 9744 | 05:27:55 INFO - PROCESS | 9744 | Cycle 1(1): loaded http://localhost:37162/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37162/tests/dromaeo/cssquery-yui.html) 05:27:55 INFO - PROCESS | 9744 | RSS: Main: 213168128 05:27:55 INFO - PROCESS | 9744 | 05:30:58 INFO - PROCESS | 9744 | Cycle 1(1): loaded http://localhost:37162/tests/dromaeo/cssquery-yui.html (next: http://localhost:37162/tests/dromaeo/cssquery-dojo.html) 05:30:58 INFO - PROCESS | 9744 | RSS: Main: 285720576 05:30:58 INFO - PROCESS | 9744 | 05:30:58 INFO - PROCESS | 9744 | __start_tp_report 05:30:58 INFO - PROCESS | 9744 | _x_x_mozilla_page_load 05:30:58 INFO - PROCESS | 9744 | _x_x_mozilla_page_load_details 05:30:58 INFO - PROCESS | 9744 | |i|pagename|runs| 05:30:58 INFO - PROCESS | 9744 | |0;dojo.html;3049.207206126407;3065.7087576680206;3067.1871953932214;3110.3157305392806;3122.45357062514;5356.678599284046;5373.140297552392;5399.757010934508;5502.669839809614;5537.197106419567;5401.540869026127;5404.243405923164;5460.180972854074;5479.890402191953;5499.587530935186;4914.901701965959;4915.975420122894;4993.75031248438;5013.749312534359;5152.227165925123;5045.949540504585;5052.191649336107;5089.923651145235;5116.155834287338;5124.103281925648;4876.341693871335;4893.853184404474;4903.82836600719;4958.3306253655655;4981.950180498185;4974.4776798436005;4998.650094493387;5062.645614806965;5070.138076527;5095.974520127375;4827.686200396998;5008.749562521859;5029.270755740434;5040.733450021559;5046.747662616891;5354.491323324278;5415.9458405415835;5431.21247419122;5499.807506737245;5503.3395992480755;5865.648061116347;5893.292804863401;5893.440123188333;5914.9112763308585;5916.704164791743;5733;5752.942470575283;5997.820065398045;6032.306284777263;6033.185519954794;5452.972735136299;5532.529734972532;5549.112142057292;5555.694436805974;5556.416576259516;6071.605345652519;6082.482988945901;6084.117802918552;6084.269887613515;6084.6349219047;5617.325920889438;5698;5736.368999410061;5843.1235314703135;5852.590318677651;5902.055671092605;5906.586538942232;5930.318013428511;5934.080217566284;5935.7625694972585;5767.596268261265;5826.096954971986;5833.4749872511675;5844.444777746107;5845.766169353264;5658.207850900877;5797.420257974169;5845.473907348359;5871.941280587225;5881.323647780475;4476.4180656514445;4477.977610111994;4479.910401791946;4483.529229430928;4522.615577675869;3990.960090399059;4006;4013.7993100344866;4029.597040295947;4041.5756345583877;5445.591580631469;5467.289252397242;5492.588055895823;5493.313335833021;5508.724563771795;5879.559033072536;5886.8822623547285;5890.823275301748;5891.204687367151;5895.115732640053;5495.148252020943;5513.696746678891;5529.944700553024;5534.1975413565615;5539.639923404966;4879.365682461257;4955.231939049453;5018.5985121190215;5025.547700706954;5045.2432135180015;6011.729472173763;6017.548683848729;6024.457798798129;6026.728797204137;6031.5476339273855;5802;5872.55955803325;5878.294604647299;5889.676067816311;5893.469587736953;5954.166416701579;5982;6014.398560143951;6122.969385153046;6127.601705889103;5744.597878148489;5787.334456537552;5801.216835727123;5801.274840644919;5851.678157701367;5848.941510584839;5885.882282354414;5888.234529511136;5903.970480147572;5904.793332233351;5677.630953987978;5730.398308177581;5731.742071606871;5739;5789.421057894177;5775.826725198251;5783.652980821164;5783.739731712168;5784.074548072288;5784.652920824764;5528.308961379827;5703.315602127771;5718.027935250934;5718.342390625131;5718.656880587178;5715.199872018004;5806.709664516842;5810.6513609183585;5816.621919575214;5892.410758924073;5611.270534830609;5638.295213098363;5649.661020338793;5652.0674088774895;5656.6888821115235 05:30:58 INFO - PROCESS | 9744 | |1;ext.html;608.3764141754702;617.8548041210316;637.9362063793618;648.5881465269553;660.5079215984092;30874.382512349766;33109.83445082777;33214.33571328572;33236.83381583092;42555;44971.77514112425;45508.54491455085;45562.316565251545;45569;45575;8914.643414263423;9040.593173307218;9060.139286767746;9063.864042039375;9066.093390660948;8905;8917.509536975464;8923.598438070303;8997.865032024525;9000.639974401016;8937.374383793138;9010.594523246436;9016.053314401992;9016.36885418021;9016.954915225415;8999.41503802254;9034.909650903473;9041.276697864156;9043.954780226122;9048.095190480964;8904;8958.148975847284;8963.641454341818;8974.551272436353;8979.236764874993;42829.35755963663;43157.35263971043;43165;43201;43254.56745432568;3550.609432962372;3709.9107187391;3733.4026555750947;3760.492333534965;3806.4290356446477;32946.17634559131;33221;33551.32897342039;33584.16039599005;34121;4407.228734971367;4438.112377524508;4515.187266292066;4635.026644404679;4635.513271106553;341268;344485;344808;345384;345833;59518.40481595129;59833.401665983656;59954.10068848971;59964.70017649971;60009.09986350208;61105.388946110856;61203.08195377073;61297.38702612917;61345.69327153335;61392;16989.150542472828;17238.827611723973;17286.740698889276;17318.480445586654;17322.740158897628;13160.670983225496;13203.339833008311;13205;13210.07529472947;13212.405441755143;15913.283902224428;17323.133843307784;17355.826441735422;17385.217665205095;17403;5671.262735844314;5731.140328950691;5786.363500014995;5864.648121112747;5867.911981320283;961.7259081161835;1040.9115225205792;1071.1323827699432;1105.6517197082894;1159.4202898550725;32929.67070329314;33107.66892331094;33200.66799331976;33270;33417.3316533668;1124.8875112488686;1125.1448898836943;1167.9824802627968;1175.371176420611;1195.3246415775059;16924.661506769797;17053.14734263282;17104.315827366765;17114.657706845792;17171.570710732332;480258;482328;482724;484549;486631;55625.66246025251;56926.14610780842;57115;57417;57439.71280143572;1238.5726924211133;1321.5374618883507;1356.5048757203747;1364.501956785766;1364.836219653648;33050.504242435905;34339.484907725906;34763.826180868935;34831.30337393187;34944.30111397707;50635.24047139369;50673.74663126661;51144.23283650674;51198.74400627973;51234.74382628063;388057;388597;388873;389812;391049;34751.304973899874;39769.40345894872;40993.59006409898;41540.33838646541;41677.16645667009;47866.28200577064;48766.75616621894;49115.754421229096;49160.508394915596;49848.50151498584;41433.58566414297;41734.791326043174;42037.78981105075;43022.784886075366;43140.13719725651;40868;41231.58768412277;41827.351816254086;41966.1606767869;42304;41224.38163427491;41234.587654123075;41489.792551037055;41923.1615367697;42440.39256663218;36029.819850900574;36758;36876.81561592175;37615.62384376121;37644.81177594094;27799.328031471596;28252.15243542697;28280.575791362735;28339.71660283453;28511.572326414705 05:30:58 INFO - PROCESS | 9744 | |2;jquery.html;375.08558500451494;380.41796052040377;386.8742658635943;393.8444314495776;405.3534612293391;18631.72052419213;20327.28854490091;20341.28805491808;20446;20684.48288792781;19963.301284455047;20109.798902010974;20340.796592034076;20599.1760329587;20715.37853864383;5410.648307859977;5522.3649280332775;5684.516816070618;5684.516816070639;5734.426557344253;5564.916526252109;5591.189277554752;5614.214010038598;5627.746751396197;5642.379338272786;5421.1326187809955;5595.608307418483;5595.664260144405;5602.691851948141;5610.130429783369;5593.300837395325;5594.440555944414;5596.104623260299;5602.1036634138545;5607.551395888319;4795.976020119912;5009.874753131165;5021.196608542652;5039.874003149914;5044.798208071673;23907.521849562912;24047.03811847524;24533.14134005301;24718.50562988748;24757.25728228156;2180.2042254576963;2342.0748804222408;2402.8197885158684;2569.40903592173;3002.564628128909;9711.125998660083;10077.44574048427;10112.140468060225;10384.94807525965;13743.244121573309;1876.840468560174;1914.6757172612754;1964.371401151632;1965.3023176772326;2032.359806660897;87069.12930870673;87071;87088.56455717744;89679.55160224222;90702.99999999935;9987.450690212108;10329;11061.391623460788;11212.719682007852;11251;15291.388344466319;15331.770023449657;15376;15407.691846163014;15409.229538523254;8086.797830054295;8309.750707478785;8469;8480.53357065355;8555.786105347415;8275;8333.708320208885;8379.371547133867;8503.872441913376;8514.063453020162;4432.711873728262;4583.862484125481;4703.882402939954;4711.199096153662;4815.6388270879825;1787.3118849242876;1797.173300281859;1802.4682718598044;1805.8194180581836;1823.5623450371816;421.70059257927215;422.03775392106047;449.0950734270448;455.731118640004;1026.810040142576;11717.531298747954;12161.452734626962;12236.449359778831;12250.387480625934;12417.130800844036;455.13978580482916;458.50939494740305;458.6812165544981;461.5684335146649;478.2921276510714;6327.082573026885;6444.677766111676;6500.284968653445;6502.382273683992;6536;502853;504279.61483466666;519854;521375;525463;90585;99329;101901.94294171187;102884.48557757313;109877.45061274643;986.4574484033752;987.8123156600223;1015.608990538648;1018.6536577563664;1022.0188618925766;14123.788143177655;17662.293508259525;18242.270309187483;18863.434096976565;18933.526661833563;33394;43178.35232471578;44263;44675.55324446714;45081.323780142666;59560.70219648874;61139.38860611337;69148.65425672839;71555.28444715486;72055.63972180105;8556.786080347792;8731.388802783998;8735.141177527434;8751.606177722146;8925.553722313989;9127.269818414377;9267.72196834096;9399.731036310011;13757;14186.574402767934;12447.813282800946;12576.811347829607;12654.620361389174;12707.174033687781;12867.292298923649;12111.858633382526;12413.069019823368;12518.311492867979;12790.872091278969;12823.487060517475;12186.086043546948;12511.311877846441;12985.740285194055;13068.346582671018;13122.212667239613;8721.65113395457;8760.38677292609;8891.4665120093;8937.46375217489;8983.730488085368;8924.419912705653;12291.56979505713;12908.419121139383;13023.348832558144;13216 05:30:58 INFO - PROCESS | 9744 | |3;mootools.html;1444.9638759031027;1470.0444710937888;1603.9358425662967;1748.248253251103;1783.6343549572339;8097.3926955478355;8551.572421378922;8634.17975292347;8637.0499245083;8637.870431943526;7346.522476039054;7920.841583168348;8172.387070969671;8174.754757357274;8456.19666131718;2241.820654347648;2254.8985295661732;2259.039908039085;2261.7398999115067;2263.3323169664905;2201.207565276507;2244.494988627562;2262.1064679451606;2266.8186545076355;2268.5122698619793;1925.2683980087618;1978.7229787829715;1980.227711192636;1989.691597802343;2195.626743453609;2204.7574766775642;2235.5417139486367;2236.13908645172;2236.8434209605334;2240.7983281504744;2215.9002844871857;2224.799768020886;2242.8317876159354;2247.2584047264527;2250.7749225077523;8567.228949394523;8602.096779838152;8612.956935215283;8617.181367770052;8622.31021518277;4773.665843390964;4835.008823191238;4869.951300486985;4871.951280487186;4877.561019508261;3048.908532744021;3113.844307784602;3152.1489197916662;3156.1793933577205;3165.1454107390878;986.2061040862175;1023.1712313026472;1044.9320794148357;1046.3460337289193;1048.9265751397406;10990.560377584887;11025.228234023622;11036.944815275872;11042.171837112248;11086.944565277203;3999.440078389028;4178.644815190682;4209.305464598368;4336.479622445327;4339.284018137035;9297.349185557081;9301.069893010645;9313.720588382359;9341.766455838522;9355.204807591295;4826.855194344175;4841.3222148899185;4846.36997190363;4849.102915960559;4853.02939412119;4443.644508439382;4490.034642551802;4497.168023915586;4499.460064792246;4500.572445617727;3864.652181303696;3914.784686842194;3945.2504024235304;3966.2464131814863;3982.7012974027066;1219.567053695925;1222.1200735470447;1278.4374875054946;1283.646997075793;1294.5145570411096;906.6781292641149;982.4645568165367;1003.1824063388315;1004.4073996342194;1010.722051435861;5993.160957465958;6078;6090.756369745249;6210.596311239755;6353.30113687494;431.1807565625337;434.8760603228065;448.41481866164315;450.25482825922495;452.4434945017647;4197.76912269822;4265.829366825292;4275.679324050709;4285.421468101828;4315.438992930899;10234.692959211086;10433.113185379329;10501.894981050245;10598.099161571352;10610.151187904949;10466.947665261778;10469.842952355568;10476;10479.318844275098;10491.213159012952;7513.586752728543;7803.804904877424;7882.605869706606;7899;7906.05127384706;5957.851053723692;6074.240719910012;6108.847278818065;6151.84620384494;6229.96885015572;9258.629654813732;9381.155695987394;9423.952880235554;9447.81104377895;9471.763205919908;8904.599293031959;9349.626014959325;9532.714018579454;9591.90408095938;9601.615935362508;7506.474546781673;7508.361789247757;7614.238576142341;7678.8080297993;7692.6922923084685;8349.415540912078;8351.95824020876;8381.455205411628;8386.790330241793;8415.11641277657;6523.510736694672;7280.708771649287;7344.22885597026;7456.142543607554;7821.648025838965;7475.2151024141685;7517.248275172439;7532.924670753222;7573.697052118074;7683.769486915401;6857.931420685729;6859.519833611599;6937.340952609494;6943.236244013256;6949.965250173716;5163.870903227299;5234.267202591716;5265.341832270966;5384.273123128328;5395;5312.203169524602;5373.677579345252;5425.240466334795;5464.562834973272;5512.503874651301 05:30:58 INFO - PROCESS | 9744 | |4;prototype.html;309.2778362523506;317.18799872326844;323.425918993786;323.79115470521515;325.32982056962675;5217.47825217478;5271.393789714184;5344.251804747334;5347.331583552056;5362.490563396476;5116.718580478072;5278.788848446067;5322.658030466592;5344.22508736234;5351.866203344918;4135;4140.772257525835;4143.627073563379;4158.397032430295;4162.396452514391;3978.3037968355566;4122.6083522065355;4136.51085609182;4146.647534959517;4159.896002599929;4068.816903239361;4077.55146933837;4118.75287482752;4120.423140760296;4129.876103716878;4071.1247081877536;4077.1641813428178;4078.245524577933;4101.159262351211;4102.630763231308;3599.262151258986;3601.3697602919383;3606.585242697071;3609.5488063992;3621.8370173342264;5149.48505149482;5163.793448262065;5181.5077567631015;5189.351331083614;5203.817866374697;4683.742394168319;4686.203345431285;4700.083483720676;4708.623310135181;4710.175719249118;5561.694106824123;5570.637908535973;5570.916436253459;5580.581456390746;5597.80407685729;3792.715546334036;3946.565877753445;3953.2884080865433;3953.3081710700512;3967.3255546557157;5698.914516282259;5720.227769251181;5733.853229354146;5752.942470575283;5781.682007489587;4000.3999400089638;4002.5597184309704;4005.239004589119;4023.295923213426;4026.959730402717;3906.824192911326;4057.857974970862;4077.1234184649848;4084.36692312692;4094.7747873867224;4604.493505714368;4608.861734147981;4644.628429725613;4663.790129444184;4679.812807487662;5533.3083364579425;5543.334799824047;5546.58400619947;5567.693776842312;5591.832245032656;1321.7641505192676;1329.5811819276896;1401.6495876030992;1417.8232067384254;1421.9548631755652;982.6806287956442;991.1575161113141;1007.9617993466741;1009.545704433008;1009.9040591143829;4699;4703.553162449562;4743.513517564587;4779.450363208206;4794.832180873653;5032.891615010693;5093.2360145977655;5096;5135.537801597799;5142.665726727751;4843.200871856175;4854.320395144682;4867.464578896319;4895.216765317532;5065.062963351792;3035.5294929285997;3068.800527965675;3069.5242237452785;3086.490729029685;3095.767817413703;5927.229460170237;5931.228940237742;5945.524358051345;5950.256217972754;5969.73136208863;5673.8297851064535;5846.210761547221;5848.736806843617;5863.237779088691;5928.881422371528;5869.6771677558145;5872.941270587325;5886.440788125121;5916.467517923322;5916.615419997686;5638.4925356718095;5700.486956173964;5736.770529178786;5758;5774.249347584787;5660.547156227574;5666.15007748841;5670.703365137126;5742.7702891883855;5750.884982300414;5856.882862342814;5931;5940.108983652487;5942.5932497338645;5963.403659634002;3731.2910546995986;3793.5827059024036;3995.280849447011;4017.919641607093;4081.816318265626;5592.916106258491;5658;5663.773449062156;5687.459691329317;5691.089425691869;5587.69267690281;5609.326880774333;5618.943810562006;5625.859353516031;5638;5399.730013499231;5569.134339996147;5599.272094627672;5630.493255607015;5665.830025099253;5528.640638358494;5547.335799260125;5561.63849349791;5562.777488900399;5621.718914054362;5335.573154147582;5595.692236927008;5654.06707893193;5689.061304884648;5689.260396148474;5471.671699697871;5523.8066667666435;5525.9723701382845;5527.834164975057;5552.250446189874 05:30:58 INFO - PROCESS | 9744 | |5;yui.html;754.9735759248425;789.8380831929453;789.9012623422072;789.9368050555956;833.4249367936127;14974.850251497483;15350.769738453931;15376;15379.077255364686;15402.768958465633;14606.573407036361;15008.024478408895;15073.773893391608;15193.848061519382;15213.087214767122;787.0673252196152;820.5445977482494;820.5938060659952;820.659426338069;821.3388222480901;676.6346173066538;789.2896393246067;814.2915663372873;816.5713000674664;827.433208252346;847.1570787066877;847.9321654267644;848.0247715127622;848.0417128644623;848.3043903998723;842.1368097699846;842.7893026743315;843.1694780641063;843.1779015459908;843.5866425451516;513.3685566752878;595.0419824083223;611.9326874043852;616.0789619518803;616.2420223125581;14759.18824464654;14779.482718104922;14787.408503659948;14804.777928331083;14846.554603361916;14261.928690356586;14933.626659333495;15070.5478835634;15116.924415377853;15249.313780879887;13071.281079540622;13271.270080145589;13330.533431329857;13583.456661733519;13721;4450.376947227391;4475.641948644101;4555.157295900269;4646.953530464686;4693.319468677057;82429;83483.58258208731;83681.5606985544;83775;83788;11545.249558778652;11807;11862.703432414086;12074.396280185956;12155.669841333145;21930.89034554817;21935.122595096338;21951.451213719465;21962.69391713847;21964.670529942065;8713.215810577078;8731;8913.955430222808;8919;8952.910470895207;4468.4414448193975;4893.119238537026;5046.722430266371;5101.336826212569;5133.845984620468;3346.0631023313026;3475;3475.0269924421204;3483.9303213935577;3484.2683036562607;570.9257796486513;584.7690162385834;590.1796502861026;590.3918963467635;599.0834023943373;606.2361424604941;668.8929771236676;682.2086379799409;688.4148473797233;699.9510034297653;9719.271054670928;9761.853572196424;9974.80050398988;10060.798784024279;10252.282340236261;661.351875162334;668.314977148417;698.12734082397;716.3910675925525;721.0662192460776;4718.577339449067;4844.878878028007;4853.344798452164;4856.17445034345;4860.246661767432;103074.96925030653;116474.41762791132;117756.41121794507;118177.40911295389;118643;66150.66924665442;66667.66666166639;78336.2166378329;100617.49691251644;102180.48909755403;88169.55915220383;88504.5574772122;90491.54754226186;91302.54348728081;91395.08604913866;9232.399894006869;9264.53677316118;9419.199368053518;9572.23422126242;9609.663661771805;52776.47223527716;53320.26758127049;53633.73183134059;54772;54843.725781372435;70105.64947175232;78049.60975195088;80187.59906200432;80836.59581702054;82504;10344.53449594755;11190.041807308651;11199.944000279946;11354.943225283821;11646.010089142517;13128.277944713132;13177.736445271232;13230.4046317914;13283;13322.600321990356;12253.75492490163;12344;12409.565665201675;12489.18820276679;12613.558525451564;11837.289762614271;12033.63899083029;12056.578019769266;12059.457324420247;12133.393330333625;12361.134720569475;12386.3187524687;12864.099513033998;12933.089776070092;13002.544910928073;9926.652567160114;10338.483075846027;10344.431056291674;10597.4701264938;10729.088027517748;10445.68662940113;11140.164487663296;12065.879341206826;12127.757444850877;12357.93821030889 05:30:58 INFO - PROCESS | 9744 | __end_tp_report 05:30:58 INFO - PROCESS | 9744 | __start_cc_report 05:30:58 INFO - PROCESS | 9744 | _x_x_mozilla_cycle_collect,787 05:30:58 INFO - PROCESS | 9744 | __end_cc_report 05:30:58 INFO - PROCESS | 9744 | __startTimestamp1468326658719__endTimestamp 05:30:58 INFO - PROCESS | 9744 | 05:30:58 INFO - PROCESS | 9744 | ------- Summary: start ------- 05:30:58 INFO - PROCESS | 9744 | Number of tests: 6 05:30:58 INFO - PROCESS | 9744 | 05:30:58 INFO - PROCESS | 9744 | [#0] dojo.html Cycles:165 Average:5448.68 Median:5658.21 stddev:630.73 (11.1%) stddev-sans-first:603.93 05:30:58 INFO - PROCESS | 9744 | Values: 3049.2 3065.7 3067.2 3110.3 3122.5 5356.7 5373.1 5399.8 5502.7 5537.2 5401.5 5404.2 5460.2 5479.9 5499.6 4914.9 4916.0 4993.8 5013.7 5152.2 5045.9 5052.2 5089.9 5116.2 5124.1 4876.3 4893.9 4903.8 4958.3 4982.0 4974.5 4998.7 5062.6 5070.1 5096.0 4827.7 5008.7 5029.3 5040.7 5046.7 5354.5 5415.9 5431.2 5499.8 5503.3 5865.6 5893.3 5893.4 5914.9 5916.7 5733.0 5752.9 5997.8 6032.3 6033.2 5453.0 5532.5 5549.1 5555.7 5556.4 6071.6 6082.5 6084.1 6084.3 6084.6 5617.3 5698.0 5736.4 5843.1 5852.6 5902.1 5906.6 5930.3 5934.1 5935.8 5767.6 5826.1 5833.5 5844.4 5845.8 5658.2 5797.4 5845.5 5871.9 5881.3 4476.4 4478.0 4479.9 4483.5 4522.6 3991.0 4006.0 4013.8 4029.6 4041.6 5445.6 5467.3 5492.6 5493.3 5508.7 5879.6 5886.9 5890.8 5891.2 5895.1 5495.1 5513.7 5529.9 5534.2 5539.6 4879.4 4955.2 5018.6 5025.5 5045.2 6011.7 6017.5 6024.5 6026.7 6031.5 5802.0 5872.6 5878.3 5889.7 5893.5 5954.2 5982.0 6014.4 6123.0 6127.6 5744.6 5787.3 5801.2 5801.3 5851.7 5848.9 5885.9 5888.2 5904.0 5904.8 5677.6 5730.4 5731.7 5739.0 5789.4 5775.8 5783.7 5783.7 5784.1 5784.7 5528.3 5703.3 5718.0 5718.3 5718.7 5715.2 5806.7 5810.7 5816.6 5892.4 5611.3 5638.3 5649.7 5652.1 5656.7 05:30:58 INFO - PROCESS | 9744 | 05:30:58 INFO - PROCESS | 9744 | [#1] ext.html Cycles:180 Average:57705.66 Median:41875.26 stddev:108117.49 (258.2%) stddev-sans-first:108335.80 05:30:58 INFO - PROCESS | 9744 | Values: 608.4 617.9 637.9 648.6 660.5 30874.4 33109.8 33214.3 33236.8 42555.0 44971.8 45508.5 45562.3 45569.0 45575.0 8914.6 9040.6 9060.1 9063.9 9066.1 8905.0 8917.5 8923.6 8997.9 9000.6 8937.4 9010.6 9016.1 9016.4 9017.0 8999.4 9034.9 9041.3 9044.0 9048.1 8904.0 8958.1 8963.6 8974.6 8979.2 42829.4 43157.4 43165.0 43201.0 43254.6 3550.6 3709.9 3733.4 3760.5 3806.4 32946.2 33221.0 33551.3 33584.2 34121.0 4407.2 4438.1 4515.2 4635.0 4635.5 341268.0 344485.0 344808.0 345384.0 345833.0 59518.4 59833.4 59954.1 59964.7 60009.1 61105.4 61203.1 61297.4 61345.7 61392.0 16989.2 17238.8 17286.7 17318.5 17322.7 13160.7 13203.3 13205.0 13210.1 13212.4 15913.3 17323.1 17355.8 17385.2 17403.0 5671.3 5731.1 5786.4 5864.6 5867.9 961.7 1040.9 1071.1 1105.7 1159.4 32929.7 33107.7 33200.7 33270.0 33417.3 1124.9 1125.1 1168.0 1175.4 1195.3 16924.7 17053.1 17104.3 17114.7 17171.6 480258.0 482328.0 482724.0 484549.0 486631.0 55625.7 56926.1 57115.0 57417.0 57439.7 1238.6 1321.5 1356.5 1364.5 1364.8 33050.5 34339.5 34763.8 34831.3 34944.3 50635.2 50673.7 51144.2 51198.7 51234.7 388057.0 388597.0 388873.0 389812.0 391049.0 34751.3 39769.4 40993.6 41540.3 41677.2 47866.3 48766.8 49115.8 49160.5 49848.5 41433.6 41734.8 42037.8 43022.8 43140.1 40868.0 41231.6 41827.4 41966.2 42304.0 41224.4 41234.6 41489.8 41923.2 42440.4 36029.8 36758.0 36876.8 37615.6 37644.8 27799.3 28252.2 28280.6 28339.7 28511.6 05:30:58 INFO - PROCESS | 9744 | 05:30:58 INFO - PROCESS | 9744 | [#2] jquery.html Cycles:180 Average:30194.25 Median:24347.86 stddev:85248.76 (350.1%) stddev-sans-first:85458.50 05:30:58 INFO - PROCESS | 9744 | Values: 375.1 380.4 386.9 393.8 405.4 18631.7 20327.3 20341.3 20446.0 20684.5 19963.3 20109.8 20340.8 20599.2 20715.4 5410.6 5522.4 5684.5 5684.5 5734.4 5564.9 5591.2 5614.2 5627.7 5642.4 5421.1 5595.6 5595.7 5602.7 5610.1 5593.3 5594.4 5596.1 5602.1 5607.6 4796.0 5009.9 5021.2 5039.9 5044.8 23907.5 24047.0 24533.1 24718.5 24757.3 2180.2 2342.1 2402.8 2569.4 3002.6 9711.1 10077.4 10112.1 10384.9 13743.2 1876.8 1914.7 1964.4 1965.3 2032.4 87069.1 87071.0 87088.6 89679.6 90703.0 9987.5 10329.0 11061.4 11212.7 11251.0 15291.4 15331.8 15376.0 15407.7 15409.2 8086.8 8309.8 8469.0 8480.5 8555.8 8275.0 8333.7 8379.4 8503.9 8514.1 4432.7 4583.9 4703.9 4711.2 4815.6 1787.3 1797.2 1802.5 1805.8 1823.6 421.7 422.0 449.1 455.7 1026.8 11717.5 12161.5 12236.4 12250.4 12417.1 455.1 458.5 458.7 461.6 478.3 6327.1 6444.7 6500.3 6502.4 6536.0 502853.0 504279.6 519854.0 521375.0 525463.0 90585.0 99329.0 101901.9 102884.5 109877.5 986.5 987.8 1015.6 1018.7 1022.0 14123.8 17662.3 18242.3 18863.4 18933.5 33394.0 43178.4 44263.0 44675.6 45081.3 59560.7 61139.4 69148.7 71555.3 72055.6 8556.8 8731.4 8735.1 8751.6 8925.6 9127.3 9267.7 9399.7 13757.0 14186.6 12447.8 12576.8 12654.6 12707.2 12867.3 12111.9 12413.1 12518.3 12790.9 12823.5 12186.1 12511.3 12985.7 13068.3 13122.2 8721.7 8760.4 8891.5 8937.5 8983.7 8924.4 12291.6 12908.4 13023.3 13216.0 05:30:58 INFO - PROCESS | 9744 | 05:30:58 INFO - PROCESS | 9744 | [#3] mootools.html Cycles:180 Average:5548.53 Median:4843.85 stddev:3107.48 (64.2%) stddev-sans-first:3100.89 05:30:58 INFO - PROCESS | 9744 | Values: 1445.0 1470.0 1603.9 1748.2 1783.6 8097.4 8551.6 8634.2 8637.0 8637.9 7346.5 7920.8 8172.4 8174.8 8456.2 2241.8 2254.9 2259.0 2261.7 2263.3 2201.2 2244.5 2262.1 2266.8 2268.5 1925.3 1978.7 1980.2 1989.7 2195.6 2204.8 2235.5 2236.1 2236.8 2240.8 2215.9 2224.8 2242.8 2247.3 2250.8 8567.2 8602.1 8613.0 8617.2 8622.3 4773.7 4835.0 4870.0 4872.0 4877.6 3048.9 3113.8 3152.1 3156.2 3165.1 986.2 1023.2 1044.9 1046.3 1048.9 10990.6 11025.2 11036.9 11042.2 11086.9 3999.4 4178.6 4209.3 4336.5 4339.3 9297.3 9301.1 9313.7 9341.8 9355.2 4826.9 4841.3 4846.4 4849.1 4853.0 4443.6 4490.0 4497.2 4499.5 4500.6 3864.7 3914.8 3945.3 3966.2 3982.7 1219.6 1222.1 1278.4 1283.6 1294.5 906.7 982.5 1003.2 1004.4 1010.7 5993.2 6078.0 6090.8 6210.6 6353.3 431.2 434.9 448.4 450.3 452.4 4197.8 4265.8 4275.7 4285.4 4315.4 10234.7 10433.1 10501.9 10598.1 10610.2 10466.9 10469.8 10476.0 10479.3 10491.2 7513.6 7803.8 7882.6 7899.0 7906.1 5957.9 6074.2 6108.8 6151.8 6230.0 9258.6 9381.2 9424.0 9447.8 9471.8 8904.6 9349.6 9532.7 9591.9 9601.6 7506.5 7508.4 7614.2 7678.8 7692.7 8349.4 8352.0 8381.5 8386.8 8415.1 6523.5 7280.7 7344.2 7456.1 7821.6 7475.2 7517.2 7532.9 7573.7 7683.8 6857.9 6859.5 6937.3 6943.2 6950.0 5163.9 5234.3 5265.3 5384.3 5395.0 5312.2 5373.7 5425.2 5464.6 5512.5 05:30:58 INFO - PROCESS | 9744 | 05:30:58 INFO - PROCESS | 9744 | [#4] prototype.html Cycles:180 Average:4638.71 Median:5172.65 stddev:1372.88 (26.5%) stddev-sans-first:1337.72 05:30:58 INFO - PROCESS | 9744 | Values: 309.3 317.2 323.4 323.8 325.3 5217.5 5271.4 5344.3 5347.3 5362.5 5116.7 5278.8 5322.7 5344.2 5351.9 4135.0 4140.8 4143.6 4158.4 4162.4 3978.3 4122.6 4136.5 4146.6 4159.9 4068.8 4077.6 4118.8 4120.4 4129.9 4071.1 4077.2 4078.2 4101.2 4102.6 3599.3 3601.4 3606.6 3609.5 3621.8 5149.5 5163.8 5181.5 5189.4 5203.8 4683.7 4686.2 4700.1 4708.6 4710.2 5561.7 5570.6 5570.9 5580.6 5597.8 3792.7 3946.6 3953.3 3953.3 3967.3 5698.9 5720.2 5733.9 5752.9 5781.7 4000.4 4002.6 4005.2 4023.3 4027.0 3906.8 4057.9 4077.1 4084.4 4094.8 4604.5 4608.9 4644.6 4663.8 4679.8 5533.3 5543.3 5546.6 5567.7 5591.8 1321.8 1329.6 1401.6 1417.8 1422.0 982.7 991.2 1008.0 1009.5 1009.9 4699.0 4703.6 4743.5 4779.5 4794.8 5032.9 5093.2 5096.0 5135.5 5142.7 4843.2 4854.3 4867.5 4895.2 5065.1 3035.5 3068.8 3069.5 3086.5 3095.8 5927.2 5931.2 5945.5 5950.3 5969.7 5673.8 5846.2 5848.7 5863.2 5928.9 5869.7 5872.9 5886.4 5916.5 5916.6 5638.5 5700.5 5736.8 5758.0 5774.2 5660.5 5666.2 5670.7 5742.8 5750.9 5856.9 5931.0 5940.1 5942.6 5963.4 3731.3 3793.6 3995.3 4017.9 4081.8 5592.9 5658.0 5663.8 5687.5 5691.1 5587.7 5609.3 5618.9 5625.9 5638.0 5399.7 5569.1 5599.3 5630.5 5665.8 5528.6 5547.3 5561.6 5562.8 5621.7 5335.6 5595.7 5654.1 5689.1 5689.3 5471.7 5523.8 5526.0 5527.8 5552.3 05:30:58 INFO - PROCESS | 9744 | 05:30:58 INFO - PROCESS | 9744 | [#5] yui.html Cycles:180 Average:20740.44 Median:4849.11 stddev:29903.82 (616.7%) stddev-sans-first:29950.06 05:30:58 INFO - PROCESS | 9744 | Values: 755.0 789.8 789.9 789.9 833.4 14974.9 15350.8 15376.0 15379.1 15402.8 14606.6 15008.0 15073.8 15193.8 15213.1 787.1 820.5 820.6 820.7 821.3 676.6 789.3 814.3 816.6 827.4 847.2 847.9 848.0 848.0 848.3 842.1 842.8 843.2 843.2 843.6 513.4 595.0 611.9 616.1 616.2 14759.2 14779.5 14787.4 14804.8 14846.6 14261.9 14933.6 15070.5 15116.9 15249.3 13071.3 13271.3 13330.5 13583.5 13721.0 4450.4 4475.6 4555.2 4647.0 4693.3 82429.0 83483.6 83681.6 83775.0 83788.0 11545.2 11807.0 11862.7 12074.4 12155.7 21930.9 21935.1 21951.5 21962.7 21964.7 8713.2 8731.0 8914.0 8919.0 8952.9 4468.4 4893.1 5046.7 5101.3 5133.8 3346.1 3475.0 3475.0 3483.9 3484.3 570.9 584.8 590.2 590.4 599.1 606.2 668.9 682.2 688.4 700.0 9719.3 9761.9 9974.8 10060.8 10252.3 661.4 668.3 698.1 716.4 721.1 4718.6 4844.9 4853.3 4856.2 4860.2 103075.0 116474.4 117756.4 118177.4 118643.0 66150.7 66667.7 78336.2 100617.5 102180.5 88169.6 88504.6 90491.5 91302.5 91395.1 9232.4 9264.5 9419.2 9572.2 9609.7 52776.5 53320.3 53633.7 54772.0 54843.7 70105.6 78049.6 80187.6 80836.6 82504.0 10344.5 11190.0 11199.9 11354.9 11646.0 13128.3 13177.7 13230.4 13283.0 13322.6 12253.8 12344.0 12409.6 12489.2 12613.6 11837.3 12033.6 12056.6 12059.5 12133.4 12361.1 12386.3 12864.1 12933.1 13002.5 9926.7 10338.5 10344.4 10597.5 10729.1 10445.7 11140.2 12065.9 12127.8 12357.9 05:30:58 INFO - PROCESS | 9744 | -------- Summary: end -------- 05:30:58 INFO - PROCESS | 9744 | 05:30:59 INFO - TEST-INFO | 9744: exit 0 05:30:59 INFO - TEST-OK | dromaeo_css | took 1112951ms 05:30:59 INFO - TEST-START | kraken 05:30:59 INFO - operating with platform_type : linux_ 05:30:59 INFO - Initialising browser for kraken test... 05:30:59 INFO - TEST-INFO | started process 9937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWXBUBS/profile http://localhost:37162/getInfo.html) 05:31:03 INFO - PROCESS | 9937 | __metrics Screen width/height:1600/1200 05:31:03 INFO - PROCESS | 9937 | colorDepth:24 05:31:03 INFO - PROCESS | 9937 | Browser inner width/height: 1024/697 05:31:03 INFO - PROCESS | 9937 | __metrics 05:31:04 INFO - PROCESS | 9937 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:31:04 INFO - PROCESS | 9937 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:31:05 INFO - TEST-INFO | 9937: exit 0 05:31:05 INFO - Browser initialized. 05:31:05 INFO - Running cycle 1/1 for kraken test... 05:31:05 INFO - TEST-INFO | started process 10020 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWXBUBS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:31:16 INFO - PROCESS | 10020 | RSS: Main: 157208576 05:31:16 INFO - PROCESS | 10020 | 05:31:19 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37162/tests/kraken/driver.html?testName=audio-beat-detection) 05:31:20 INFO - PROCESS | 10020 | RSS: Main: 215367680 05:31:20 INFO - PROCESS | 10020 | 05:31:22 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37162/tests/kraken/driver.html?testName=audio-dft) 05:31:23 INFO - PROCESS | 10020 | RSS: Main: 203239424 05:31:23 INFO - PROCESS | 10020 | 05:31:26 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37162/tests/kraken/driver.html?testName=audio-fft) 05:31:27 INFO - PROCESS | 10020 | RSS: Main: 269180928 05:31:27 INFO - PROCESS | 10020 | 05:31:29 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37162/tests/kraken/driver.html?testName=audio-oscillator) 05:31:29 INFO - PROCESS | 10020 | RSS: Main: 180183040 05:31:29 INFO - PROCESS | 10020 | 05:31:32 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37162/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:31:32 INFO - PROCESS | 10020 | RSS: Main: 184598528 05:31:32 INFO - PROCESS | 10020 | 05:31:35 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37162/tests/kraken/driver.html?testName=imaging-darkroom) 05:31:36 INFO - PROCESS | 10020 | RSS: Main: 218898432 05:31:36 INFO - PROCESS | 10020 | 05:31:39 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37162/tests/kraken/driver.html?testName=imaging-desaturate) 05:31:40 INFO - PROCESS | 10020 | RSS: Main: 221495296 05:31:40 INFO - PROCESS | 10020 | 05:31:43 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37162/tests/kraken/driver.html?testName=json-parse-financial) 05:31:43 INFO - PROCESS | 10020 | RSS: Main: 221184000 05:31:43 INFO - PROCESS | 10020 | 05:31:45 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37162/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:31:45 INFO - PROCESS | 10020 | RSS: Main: 208953344 05:31:45 INFO - PROCESS | 10020 | 05:31:47 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37162/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:31:48 INFO - PROCESS | 10020 | RSS: Main: 212852736 05:31:48 INFO - PROCESS | 10020 | 05:31:50 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37162/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:31:50 INFO - PROCESS | 10020 | RSS: Main: 209698816 05:31:50 INFO - PROCESS | 10020 | 05:31:53 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:31:54 INFO - PROCESS | 10020 | RSS: Main: 231047168 05:31:54 INFO - PROCESS | 10020 | 05:31:56 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:31:57 INFO - PROCESS | 10020 | RSS: Main: 226295808 05:31:57 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | Cycle 1(1): loaded http://localhost:37162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37162/tests/kraken/driver.html?testName=ai-astar) 05:31:59 INFO - PROCESS | 10020 | RSS: Main: 267755520 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | __start_tp_report 05:31:59 INFO - PROCESS | 10020 | _x_x_mozilla_page_load 05:31:59 INFO - PROCESS | 10020 | _x_x_mozilla_page_load_details 05:31:59 INFO - PROCESS | 10020 | |i|pagename|runs| 05:31:59 INFO - PROCESS | 10020 | |0;ai-astar;101;111;111;109;111;109;110;109;110;109 05:31:59 INFO - PROCESS | 10020 | |1;audio-beat-detection;150;121;120;182;116;118;146;114;159;118 05:31:59 INFO - PROCESS | 10020 | |2;audio-dft;159;159;160;161;160;160;159;162;161;161 05:31:59 INFO - PROCESS | 10020 | |3;audio-fft;74;75;74;107;75;75;75;76;109;74 05:31:59 INFO - PROCESS | 10020 | |4;audio-oscillator;84;85;117;83;84;84;121;83;84;131 05:31:59 INFO - PROCESS | 10020 | |5;imaging-gaussian-blur;117;117;116;116;116;118;116;116;116;116 05:31:59 INFO - PROCESS | 10020 | |6;imaging-darkroom;145;145;146;145;145;145;147;147;146;146 05:31:59 INFO - PROCESS | 10020 | |7;imaging-desaturate;95;95;95;96;95;95;95;95;96;95 05:31:59 INFO - PROCESS | 10020 | |8;json-parse-financial;53;52;53;53;53;53;58;52;53;53 05:31:59 INFO - PROCESS | 10020 | |9;json-stringify-tinderbox;62;63;62;63;63;62;64;62;62;62 05:31:59 INFO - PROCESS | 10020 | |10;stanford-crypto-aes;76;84;78;75;75;77;80;76;75;79 05:31:59 INFO - PROCESS | 10020 | |11;stanford-crypto-ccm;119;117;118;126;124;120;119;128;150;128 05:31:59 INFO - PROCESS | 10020 | |12;stanford-crypto-pbkdf2;159;158;158;158;158;158;162;161;161;158 05:31:59 INFO - PROCESS | 10020 | |13;stanford-crypto-sha256-iterative;62;61;62;64;62;63;65;62;61;61 05:31:59 INFO - PROCESS | 10020 | __end_tp_report 05:31:59 INFO - PROCESS | 10020 | __start_cc_report 05:31:59 INFO - PROCESS | 10020 | _x_x_mozilla_cycle_collect,1634 05:31:59 INFO - PROCESS | 10020 | __end_cc_report 05:31:59 INFO - PROCESS | 10020 | __startTimestamp1468326719266__endTimestamp 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | ------- Summary: start ------- 05:31:59 INFO - PROCESS | 10020 | Number of tests: 14 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#0] ai-astar Cycles:10 Average:109.00 Median:110.00 stddev:2.94 (2.7%) stddev-sans-first:0.93 05:31:59 INFO - PROCESS | 10020 | Values: 101.0 111.0 111.0 109.0 111.0 109.0 110.0 109.0 110.0 109.0 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:133.50 stddev:23.40 (17.5%) stddev-sans-first:24.13 05:31:59 INFO - PROCESS | 10020 | Values: 150.0 121.0 120.0 182.0 116.0 118.0 146.0 114.0 159.0 118.0 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#2] audio-dft Cycles:10 Average:160.20 Median:160.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 05:31:59 INFO - PROCESS | 10020 | Values: 159.0 159.0 160.0 161.0 160.0 160.0 159.0 162.0 161.0 161.0 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#3] audio-fft Cycles:10 Average:81.40 Median:75.00 stddev:14.04 (18.7%) stddev-sans-first:14.64 05:31:59 INFO - PROCESS | 10020 | Values: 74.0 75.0 74.0 107.0 75.0 75.0 75.0 76.0 109.0 74.0 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#4] audio-oscillator Cycles:10 Average:95.60 Median:84.00 stddev:19.22 (22.9%) stddev-sans-first:19.92 05:31:59 INFO - PROCESS | 10020 | Values: 84.0 85.0 117.0 83.0 84.0 84.0 121.0 83.0 84.0 131.0 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#5] imaging-gaussian-blur Cycles:10 Average:116.40 Median:116.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 05:31:59 INFO - PROCESS | 10020 | Values: 117.0 117.0 116.0 116.0 116.0 118.0 116.0 116.0 116.0 116.0 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.82 (0.6%) stddev-sans-first:0.83 05:31:59 INFO - PROCESS | 10020 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 147.0 147.0 146.0 146.0 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:31:59 INFO - PROCESS | 10020 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:1.70 (3.2%) stddev-sans-first:1.80 05:31:59 INFO - PROCESS | 10020 | Values: 53.0 52.0 53.0 53.0 53.0 53.0 58.0 52.0 53.0 53.0 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#9] json-stringify-tinderbox Cycles:10 Average:62.50 Median:62.50 stddev:0.71 (1.1%) stddev-sans-first:0.73 05:31:59 INFO - PROCESS | 10020 | Values: 62.0 63.0 62.0 63.0 63.0 62.0 64.0 62.0 62.0 62.0 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:77.50 stddev:2.88 (3.7%) stddev-sans-first:3.00 05:31:59 INFO - PROCESS | 10020 | Values: 76.0 84.0 78.0 75.0 75.0 77.0 80.0 76.0 75.0 79.0 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:125.00 stddev:9.75 (7.8%) stddev-sans-first:10.10 05:31:59 INFO - PROCESS | 10020 | Values: 119.0 117.0 118.0 126.0 124.0 120.0 119.0 128.0 150.0 128.0 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:158.50 stddev:1.60 (1.0%) stddev-sans-first:1.69 05:31:59 INFO - PROCESS | 10020 | Values: 159.0 158.0 158.0 158.0 158.0 158.0 162.0 161.0 161.0 158.0 05:31:59 INFO - PROCESS | 10020 | 05:31:59 INFO - PROCESS | 10020 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.00 stddev:1.34 (2.2%) stddev-sans-first:1.41 05:31:59 INFO - PROCESS | 10020 | Values: 62.0 61.0 62.0 64.0 62.0 63.0 65.0 62.0 61.0 61.0 05:31:59 INFO - PROCESS | 10020 | -------- Summary: end -------- 05:31:59 INFO - PROCESS | 10020 | 05:32:00 INFO - TEST-INFO | 10020: exit 0 05:32:00 INFO - TEST-OK | kraken | took 60752ms 05:32:00 INFO - SUITE-END | took 1173s 05:32:00 INFO - Completed test suite (00:19:33) 05:32:00 INFO - javascript benchmark 05:32:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3049.207206126407, 3065.7087576680206, 3067.1871953932214, 3110.3157305392806, 3122.45357062514, 5356.678599284046, 5373.140297552392, 5399.757010934508, 5502.669839809614, 5537.197106419567, 5401.540869026127, 5404.243405923164, 5460.180972854074, 5479.890402191953, 5499.587530935186, 4914.901701965959, 4915.975420122894, 4993.75031248438, 5013.749312534359, 5152.227165925123, 5045.949540504585, 5052.191649336107, 5089.923651145235, 5116.155834287338, 5124.103281925648, 4876.341693871335, 4893.853184404474, 4903.82836600719, 4958.3306253655655, 4981.950180498185, 4974.4776798436005, 4998.650094493387, 5062.645614806965, 5070.138076527, 5095.974520127375, 4827.686200396998, 5008.749562521859, 5029.270755740434, 5040.733450021559, 5046.747662616891, 5354.491323324278, 5415.9458405415835, 5431.21247419122, 5499.807506737245, 5503.3395992480755, 5865.648061116347, 5893.292804863401, 5893.440123188333, 5914.9112763308585, 5916.704164791743, 5733.0, 5752.942470575283, 5997.820065398045, 6032.306284777263, 6033.185519954794, 5452.972735136299, 5532.529734972532, 5549.112142057292, 5555.694436805974, 5556.416576259516, 6071.605345652519, 6082.482988945901, 6084.117802918552, 6084.269887613515, 6084.6349219047, 5617.325920889438, 5698.0, 5736.368999410061, 5843.1235314703135, 5852.590318677651, 5902.055671092605, 5906.586538942232, 5930.318013428511, 5934.080217566284, 5935.7625694972585, 5767.596268261265, 5826.096954971986, 5833.4749872511675, 5844.444777746107, 5845.766169353264, 5658.207850900877, 5797.420257974169, 5845.473907348359, 5871.941280587225, 5881.323647780475, 4476.4180656514445, 4477.977610111994, 4479.910401791946, 4483.529229430928, 4522.615577675869, 3990.960090399059, 4006.0, 4013.7993100344866, 4029.597040295947, 4041.5756345583877, 5445.591580631469, 5467.289252397242, 5492.588055895823, 5493.313335833021, 5508.724563771795, 5879.559033072536, 5886.8822623547285, 5890.823275301748, 5891.204687367151, 5895.115732640053, 5495.148252020943, 5513.696746678891, 5529.944700553024, 5534.1975413565615, 5539.639923404966, 4879.365682461257, 4955.231939049453, 5018.5985121190215, 5025.547700706954, 5045.2432135180015, 6011.729472173763, 6017.548683848729, 6024.457798798129, 6026.728797204137, 6031.5476339273855, 5802.0, 5872.55955803325, 5878.294604647299, 5889.676067816311, 5893.469587736953, 5954.166416701579, 5982.0, 6014.398560143951, 6122.969385153046, 6127.601705889103, 5744.597878148489, 5787.334456537552, 5801.216835727123, 5801.274840644919, 5851.678157701367, 5848.941510584839, 5885.882282354414, 5888.234529511136, 5903.970480147572, 5904.793332233351, 5677.630953987978, 5730.398308177581, 5731.742071606871, 5739.0, 5789.421057894177, 5775.826725198251, 5783.652980821164, 5783.739731712168, 5784.074548072288, 5784.652920824764, 5528.308961379827, 5703.315602127771, 5718.027935250934, 5718.342390625131, 5718.656880587178, 5715.199872018004, 5806.709664516842, 5810.6513609183585, 5816.621919575214, 5892.410758924073, 5611.270534830609, 5638.295213098363, 5649.661020338793, 5652.0674088774895, 5656.6888821115235], "value": 5404.725737197177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.3764141754702, 617.8548041210316, 637.9362063793618, 648.5881465269553, 660.5079215984092, 30874.382512349766, 33109.83445082777, 33214.33571328572, 33236.83381583092, 42555.0, 44971.77514112425, 45508.54491455085, 45562.316565251545, 45569.0, 45575.0, 8914.643414263423, 9040.593173307218, 9060.139286767746, 9063.864042039375, 9066.093390660948, 8905.0, 8917.509536975464, 8923.598438070303, 8997.865032024525, 9000.639974401016, 8937.374383793138, 9010.594523246436, 9016.053314401992, 9016.36885418021, 9016.954915225415, 8999.41503802254, 9034.909650903473, 9041.276697864156, 9043.954780226122, 9048.095190480964, 8904.0, 8958.148975847284, 8963.641454341818, 8974.551272436353, 8979.236764874993, 42829.35755963663, 43157.35263971043, 43165.0, 43201.0, 43254.56745432568, 3550.609432962372, 3709.9107187391, 3733.4026555750947, 3760.492333534965, 3806.4290356446477, 32946.17634559131, 33221.0, 33551.32897342039, 33584.16039599005, 34121.0, 4407.228734971367, 4438.112377524508, 4515.187266292066, 4635.026644404679, 4635.513271106553, 341268.0, 344485.0, 344808.0, 345384.0, 345833.0, 59518.40481595129, 59833.401665983656, 59954.10068848971, 59964.70017649971, 60009.09986350208, 61105.388946110856, 61203.08195377073, 61297.38702612917, 61345.69327153335, 61392.0, 16989.150542472828, 17238.827611723973, 17286.740698889276, 17318.480445586654, 17322.740158897628, 13160.670983225496, 13203.339833008311, 13205.0, 13210.07529472947, 13212.405441755143, 15913.283902224428, 17323.133843307784, 17355.826441735422, 17385.217665205095, 17403.0, 5671.262735844314, 5731.140328950691, 5786.363500014995, 5864.648121112747, 5867.911981320283, 961.7259081161835, 1040.9115225205792, 1071.1323827699432, 1105.6517197082894, 1159.4202898550725, 32929.67070329314, 33107.66892331094, 33200.66799331976, 33270.0, 33417.3316533668, 1124.8875112488686, 1125.1448898836943, 1167.9824802627968, 1175.371176420611, 1195.3246415775059, 16924.661506769797, 17053.14734263282, 17104.315827366765, 17114.657706845792, 17171.570710732332, 480258.0, 482328.0, 482724.0, 484549.0, 486631.0, 55625.66246025251, 56926.14610780842, 57115.0, 57417.0, 57439.71280143572, 1238.5726924211133, 1321.5374618883507, 1356.5048757203747, 1364.501956785766, 1364.836219653648, 33050.504242435905, 34339.484907725906, 34763.826180868935, 34831.30337393187, 34944.30111397707, 50635.24047139369, 50673.74663126661, 51144.23283650674, 51198.74400627973, 51234.74382628063, 388057.0, 388597.0, 388873.0, 389812.0, 391049.0, 34751.304973899874, 39769.40345894872, 40993.59006409898, 41540.33838646541, 41677.16645667009, 47866.28200577064, 48766.75616621894, 49115.754421229096, 49160.508394915596, 49848.50151498584, 41433.58566414297, 41734.791326043174, 42037.78981105075, 43022.784886075366, 43140.13719725651, 40868.0, 41231.58768412277, 41827.351816254086, 41966.1606767869, 42304.0, 41224.38163427491, 41234.587654123075, 41489.792551037055, 41923.1615367697, 42440.39256663218, 36029.819850900574, 36758.0, 36876.81561592175, 37615.62384376121, 37644.81177594094, 27799.328031471596, 28252.15243542697, 28280.575791362735, 28339.71660283453, 28511.572326414705], "value": 20240.17754878315, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.08558500451494, 380.41796052040377, 386.8742658635943, 393.8444314495776, 405.3534612293391, 18631.72052419213, 20327.28854490091, 20341.28805491808, 20446.0, 20684.48288792781, 19963.301284455047, 20109.798902010974, 20340.796592034076, 20599.1760329587, 20715.37853864383, 5410.648307859977, 5522.3649280332775, 5684.516816070618, 5684.516816070639, 5734.426557344253, 5564.916526252109, 5591.189277554752, 5614.214010038598, 5627.746751396197, 5642.379338272786, 5421.1326187809955, 5595.608307418483, 5595.664260144405, 5602.691851948141, 5610.130429783369, 5593.300837395325, 5594.440555944414, 5596.104623260299, 5602.1036634138545, 5607.551395888319, 4795.976020119912, 5009.874753131165, 5021.196608542652, 5039.874003149914, 5044.798208071673, 23907.521849562912, 24047.03811847524, 24533.14134005301, 24718.50562988748, 24757.25728228156, 2180.2042254576963, 2342.0748804222408, 2402.8197885158684, 2569.40903592173, 3002.564628128909, 9711.125998660083, 10077.44574048427, 10112.140468060225, 10384.94807525965, 13743.244121573309, 1876.840468560174, 1914.6757172612754, 1964.371401151632, 1965.3023176772326, 2032.359806660897, 87069.12930870673, 87071.0, 87088.56455717744, 89679.55160224222, 90702.99999999935, 9987.450690212108, 10329.0, 11061.391623460788, 11212.719682007852, 11251.0, 15291.388344466319, 15331.770023449657, 15376.0, 15407.691846163014, 15409.229538523254, 8086.797830054295, 8309.750707478785, 8469.0, 8480.53357065355, 8555.786105347415, 8275.0, 8333.708320208885, 8379.371547133867, 8503.872441913376, 8514.063453020162, 4432.711873728262, 4583.862484125481, 4703.882402939954, 4711.199096153662, 4815.6388270879825, 1787.3118849242876, 1797.173300281859, 1802.4682718598044, 1805.8194180581836, 1823.5623450371816, 421.70059257927215, 422.03775392106047, 449.0950734270448, 455.731118640004, 1026.810040142576, 11717.531298747954, 12161.452734626962, 12236.449359778831, 12250.387480625934, 12417.130800844036, 455.13978580482916, 458.50939494740305, 458.6812165544981, 461.5684335146649, 478.2921276510714, 6327.082573026885, 6444.677766111676, 6500.284968653445, 6502.382273683992, 6536.0, 502853.0, 504279.61483466666, 519854.0, 521375.0, 525463.0, 90585.0, 99329.0, 101901.94294171187, 102884.48557757313, 109877.45061274643, 986.4574484033752, 987.8123156600223, 1015.608990538648, 1018.6536577563664, 1022.0188618925766, 14123.788143177655, 17662.293508259525, 18242.270309187483, 18863.434096976565, 18933.526661833563, 33394.0, 43178.35232471578, 44263.0, 44675.55324446714, 45081.323780142666, 59560.70219648874, 61139.38860611337, 69148.65425672839, 71555.28444715486, 72055.63972180105, 8556.786080347792, 8731.388802783998, 8735.141177527434, 8751.606177722146, 8925.553722313989, 9127.269818414377, 9267.72196834096, 9399.731036310011, 13757.0, 14186.574402767934, 12447.813282800946, 12576.811347829607, 12654.620361389174, 12707.174033687781, 12867.292298923649, 12111.858633382526, 12413.069019823368, 12518.311492867979, 12790.872091278969, 12823.487060517475, 12186.086043546948, 12511.311877846441, 12985.740285194055, 13068.346582671018, 13122.212667239613, 8721.65113395457, 8760.38677292609, 8891.4665120093, 8937.46375217489, 8983.730488085368, 8924.419912705653, 12291.56979505713, 12908.419121139383, 13023.348832558144, 13216.0], "value": 8786.573933539656, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.9638759031027, 1470.0444710937888, 1603.9358425662967, 1748.248253251103, 1783.6343549572339, 8097.3926955478355, 8551.572421378922, 8634.17975292347, 8637.0499245083, 8637.870431943526, 7346.522476039054, 7920.841583168348, 8172.387070969671, 8174.754757357274, 8456.19666131718, 2241.820654347648, 2254.8985295661732, 2259.039908039085, 2261.7398999115067, 2263.3323169664905, 2201.207565276507, 2244.494988627562, 2262.1064679451606, 2266.8186545076355, 2268.5122698619793, 1925.2683980087618, 1978.7229787829715, 1980.227711192636, 1989.691597802343, 2195.626743453609, 2204.7574766775642, 2235.5417139486367, 2236.13908645172, 2236.8434209605334, 2240.7983281504744, 2215.9002844871857, 2224.799768020886, 2242.8317876159354, 2247.2584047264527, 2250.7749225077523, 8567.228949394523, 8602.096779838152, 8612.956935215283, 8617.181367770052, 8622.31021518277, 4773.665843390964, 4835.008823191238, 4869.951300486985, 4871.951280487186, 4877.561019508261, 3048.908532744021, 3113.844307784602, 3152.1489197916662, 3156.1793933577205, 3165.1454107390878, 986.2061040862175, 1023.1712313026472, 1044.9320794148357, 1046.3460337289193, 1048.9265751397406, 10990.560377584887, 11025.228234023622, 11036.944815275872, 11042.171837112248, 11086.944565277203, 3999.440078389028, 4178.644815190682, 4209.305464598368, 4336.479622445327, 4339.284018137035, 9297.349185557081, 9301.069893010645, 9313.720588382359, 9341.766455838522, 9355.204807591295, 4826.855194344175, 4841.3222148899185, 4846.36997190363, 4849.102915960559, 4853.02939412119, 4443.644508439382, 4490.034642551802, 4497.168023915586, 4499.460064792246, 4500.572445617727, 3864.652181303696, 3914.784686842194, 3945.2504024235304, 3966.2464131814863, 3982.7012974027066, 1219.567053695925, 1222.1200735470447, 1278.4374875054946, 1283.646997075793, 1294.5145570411096, 906.6781292641149, 982.4645568165367, 1003.1824063388315, 1004.4073996342194, 1010.722051435861, 5993.160957465958, 6078.0, 6090.756369745249, 6210.596311239755, 6353.30113687494, 431.1807565625337, 434.8760603228065, 448.41481866164315, 450.25482825922495, 452.4434945017647, 4197.76912269822, 4265.829366825292, 4275.679324050709, 4285.421468101828, 4315.438992930899, 10234.692959211086, 10433.113185379329, 10501.894981050245, 10598.099161571352, 10610.151187904949, 10466.947665261778, 10469.842952355568, 10476.0, 10479.318844275098, 10491.213159012952, 7513.586752728543, 7803.804904877424, 7882.605869706606, 7899.0, 7906.05127384706, 5957.851053723692, 6074.240719910012, 6108.847278818065, 6151.84620384494, 6229.96885015572, 9258.629654813732, 9381.155695987394, 9423.952880235554, 9447.81104377895, 9471.763205919908, 8904.599293031959, 9349.626014959325, 9532.714018579454, 9591.90408095938, 9601.615935362508, 7506.474546781673, 7508.361789247757, 7614.238576142341, 7678.8080297993, 7692.6922923084685, 8349.415540912078, 8351.95824020876, 8381.455205411628, 8386.790330241793, 8415.11641277657, 6523.510736694672, 7280.708771649287, 7344.22885597026, 7456.142543607554, 7821.648025838965, 7475.2151024141685, 7517.248275172439, 7532.924670753222, 7573.697052118074, 7683.769486915401, 6857.931420685729, 6859.519833611599, 6937.340952609494, 6943.236244013256, 6949.965250173716, 5163.870903227299, 5234.267202591716, 5265.341832270966, 5384.273123128328, 5395.0, 5312.203169524602, 5373.677579345252, 5425.240466334795, 5464.562834973272, 5512.503874651301], "value": 4384.667072811947, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.2778362523506, 317.18799872326844, 323.425918993786, 323.79115470521515, 325.32982056962675, 5217.47825217478, 5271.393789714184, 5344.251804747334, 5347.331583552056, 5362.490563396476, 5116.718580478072, 5278.788848446067, 5322.658030466592, 5344.22508736234, 5351.866203344918, 4135.0, 4140.772257525835, 4143.627073563379, 4158.397032430295, 4162.396452514391, 3978.3037968355566, 4122.6083522065355, 4136.51085609182, 4146.647534959517, 4159.896002599929, 4068.816903239361, 4077.55146933837, 4118.75287482752, 4120.423140760296, 4129.876103716878, 4071.1247081877536, 4077.1641813428178, 4078.245524577933, 4101.159262351211, 4102.630763231308, 3599.262151258986, 3601.3697602919383, 3606.585242697071, 3609.5488063992, 3621.8370173342264, 5149.48505149482, 5163.793448262065, 5181.5077567631015, 5189.351331083614, 5203.817866374697, 4683.742394168319, 4686.203345431285, 4700.083483720676, 4708.623310135181, 4710.175719249118, 5561.694106824123, 5570.637908535973, 5570.916436253459, 5580.581456390746, 5597.80407685729, 3792.715546334036, 3946.565877753445, 3953.2884080865433, 3953.3081710700512, 3967.3255546557157, 5698.914516282259, 5720.227769251181, 5733.853229354146, 5752.942470575283, 5781.682007489587, 4000.3999400089638, 4002.5597184309704, 4005.239004589119, 4023.295923213426, 4026.959730402717, 3906.824192911326, 4057.857974970862, 4077.1234184649848, 4084.36692312692, 4094.7747873867224, 4604.493505714368, 4608.861734147981, 4644.628429725613, 4663.790129444184, 4679.812807487662, 5533.3083364579425, 5543.334799824047, 5546.58400619947, 5567.693776842312, 5591.832245032656, 1321.7641505192676, 1329.5811819276896, 1401.6495876030992, 1417.8232067384254, 1421.9548631755652, 982.6806287956442, 991.1575161113141, 1007.9617993466741, 1009.545704433008, 1009.9040591143829, 4699.0, 4703.553162449562, 4743.513517564587, 4779.450363208206, 4794.832180873653, 5032.891615010693, 5093.2360145977655, 5096.0, 5135.537801597799, 5142.665726727751, 4843.200871856175, 4854.320395144682, 4867.464578896319, 4895.216765317532, 5065.062963351792, 3035.5294929285997, 3068.800527965675, 3069.5242237452785, 3086.490729029685, 3095.767817413703, 5927.229460170237, 5931.228940237742, 5945.524358051345, 5950.256217972754, 5969.73136208863, 5673.8297851064535, 5846.210761547221, 5848.736806843617, 5863.237779088691, 5928.881422371528, 5869.6771677558145, 5872.941270587325, 5886.440788125121, 5916.467517923322, 5916.615419997686, 5638.4925356718095, 5700.486956173964, 5736.770529178786, 5758.0, 5774.249347584787, 5660.547156227574, 5666.15007748841, 5670.703365137126, 5742.7702891883855, 5750.884982300414, 5856.882862342814, 5931.0, 5940.108983652487, 5942.5932497338645, 5963.403659634002, 3731.2910546995986, 3793.5827059024036, 3995.280849447011, 4017.919641607093, 4081.816318265626, 5592.916106258491, 5658.0, 5663.773449062156, 5687.459691329317, 5691.089425691869, 5587.69267690281, 5609.326880774333, 5618.943810562006, 5625.859353516031, 5638.0, 5399.730013499231, 5569.134339996147, 5599.272094627672, 5630.493255607015, 5665.830025099253, 5528.640638358494, 5547.335799260125, 5561.63849349791, 5562.777488900399, 5621.718914054362, 5335.573154147582, 5595.692236927008, 5654.06707893193, 5689.061304884648, 5689.260396148474, 5471.671699697871, 5523.8066667666435, 5525.9723701382845, 5527.834164975057, 5552.250446189874], "value": 4202.9552554349475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.9735759248425, 789.8380831929453, 789.9012623422072, 789.9368050555956, 833.4249367936127, 14974.850251497483, 15350.769738453931, 15376.0, 15379.077255364686, 15402.768958465633, 14606.573407036361, 15008.024478408895, 15073.773893391608, 15193.848061519382, 15213.087214767122, 787.0673252196152, 820.5445977482494, 820.5938060659952, 820.659426338069, 821.3388222480901, 676.6346173066538, 789.2896393246067, 814.2915663372873, 816.5713000674664, 827.433208252346, 847.1570787066877, 847.9321654267644, 848.0247715127622, 848.0417128644623, 848.3043903998723, 842.1368097699846, 842.7893026743315, 843.1694780641063, 843.1779015459908, 843.5866425451516, 513.3685566752878, 595.0419824083223, 611.9326874043852, 616.0789619518803, 616.2420223125581, 14759.18824464654, 14779.482718104922, 14787.408503659948, 14804.777928331083, 14846.554603361916, 14261.928690356586, 14933.626659333495, 15070.5478835634, 15116.924415377853, 15249.313780879887, 13071.281079540622, 13271.270080145589, 13330.533431329857, 13583.456661733519, 13721.0, 4450.376947227391, 4475.641948644101, 4555.157295900269, 4646.953530464686, 4693.319468677057, 82429.0, 83483.58258208731, 83681.5606985544, 83775.0, 83788.0, 11545.249558778652, 11807.0, 11862.703432414086, 12074.396280185956, 12155.669841333145, 21930.89034554817, 21935.122595096338, 21951.451213719465, 21962.69391713847, 21964.670529942065, 8713.215810577078, 8731.0, 8913.955430222808, 8919.0, 8952.910470895207, 4468.4414448193975, 4893.119238537026, 5046.722430266371, 5101.336826212569, 5133.845984620468, 3346.0631023313026, 3475.0, 3475.0269924421204, 3483.9303213935577, 3484.2683036562607, 570.9257796486513, 584.7690162385834, 590.1796502861026, 590.3918963467635, 599.0834023943373, 606.2361424604941, 668.8929771236676, 682.2086379799409, 688.4148473797233, 699.9510034297653, 9719.271054670928, 9761.853572196424, 9974.80050398988, 10060.798784024279, 10252.282340236261, 661.351875162334, 668.314977148417, 698.12734082397, 716.3910675925525, 721.0662192460776, 4718.577339449067, 4844.878878028007, 4853.344798452164, 4856.17445034345, 4860.246661767432, 103074.96925030653, 116474.41762791132, 117756.41121794507, 118177.40911295389, 118643.0, 66150.66924665442, 66667.66666166639, 78336.2166378329, 100617.49691251644, 102180.48909755403, 88169.55915220383, 88504.5574772122, 90491.54754226186, 91302.54348728081, 91395.08604913866, 9232.399894006869, 9264.53677316118, 9419.199368053518, 9572.23422126242, 9609.663661771805, 52776.47223527716, 53320.26758127049, 53633.73183134059, 54772.0, 54843.725781372435, 70105.64947175232, 78049.60975195088, 80187.59906200432, 80836.59581702054, 82504.0, 10344.53449594755, 11190.041807308651, 11199.944000279946, 11354.943225283821, 11646.010089142517, 13128.277944713132, 13177.736445271232, 13230.4046317914, 13283.0, 13322.600321990356, 12253.75492490163, 12344.0, 12409.565665201675, 12489.18820276679, 12613.558525451564, 11837.289762614271, 12033.63899083029, 12056.578019769266, 12059.457324420247, 12133.393330333625, 12361.134720569475, 12386.3187524687, 12864.099513033998, 12933.089776070092, 13002.544910928073, 9926.652567160114, 10338.483075846027, 10344.431056291674, 10597.4701264938, 10729.088027517748, 10445.68662940113, 11140.164487663296, 12065.879341206826, 12127.757444850877, 12357.93821030889], "value": 7507.582630645821, "unit": "score"}], "name": "dromaeo_css", "value": 7144.54042634182, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 111.0, 109.0, 111.0, 109.0, 110.0, 109.0, 110.0, 109.0], "value": 109.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 121.0, 120.0, 182.0, 116.0, 118.0, 146.0, 114.0, 159.0, 118.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 160.0, 161.0, 160.0, 160.0, 159.0, 162.0, 161.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 107.0, 75.0, 75.0, 75.0, 76.0, 109.0, 74.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 117.0, 83.0, 84.0, 84.0, 121.0, 83.0, 84.0, 131.0], "value": 95.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 118.0, 116.0, 116.0, 116.0, 116.0], "value": 116.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 147.0, 147.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 53.0, 53.0, 53.0, 58.0, 52.0, 53.0, 53.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 63.0, 62.0, 64.0, 62.0, 62.0, 62.0], "value": 62.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 84.0, 78.0, 75.0, 75.0, 77.0, 80.0, 76.0, 75.0, 79.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 118.0, 126.0, 124.0, 120.0, 119.0, 128.0, 150.0, 128.0], "value": 124.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 158.0, 158.0, 158.0, 158.0, 158.0, 162.0, 161.0, 161.0, 158.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 62.0, 64.0, 62.0, 63.0, 65.0, 62.0, 61.0, 61.0], "value": 62.3, "unit": "score"}], "name": "kraken", "value": 1477.5, "alertThreshold": 2.0}]} 05:32:00 INFO - Return code: 0 05:32:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:32:00 INFO - # TBPL SUCCESS # 05:32:00 INFO - Running post-action listener: _resource_record_post_action 05:32:00 INFO - ##### 05:32:00 INFO - ##### Finished run-tests step (success) 05:32:00 INFO - ##### 05:32:00 INFO - Running post-run listener: _resource_record_post_run 05:32:00 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 559403008; Read time: 16; Write time: 476788 05:32:00 INFO - TinderboxPrint: CPU usage
13.0% 05:32:00 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:32:00 INFO - TinderboxPrint: I/O write bytes / time
559,403,008 / 476,788 05:32:00 INFO - TinderboxPrint: CPU idle
8,268.3 (87.0%) 05:32:00 INFO - TinderboxPrint: CPU user
1,195.2 (12.6%) 05:32:00 INFO - TinderboxPrint: Swap in / out
0 / 0 05:32:00 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 262922240; Read time: 0; Write time: 289848 05:32:00 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 296480768; Read time: 0; Write time: 186940 05:32:01 INFO - Running post-run listener: _upload_blobber_files 05:32:01 INFO - Blob upload gear active. 05:32:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:32:01 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 05:32:01 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'] 05:32:01 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 05:32:01 INFO - (blobuploader) - INFO - Open directory for files ... 05:32:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:32:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:32:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:02 INFO - (blobuploader) - INFO - Done attempting. 05:32:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:32:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:32:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:03 INFO - (blobuploader) - INFO - Done attempting. 05:32:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:32:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:32:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:32:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:32:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:32:06 INFO - (blobuploader) - INFO - Done attempting. 05:32:06 INFO - (blobuploader) - INFO - Iteration through files over. 05:32:06 INFO - Return code: 0 05:32:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:32:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:32:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf271a0c1589c9a4faaf02c2f802cb775676d404e96b86ccabb87c3ffa69836ff8b02abfd000b147e6765f181f19b8635e8663c07644a879d1e66a5b1828d468", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8dc2aca5ac8c421c5579e2c16785779a62423a5438b0c4a1304fcd40562736e4feb7dcbb68fc6e017e1babc35d17ec4f34caebbe970f33e9904c8f057f735447", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc9d2205e0e28c138b00d2ef79699cb5f4672d29295129da7e7e742b96e142e85e741b9d323a4bfd1f37907b96cf5ecb6e5fb8e90259f86996b31a7453bfcc4e"} 05:32:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:32:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:32:06 INFO - Contents: 05:32:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf271a0c1589c9a4faaf02c2f802cb775676d404e96b86ccabb87c3ffa69836ff8b02abfd000b147e6765f181f19b8635e8663c07644a879d1e66a5b1828d468", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8dc2aca5ac8c421c5579e2c16785779a62423a5438b0c4a1304fcd40562736e4feb7dcbb68fc6e017e1babc35d17ec4f34caebbe970f33e9904c8f057f735447", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc9d2205e0e28c138b00d2ef79699cb5f4672d29295129da7e7e742b96e142e85e741b9d323a4bfd1f37907b96cf5ecb6e5fb8e90259f86996b31a7453bfcc4e"} 05:32:06 INFO - Running post-run listener: copy_logs_to_upload_dir 05:32:06 INFO - Copying logs to upload dir... 05:32:06 INFO - mkdir: /builds/slave/test/build/upload/logs 05:32:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.977068 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-07-12 05:32:06.533773) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 05:32:06.537732) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183 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/bf271a0c1589c9a4faaf02c2f802cb775676d404e96b86ccabb87c3ffa69836ff8b02abfd000b147e6765f181f19b8635e8663c07644a879d1e66a5b1828d468", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8dc2aca5ac8c421c5579e2c16785779a62423a5438b0c4a1304fcd40562736e4feb7dcbb68fc6e017e1babc35d17ec4f34caebbe970f33e9904c8f057f735447", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc9d2205e0e28c138b00d2ef79699cb5f4672d29295129da7e7e742b96e142e85e741b9d323a4bfd1f37907b96cf5ecb6e5fb8e90259f86996b31a7453bfcc4e"} build_url:https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011136 build_url: 'https://queue.taskcluster.net/v1/task/C2ofgm6FQNKOAGPLPXRkVg/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/bf271a0c1589c9a4faaf02c2f802cb775676d404e96b86ccabb87c3ffa69836ff8b02abfd000b147e6765f181f19b8635e8663c07644a879d1e66a5b1828d468", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8dc2aca5ac8c421c5579e2c16785779a62423a5438b0c4a1304fcd40562736e4feb7dcbb68fc6e017e1babc35d17ec4f34caebbe970f33e9904c8f057f735447", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/cc9d2205e0e28c138b00d2ef79699cb5f4672d29295129da7e7e742b96e142e85e741b9d323a4bfd1f37907b96cf5ecb6e5fb8e90259f86996b31a7453bfcc4e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-12 05:32:06.567195) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:32:06.568003) ========= 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=56c518bb7cbc29fb3c9463e2000001c4-1468325494.142475-329584183 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004414 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-12 05:32:06.654175) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 05:32:06.654886) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-12 05:32:06.655571) ========= ========= Total master_lag: 0.20 =========